builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1470449520.14 results: success (0) buildid: 20160805163004 builduid: 8d0180b9188a412eb36fa16ecebdc83e revision: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.140634) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.141277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.141588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.162288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.162669) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 19:12:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-08-05 19:12:01 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134428 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.312808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.313104) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015367 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.367252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:00.367839) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 19:12:01,235 truncating revision to first 12 chars 2016-08-05 19:12:01,235 Setting DEBUG logging. 2016-08-05 19:12:01,235 attempt 1/10 2016-08-05 19:12:01,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6b65dd49d4f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 19:12:01,537 unpacking tar archive at: mozilla-central-6b65dd49d4f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638645 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:01.020701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:01.021009) ========= script_repo_revision: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:01.021442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:01.021736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 19:12:01.032393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-05 19:12:01.032760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:12:01 INFO - MultiFileLogger online at 20160805 19:12:01 in /builds/slave/test 19:12:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:12:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:12:01 INFO - {'append_to_log': False, 19:12:01 INFO - 'base_work_dir': '/builds/slave/test', 19:12:01 INFO - 'blob_upload_branch': 'Firefox', 19:12:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:12:01 INFO - 'branch': 'Firefox', 19:12:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:12:01 INFO - 'config_files': ('talos/linux_config.py',), 19:12:01 INFO - 'default_actions': ('clobber', 19:12:01 INFO - 'read-buildbot-config', 19:12:01 INFO - 'download-and-extract', 19:12:01 INFO - 'populate-webroot', 19:12:01 INFO - 'create-virtualenv', 19:12:01 INFO - 'install', 19:12:01 INFO - 'run-tests'), 19:12:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:12:01 INFO - 'download_minidump_stackwalk': True, 19:12:01 INFO - 'download_symbols': 'ondemand', 19:12:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:12:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:12:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:12:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:12:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:12:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:12:01 INFO - 'installer_path': 'installer.exe', 19:12:01 INFO - 'log_level': 'info', 19:12:01 INFO - 'log_name': 'talos', 19:12:01 INFO - 'log_to_console': True, 19:12:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:12:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:12:01 INFO - 'opt_config_files': (), 19:12:01 INFO - 'pip_index': False, 19:12:01 INFO - 'sps_profile': False, 19:12:01 INFO - 'sps_profile_interval': 0, 19:12:01 INFO - 'suite': 'dromaeojs-e10s', 19:12:01 INFO - 'system_bits': '32', 19:12:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:12:01 INFO - 'title': 'talos-linux64-ix-049', 19:12:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:12:01 INFO - 'use_talos_json': True, 19:12:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:12:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:12:01 INFO - 'work_dir': 'build'} 19:12:01 INFO - [mozharness: 2016-08-06 02:12:01.985268Z] Running clobber step. 19:12:01 INFO - Running pre-action listener: _resource_record_pre_action 19:12:01 INFO - Running main action method: clobber 19:12:01 INFO - rmtree: /builds/slave/test/build 19:12:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:02 INFO - Running post-action listener: _resource_record_post_action 19:12:02 INFO - [mozharness: 2016-08-06 02:12:02.451528Z] Finished clobber step (success) 19:12:02 INFO - [mozharness: 2016-08-06 02:12:02.451628Z] Running read-buildbot-config step. 19:12:02 INFO - Running pre-action listener: _resource_record_pre_action 19:12:02 INFO - Running main action method: read_buildbot_config 19:12:02 INFO - Using buildbot properties: 19:12:02 INFO - { 19:12:02 INFO - "project": "", 19:12:02 INFO - "product": "firefox", 19:12:02 INFO - "script_repo_revision": "production", 19:12:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:12:02 INFO - "repository": "", 19:12:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:12:02 INFO - "buildid": "20160805163004", 19:12:02 INFO - "pgo_build": "True", 19:12:02 INFO - "basedir": "/builds/slave/test", 19:12:02 INFO - "buildnumber": 306, 19:12:02 INFO - "slavename": "talos-linux64-ix-049", 19:12:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:12:02 INFO - "platform": "ubuntu64_hw", 19:12:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:12:02 INFO - "branch": "mozilla-central", 19:12:02 INFO - "repo_path": "mozilla-central", 19:12:02 INFO - "revision": "6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8", 19:12:02 INFO - "stage_platform": "linux64-pgo", 19:12:02 INFO - "builduid": "8d0180b9188a412eb36fa16ecebdc83e", 19:12:02 INFO - "slavebuilddir": "test" 19:12:02 INFO - } 19:12:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:12:02 INFO - Running post-action listener: _resource_record_post_action 19:12:02 INFO - [mozharness: 2016-08-06 02:12:02.454339Z] Finished read-buildbot-config step (success) 19:12:02 INFO - [mozharness: 2016-08-06 02:12:02.454428Z] Running download-and-extract step. 19:12:02 INFO - Running pre-action listener: _resource_record_pre_action 19:12:02 INFO - Running main action method: download_and_extract 19:12:02 INFO - mkdir: /builds/slave/test/build/tests 19:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:02 INFO - trying https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:12:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:12:03 INFO - Downloaded 1361 bytes. 19:12:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:12:03 INFO - Using the following test package requirements: 19:12:03 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:12:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:12:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'jsshell-linux-x86_64.zip'], 19:12:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:12:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:12:03 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:12:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:12:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:12:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:03 INFO - trying https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:12:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:12:03 INFO - Downloaded 21826248 bytes. 19:12:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:12:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:12:05 INFO - Return code: 0 19:12:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:05 INFO - trying https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:12:05 INFO - Downloading https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:12:06 INFO - Downloaded 21826248 bytes. 19:12:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:12:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:12:07 INFO - Return code: 0 19:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:07 INFO - trying https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:12:07 INFO - Downloading https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:12:08 INFO - Downloaded 14413723 bytes. 19:12:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:12:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:12:08 INFO - Return code: 0 19:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:08 INFO - trying https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:12:08 INFO - Downloading https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:12:10 INFO - Downloaded 59948525 bytes. 19:12:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:12:10 INFO - mkdir: /builds/slave/test/properties 19:12:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:12:10 INFO - Writing to file /builds/slave/test/properties/build_url 19:12:10 INFO - Contents: 19:12:10 INFO - build_url:https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:12:11 INFO - Running post-action listener: _resource_record_post_action 19:12:11 INFO - Running post-action listener: set_extra_try_arguments 19:12:11 INFO - [mozharness: 2016-08-06 02:12:11.181416Z] Finished download-and-extract step (success) 19:12:11 INFO - [mozharness: 2016-08-06 02:12:11.181739Z] Running populate-webroot step. 19:12:11 INFO - Running pre-action listener: _resource_record_pre_action 19:12:11 INFO - Running main action method: populate_webroot 19:12:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:12:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:12:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:12:11 INFO - '--tppagecycles', 19:12:11 INFO - '7'], 19:12:11 INFO - 'tests': ['tsvgm']}}, 19:12:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:12:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:12:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:12:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:12:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['damp', 'tps']}, 19:12:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'tests': ['damp', 'tps']}, 19:12:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['dromaeo_dom']}, 19:12:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:12:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['basic_compositor_video']}, 19:12:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:12:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['a11yr', 19:12:11 INFO - 'ts_paint', 19:12:11 INFO - 'tpaint', 19:12:11 INFO - 'sessionrestore', 19:12:11 INFO - 'sessionrestore_no_auto_restore', 19:12:11 INFO - 'tabpaint']}, 19:12:11 INFO - 'other-e10s': {'tests': ['a11yr', 19:12:11 INFO - 'ts_paint', 19:12:11 INFO - 'tpaint', 19:12:11 INFO - 'sessionrestore', 19:12:11 INFO - 'sessionrestore_no_auto_restore', 19:12:11 INFO - 'tabpaint']}, 19:12:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:12:11 INFO - 'ts_paint', 19:12:11 INFO - 'tpaint', 19:12:11 INFO - 'sessionrestore', 19:12:11 INFO - 'sessionrestore_no_auto_restore', 19:12:11 INFO - 'tabpaint']}, 19:12:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:12:11 INFO - 'ts_paint', 19:12:11 INFO - 'tpaint', 19:12:11 INFO - 'sessionrestore', 19:12:11 INFO - 'sessionrestore_no_auto_restore', 19:12:11 INFO - 'tabpaint']}, 19:12:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['a11yr', 19:12:11 INFO - 'ts_paint', 19:12:11 INFO - 'tpaint', 19:12:11 INFO - 'sessionrestore', 19:12:11 INFO - 'sessionrestore_no_auto_restore', 19:12:11 INFO - 'tabpaint']}, 19:12:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['a11yr', 19:12:11 INFO - 'ts_paint', 19:12:11 INFO - 'tpaint', 19:12:11 INFO - 'sessionrestore', 19:12:11 INFO - 'sessionrestore_no_auto_restore', 19:12:11 INFO - 'tabpaint']}, 19:12:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['tsvgx', 19:12:11 INFO - 'tsvgr_opacity', 19:12:11 INFO - 'tart', 19:12:11 INFO - 'tscrollx', 19:12:11 INFO - 'cart']}, 19:12:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:12:11 INFO - 'tsvgr_opacity', 19:12:11 INFO - 'tart', 19:12:11 INFO - 'tscrollx', 19:12:11 INFO - 'cart']}, 19:12:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'talos_options': ['--disable-e10s'], 19:12:11 INFO - 'tests': ['tp5o']}, 19:12:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'tests': ['tp5o']}, 19:12:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'talos_options': ['--disable-e10s', 19:12:11 INFO - '--xperf_path', 19:12:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:11 INFO - 'tests': ['tp5n']}, 19:12:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:11 INFO - 'talos_options': ['--xperf_path', 19:12:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:11 INFO - 'tests': ['tp5n']}}, 19:12:11 INFO - 'talos.zip': {'path': '', 19:12:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:12:11 INFO - Running post-action listener: _resource_record_post_action 19:12:11 INFO - [mozharness: 2016-08-06 02:12:11.197631Z] Finished populate-webroot step (success) 19:12:11 INFO - [mozharness: 2016-08-06 02:12:11.197719Z] Running create-virtualenv step. 19:12:11 INFO - Running pre-action listener: _resource_record_pre_action 19:12:11 INFO - Running main action method: create_virtualenv 19:12:11 INFO - Creating virtualenv /builds/slave/test/build/venv 19:12:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:12:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:12:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:12:11 INFO - Using real prefix '/usr' 19:12:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:12:11 INFO - Installing distribute.............................................................................................................................................................................................done. 19:12:13 INFO - Installing pip.................done. 19:12:13 INFO - Return code: 0 19:12:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:12:13 INFO - Using env: {'DISPLAY': ':0', 19:12:13 INFO - 'HOME': '/home/cltbld', 19:12:13 INFO - 'LANG': 'en_US.UTF-8', 19:12:13 INFO - 'LANGUAGE': 'en_US:en', 19:12:13 INFO - 'LOGNAME': 'cltbld', 19:12:13 INFO - 'MAIL': '/var/mail/cltbld', 19:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:13 INFO - 'MOZ_NO_REMOTE': '1', 19:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:13 INFO - 'NO_EM_RESTART': '1', 19:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:13 INFO - 'PWD': '/builds/slave/test', 19:12:13 INFO - 'SHELL': '/bin/bash', 19:12:13 INFO - 'SHLVL': '1', 19:12:13 INFO - 'TERM': 'linux', 19:12:13 INFO - 'TMOUT': '86400', 19:12:13 INFO - 'USER': 'cltbld', 19:12:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:13 INFO - '_': '/tools/buildbot/bin/python'} 19:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:12:14 INFO - Cleaning up... 19:12:14 INFO - Return code: 0 19:12:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:12:14 INFO - Using env: {'DISPLAY': ':0', 19:12:14 INFO - 'HOME': '/home/cltbld', 19:12:14 INFO - 'LANG': 'en_US.UTF-8', 19:12:14 INFO - 'LANGUAGE': 'en_US:en', 19:12:14 INFO - 'LOGNAME': 'cltbld', 19:12:14 INFO - 'MAIL': '/var/mail/cltbld', 19:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:14 INFO - 'MOZ_NO_REMOTE': '1', 19:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:14 INFO - 'NO_EM_RESTART': '1', 19:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:14 INFO - 'PWD': '/builds/slave/test', 19:12:14 INFO - 'SHELL': '/bin/bash', 19:12:14 INFO - 'SHLVL': '1', 19:12:14 INFO - 'TERM': 'linux', 19:12:14 INFO - 'TMOUT': '86400', 19:12:14 INFO - 'USER': 'cltbld', 19:12:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:14 INFO - '_': '/tools/buildbot/bin/python'} 19:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:14 INFO - Downloading/unpacking psutil>=3.1.1 19:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:12:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:16 INFO - Installing collected packages: psutil 19:12:16 INFO - Running setup.py install for psutil 19:12:16 INFO - building 'psutil._psutil_linux' extension 19:12:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:12:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:12:16 INFO - building 'psutil._psutil_posix' extension 19:12:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:12:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:12:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:16 INFO - Successfully installed psutil 19:12:16 INFO - Cleaning up... 19:12:16 INFO - Return code: 0 19:12:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:12:16 INFO - Using env: {'DISPLAY': ':0', 19:12:16 INFO - 'HOME': '/home/cltbld', 19:12:16 INFO - 'LANG': 'en_US.UTF-8', 19:12:16 INFO - 'LANGUAGE': 'en_US:en', 19:12:16 INFO - 'LOGNAME': 'cltbld', 19:12:16 INFO - 'MAIL': '/var/mail/cltbld', 19:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:16 INFO - 'MOZ_NO_REMOTE': '1', 19:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:16 INFO - 'NO_EM_RESTART': '1', 19:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:16 INFO - 'PWD': '/builds/slave/test', 19:12:16 INFO - 'SHELL': '/bin/bash', 19:12:16 INFO - 'SHLVL': '1', 19:12:16 INFO - 'TERM': 'linux', 19:12:16 INFO - 'TMOUT': '86400', 19:12:16 INFO - 'USER': 'cltbld', 19:12:16 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:16 INFO - '_': '/tools/buildbot/bin/python'} 19:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:12:18 INFO - Installing collected packages: mozsystemmonitor 19:12:18 INFO - Running setup.py install for mozsystemmonitor 19:12:19 INFO - Successfully installed mozsystemmonitor 19:12:19 INFO - Cleaning up... 19:12:19 INFO - Return code: 0 19:12:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:12:19 INFO - Using env: {'DISPLAY': ':0', 19:12:19 INFO - 'HOME': '/home/cltbld', 19:12:19 INFO - 'LANG': 'en_US.UTF-8', 19:12:19 INFO - 'LANGUAGE': 'en_US:en', 19:12:19 INFO - 'LOGNAME': 'cltbld', 19:12:19 INFO - 'MAIL': '/var/mail/cltbld', 19:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:19 INFO - 'MOZ_NO_REMOTE': '1', 19:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:19 INFO - 'NO_EM_RESTART': '1', 19:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:19 INFO - 'PWD': '/builds/slave/test', 19:12:19 INFO - 'SHELL': '/bin/bash', 19:12:19 INFO - 'SHLVL': '1', 19:12:19 INFO - 'TERM': 'linux', 19:12:19 INFO - 'TMOUT': '86400', 19:12:19 INFO - 'USER': 'cltbld', 19:12:19 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:19 INFO - '_': '/tools/buildbot/bin/python'} 19:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:19 INFO - Downloading/unpacking jsonschema==2.5.1 19:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:12:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:21 INFO - Downloading functools32-3.2.3-2.tar.gz 19:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:12:21 INFO - warning: no files found matching '*.txt' 19:12:21 INFO - no previously-included directories found matching 'build' 19:12:21 INFO - no previously-included directories found matching 'dist' 19:12:21 INFO - no previously-included directories found matching '.git*' 19:12:21 INFO - Installing collected packages: jsonschema, functools32 19:12:21 INFO - Running setup.py install for functools32 19:12:21 INFO - warning: no files found matching '*.txt' 19:12:21 INFO - no previously-included directories found matching 'build' 19:12:21 INFO - no previously-included directories found matching 'dist' 19:12:21 INFO - no previously-included directories found matching '.git*' 19:12:21 INFO - Successfully installed jsonschema functools32 19:12:21 INFO - Cleaning up... 19:12:21 INFO - Return code: 0 19:12:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:12:21 INFO - Using env: {'DISPLAY': ':0', 19:12:21 INFO - 'HOME': '/home/cltbld', 19:12:21 INFO - 'LANG': 'en_US.UTF-8', 19:12:21 INFO - 'LANGUAGE': 'en_US:en', 19:12:21 INFO - 'LOGNAME': 'cltbld', 19:12:21 INFO - 'MAIL': '/var/mail/cltbld', 19:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:21 INFO - 'MOZ_NO_REMOTE': '1', 19:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:21 INFO - 'NO_EM_RESTART': '1', 19:12:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:21 INFO - 'PWD': '/builds/slave/test', 19:12:21 INFO - 'SHELL': '/bin/bash', 19:12:21 INFO - 'SHLVL': '1', 19:12:21 INFO - 'TERM': 'linux', 19:12:21 INFO - 'TMOUT': '86400', 19:12:21 INFO - 'USER': 'cltbld', 19:12:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:21 INFO - '_': '/tools/buildbot/bin/python'} 19:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:12:21 INFO - Cleaning up... 19:12:21 INFO - Return code: 0 19:12:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:12:21 INFO - Using env: {'DISPLAY': ':0', 19:12:21 INFO - 'HOME': '/home/cltbld', 19:12:21 INFO - 'LANG': 'en_US.UTF-8', 19:12:21 INFO - 'LANGUAGE': 'en_US:en', 19:12:21 INFO - 'LOGNAME': 'cltbld', 19:12:21 INFO - 'MAIL': '/var/mail/cltbld', 19:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:21 INFO - 'MOZ_NO_REMOTE': '1', 19:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:21 INFO - 'NO_EM_RESTART': '1', 19:12:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:21 INFO - 'PWD': '/builds/slave/test', 19:12:21 INFO - 'SHELL': '/bin/bash', 19:12:21 INFO - 'SHLVL': '1', 19:12:21 INFO - 'TERM': 'linux', 19:12:21 INFO - 'TMOUT': '86400', 19:12:21 INFO - 'USER': 'cltbld', 19:12:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:21 INFO - '_': '/tools/buildbot/bin/python'} 19:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:22 INFO - Downloading/unpacking blobuploader==1.2.4 19:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:23 INFO - Downloading blobuploader-1.2.4.tar.gz 19:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:12:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:12:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:24 INFO - Downloading docopt-0.6.1.tar.gz 19:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:12:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:12:24 INFO - Running setup.py install for blobuploader 19:12:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:12:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:12:24 INFO - Running setup.py install for requests 19:12:25 INFO - Running setup.py install for docopt 19:12:25 INFO - Successfully installed blobuploader requests docopt 19:12:25 INFO - Cleaning up... 19:12:25 INFO - Return code: 0 19:12:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:12:25 INFO - Using env: {'DISPLAY': ':0', 19:12:25 INFO - 'HOME': '/home/cltbld', 19:12:25 INFO - 'LANG': 'en_US.UTF-8', 19:12:25 INFO - 'LANGUAGE': 'en_US:en', 19:12:25 INFO - 'LOGNAME': 'cltbld', 19:12:25 INFO - 'MAIL': '/var/mail/cltbld', 19:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:25 INFO - 'MOZ_NO_REMOTE': '1', 19:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:25 INFO - 'NO_EM_RESTART': '1', 19:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:25 INFO - 'PWD': '/builds/slave/test', 19:12:25 INFO - 'SHELL': '/bin/bash', 19:12:25 INFO - 'SHLVL': '1', 19:12:25 INFO - 'TERM': 'linux', 19:12:25 INFO - 'TMOUT': '86400', 19:12:25 INFO - 'USER': 'cltbld', 19:12:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:25 INFO - '_': '/tools/buildbot/bin/python'} 19:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:25 INFO - Running setup.py (path:/tmp/pip-qgdgFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:25 INFO - Running setup.py (path:/tmp/pip-ty42R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:25 INFO - Running setup.py (path:/tmp/pip-DNKKQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:25 INFO - Running setup.py (path:/tmp/pip-wohQIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:25 INFO - Running setup.py (path:/tmp/pip-ZuVAZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:25 INFO - Running setup.py (path:/tmp/pip-1SZlnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:26 INFO - Running setup.py (path:/tmp/pip-qsXCtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:26 INFO - Running setup.py (path:/tmp/pip-if_FWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:26 INFO - Running setup.py (path:/tmp/pip-huNSoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:26 INFO - Running setup.py (path:/tmp/pip-rxtK6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:26 INFO - Running setup.py (path:/tmp/pip-mID1Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:26 INFO - Running setup.py (path:/tmp/pip-k8B6iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:26 INFO - Running setup.py (path:/tmp/pip-VFySXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:26 INFO - Running setup.py (path:/tmp/pip-0P5xco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:26 INFO - Running setup.py (path:/tmp/pip-Rtfn_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:26 INFO - Running setup.py (path:/tmp/pip-HLwJF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:26 INFO - Running setup.py (path:/tmp/pip-I715tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:12:26 INFO - Running setup.py install for manifestparser 19:12:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:12:26 INFO - Running setup.py install for mozcrash 19:12:26 INFO - Running setup.py install for mozdebug 19:12:27 INFO - Running setup.py install for mozdevice 19:12:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Running setup.py install for mozfile 19:12:27 INFO - Running setup.py install for mozhttpd 19:12:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Running setup.py install for mozinfo 19:12:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Running setup.py install for mozInstall 19:12:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Running setup.py install for mozleak 19:12:27 INFO - Running setup.py install for mozlog 19:12:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Running setup.py install for moznetwork 19:12:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:12:27 INFO - Running setup.py install for mozprocess 19:12:28 INFO - Running setup.py install for mozprofile 19:12:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:12:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:12:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:12:28 INFO - Running setup.py install for mozrunner 19:12:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:12:28 INFO - Running setup.py install for mozscreenshot 19:12:28 INFO - Running setup.py install for moztest 19:12:28 INFO - Running setup.py install for mozversion 19:12:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:12:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:12:28 INFO - Cleaning up... 19:12:28 INFO - Return code: 0 19:12:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:12:28 INFO - Using env: {'DISPLAY': ':0', 19:12:28 INFO - 'HOME': '/home/cltbld', 19:12:28 INFO - 'LANG': 'en_US.UTF-8', 19:12:28 INFO - 'LANGUAGE': 'en_US:en', 19:12:28 INFO - 'LOGNAME': 'cltbld', 19:12:28 INFO - 'MAIL': '/var/mail/cltbld', 19:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:28 INFO - 'MOZ_NO_REMOTE': '1', 19:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:28 INFO - 'NO_EM_RESTART': '1', 19:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:28 INFO - 'PWD': '/builds/slave/test', 19:12:28 INFO - 'SHELL': '/bin/bash', 19:12:28 INFO - 'SHLVL': '1', 19:12:28 INFO - 'TERM': 'linux', 19:12:28 INFO - 'TMOUT': '86400', 19:12:28 INFO - 'USER': 'cltbld', 19:12:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:28 INFO - '_': '/tools/buildbot/bin/python'} 19:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:28 INFO - Running setup.py (path:/tmp/pip-KgBrbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:28 INFO - Running setup.py (path:/tmp/pip-cpkG5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:28 INFO - Running setup.py (path:/tmp/pip-NkHUaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:29 INFO - Running setup.py (path:/tmp/pip-g0MDJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:29 INFO - Running setup.py (path:/tmp/pip-VbqOVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:29 INFO - Running setup.py (path:/tmp/pip-M4AdQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:29 INFO - Running setup.py (path:/tmp/pip-vpzx2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:29 INFO - Running setup.py (path:/tmp/pip-Am4EZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:29 INFO - Running setup.py (path:/tmp/pip-DGlLwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:29 INFO - Running setup.py (path:/tmp/pip-t1aT3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:29 INFO - Running setup.py (path:/tmp/pip-dNbcPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:29 INFO - Running setup.py (path:/tmp/pip-r87LFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:29 INFO - Running setup.py (path:/tmp/pip-mWo8Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:29 INFO - Running setup.py (path:/tmp/pip-kPrXFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:29 INFO - Running setup.py (path:/tmp/pip-Hh0LsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:29 INFO - Running setup.py (path:/tmp/pip-uxsXVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:30 INFO - Running setup.py (path:/tmp/pip-KqXrtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:12:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:32 INFO - Downloading blessings-1.6.tar.gz 19:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:12:32 INFO - Installing collected packages: blessings 19:12:32 INFO - Running setup.py install for blessings 19:12:32 INFO - Successfully installed blessings 19:12:32 INFO - Cleaning up... 19:12:32 INFO - Return code: 0 19:12:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:12:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:32 INFO - Reading from file tmpfile_stdout 19:12:32 INFO - Current package versions: 19:12:32 INFO - argparse == 1.2.1 19:12:32 INFO - blessings == 1.6 19:12:32 INFO - blobuploader == 1.2.4 19:12:32 INFO - docopt == 0.6.1 19:12:32 INFO - functools32 == 3.2.3-2 19:12:32 INFO - jsonschema == 2.5.1 19:12:32 INFO - manifestparser == 1.1 19:12:32 INFO - mozInstall == 1.12 19:12:32 INFO - mozcrash == 0.17 19:12:32 INFO - mozdebug == 0.1 19:12:32 INFO - mozdevice == 0.48 19:12:32 INFO - mozfile == 1.2 19:12:32 INFO - mozhttpd == 0.7 19:12:32 INFO - mozinfo == 0.9 19:12:32 INFO - mozleak == 0.1 19:12:32 INFO - mozlog == 3.3 19:12:32 INFO - moznetwork == 0.27 19:12:32 INFO - mozprocess == 0.23 19:12:32 INFO - mozprofile == 0.28 19:12:32 INFO - mozrunner == 6.12 19:12:32 INFO - mozscreenshot == 0.1 19:12:32 INFO - mozsystemmonitor == 0.3 19:12:32 INFO - moztest == 0.7 19:12:32 INFO - mozversion == 1.4 19:12:32 INFO - psutil == 3.1.1 19:12:32 INFO - requests == 1.2.3 19:12:32 INFO - wsgiref == 0.1.2 19:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:12:32 INFO - Using env: {'DISPLAY': ':0', 19:12:32 INFO - 'HOME': '/home/cltbld', 19:12:32 INFO - 'LANG': 'en_US.UTF-8', 19:12:32 INFO - 'LANGUAGE': 'en_US:en', 19:12:32 INFO - 'LOGNAME': 'cltbld', 19:12:32 INFO - 'MAIL': '/var/mail/cltbld', 19:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:32 INFO - 'MOZ_NO_REMOTE': '1', 19:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:32 INFO - 'NO_EM_RESTART': '1', 19:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:32 INFO - 'PWD': '/builds/slave/test', 19:12:32 INFO - 'SHELL': '/bin/bash', 19:12:32 INFO - 'SHLVL': '1', 19:12:32 INFO - 'TERM': 'linux', 19:12:32 INFO - 'TMOUT': '86400', 19:12:32 INFO - 'USER': 'cltbld', 19:12:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:32 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:12:33 INFO - Cleaning up... 19:12:33 INFO - Return code: 0 19:12:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:12:33 INFO - Using env: {'DISPLAY': ':0', 19:12:33 INFO - 'HOME': '/home/cltbld', 19:12:33 INFO - 'LANG': 'en_US.UTF-8', 19:12:33 INFO - 'LANGUAGE': 'en_US:en', 19:12:33 INFO - 'LOGNAME': 'cltbld', 19:12:33 INFO - 'MAIL': '/var/mail/cltbld', 19:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:33 INFO - 'MOZ_NO_REMOTE': '1', 19:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:33 INFO - 'NO_EM_RESTART': '1', 19:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:33 INFO - 'PWD': '/builds/slave/test', 19:12:33 INFO - 'SHELL': '/bin/bash', 19:12:33 INFO - 'SHLVL': '1', 19:12:33 INFO - 'TERM': 'linux', 19:12:33 INFO - 'TMOUT': '86400', 19:12:33 INFO - 'USER': 'cltbld', 19:12:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:33 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:12:33 INFO - Cleaning up... 19:12:33 INFO - Return code: 0 19:12:33 INFO - Running post-action listener: _resource_record_post_action 19:12:33 INFO - Running post-action listener: _start_resource_monitoring 19:12:33 INFO - Starting resource monitoring. 19:12:33 INFO - [mozharness: 2016-08-06 02:12:33.412012Z] Finished create-virtualenv step (success) 19:12:33 INFO - [mozharness: 2016-08-06 02:12:33.412548Z] Running install step. 19:12:33 INFO - Running pre-action listener: _resource_record_pre_action 19:12:33 INFO - Running main action method: install 19:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:33 INFO - Reading from file tmpfile_stdout 19:12:33 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:33 INFO - Reading from file tmpfile_stdout 19:12:33 INFO - Output received: 19:12:33 INFO - Usage: mozinstall [options] installer 19:12:33 INFO - Options: 19:12:33 INFO - -h, --help show this help message and exit 19:12:33 INFO - -d DEST, --destination=DEST 19:12:33 INFO - Directory to install application into. [default: 19:12:33 INFO - "/builds/slave/test"] 19:12:33 INFO - --app=APP Application being installed. [default: firefox] 19:12:33 INFO - mkdir: /builds/slave/test/build/application 19:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:12:50 INFO - Reading from file tmpfile_stdout 19:12:50 INFO - Output received: 19:12:50 INFO - /builds/slave/test/build/application/firefox/firefox 19:12:50 INFO - Running post-action listener: _resource_record_post_action 19:12:50 INFO - [mozharness: 2016-08-06 02:12:50.774280Z] Finished install step (success) 19:12:50 INFO - [mozharness: 2016-08-06 02:12:50.774621Z] Running run-tests step. 19:12:50 INFO - Running pre-action listener: _resource_record_pre_action 19:12:50 INFO - Running main action method: run_tests 19:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:50 INFO - Python 2.7.3 19:12:50 INFO - Return code: 0 19:12:50 INFO - grabbing minidump binary from tooltool 19:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:12:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:12:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:12:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:50 INFO - Return code: 0 19:12:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:12:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:12:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:12:50 INFO - Using env: {'DISPLAY': ':0', 19:12:50 INFO - 'HOME': '/home/cltbld', 19:12:50 INFO - 'LANG': 'en_US.UTF-8', 19:12:50 INFO - 'LANGUAGE': 'en_US:en', 19:12:50 INFO - 'LOGNAME': 'cltbld', 19:12:50 INFO - 'MAIL': '/var/mail/cltbld', 19:12:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:50 INFO - 'MOZ_NO_REMOTE': '1', 19:12:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:50 INFO - 'NO_EM_RESTART': '1', 19:12:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:50 INFO - 'PWD': '/builds/slave/test', 19:12:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:50 INFO - 'SHELL': '/bin/bash', 19:12:50 INFO - 'SHLVL': '1', 19:12:50 INFO - 'TERM': 'linux', 19:12:50 INFO - 'TMOUT': '86400', 19:12:50 INFO - 'USER': 'cltbld', 19:12:50 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830', 19:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:50 INFO - '_': '/tools/buildbot/bin/python'} 19:12:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:12:51 INFO - mozversion application_buildid: 20160805163004 19:12:51 INFO - mozversion application_changeset: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 19:12:51 INFO - mozversion application_display_name: Nightly 19:12:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:51 INFO - mozversion application_name: Firefox 19:12:51 INFO - mozversion application_remotingname: firefox 19:12:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:12:51 INFO - mozversion application_vendor: Mozilla 19:12:51 INFO - mozversion application_version: 51.0a1 19:12:51 INFO - mozversion platform_buildid: 20160805163004 19:12:51 INFO - mozversion platform_changeset: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 19:12:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:12:51 INFO - mozversion platform_version: 51.0a1 19:12:51 INFO - using testdate: 1470449571 19:12:51 INFO - actual date: 1470449571 19:12:51 INFO - starting webserver on 'localhost:38038' 19:12:51 INFO - SUITE-START | Running 2 tests 19:12:51 INFO - TEST-START | dromaeo_css 19:12:51 INFO - operating with platform_type : linux_ 19:12:51 INFO - Initialising browser for dromaeo_css test... 19:12:51 INFO - TEST-INFO | started process 30446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe5vNov/profile http://localhost:38038/getInfo.html) 19:12:55 INFO - PROCESS | 30446 | __metrics Screen width/height:1600/1200 19:12:55 INFO - PROCESS | 30446 | colorDepth:24 19:12:55 INFO - PROCESS | 30446 | Browser inner width/height: 1024/697 19:12:55 INFO - PROCESS | 30446 | __metrics 19:12:56 ERROR - PROCESS | 30446 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:12:57 INFO - TEST-INFO | 30446: exit 0 19:12:57 INFO - Browser initialized. 19:12:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:57 INFO - TEST-INFO | started process 30566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe5vNov/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:08 INFO - PROCESS | 30566 | RSS: Main: 163950592 19:13:08 INFO - PROCESS | 30566 | 19:13:58 INFO - PROCESS | 30566 | 1470449638564 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:16:08 INFO - PROCESS | 30566 | Cycle 1(1): loaded http://localhost:38038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38038/tests/dromaeo/cssquery-ext.html) 19:16:09 INFO - PROCESS | 30566 | RSS: Main: 166989824 19:16:09 INFO - PROCESS | 30566 | 19:19:11 INFO - PROCESS | 30566 | Cycle 1(1): loaded http://localhost:38038/tests/dromaeo/cssquery-ext.html (next: http://localhost:38038/tests/dromaeo/cssquery-jquery.html) 19:19:12 INFO - PROCESS | 30566 | RSS: Main: 165384192 19:19:12 INFO - PROCESS | 30566 | 19:22:13 INFO - PROCESS | 30566 | Cycle 1(1): loaded http://localhost:38038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38038/tests/dromaeo/cssquery-mootools.html) 19:22:14 INFO - PROCESS | 30566 | RSS: Main: 169930752 19:22:14 INFO - PROCESS | 30566 | 19:25:16 INFO - PROCESS | 30566 | Cycle 1(1): loaded http://localhost:38038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38038/tests/dromaeo/cssquery-prototype.html) 19:25:16 INFO - PROCESS | 30566 | RSS: Main: 165027840 19:25:16 INFO - PROCESS | 30566 | 19:28:19 INFO - PROCESS | 30566 | Cycle 1(1): loaded http://localhost:38038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38038/tests/dromaeo/cssquery-yui.html) 19:28:20 INFO - PROCESS | 30566 | RSS: Main: 166846464 19:28:20 INFO - PROCESS | 30566 | 19:31:22 INFO - PROCESS | 30566 | Cycle 1(1): loaded http://localhost:38038/tests/dromaeo/cssquery-yui.html (next: http://localhost:38038/tests/dromaeo/cssquery-dojo.html) 19:31:23 INFO - PROCESS | 30566 | RSS: Main: 170070016 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | __start_tp_report 19:31:23 INFO - PROCESS | 30566 | _x_x_mozilla_page_load 19:31:23 INFO - PROCESS | 30566 | _x_x_mozilla_page_load_details 19:31:23 INFO - PROCESS | 30566 | |i|pagename|runs| 19:31:23 INFO - PROCESS | 30566 | |0;dojo.html;3056.5873607063045;3072.308730535631;3095.3963977024473;3095.6749541298163;3099.504079347305;5175.223716442535;5223.425423203449;5249.977551407273;5272.683638981659;5295.31160949077;5265.078611243036;5307.779210781522;5316.388615309241;5330.520253177213;5351.197320401941;4625.329967822118;4754.548317909793;4833.854984350475;4882.438519570242;4900.632452566054;4873.439554451248;4893.4617192108835;4893.657443978923;4898.975505122487;4927.926081108786;4758.595519380857;4760.95239047612;4843.4914333994775;4881.804727810883;4892.584130348924;4728.432588089417;4751.477337492873;4754;4805.975970120162;4907.2393778964315;4743.786529606176;4767.523247675239;4769.141554520185;4772.7136371817805;4811.951880481185;5185.714785686786;5230.398504172031;5241.895162096736;5254.369475662907;5284.815031473919;5663.575231857627;5676.148577713335;5678.148277758328;5686.516646085088;5718.885622287573;5663.801766938137;5673.886522269531;5699.287589051369;5731.570132240057;5748.540116790647;5207.791688332462;5224.4775522447835;5251.973740131351;5260.842174734764;5319.175527793198;5753.827385178452;5767.913481297784;5776.711164441761;5782.653040817564;5796.304443466811;5535.474129957647;5554.72226388679;5555.638883472561;5556;5570.359408668055;5478.287822583039;5562.3881373048935;5623.859403514863;5624.3250809903075;5630.5214056805635;5381.327334083239;5555.638883472561;5574.86062848432;5642.322921249394;5648.71756412186;5631.465010823965;5634.60557760961;5635.351934527582;5637.210790489335;5647.717614119278;4187;4342.6742994275555;4387.210302145644;4398.978005109954;4455.2648812946145;3883.30100581898;3883.475730776309;3933.1740334529495;3939.074317535377;3950.1309711863346;5380.677159370451;5386;5395.892082158335;5410.48600382963;5426.158945363475;5474;5619.887602247933;5666.829995100154;5667.943320566824;5675.659460432387;5407.432219616962;5452.154915988028;5459.69971651563;5478.233047373371;5482.095454250084;4916.631252656065;4924.8276310328965;4950.2822090796635;4959.578435832995;4968.6025117990475;5785.913211301834;5897.7935772247765;5967.522598192134;5991.310999235144;6003.459688627957;5666;5688.971555142363;5719.5710321726865;5759.94240057594;5761.798337058351;5897.911531326948;5946.73239704223;5970.910436343372;5977.491913187428;5987.670678112746;5408.729563521887;5479.2602998594675;5602.047651899105;5616.85957851057;5627.268455100811;5621.775128994958;5642.971785141048;5677.914831277617;5712.542996560348;5724.885502290014;5524.33707955048;5529.391766905717;5532.612717109763;5542.445755424425;5544.085225937675;5311.044012077863;5423.701696406735;5520.420355862737;5539;5585.413531579125;5390.353157621111;5407.567394608343;5420.430854760193;5424.647397919122;5476.2607048048;5451.945480545144;5457.754401051883;5480.420314887805;5492.890142197213;5531.391546929915;5326.2809520715755;5383.650062745909;5390;5407;5410.053240682943 19:31:23 INFO - PROCESS | 30566 | |1;ext.html;546.6903073286052;579.0821547846663;589.2604780999848;596.501920896052;616.1220261127892;39684.80157599212;43604.56395436045;43621.7818910905;43749.34375984363;43851.34222986654;43272.35091473631;43916.56083439165;43984;44141.558584414146;44147.558524414744;8903.42127761695;9011.95494022529;9089.909100908972;9110.726678199631;9123.042080581543;8858.955705221497;9024.639014439415;9025.104728007094;9026.909730902673;9033.09669033098;8781.253593444564;8814.515201663906;8822.558872056403;8856.955715221415;8858.689945851896;8999.685011024616;9043.276537876955;9067.727968160965;9090.7272781816;9108.407953483002;8973.865392019125;8990.235829954461;9055.592498337524;9078.68224612142;9086.136817002374;41938.58061419377;42661.57338426607;42677.35983960243;42695.14609707819;42866.57133428657;3760.905977350561;3765.2093060457337;3864.3044252034624;3874.380099184117;4255.127698821734;32891.50662740061;33563;33657.831710841536;34234;34315.31369372624;4375.540568240321;4390.8902277443;4423.358613001129;4433;4488.349189367524;376667;378993;379654;380663;382020.9999999972;58235.70882145562;58710.11934820981;58823.41176588265;58904;58940.41059589435;36826.8158659205;37853.432198517046;38030.809845951146;61926;62090.37909620936;16951;17361.47915562535;17363.04503252308;17387.391441299747;17389.65220695579;13451.730965380637;13545;13639.590812275648;13644.727105458034;13736.587902362946;18642.254309827727;18689.626207476045;18799.342023029403;18900;18926.43220703381;7379.3358597726465;7508.624568771649;7518.706794427752;7628.580428076398;7652.273034061866;957.9712608621752;1014.4775440648073;1014.7310962594918;1132.1678566253797;1143.5597295041302;32779.836100819346;33415.164620884185;33666.15834604154;34177.658223417944;34491.827540862134;1089.6839916424308;1116.8045592021365;1206.3003457994341;1213.7936550786387;1230.274138258414;17022.744658830128;17031.574210644587;17102.657946841242;17249.655006899793;17450.214740336716;553761;559761;559905;559958;564058;61013.69493152595;61381;61415.38584614186;61524.69237653783;61687;1337.6588969812635;1348.4740951029107;1350.3045931345364;1383.5849245226593;1392.373431955624;31489.685103149593;32689.836550817094;33820.154496137795;33856.322873542886;33858.37338648392;50921;51847;51958.740206298724;51961.7401912988;52222.21666675079;420889;421696;422283;422753;423732;28834.855825720737;29299.121026369245;29760.553591696575;29885.103446896628;31264.062078137693;49563;49811.75094124506;50066.249006265665;50113.498865010886;50354.496455036446;41539.58460415478;42077.78961105175;43581;44094;44413.55586444094;42013;42149.367759484245;42922.57077429186;44280.33579496374;44293.33559996667;40211.79894100511;42050.36924446197;42421.78789106035;42487;43304.350434742875;35270.47094293639;37593.62406375901;37750;37885.43171852479;38580.80709596434;29251;29404.264893377836;29575.704242958156;29593.408131837674;29749.256268593457 19:31:23 INFO - PROCESS | 30566 | |2;jquery.html;377.44515562123684;384.3274270027452;387.4188716924613;401.9839206431743;402.68791686443;17887.284508619658;19954.60090798187;20032.69950950735;20071.899640501797;20133.59732805343;19004.714929276073;19166.61666766664;19658;19895;19972.60054798903;5644.576656750729;5752.137179423078;5795.884082318372;5805.071188609823;5884.323302820167;5618.410066942974;5789.797357092502;5794.855128621797;5797.652140871562;5814.854628634275;5583.078791999315;5702.372738998707;5715;5731.656100633954;5736.254286942692;5716.28546431696;5734.7419366128415;5741.913871291934;5744.080947048494;5765.827025189251;5116.846494605168;5134.460881607452;5171.5862730981435;5174.767135478913;5176.896462070775;23230.3030909073;23572.410689732722;23695.28914132579;23850.16524421637;23953.281401557982;2441.645961335614;2881.1932658855553;3025.9862945913146;3086.36729470458;3167.224030112614;14753.631159220999;14948.925255373653;14981.176035318162;15010;15349.46276880315;1964.6365422396902;2010.517475805796;2051.907664155102;2078.324544523036;2084.739407574053;77592.61203693945;79517.20482795214;81104.59447702723;81690;82347;9714.271429642806;10636.149108071335;10749.570017199225;11019.173561982723;11389.259698119597;14313.6421589459;14353;14372.784408233885;14405.991580589467;14457.78313325301;7938.920610793818;8188.754337369888;8258.380621453414;8445.746627601182;8448.746537603882;8267.379946503916;8328.541930193898;8353.582320883932;8510;8586.828263434696;6334.410513805285;6384.233891932998;6439.710213040331;6467.935320646733;6482.967585162044;1834.2937968882077;1889.8866068035961;1890.2722451856134;1895.1906667597952;1942.4755316064584;953.6328513522344;1060.9045185933148;1074.2533938912381;1125.234840308598;1127.3236058364917;19827.900860495603;20270.290539831036;20468.283610073577;20667.17331306731;21121.155153793676;902.5126431726925;1040.432964034603;1056.5984925728173;1068.3589846092282;1137.6132115080911;8966.489879427125;10851.348919064882;10952;11001.394923279297;11016.504257308441;466471;475913;493933;498565;499216;87713.56143219244;87825.56087219523;88351.55824220838;94895;100975.49512252392;961.1205746741653;1019.5259204469957;1085.6200329884477;1086.5436516662862;1090.0843291635065;17600.29598816033;18051.548711282325;18272.72590911164;18355.174017169527;18552.44342669722;41582.37626435545;41629.19836103134;41718;41932.790336049344;42685.57314426816;59134.704326478095;59803;60654.696726516086;61572.69213653903;61897.07154392597;8537.445066070686;8666.480011199348;8688.78278043054;8788.252998494943;8926.553672316228;10932.453377331261;12741.49034038628;13011.284379358847;13089.541866034642;13179.67050823737;11000.614978475714;11951.76096478083;12186.51253949832;12201.389930503618;12413.503459861504;11661.300321980709;11886.405679716152;11959.222650527689;11976.940115299367;12183.512659493876;11539.596114135966;11725.355105469282;11949.22330048544;12222.816657749963;12646.620601381974;7228.132624085143;7564.886526702214;7571.734989275569;8122.715704950535;8514.74455766328;10820.621278255223;11618.128640351839;11753.294802311546;11856.11079169083;12137.817932731192 19:31:23 INFO - PROCESS | 30566 | |3;mootools.html;1465.5163795947337;1471.529110684581;1607.5257798949317;1755.5347832824295;1765.4880084775416;7494.587797671126;8093.514389136656;8170.4280700350855;8671.132886711333;8674.392792504526;8474.067852536216;8515.829683406344;8524.573771311441;8533.701320453785;8535.658573657047;2298.069281940817;2337.2988103568946;2340.2979106268135;2351.130081869702;2357.7760112789256;2256.244158207003;2266.8526545774553;2330.196082351586;2330.685357476736;2332.6034574122355;2296.207808306132;2302.5625131225097;2302.9424264393356;2329.3943574670625;2332.3119679694532;2255.785700358463;2262.7284725833006;2266.546690661866;2267.1724820440504;2268.65970104484;2240.9775902241095;2241.2043724477903;2247.9996401601293;2252.110416385535;2255.1994042114975;8551.529665868375;8564.571771411405;8567.44311619749;8611.483311001297;8614.913850861474;4859.73271470069;4977.552020318152;5049.899002019939;5056;5090.465501122366;3077.1691643256418;3083.275430273884;3149.9055028349185;3157.9684203157904;3189.409959157563;1048.8269435543127;1056.0442799266675;1058.2433560004633;1074.962376316833;1079.1420820447763;11306.717332066683;11382.089432845352;11387.430628468543;11430.571178602675;11457.083433325397;4230.344296634026;4321.243782338078;4380.4305440292555;4424.380586717862;4426.557344265612;9730.075642813921;9749.073837985521;9763.755906102262;9771;9873.062059104517;5011.223260394645;5049.899002019939;5073.898522029613;5118.692878427232;5132.127538318495;4023.3160362738404;4464.308032255006;4598.218302888517;4599.908001840012;4645.396098507173;3727.7390582658954;3774.3958817502453;3863;3893.785841778673;3936.0946982194255;1131.5473810475876;1172.5075468303332;1179.4633441783967;1180.7107258721496;1184.6742145909943;892.2148509311764;893.4371346052076;907.464595888429;929.5120061967522;933.1368484152132;5771.88456230873;5800.390958949334;5973.910391344133;6116.021436570217;6390.201224846895;935.083618054297;953.828310904044;995.7361299255703;1012.8885822559513;1034.1209971524295;3908.726389152732;4012.137390461065;4089.20260549196;4093.3041382964966;4210.894727631834;10049.145822605014;10535.157187424988;10546.736331591617;10573.89426105729;10594.523246453928;10370.066693997576;10459.110975567162;10465.529051192714;10482.73793155162;10507.422091784872;7722.150563438017;7941.9278397416765;8041.396895232998;8052.59737013147;8056.113827478973;5785.913211301918;5791.710414479344;5861.7655293787775;5913.881722365614;5957.314908785372;9677;9710.22318214527;9746.220302375652;9884.802303953737;9886.653967111117;9556.187724043257;9631.229501639993;9667.661631842851;9754.804903902024;9791.314607977372;6501.804945851632;6750.088738020305;6851.177858656993;6934.7226110955;7044.436445084483;8226.177382261725;8351.1648835116;8378.287845533197;8382.538960356995;8391.035030971272;7466.626668666437;7552.697892084255;7582;7592.392608591189;7797.220277972384;7127.429805615435;7187.928120718935;7198.5320954137815;7339.889901651372;7349.853002940018;6738.460923126237;6869.210040845167;6889.827754306182;6970.581765094111;6980.825479363057;4995.675281106716;5168.870778230575;5196.114140874861;5309.150535914389;5362;5066.265391518135;5099.974500127476;5133.435322114489;5238.397584277857;5434.64674796137 19:31:23 INFO - PROCESS | 30566 | |4;prototype.html;310.88652641785757;311.9001919385796;321.48740177465027;322.4099897188146;326.64069523524114;5347.839564813062;5392.2181283713835;5513.932275396726;5562.610617256793;5583.3020872391;5415.729213539327;5470.617056806025;5477.233187353773;5482.862928426792;5519.889602207963;4318.784060796963;4319.978400108011;4332.35014747788;4334.916270932267;4342.761148136851;4174.123434078847;4256.808093733759;4345.804903651489;4348.804078878318;4358.3462480628;4284.614384705376;4287.614114729674;4300.677449191323;4301.26878430666;4302.591253830881;4281.593248641389;4308.9353659695125;4312.676549258818;4337.9132417351475;4338.262495375762;3448;3832.827522761482;3836.8105887175066;3855.691544676419;3858.2283543291173;5271.525562699337;5287.101192797234;5299.576033917316;5305.814296499642;5322.733863306819;4746.1931471649905;4752.572268495852;4795.976020119912;4805.519448055166;4815.446223684286;5516.586256030773;5662.924044431545;5676.205331253628;5696.1455781633085;5697.544196464273;4003.779792111433;4009.6190861868076;4018.618231268025;4028.436018957319;4028.4964379452567;5966;6006.699665016776;6007.669578173199;6027;6034.8189554313;4026.315526360526;4108.609682080198;4156.480439945007;4159.667226621863;4168.895777605523;4109.383592461095;4128.504579450425;4150.377443383517;4166.708330416903;4167.229062623424;4784.497627749036;4788.545088216614;4796.088743138793;4817.108834865491;4849.369581954324;5567.610267281332;5776.971115144482;5791.82624521265;5802.88394232113;5816.272965879265;1410.7531182043306;1436.5977526292654;1438.0437009388847;1439.1868594244218;1440.3878351700484;885.3536918049731;916.1388295002677;917.5091326140483;923.5982347678781;933.7618907178762;4855.417349918032;4892.437369702458;4910.8281210157475;4927.43334516528;5011.724355160502;5125.333706618116;5131.461196574381;5134;5208.5051920067535;5222.660527065728;4688.859334219979;4918.606511479073;4925.581325587365;4991.126552853236;4991.276264941564;2734.786625714777;2741.7258274172823;2744.245332533569;2748.6531599516493;2753.3116720819794;5456.699881506555;5462.535684466785;5469.964169885751;5471.480209380103;5477.7261136943;5318.734063296897;5349.5720342372515;5514.6858481826985;6022.457978781843;6144.17053697754;6139.293981192131;6196.907046394308;6214.632780788219;6224.719887605069;6232.345603711636;5611.494965453129;5906.291245050621;5959.046552551571;5963.970180149072;6008.429199226067;5815.82552523425;5853.678047707247;5855.151003104441;5876.382979787232;5880.735366908585;6189.876202475835;6212.751489940351;6234.937650623436;6272.341404152498;6277.905831412441;3779.7921114338974;4071.9796401017807;4088.4480595120467;4119.702293777451;4203.285441474895;5849.356570777126;5892.7642894283745;5915.497182739516;5923.318818335946;5985.25184351956;5631.6902570359025;5767.163761254511;5785;5812.360640329476;5854.9121763174435;5640.464155905182;5674.801381951612;5677.318721753416;5697.230873832145;5700.862176683743;5645.899049685272;5650.85872853182;5704.229928959538;5714.114312281603;5717;5514.814314922311;5687.658740475585;5697.971510142423;5722.914156287742;5775.335836378702;5562;5601.439856014366;5601.915971260353;5609.915851262316;5610.7755689773585 19:31:23 INFO - PROCESS | 30566 | |5;yui.html;733.1934871641196;769.6767357709762;816.3591580609219;825.9091499935006;865.3726048614759;15510;16695.83304166958;17047.31810727571;17072.829271707295;17355.566110847234;15333.156676382794;15674.686506269867;15674.921625391886;15700.21498925055;15769.684606307866;811.9715809946653;816.3306089007002;828.4863384701464;835.4235577451539;835.5237514616671;825.8100636853527;827.2058823529419;829.6764261937819;830.9709160179395;833.3083540661237;849.362977766675;850.5407080176698;850.5407080176728;853.9188777066169;861.0872475176333;842.7387509871959;847.6609356257516;848.1899785704668;851.4933614499363;852.1180578101697;625.2653132569213;625.4902254662481;627.109504503606;627.1627377451108;628.0202883501752;15352.616184595363;15387.923060384739;15396.384144634201;15399.461018864286;15424.5372638821;15432.459863904822;15559.37762489499;15589.922050389789;15631.843681563152;15660.68678626421;12540.937295313464;12925.35373231344;12998.675033124153;13313.26777027263;13493.19040857542;3885.2423777363424;3935.8425662973445;3960.881173564798;3968.1666849961543;4122.299209134424;84375.57812210961;84600.15399846046;86228.56885715594;87158.12841871564;87305;11953.52185912571;11988.64034078979;12135.87864121365;12239.75520489603;12267.754644907052;21982.01080951361;22034.669479957814;22066.66899996501;22136.557268854856;22190.778092219192;8501.95749021251;8541.53021583819;8564.828703426021;8597.323521913167;8639.179277968582;4661.603763680057;4667.32323813052;4708.293755936568;4759.262314341283;4857.149998750205;3453.8618455262013;3567.340042092221;3593.6047034826147;3602.603713591503;3609.639036096369;625.8060001399581;649.2468736265909;656.4092316914815;661.9635920024444;669.3072669786748;683.2313647146959;715.7852644206718;744.4119145874806;747.6560782040323;753.9623018849036;9350.719478415658;9367.578458969363;9556.808863822685;9785.510724463747;9930.702078937644;729.7190581626006;753.3935182178399;759.9126100498403;768.4275214964775;798.8282519258387;4266.978665106717;4570.468892920842;4634.2585186370015;4671.205894997858;4763.976180119077;72300;94677.52661236787;97295;99752.50123749334;116546;90731.54634226787;94213;94644.52677736567;96973.51513242388;99332.50333748285;84655.57672211599;85751.57124214464;86579;87661;87760.56119719488;9706.5146742664;9711.125998660154;9723.756906077404;9774.218062555121;9797.657082002095;45324;46456.7677161612;46833.765831170625;48801;49004.50995489999;49424;49813;55990.16014759863;64384.35615643971;64585;12585.24488530691;12931.612051638465;13040.478380864659;13884;13975.720485590027;14379;14525.273736313353;15093.528488447499;15102.924485377504;15114.622134446727;13296.069275151034;13389.263590502616;13893.166410015432;13896.096753710977;14242.572722817917;13155.276459794803;13941.930290348484;14421.855781442471;15317.38730450814;15320.157391343582;13625.727485450434;13742.175469471864;13743.862561374659;14414;14435.133891966516;10761.246712730033;10872.347659140476;11205.71985700364;11290.943545282222;11382.089432845518;10594.629187978384;12225.327606981346;12350.764923507577;12449.190802597803;12454.25274483534 19:31:23 INFO - PROCESS | 30566 | __end_tp_report 19:31:23 INFO - PROCESS | 30566 | __start_cc_report 19:31:23 INFO - PROCESS | 30566 | _x_x_mozilla_cycle_collect,346 19:31:23 INFO - PROCESS | 30566 | __end_cc_report 19:31:23 INFO - PROCESS | 30566 | __startTimestamp1470450683234__endTimestamp 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | ------- Summary: start ------- 19:31:23 INFO - PROCESS | 30566 | Number of tests: 6 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | [#0] dojo.html Cycles:165 Average:5258.82 Median:5424.65 stddev:589.61 (10.9%) stddev-sans-first:565.54 19:31:23 INFO - PROCESS | 30566 | Values: 3056.6 3072.3 3095.4 3095.7 3099.5 5175.2 5223.4 5250.0 5272.7 5295.3 5265.1 5307.8 5316.4 5330.5 5351.2 4625.3 4754.5 4833.9 4882.4 4900.6 4873.4 4893.5 4893.7 4899.0 4927.9 4758.6 4761.0 4843.5 4881.8 4892.6 4728.4 4751.5 4754.0 4806.0 4907.2 4743.8 4767.5 4769.1 4772.7 4812.0 5185.7 5230.4 5241.9 5254.4 5284.8 5663.6 5676.1 5678.1 5686.5 5718.9 5663.8 5673.9 5699.3 5731.6 5748.5 5207.8 5224.5 5252.0 5260.8 5319.2 5753.8 5767.9 5776.7 5782.7 5796.3 5535.5 5554.7 5555.6 5556.0 5570.4 5478.3 5562.4 5623.9 5624.3 5630.5 5381.3 5555.6 5574.9 5642.3 5648.7 5631.5 5634.6 5635.4 5637.2 5647.7 4187.0 4342.7 4387.2 4399.0 4455.3 3883.3 3883.5 3933.2 3939.1 3950.1 5380.7 5386.0 5395.9 5410.5 5426.2 5474.0 5619.9 5666.8 5667.9 5675.7 5407.4 5452.2 5459.7 5478.2 5482.1 4916.6 4924.8 4950.3 4959.6 4968.6 5785.9 5897.8 5967.5 5991.3 6003.5 5666.0 5689.0 5719.6 5759.9 5761.8 5897.9 5946.7 5970.9 5977.5 5987.7 5408.7 5479.3 5602.0 5616.9 5627.3 5621.8 5643.0 5677.9 5712.5 5724.9 5524.3 5529.4 5532.6 5542.4 5544.1 5311.0 5423.7 5520.4 5539.0 5585.4 5390.4 5407.6 5420.4 5424.6 5476.3 5451.9 5457.8 5480.4 5492.9 5531.4 5326.3 5383.7 5390.0 5407.0 5410.1 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | [#1] ext.html Cycles:180 Average:61597.41 Median:23371.06 stddev:122004.81 (522.0%) stddev-sans-first:122260.96 19:31:23 INFO - PROCESS | 30566 | Values: 546.7 579.1 589.3 596.5 616.1 39684.8 43604.6 43621.8 43749.3 43851.3 43272.4 43916.6 43984.0 44141.6 44147.6 8903.4 9012.0 9089.9 9110.7 9123.0 8859.0 9024.6 9025.1 9026.9 9033.1 8781.3 8814.5 8822.6 8857.0 8858.7 8999.7 9043.3 9067.7 9090.7 9108.4 8973.9 8990.2 9055.6 9078.7 9086.1 41938.6 42661.6 42677.4 42695.1 42866.6 3760.9 3765.2 3864.3 3874.4 4255.1 32891.5 33563.0 33657.8 34234.0 34315.3 4375.5 4390.9 4423.4 4433.0 4488.3 376667.0 378993.0 379654.0 380663.0 382021.0 58235.7 58710.1 58823.4 58904.0 58940.4 36826.8 37853.4 38030.8 61926.0 62090.4 16951.0 17361.5 17363.0 17387.4 17389.7 13451.7 13545.0 13639.6 13644.7 13736.6 18642.3 18689.6 18799.3 18900.0 18926.4 7379.3 7508.6 7518.7 7628.6 7652.3 958.0 1014.5 1014.7 1132.2 1143.6 32779.8 33415.2 33666.2 34177.7 34491.8 1089.7 1116.8 1206.3 1213.8 1230.3 17022.7 17031.6 17102.7 17249.7 17450.2 553761.0 559761.0 559905.0 559958.0 564058.0 61013.7 61381.0 61415.4 61524.7 61687.0 1337.7 1348.5 1350.3 1383.6 1392.4 31489.7 32689.8 33820.2 33856.3 33858.4 50921.0 51847.0 51958.7 51961.7 52222.2 420889.0 421696.0 422283.0 422753.0 423732.0 28834.9 29299.1 29760.6 29885.1 31264.1 49563.0 49811.8 50066.2 50113.5 50354.5 41539.6 42077.8 43581.0 44094.0 44413.6 42013.0 42149.4 42922.6 44280.3 44293.3 40211.8 42050.4 42421.8 42487.0 43304.4 35270.5 37593.6 37750.0 37885.4 38580.8 29251.0 29404.3 29575.7 29593.4 29749.3 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | [#2] jquery.html Cycles:180 Average:29225.29 Median:13197.46 stddev:80286.85 (608.4%) stddev-sans-first:80482.85 19:31:23 INFO - PROCESS | 30566 | Values: 377.4 384.3 387.4 402.0 402.7 17887.3 19954.6 20032.7 20071.9 20133.6 19004.7 19166.6 19658.0 19895.0 19972.6 5644.6 5752.1 5795.9 5805.1 5884.3 5618.4 5789.8 5794.9 5797.7 5814.9 5583.1 5702.4 5715.0 5731.7 5736.3 5716.3 5734.7 5741.9 5744.1 5765.8 5116.8 5134.5 5171.6 5174.8 5176.9 23230.3 23572.4 23695.3 23850.2 23953.3 2441.6 2881.2 3026.0 3086.4 3167.2 14753.6 14948.9 14981.2 15010.0 15349.5 1964.6 2010.5 2051.9 2078.3 2084.7 77592.6 79517.2 81104.6 81690.0 82347.0 9714.3 10636.1 10749.6 11019.2 11389.3 14313.6 14353.0 14372.8 14406.0 14457.8 7938.9 8188.8 8258.4 8445.7 8448.7 8267.4 8328.5 8353.6 8510.0 8586.8 6334.4 6384.2 6439.7 6467.9 6483.0 1834.3 1889.9 1890.3 1895.2 1942.5 953.6 1060.9 1074.3 1125.2 1127.3 19827.9 20270.3 20468.3 20667.2 21121.2 902.5 1040.4 1056.6 1068.4 1137.6 8966.5 10851.3 10952.0 11001.4 11016.5 466471.0 475913.0 493933.0 498565.0 499216.0 87713.6 87825.6 88351.6 94895.0 100975.5 961.1 1019.5 1085.6 1086.5 1090.1 17600.3 18051.5 18272.7 18355.2 18552.4 41582.4 41629.2 41718.0 41932.8 42685.6 59134.7 59803.0 60654.7 61572.7 61897.1 8537.4 8666.5 8688.8 8788.3 8926.6 10932.5 12741.5 13011.3 13089.5 13179.7 11000.6 11951.8 12186.5 12201.4 12413.5 11661.3 11886.4 11959.2 11976.9 12183.5 11539.6 11725.4 11949.2 12222.8 12646.6 7228.1 7564.9 7571.7 8122.7 8514.7 10820.6 11618.1 11753.3 11856.1 12137.8 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | [#3] mootools.html Cycles:180 Average:5587.32 Median:5082.18 stddev:3125.52 (61.5%) stddev-sans-first:3118.94 19:31:23 INFO - PROCESS | 30566 | Values: 1465.5 1471.5 1607.5 1755.5 1765.5 7494.6 8093.5 8170.4 8671.1 8674.4 8474.1 8515.8 8524.6 8533.7 8535.7 2298.1 2337.3 2340.3 2351.1 2357.8 2256.2 2266.9 2330.2 2330.7 2332.6 2296.2 2302.6 2302.9 2329.4 2332.3 2255.8 2262.7 2266.5 2267.2 2268.7 2241.0 2241.2 2248.0 2252.1 2255.2 8551.5 8564.6 8567.4 8611.5 8614.9 4859.7 4977.6 5049.9 5056.0 5090.5 3077.2 3083.3 3149.9 3158.0 3189.4 1048.8 1056.0 1058.2 1075.0 1079.1 11306.7 11382.1 11387.4 11430.6 11457.1 4230.3 4321.2 4380.4 4424.4 4426.6 9730.1 9749.1 9763.8 9771.0 9873.1 5011.2 5049.9 5073.9 5118.7 5132.1 4023.3 4464.3 4598.2 4599.9 4645.4 3727.7 3774.4 3863.0 3893.8 3936.1 1131.5 1172.5 1179.5 1180.7 1184.7 892.2 893.4 907.5 929.5 933.1 5771.9 5800.4 5973.9 6116.0 6390.2 935.1 953.8 995.7 1012.9 1034.1 3908.7 4012.1 4089.2 4093.3 4210.9 10049.1 10535.2 10546.7 10573.9 10594.5 10370.1 10459.1 10465.5 10482.7 10507.4 7722.2 7941.9 8041.4 8052.6 8056.1 5785.9 5791.7 5861.8 5913.9 5957.3 9677.0 9710.2 9746.2 9884.8 9886.7 9556.2 9631.2 9667.7 9754.8 9791.3 6501.8 6750.1 6851.2 6934.7 7044.4 8226.2 8351.2 8378.3 8382.5 8391.0 7466.6 7552.7 7582.0 7592.4 7797.2 7127.4 7187.9 7198.5 7339.9 7349.9 6738.5 6869.2 6889.8 6970.6 6980.8 4995.7 5168.9 5196.1 5309.2 5362.0 5066.3 5100.0 5133.4 5238.4 5434.6 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | [#4] prototype.html Cycles:180 Average:4739.99 Median:5335.29 stddev:1418.60 (26.6%) stddev-sans-first:1383.08 19:31:23 INFO - PROCESS | 30566 | Values: 310.9 311.9 321.5 322.4 326.6 5347.8 5392.2 5513.9 5562.6 5583.3 5415.7 5470.6 5477.2 5482.9 5519.9 4318.8 4320.0 4332.4 4334.9 4342.8 4174.1 4256.8 4345.8 4348.8 4358.3 4284.6 4287.6 4300.7 4301.3 4302.6 4281.6 4308.9 4312.7 4337.9 4338.3 3448.0 3832.8 3836.8 3855.7 3858.2 5271.5 5287.1 5299.6 5305.8 5322.7 4746.2 4752.6 4796.0 4805.5 4815.4 5516.6 5662.9 5676.2 5696.1 5697.5 4003.8 4009.6 4018.6 4028.4 4028.5 5966.0 6006.7 6007.7 6027.0 6034.8 4026.3 4108.6 4156.5 4159.7 4168.9 4109.4 4128.5 4150.4 4166.7 4167.2 4784.5 4788.5 4796.1 4817.1 4849.4 5567.6 5777.0 5791.8 5802.9 5816.3 1410.8 1436.6 1438.0 1439.2 1440.4 885.4 916.1 917.5 923.6 933.8 4855.4 4892.4 4910.8 4927.4 5011.7 5125.3 5131.5 5134.0 5208.5 5222.7 4688.9 4918.6 4925.6 4991.1 4991.3 2734.8 2741.7 2744.2 2748.7 2753.3 5456.7 5462.5 5470.0 5471.5 5477.7 5318.7 5349.6 5514.7 6022.5 6144.2 6139.3 6196.9 6214.6 6224.7 6232.3 5611.5 5906.3 5959.0 5964.0 6008.4 5815.8 5853.7 5855.2 5876.4 5880.7 6189.9 6212.8 6234.9 6272.3 6277.9 3779.8 4072.0 4088.4 4119.7 4203.3 5849.4 5892.8 5915.5 5923.3 5985.3 5631.7 5767.2 5785.0 5812.4 5854.9 5640.5 5674.8 5677.3 5697.2 5700.9 5645.9 5650.9 5704.2 5714.1 5717.0 5514.8 5687.7 5698.0 5722.9 5775.3 5562.0 5601.4 5601.9 5609.9 5610.8 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - PROCESS | 30566 | [#5] yui.html Cycles:180 Average:20097.79 Median:4733.78 stddev:27841.44 (588.1%) stddev-sans-first:27881.57 19:31:23 INFO - PROCESS | 30566 | Values: 733.2 769.7 816.4 825.9 865.4 15510.0 16695.8 17047.3 17072.8 17355.6 15333.2 15674.7 15674.9 15700.2 15769.7 812.0 816.3 828.5 835.4 835.5 825.8 827.2 829.7 831.0 833.3 849.4 850.5 850.5 853.9 861.1 842.7 847.7 848.2 851.5 852.1 625.3 625.5 627.1 627.2 628.0 15352.6 15387.9 15396.4 15399.5 15424.5 15432.5 15559.4 15589.9 15631.8 15660.7 12540.9 12925.4 12998.7 13313.3 13493.2 3885.2 3935.8 3960.9 3968.2 4122.3 84375.6 84600.2 86228.6 87158.1 87305.0 11953.5 11988.6 12135.9 12239.8 12267.8 21982.0 22034.7 22066.7 22136.6 22190.8 8502.0 8541.5 8564.8 8597.3 8639.2 4661.6 4667.3 4708.3 4759.3 4857.1 3453.9 3567.3 3593.6 3602.6 3609.6 625.8 649.2 656.4 662.0 669.3 683.2 715.8 744.4 747.7 754.0 9350.7 9367.6 9556.8 9785.5 9930.7 729.7 753.4 759.9 768.4 798.8 4267.0 4570.5 4634.3 4671.2 4764.0 72300.0 94677.5 97295.0 99752.5 116546.0 90731.5 94213.0 94644.5 96973.5 99332.5 84655.6 85751.6 86579.0 87661.0 87760.6 9706.5 9711.1 9723.8 9774.2 9797.7 45324.0 46456.8 46833.8 48801.0 49004.5 49424.0 49813.0 55990.2 64384.4 64585.0 12585.2 12931.6 13040.5 13884.0 13975.7 14379.0 14525.3 15093.5 15102.9 15114.6 13296.1 13389.3 13893.2 13896.1 14242.6 13155.3 13941.9 14421.9 15317.4 15320.2 13625.7 13742.2 13743.9 14414.0 14435.1 10761.2 10872.3 11205.7 11290.9 11382.1 10594.6 12225.3 12350.8 12449.2 12454.3 19:31:23 INFO - PROCESS | 30566 | -------- Summary: end -------- 19:31:23 INFO - PROCESS | 30566 | 19:31:23 INFO - TEST-INFO | 30566: exit 0 19:31:24 INFO - TEST-OK | dromaeo_css | took 1112962ms 19:31:24 INFO - TEST-START | kraken 19:31:24 INFO - operating with platform_type : linux_ 19:31:24 INFO - Initialising browser for kraken test... 19:31:24 INFO - TEST-INFO | started process 30817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvyvnkb/profile http://localhost:38038/getInfo.html) 19:31:28 INFO - PROCESS | 30817 | __metrics Screen width/height:1600/1200 19:31:28 INFO - PROCESS | 30817 | colorDepth:24 19:31:28 INFO - PROCESS | 30817 | Browser inner width/height: 1024/697 19:31:28 INFO - PROCESS | 30817 | __metrics 19:31:29 ERROR - PROCESS | 30817 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:31:30 INFO - TEST-INFO | 30817: exit 0 19:31:30 INFO - Browser initialized. 19:31:30 INFO - Running cycle 1/1 for kraken test... 19:31:30 INFO - TEST-INFO | started process 30938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvyvnkb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:41 INFO - PROCESS | 30938 | RSS: Main: 163500032 19:31:41 INFO - PROCESS | 30938 | 19:31:44 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38038/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:45 INFO - PROCESS | 30938 | RSS: Main: 169279488 19:31:45 INFO - PROCESS | 30938 | 19:31:47 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38038/tests/kraken/driver.html?testName=audio-dft) 19:31:48 INFO - PROCESS | 30938 | RSS: Main: 167788544 19:31:48 INFO - PROCESS | 30938 | 19:31:51 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38038/tests/kraken/driver.html?testName=audio-fft) 19:31:52 INFO - PROCESS | 30938 | RSS: Main: 163180544 19:31:52 INFO - PROCESS | 30938 | 19:31:54 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38038/tests/kraken/driver.html?testName=audio-oscillator) 19:31:54 INFO - PROCESS | 30938 | RSS: Main: 164978688 19:31:54 INFO - PROCESS | 30938 | 19:31:57 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:57 INFO - PROCESS | 30938 | RSS: Main: 165281792 19:31:57 INFO - PROCESS | 30938 | 19:32:00 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38038/tests/kraken/driver.html?testName=imaging-darkroom) 19:32:01 INFO - PROCESS | 30938 | RSS: Main: 164761600 19:32:01 INFO - PROCESS | 30938 | 19:32:04 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38038/tests/kraken/driver.html?testName=imaging-desaturate) 19:32:05 INFO - PROCESS | 30938 | RSS: Main: 163598336 19:32:05 INFO - PROCESS | 30938 | 19:32:08 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38038/tests/kraken/driver.html?testName=json-parse-financial) 19:32:09 INFO - PROCESS | 30938 | RSS: Main: 164671488 19:32:09 INFO - PROCESS | 30938 | 19:32:10 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:32:11 INFO - PROCESS | 30938 | RSS: Main: 165294080 19:32:11 INFO - PROCESS | 30938 | 19:32:12 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:32:13 INFO - PROCESS | 30938 | RSS: Main: 164532224 19:32:13 INFO - PROCESS | 30938 | 19:32:15 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:32:16 INFO - PROCESS | 30938 | RSS: Main: 166260736 19:32:16 INFO - PROCESS | 30938 | 19:32:19 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:32:19 INFO - PROCESS | 30938 | RSS: Main: 166436864 19:32:19 INFO - PROCESS | 30938 | 19:32:22 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:32:22 INFO - PROCESS | 30938 | RSS: Main: 165781504 19:32:22 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | Cycle 1(1): loaded http://localhost:38038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38038/tests/kraken/driver.html?testName=ai-astar) 19:32:24 INFO - PROCESS | 30938 | RSS: Main: 166457344 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | __start_tp_report 19:32:24 INFO - PROCESS | 30938 | _x_x_mozilla_page_load 19:32:24 INFO - PROCESS | 30938 | _x_x_mozilla_page_load_details 19:32:24 INFO - PROCESS | 30938 | |i|pagename|runs| 19:32:24 INFO - PROCESS | 30938 | |0;ai-astar;105;116;106;114;112;113;114;112;112;112 19:32:24 INFO - PROCESS | 30938 | |1;audio-beat-detection;144;123;143;178;120;148;144;119;191;120 19:32:24 INFO - PROCESS | 30938 | |2;audio-dft;162;163;163;164;162;166;184;163;161;162 19:32:24 INFO - PROCESS | 30938 | |3;audio-fft;75;76;76;178;76;77;75;75;156;76 19:32:24 INFO - PROCESS | 30938 | |4;audio-oscillator;86;84;156;84;84;85;140;89;86;142 19:32:24 INFO - PROCESS | 30938 | |5;imaging-gaussian-blur;118;118;117;118;118;118;118;118;118;117 19:32:24 INFO - PROCESS | 30938 | |6;imaging-darkroom;147;153;149;149;147;148;148;148;147;149 19:32:24 INFO - PROCESS | 30938 | |7;imaging-desaturate;96;96;95;96;96;95;95;97;96;96 19:32:24 INFO - PROCESS | 30938 | |8;json-parse-financial;53;57;51;51;51;52;51;52;52;52 19:32:24 INFO - PROCESS | 30938 | |9;json-stringify-tinderbox;61;63;62;61;63;63;61;67;62;62 19:32:24 INFO - PROCESS | 30938 | |10;stanford-crypto-aes;81;76;76;76;76;76;76;76;82;76 19:32:24 INFO - PROCESS | 30938 | |11;stanford-crypto-ccm;126;126;137;124;131;124;146;147;132;128 19:32:24 INFO - PROCESS | 30938 | |12;stanford-crypto-pbkdf2;160;161;164;161;157;162;156;161;158;157 19:32:24 INFO - PROCESS | 30938 | |13;stanford-crypto-sha256-iterative;65;64;63;63;68;64;64;64;63;64 19:32:24 INFO - PROCESS | 30938 | __end_tp_report 19:32:24 INFO - PROCESS | 30938 | __start_cc_report 19:32:24 INFO - PROCESS | 30938 | _x_x_mozilla_cycle_collect,852 19:32:24 INFO - PROCESS | 30938 | __end_cc_report 19:32:24 INFO - PROCESS | 30938 | __startTimestamp1470450744907__endTimestamp 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | ------- Summary: start ------- 19:32:24 INFO - PROCESS | 30938 | Number of tests: 14 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.47 (3.1%) stddev-sans-first:2.74 19:32:24 INFO - PROCESS | 30938 | Values: 105.0 116.0 106.0 114.0 112.0 113.0 114.0 112.0 112.0 112.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:144.00 stddev:24.92 (17.3%) stddev-sans-first:26.43 19:32:24 INFO - PROCESS | 30938 | Values: 144.0 123.0 143.0 178.0 120.0 148.0 144.0 119.0 191.0 120.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#2] audio-dft Cycles:10 Average:165.00 Median:163.00 stddev:6.82 (4.2%) stddev-sans-first:7.14 19:32:24 INFO - PROCESS | 30938 | Values: 162.0 163.0 163.0 164.0 162.0 166.0 184.0 163.0 161.0 162.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:38.83 (51.1%) stddev-sans-first:40.57 19:32:24 INFO - PROCESS | 30938 | Values: 75.0 76.0 76.0 178.0 76.0 77.0 75.0 75.0 156.0 76.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.50 stddev:29.58 (35.0%) stddev-sans-first:30.68 19:32:24 INFO - PROCESS | 30938 | Values: 86.0 84.0 156.0 84.0 84.0 85.0 140.0 89.0 86.0 142.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:32:24 INFO - PROCESS | 30938 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.78 (1.2%) stddev-sans-first:1.80 19:32:24 INFO - PROCESS | 30938 | Values: 147.0 153.0 149.0 149.0 147.0 148.0 148.0 148.0 147.0 149.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 19:32:24 INFO - PROCESS | 30938 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 95.0 97.0 96.0 96.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.81 (3.5%) stddev-sans-first:1.90 19:32:24 INFO - PROCESS | 30938 | Values: 53.0 57.0 51.0 51.0 51.0 52.0 51.0 52.0 52.0 52.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:1.78 (2.8%) stddev-sans-first:1.80 19:32:24 INFO - PROCESS | 30938 | Values: 61.0 63.0 62.0 61.0 63.0 63.0 61.0 67.0 62.0 62.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:2.33 (3.1%) stddev-sans-first:2.00 19:32:24 INFO - PROCESS | 30938 | Values: 81.0 76.0 76.0 76.0 76.0 76.0 76.0 76.0 82.0 76.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:131.50 stddev:8.58 (6.5%) stddev-sans-first:8.81 19:32:24 INFO - PROCESS | 30938 | Values: 126.0 126.0 137.0 124.0 131.0 124.0 146.0 147.0 132.0 128.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:161.00 stddev:2.58 (1.6%) stddev-sans-first:2.74 19:32:24 INFO - PROCESS | 30938 | Values: 160.0 161.0 164.0 161.0 157.0 162.0 156.0 161.0 158.0 157.0 19:32:24 INFO - PROCESS | 30938 | 19:32:24 INFO - PROCESS | 30938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.48 (2.3%) stddev-sans-first:1.54 19:32:24 INFO - PROCESS | 30938 | Values: 65.0 64.0 63.0 63.0 68.0 64.0 64.0 64.0 63.0 64.0 19:32:24 INFO - PROCESS | 30938 | -------- Summary: end -------- 19:32:24 INFO - PROCESS | 30938 | 19:32:25 INFO - TEST-INFO | 30938: exit 0 19:32:25 INFO - TEST-OK | kraken | took 61885ms 19:32:25 INFO - SUITE-END | took 1174s 19:32:26 INFO - Completed test suite (00:19:35) 19:32:26 INFO - javascript benchmark 19:32:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7289.813259902797, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.5873607063045, 3072.308730535631, 3095.3963977024473, 3095.6749541298163, 3099.504079347305, 5175.223716442535, 5223.425423203449, 5249.977551407273, 5272.683638981659, 5295.31160949077, 5265.078611243036, 5307.779210781522, 5316.388615309241, 5330.520253177213, 5351.197320401941, 4625.329967822118, 4754.548317909793, 4833.854984350475, 4882.438519570242, 4900.632452566054, 4873.439554451248, 4893.4617192108835, 4893.657443978923, 4898.975505122487, 4927.926081108786, 4758.595519380857, 4760.95239047612, 4843.4914333994775, 4881.804727810883, 4892.584130348924, 4728.432588089417, 4751.477337492873, 4754.0, 4805.975970120162, 4907.2393778964315, 4743.786529606176, 4767.523247675239, 4769.141554520185, 4772.7136371817805, 4811.951880481185, 5185.714785686786, 5230.398504172031, 5241.895162096736, 5254.369475662907, 5284.815031473919, 5663.575231857627, 5676.148577713335, 5678.148277758328, 5686.516646085088, 5718.885622287573, 5663.801766938137, 5673.886522269531, 5699.287589051369, 5731.570132240057, 5748.540116790647, 5207.791688332462, 5224.4775522447835, 5251.973740131351, 5260.842174734764, 5319.175527793198, 5753.827385178452, 5767.913481297784, 5776.711164441761, 5782.653040817564, 5796.304443466811, 5535.474129957647, 5554.72226388679, 5555.638883472561, 5556.0, 5570.359408668055, 5478.287822583039, 5562.3881373048935, 5623.859403514863, 5624.3250809903075, 5630.5214056805635, 5381.327334083239, 5555.638883472561, 5574.86062848432, 5642.322921249394, 5648.71756412186, 5631.465010823965, 5634.60557760961, 5635.351934527582, 5637.210790489335, 5647.717614119278, 4187.0, 4342.6742994275555, 4387.210302145644, 4398.978005109954, 4455.2648812946145, 3883.30100581898, 3883.475730776309, 3933.1740334529495, 3939.074317535377, 3950.1309711863346, 5380.677159370451, 5386.0, 5395.892082158335, 5410.48600382963, 5426.158945363475, 5474.0, 5619.887602247933, 5666.829995100154, 5667.943320566824, 5675.659460432387, 5407.432219616962, 5452.154915988028, 5459.69971651563, 5478.233047373371, 5482.095454250084, 4916.631252656065, 4924.8276310328965, 4950.2822090796635, 4959.578435832995, 4968.6025117990475, 5785.913211301834, 5897.7935772247765, 5967.522598192134, 5991.310999235144, 6003.459688627957, 5666.0, 5688.971555142363, 5719.5710321726865, 5759.94240057594, 5761.798337058351, 5897.911531326948, 5946.73239704223, 5970.910436343372, 5977.491913187428, 5987.670678112746, 5408.729563521887, 5479.2602998594675, 5602.047651899105, 5616.85957851057, 5627.268455100811, 5621.775128994958, 5642.971785141048, 5677.914831277617, 5712.542996560348, 5724.885502290014, 5524.33707955048, 5529.391766905717, 5532.612717109763, 5542.445755424425, 5544.085225937675, 5311.044012077863, 5423.701696406735, 5520.420355862737, 5539.0, 5585.413531579125, 5390.353157621111, 5407.567394608343, 5420.430854760193, 5424.647397919122, 5476.2607048048, 5451.945480545144, 5457.754401051883, 5480.420314887805, 5492.890142197213, 5531.391546929915, 5326.2809520715755, 5383.650062745909, 5390.0, 5407.0, 5410.053240682943], "value": 5219.730100692609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.6903073286052, 579.0821547846663, 589.2604780999848, 596.501920896052, 616.1220261127892, 39684.80157599212, 43604.56395436045, 43621.7818910905, 43749.34375984363, 43851.34222986654, 43272.35091473631, 43916.56083439165, 43984.0, 44141.558584414146, 44147.558524414744, 8903.42127761695, 9011.95494022529, 9089.909100908972, 9110.726678199631, 9123.042080581543, 8858.955705221497, 9024.639014439415, 9025.104728007094, 9026.909730902673, 9033.09669033098, 8781.253593444564, 8814.515201663906, 8822.558872056403, 8856.955715221415, 8858.689945851896, 8999.685011024616, 9043.276537876955, 9067.727968160965, 9090.7272781816, 9108.407953483002, 8973.865392019125, 8990.235829954461, 9055.592498337524, 9078.68224612142, 9086.136817002374, 41938.58061419377, 42661.57338426607, 42677.35983960243, 42695.14609707819, 42866.57133428657, 3760.905977350561, 3765.2093060457337, 3864.3044252034624, 3874.380099184117, 4255.127698821734, 32891.50662740061, 33563.0, 33657.831710841536, 34234.0, 34315.31369372624, 4375.540568240321, 4390.8902277443, 4423.358613001129, 4433.0, 4488.349189367524, 376667.0, 378993.0, 379654.0, 380663.0, 382020.9999999972, 58235.70882145562, 58710.11934820981, 58823.41176588265, 58904.0, 58940.41059589435, 36826.8158659205, 37853.432198517046, 38030.809845951146, 61926.0, 62090.37909620936, 16951.0, 17361.47915562535, 17363.04503252308, 17387.391441299747, 17389.65220695579, 13451.730965380637, 13545.0, 13639.590812275648, 13644.727105458034, 13736.587902362946, 18642.254309827727, 18689.626207476045, 18799.342023029403, 18900.0, 18926.43220703381, 7379.3358597726465, 7508.624568771649, 7518.706794427752, 7628.580428076398, 7652.273034061866, 957.9712608621752, 1014.4775440648073, 1014.7310962594918, 1132.1678566253797, 1143.5597295041302, 32779.836100819346, 33415.164620884185, 33666.15834604154, 34177.658223417944, 34491.827540862134, 1089.6839916424308, 1116.8045592021365, 1206.3003457994341, 1213.7936550786387, 1230.274138258414, 17022.744658830128, 17031.574210644587, 17102.657946841242, 17249.655006899793, 17450.214740336716, 553761.0, 559761.0, 559905.0, 559958.0, 564058.0, 61013.69493152595, 61381.0, 61415.38584614186, 61524.69237653783, 61687.0, 1337.6588969812635, 1348.4740951029107, 1350.3045931345364, 1383.5849245226593, 1392.373431955624, 31489.685103149593, 32689.836550817094, 33820.154496137795, 33856.322873542886, 33858.37338648392, 50921.0, 51847.0, 51958.740206298724, 51961.7401912988, 52222.21666675079, 420889.0, 421696.0, 422283.0, 422753.0, 423732.0, 28834.855825720737, 29299.121026369245, 29760.553591696575, 29885.103446896628, 31264.062078137693, 49563.0, 49811.75094124506, 50066.249006265665, 50113.498865010886, 50354.496455036446, 41539.58460415478, 42077.78961105175, 43581.0, 44094.0, 44413.55586444094, 42013.0, 42149.367759484245, 42922.57077429186, 44280.33579496374, 44293.33559996667, 40211.79894100511, 42050.36924446197, 42421.78789106035, 42487.0, 43304.350434742875, 35270.47094293639, 37593.62406375901, 37750.0, 37885.43171852479, 38580.80709596434, 29251.0, 29404.264893377836, 29575.704242958156, 29593.408131837674, 29749.256268593457], "value": 20532.99641857669, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.44515562123684, 384.3274270027452, 387.4188716924613, 401.9839206431743, 402.68791686443, 17887.284508619658, 19954.60090798187, 20032.69950950735, 20071.899640501797, 20133.59732805343, 19004.714929276073, 19166.61666766664, 19658.0, 19895.0, 19972.60054798903, 5644.576656750729, 5752.137179423078, 5795.884082318372, 5805.071188609823, 5884.323302820167, 5618.410066942974, 5789.797357092502, 5794.855128621797, 5797.652140871562, 5814.854628634275, 5583.078791999315, 5702.372738998707, 5715.0, 5731.656100633954, 5736.254286942692, 5716.28546431696, 5734.7419366128415, 5741.913871291934, 5744.080947048494, 5765.827025189251, 5116.846494605168, 5134.460881607452, 5171.5862730981435, 5174.767135478913, 5176.896462070775, 23230.3030909073, 23572.410689732722, 23695.28914132579, 23850.16524421637, 23953.281401557982, 2441.645961335614, 2881.1932658855553, 3025.9862945913146, 3086.36729470458, 3167.224030112614, 14753.631159220999, 14948.925255373653, 14981.176035318162, 15010.0, 15349.46276880315, 1964.6365422396902, 2010.517475805796, 2051.907664155102, 2078.324544523036, 2084.739407574053, 77592.61203693945, 79517.20482795214, 81104.59447702723, 81690.0, 82347.0, 9714.271429642806, 10636.149108071335, 10749.570017199225, 11019.173561982723, 11389.259698119597, 14313.6421589459, 14353.0, 14372.784408233885, 14405.991580589467, 14457.78313325301, 7938.920610793818, 8188.754337369888, 8258.380621453414, 8445.746627601182, 8448.746537603882, 8267.379946503916, 8328.541930193898, 8353.582320883932, 8510.0, 8586.828263434696, 6334.410513805285, 6384.233891932998, 6439.710213040331, 6467.935320646733, 6482.967585162044, 1834.2937968882077, 1889.8866068035961, 1890.2722451856134, 1895.1906667597952, 1942.4755316064584, 953.6328513522344, 1060.9045185933148, 1074.2533938912381, 1125.234840308598, 1127.3236058364917, 19827.900860495603, 20270.290539831036, 20468.283610073577, 20667.17331306731, 21121.155153793676, 902.5126431726925, 1040.432964034603, 1056.5984925728173, 1068.3589846092282, 1137.6132115080911, 8966.489879427125, 10851.348919064882, 10952.0, 11001.394923279297, 11016.504257308441, 466471.0, 475913.0, 493933.0, 498565.0, 499216.0, 87713.56143219244, 87825.56087219523, 88351.55824220838, 94895.0, 100975.49512252392, 961.1205746741653, 1019.5259204469957, 1085.6200329884477, 1086.5436516662862, 1090.0843291635065, 17600.29598816033, 18051.548711282325, 18272.72590911164, 18355.174017169527, 18552.44342669722, 41582.37626435545, 41629.19836103134, 41718.0, 41932.790336049344, 42685.57314426816, 59134.704326478095, 59803.0, 60654.696726516086, 61572.69213653903, 61897.07154392597, 8537.445066070686, 8666.480011199348, 8688.78278043054, 8788.252998494943, 8926.553672316228, 10932.453377331261, 12741.49034038628, 13011.284379358847, 13089.541866034642, 13179.67050823737, 11000.614978475714, 11951.76096478083, 12186.51253949832, 12201.389930503618, 12413.503459861504, 11661.300321980709, 11886.405679716152, 11959.222650527689, 11976.940115299367, 12183.512659493876, 11539.596114135966, 11725.355105469282, 11949.22330048544, 12222.816657749963, 12646.620601381974, 7228.132624085143, 7564.886526702214, 7571.734989275569, 8122.715704950535, 8514.74455766328, 10820.621278255223, 11618.128640351839, 11753.294802311546, 11856.11079169083, 12137.817932731192], "value": 9512.981029474686, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.5163795947337, 1471.529110684581, 1607.5257798949317, 1755.5347832824295, 1765.4880084775416, 7494.587797671126, 8093.514389136656, 8170.4280700350855, 8671.132886711333, 8674.392792504526, 8474.067852536216, 8515.829683406344, 8524.573771311441, 8533.701320453785, 8535.658573657047, 2298.069281940817, 2337.2988103568946, 2340.2979106268135, 2351.130081869702, 2357.7760112789256, 2256.244158207003, 2266.8526545774553, 2330.196082351586, 2330.685357476736, 2332.6034574122355, 2296.207808306132, 2302.5625131225097, 2302.9424264393356, 2329.3943574670625, 2332.3119679694532, 2255.785700358463, 2262.7284725833006, 2266.546690661866, 2267.1724820440504, 2268.65970104484, 2240.9775902241095, 2241.2043724477903, 2247.9996401601293, 2252.110416385535, 2255.1994042114975, 8551.529665868375, 8564.571771411405, 8567.44311619749, 8611.483311001297, 8614.913850861474, 4859.73271470069, 4977.552020318152, 5049.899002019939, 5056.0, 5090.465501122366, 3077.1691643256418, 3083.275430273884, 3149.9055028349185, 3157.9684203157904, 3189.409959157563, 1048.8269435543127, 1056.0442799266675, 1058.2433560004633, 1074.962376316833, 1079.1420820447763, 11306.717332066683, 11382.089432845352, 11387.430628468543, 11430.571178602675, 11457.083433325397, 4230.344296634026, 4321.243782338078, 4380.4305440292555, 4424.380586717862, 4426.557344265612, 9730.075642813921, 9749.073837985521, 9763.755906102262, 9771.0, 9873.062059104517, 5011.223260394645, 5049.899002019939, 5073.898522029613, 5118.692878427232, 5132.127538318495, 4023.3160362738404, 4464.308032255006, 4598.218302888517, 4599.908001840012, 4645.396098507173, 3727.7390582658954, 3774.3958817502453, 3863.0, 3893.785841778673, 3936.0946982194255, 1131.5473810475876, 1172.5075468303332, 1179.4633441783967, 1180.7107258721496, 1184.6742145909943, 892.2148509311764, 893.4371346052076, 907.464595888429, 929.5120061967522, 933.1368484152132, 5771.88456230873, 5800.390958949334, 5973.910391344133, 6116.021436570217, 6390.201224846895, 935.083618054297, 953.828310904044, 995.7361299255703, 1012.8885822559513, 1034.1209971524295, 3908.726389152732, 4012.137390461065, 4089.20260549196, 4093.3041382964966, 4210.894727631834, 10049.145822605014, 10535.157187424988, 10546.736331591617, 10573.89426105729, 10594.523246453928, 10370.066693997576, 10459.110975567162, 10465.529051192714, 10482.73793155162, 10507.422091784872, 7722.150563438017, 7941.9278397416765, 8041.396895232998, 8052.59737013147, 8056.113827478973, 5785.913211301918, 5791.710414479344, 5861.7655293787775, 5913.881722365614, 5957.314908785372, 9677.0, 9710.22318214527, 9746.220302375652, 9884.802303953737, 9886.653967111117, 9556.187724043257, 9631.229501639993, 9667.661631842851, 9754.804903902024, 9791.314607977372, 6501.804945851632, 6750.088738020305, 6851.177858656993, 6934.7226110955, 7044.436445084483, 8226.177382261725, 8351.1648835116, 8378.287845533197, 8382.538960356995, 8391.035030971272, 7466.626668666437, 7552.697892084255, 7582.0, 7592.392608591189, 7797.220277972384, 7127.429805615435, 7187.928120718935, 7198.5320954137815, 7339.889901651372, 7349.853002940018, 6738.460923126237, 6869.210040845167, 6889.827754306182, 6970.581765094111, 6980.825479363057, 4995.675281106716, 5168.870778230575, 5196.114140874861, 5309.150535914389, 5362.0, 5066.265391518135, 5099.974500127476, 5133.435322114489, 5238.397584277857, 5434.64674796137], "value": 4494.577555451212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.88652641785757, 311.9001919385796, 321.48740177465027, 322.4099897188146, 326.64069523524114, 5347.839564813062, 5392.2181283713835, 5513.932275396726, 5562.610617256793, 5583.3020872391, 5415.729213539327, 5470.617056806025, 5477.233187353773, 5482.862928426792, 5519.889602207963, 4318.784060796963, 4319.978400108011, 4332.35014747788, 4334.916270932267, 4342.761148136851, 4174.123434078847, 4256.808093733759, 4345.804903651489, 4348.804078878318, 4358.3462480628, 4284.614384705376, 4287.614114729674, 4300.677449191323, 4301.26878430666, 4302.591253830881, 4281.593248641389, 4308.9353659695125, 4312.676549258818, 4337.9132417351475, 4338.262495375762, 3448.0, 3832.827522761482, 3836.8105887175066, 3855.691544676419, 3858.2283543291173, 5271.525562699337, 5287.101192797234, 5299.576033917316, 5305.814296499642, 5322.733863306819, 4746.1931471649905, 4752.572268495852, 4795.976020119912, 4805.519448055166, 4815.446223684286, 5516.586256030773, 5662.924044431545, 5676.205331253628, 5696.1455781633085, 5697.544196464273, 4003.779792111433, 4009.6190861868076, 4018.618231268025, 4028.436018957319, 4028.4964379452567, 5966.0, 6006.699665016776, 6007.669578173199, 6027.0, 6034.8189554313, 4026.315526360526, 4108.609682080198, 4156.480439945007, 4159.667226621863, 4168.895777605523, 4109.383592461095, 4128.504579450425, 4150.377443383517, 4166.708330416903, 4167.229062623424, 4784.497627749036, 4788.545088216614, 4796.088743138793, 4817.108834865491, 4849.369581954324, 5567.610267281332, 5776.971115144482, 5791.82624521265, 5802.88394232113, 5816.272965879265, 1410.7531182043306, 1436.5977526292654, 1438.0437009388847, 1439.1868594244218, 1440.3878351700484, 885.3536918049731, 916.1388295002677, 917.5091326140483, 923.5982347678781, 933.7618907178762, 4855.417349918032, 4892.437369702458, 4910.8281210157475, 4927.43334516528, 5011.724355160502, 5125.333706618116, 5131.461196574381, 5134.0, 5208.5051920067535, 5222.660527065728, 4688.859334219979, 4918.606511479073, 4925.581325587365, 4991.126552853236, 4991.276264941564, 2734.786625714777, 2741.7258274172823, 2744.245332533569, 2748.6531599516493, 2753.3116720819794, 5456.699881506555, 5462.535684466785, 5469.964169885751, 5471.480209380103, 5477.7261136943, 5318.734063296897, 5349.5720342372515, 5514.6858481826985, 6022.457978781843, 6144.17053697754, 6139.293981192131, 6196.907046394308, 6214.632780788219, 6224.719887605069, 6232.345603711636, 5611.494965453129, 5906.291245050621, 5959.046552551571, 5963.970180149072, 6008.429199226067, 5815.82552523425, 5853.678047707247, 5855.151003104441, 5876.382979787232, 5880.735366908585, 6189.876202475835, 6212.751489940351, 6234.937650623436, 6272.341404152498, 6277.905831412441, 3779.7921114338974, 4071.9796401017807, 4088.4480595120467, 4119.702293777451, 4203.285441474895, 5849.356570777126, 5892.7642894283745, 5915.497182739516, 5923.318818335946, 5985.25184351956, 5631.6902570359025, 5767.163761254511, 5785.0, 5812.360640329476, 5854.9121763174435, 5640.464155905182, 5674.801381951612, 5677.318721753416, 5697.230873832145, 5700.862176683743, 5645.899049685272, 5650.85872853182, 5704.229928959538, 5714.114312281603, 5717.0, 5514.814314922311, 5687.658740475585, 5697.971510142423, 5722.914156287742, 5775.335836378702, 5562.0, 5601.439856014366, 5601.915971260353, 5609.915851262316, 5610.7755689773585], "value": 4279.113033049111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.1934871641196, 769.6767357709762, 816.3591580609219, 825.9091499935006, 865.3726048614759, 15510.0, 16695.83304166958, 17047.31810727571, 17072.829271707295, 17355.566110847234, 15333.156676382794, 15674.686506269867, 15674.921625391886, 15700.21498925055, 15769.684606307866, 811.9715809946653, 816.3306089007002, 828.4863384701464, 835.4235577451539, 835.5237514616671, 825.8100636853527, 827.2058823529419, 829.6764261937819, 830.9709160179395, 833.3083540661237, 849.362977766675, 850.5407080176698, 850.5407080176728, 853.9188777066169, 861.0872475176333, 842.7387509871959, 847.6609356257516, 848.1899785704668, 851.4933614499363, 852.1180578101697, 625.2653132569213, 625.4902254662481, 627.109504503606, 627.1627377451108, 628.0202883501752, 15352.616184595363, 15387.923060384739, 15396.384144634201, 15399.461018864286, 15424.5372638821, 15432.459863904822, 15559.37762489499, 15589.922050389789, 15631.843681563152, 15660.68678626421, 12540.937295313464, 12925.35373231344, 12998.675033124153, 13313.26777027263, 13493.19040857542, 3885.2423777363424, 3935.8425662973445, 3960.881173564798, 3968.1666849961543, 4122.299209134424, 84375.57812210961, 84600.15399846046, 86228.56885715594, 87158.12841871564, 87305.0, 11953.52185912571, 11988.64034078979, 12135.87864121365, 12239.75520489603, 12267.754644907052, 21982.01080951361, 22034.669479957814, 22066.66899996501, 22136.557268854856, 22190.778092219192, 8501.95749021251, 8541.53021583819, 8564.828703426021, 8597.323521913167, 8639.179277968582, 4661.603763680057, 4667.32323813052, 4708.293755936568, 4759.262314341283, 4857.149998750205, 3453.8618455262013, 3567.340042092221, 3593.6047034826147, 3602.603713591503, 3609.639036096369, 625.8060001399581, 649.2468736265909, 656.4092316914815, 661.9635920024444, 669.3072669786748, 683.2313647146959, 715.7852644206718, 744.4119145874806, 747.6560782040323, 753.9623018849036, 9350.719478415658, 9367.578458969363, 9556.808863822685, 9785.510724463747, 9930.702078937644, 729.7190581626006, 753.3935182178399, 759.9126100498403, 768.4275214964775, 798.8282519258387, 4266.978665106717, 4570.468892920842, 4634.2585186370015, 4671.205894997858, 4763.976180119077, 72300.0, 94677.52661236787, 97295.0, 99752.50123749334, 116546.0, 90731.54634226787, 94213.0, 94644.52677736567, 96973.51513242388, 99332.50333748285, 84655.57672211599, 85751.57124214464, 86579.0, 87661.0, 87760.56119719488, 9706.5146742664, 9711.125998660154, 9723.756906077404, 9774.218062555121, 9797.657082002095, 45324.0, 46456.7677161612, 46833.765831170625, 48801.0, 49004.50995489999, 49424.0, 49813.0, 55990.16014759863, 64384.35615643971, 64585.0, 12585.24488530691, 12931.612051638465, 13040.478380864659, 13884.0, 13975.720485590027, 14379.0, 14525.273736313353, 15093.528488447499, 15102.924485377504, 15114.622134446727, 13296.069275151034, 13389.263590502616, 13893.166410015432, 13896.096753710977, 14242.572722817917, 13155.276459794803, 13941.930290348484, 14421.855781442471, 15317.38730450814, 15320.157391343582, 13625.727485450434, 13742.175469471864, 13743.862561374659, 14414.0, 14435.133891966516, 10761.246712730033, 10872.347659140476, 11205.71985700364, 11290.943545282222, 11382.089432845518, 10594.629187978384, 12225.327606981346, 12350.764923507577, 12449.190802597803, 12454.25274483534], "value": 7652.28896047786, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 106.0, 114.0, 112.0, 113.0, 114.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 143.0, 178.0, 120.0, 148.0, 144.0, 119.0, 191.0, 120.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 162.0, 166.0, 184.0, 163.0, 161.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 178.0, 76.0, 77.0, 75.0, 75.0, 156.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 156.0, 84.0, 84.0, 85.0, 140.0, 89.0, 86.0, 142.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 153.0, 149.0, 149.0, 147.0, 148.0, 148.0, 148.0, 147.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 51.0, 51.0, 51.0, 52.0, 51.0, 52.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 63.0, 63.0, 61.0, 67.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 76.0, 76.0, 76.0, 76.0, 76.0, 76.0, 82.0, 76.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 137.0, 124.0, 131.0, 124.0, 146.0, 147.0, 132.0, 128.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 164.0, 161.0, 157.0, 162.0, 156.0, 161.0, 158.0, 157.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 68.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 64.2, "unit": "score"}]}]} 19:32:26 INFO - Return code: 0 19:32:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:32:26 ERROR - # TBPL SUCCESS # 19:32:26 INFO - Running post-action listener: _resource_record_post_action 19:32:26 INFO - [mozharness: 2016-08-06 02:32:26.211374Z] Finished run-tests step (success) 19:32:26 INFO - Running post-run listener: _resource_record_post_run 19:32:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555450368; Read time: 224; Write time: 588044 19:32:26 INFO - TinderboxPrint: CPU usage
13.3% 19:32:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 224 19:32:26 INFO - TinderboxPrint: I/O write bytes / time
555,450,368 / 588,044 19:32:26 INFO - TinderboxPrint: CPU idle
8,242.2 (86.7%) 19:32:26 INFO - TinderboxPrint: CPU user
1,208.5 (12.7%) 19:32:26 INFO - TinderboxPrint: Swap in / out
0 / 0 19:32:26 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 261279744; Read time: 0; Write time: 310832 19:32:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293994496; Read time: 216; Write time: 277172 19:32:26 INFO - Running post-run listener: _upload_blobber_files 19:32:26 INFO - Blob upload gear active. 19:32:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:32:27 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:28 INFO - (blobuploader) - INFO - Done attempting. 19:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:28 INFO - (blobuploader) - INFO - Done attempting. 19:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:32 INFO - (blobuploader) - INFO - Done attempting. 19:32:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:32:32 INFO - Return code: 0 19:32:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:32:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:32:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9197d091c08860b09fbdce6be671207fed890d44df306b45dfaf0065659cdcd461b293972c613d674ee676d396c0b23de0afe7a83a27fb3b8f1180a3a6aadad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d565f34d603d6321d608b2247eba72878d36a94fcf7be583679d2611a4da0d3088470389c917f868ff0cd9b5a5e22c17e41fc181908719c4d2d6d32b2346d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e9022dd8f7486f7a02eed0965e069bc52c2b190e7b2a996297df0219ad84ebe3e3585c4414d23c8810ef4bfa55f3e271f4ba092b3e0392c37c3f43cb2915c5"} 19:32:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:32:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:32:32 INFO - Contents: 19:32:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9197d091c08860b09fbdce6be671207fed890d44df306b45dfaf0065659cdcd461b293972c613d674ee676d396c0b23de0afe7a83a27fb3b8f1180a3a6aadad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d565f34d603d6321d608b2247eba72878d36a94fcf7be583679d2611a4da0d3088470389c917f868ff0cd9b5a5e22c17e41fc181908719c4d2d6d32b2346d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e9022dd8f7486f7a02eed0965e069bc52c2b190e7b2a996297df0219ad84ebe3e3585c4414d23c8810ef4bfa55f3e271f4ba092b3e0392c37c3f43cb2915c5"} 19:32:32 INFO - Running post-run listener: copy_logs_to_upload_dir 19:32:32 INFO - Copying logs to upload dir... 19:32:32 INFO - mkdir: /builds/slave/test/build/upload/logs 19:32:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.649073 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-05 19:32:31.693306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 19:32:31.696740) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9197d091c08860b09fbdce6be671207fed890d44df306b45dfaf0065659cdcd461b293972c613d674ee676d396c0b23de0afe7a83a27fb3b8f1180a3a6aadad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d565f34d603d6321d608b2247eba72878d36a94fcf7be583679d2611a4da0d3088470389c917f868ff0cd9b5a5e22c17e41fc181908719c4d2d6d32b2346d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e9022dd8f7486f7a02eed0965e069bc52c2b190e7b2a996297df0219ad84ebe3e3585c4414d23c8810ef4bfa55f3e271f4ba092b3e0392c37c3f43cb2915c5"} build_url:https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/bQ6o_xhQT_G0j0UVAMX6VA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9197d091c08860b09fbdce6be671207fed890d44df306b45dfaf0065659cdcd461b293972c613d674ee676d396c0b23de0afe7a83a27fb3b8f1180a3a6aadad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d565f34d603d6321d608b2247eba72878d36a94fcf7be583679d2611a4da0d3088470389c917f868ff0cd9b5a5e22c17e41fc181908719c4d2d6d32b2346d65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e9022dd8f7486f7a02eed0965e069bc52c2b190e7b2a996297df0219ad84ebe3e3585c4414d23c8810ef4bfa55f3e271f4ba092b3e0392c37c3f43cb2915c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 19:32:31.722270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:32:31.722598) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1470443499.283627-1725344830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 19:32:31.805211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 19:32:31.805551) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 19:32:31.805858) ========= ========= Total master_lag: 0.17 =========