builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1476684943.61 results: success (0) buildid: 20161016201455 builduid: 54f65ac94d7d449f96a04cc38229aa1c revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.614181) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.614685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.615017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.643014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.643302) ========= 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=fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-16 23:15:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.6M=0s 2016-10-16 23:15:44 (25.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125752 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.784803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.785133) ========= 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=fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015077 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:43.839572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 23:15:43.839963) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 687572ea20cb84f1842ad00dcc8ca1712868a361 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 687572ea20cb84f1842ad00dcc8ca1712868a361 --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=fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-16 23:15:45,116 truncating revision to first 12 chars 2016-10-16 23:15:45,116 Setting DEBUG logging. 2016-10-16 23:15:45,116 attempt 1/10 2016-10-16 23:15:45,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/687572ea20cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 23:15:45,859 unpacking tar archive at: fx-team-687572ea20cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 23:15:44.913670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:44.914024) ========= script_repo_revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:44.914489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:44.914825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:44.925711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-16 23:15:44.926026) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:15:46 INFO - MultiFileLogger online at 20161016 23:15:46 in /builds/slave/test 23:15:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:15:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:15:46 INFO - {'append_to_log': False, 23:15:46 INFO - 'base_work_dir': '/builds/slave/test', 23:15:46 INFO - 'blob_upload_branch': 'Fx-Team', 23:15:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:15:46 INFO - 'branch': 'Fx-Team', 23:15:46 INFO - 'buildbot_json_path': 'buildprops.json', 23:15:46 INFO - 'config_files': ('talos/linux_config.py',), 23:15:46 INFO - 'default_actions': ('clobber', 23:15:46 INFO - 'read-buildbot-config', 23:15:46 INFO - 'download-and-extract', 23:15:46 INFO - 'populate-webroot', 23:15:46 INFO - 'create-virtualenv', 23:15:46 INFO - 'install', 23:15:46 INFO - 'run-tests'), 23:15:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:15:46 INFO - 'download_minidump_stackwalk': True, 23:15:46 INFO - 'download_symbols': 'ondemand', 23:15:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:15:46 INFO - 'tooltool.py': '/tools/tooltool.py', 23:15:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:15:46 INFO - '/tools/misc-python/virtualenv.py')}, 23:15:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:15:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:15:46 INFO - 'installer_path': 'installer.exe', 23:15:46 INFO - 'log_level': 'info', 23:15:46 INFO - 'log_name': 'talos', 23:15:46 INFO - 'log_to_console': True, 23:15:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:15:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:15:46 INFO - 'opt_config_files': (), 23:15:46 INFO - 'pip_index': False, 23:15:46 INFO - 'sps_profile': False, 23:15:46 INFO - 'sps_profile_interval': 0, 23:15:46 INFO - 'suite': 'dromaeojs-e10s', 23:15:46 INFO - 'system_bits': '32', 23:15:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:15:46 INFO - 'title': 'talos-linux64-ix-048', 23:15:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:15:46 INFO - 'use_talos_json': True, 23:15:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:15:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:15:46 INFO - 'work_dir': 'build'} 23:15:46 INFO - [mozharness: 2016-10-17 06:15:46.296701Z] Running clobber step. 23:15:46 INFO - Running pre-action listener: _resource_record_pre_action 23:15:46 INFO - Running main action method: clobber 23:15:46 INFO - rmtree: /builds/slave/test/build 23:15:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:15:46 INFO - Running post-action listener: _resource_record_post_action 23:15:46 INFO - [mozharness: 2016-10-17 06:15:46.756065Z] Finished clobber step (success) 23:15:46 INFO - [mozharness: 2016-10-17 06:15:46.756174Z] Running read-buildbot-config step. 23:15:46 INFO - Running pre-action listener: _resource_record_pre_action 23:15:46 INFO - Running main action method: read_buildbot_config 23:15:46 INFO - Using buildbot properties: 23:15:46 INFO - { 23:15:46 INFO - "project": "", 23:15:46 INFO - "product": "firefox", 23:15:46 INFO - "script_repo_revision": "production", 23:15:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:15:46 INFO - "repository": "", 23:15:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:15:46 INFO - "buildid": "20161016201455", 23:15:46 INFO - "pgo_build": "True", 23:15:46 INFO - "basedir": "/builds/slave/test", 23:15:46 INFO - "buildnumber": 1253, 23:15:46 INFO - "slavename": "talos-linux64-ix-048", 23:15:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:15:46 INFO - "platform": "ubuntu64_hw", 23:15:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:15:46 INFO - "branch": "fx-team", 23:15:46 INFO - "repo_path": "integration/fx-team", 23:15:46 INFO - "revision": "687572ea20cb84f1842ad00dcc8ca1712868a361", 23:15:46 INFO - "stage_platform": "linux64-pgo", 23:15:46 INFO - "builduid": "54f65ac94d7d449f96a04cc38229aa1c", 23:15:46 INFO - "slavebuilddir": "test" 23:15:46 INFO - } 23:15:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:15:46 INFO - Running post-action listener: _resource_record_post_action 23:15:46 INFO - [mozharness: 2016-10-17 06:15:46.758603Z] Finished read-buildbot-config step (success) 23:15:46 INFO - [mozharness: 2016-10-17 06:15:46.758691Z] Running download-and-extract step. 23:15:46 INFO - Running pre-action listener: _resource_record_pre_action 23:15:46 INFO - Running main action method: download_and_extract 23:15:46 INFO - mkdir: /builds/slave/test/build/tests 23:15:46 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')]} 23:15:46 INFO - trying https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:46 INFO - Downloading https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:15:47 INFO - Downloaded 1361 bytes. 23:15:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:47 INFO - Using the following test package requirements: 23:15:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:15:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:15:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'jsshell-linux-x86_64.zip'], 23:15:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:15:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:15:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:15:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:15:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:15:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:15:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:15:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:15:47 INFO - Fetch https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:15:48 INFO - Http code: 200 23:15:48 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 23:15:48 INFO - x-amz-cf-id: uw0NLMeUihSABPsMIDGaJ8fp1Wvq8IH9SwF1Wlrw6CGxqRkldcFZ_A== 23:15:48 INFO - x-amz-version-id: nq_xRi390ITI4MZbOFbmyA3Rh0ZVF8m7 23:15:49 INFO - Expected file size: 22100551 23:15:49 INFO - Obtained file size: 22100551 23:15:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:15:53 INFO - Http code: 200 23:15:53 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 23:15:53 INFO - x-amz-cf-id: xbanTrWEhyZGeb-XH6z8UMLRGNIy9DdsrW_0NMRibQYtH9uDI9OMYg== 23:15:53 INFO - x-amz-version-id: nq_xRi390ITI4MZbOFbmyA3Rh0ZVF8m7 23:15:53 INFO - Expected file size: 22100551 23:15:53 INFO - Obtained file size: 22100551 23:15:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:15:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:15:58 INFO - Fetch https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:15:59 INFO - Http code: 200 23:15:59 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 23:15:59 INFO - x-amz-cf-id: nM0dIGjUZfBbZJjKVm3LfyNZkF85bCnkWoDRo5YtQi6duFoqgBWbew== 23:15:59 INFO - x-amz-version-id: v23c.vIQAQ5WiAPmSokuc7LnsV7UvHx6 23:15:59 INFO - Expected file size: 14409006 23:15:59 INFO - Obtained file size: 14409006 23:16:00 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')]} 23:16:00 INFO - trying https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:00 INFO - Downloading https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:16:02 INFO - Downloaded 59780329 bytes. 23:16:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:02 INFO - mkdir: /builds/slave/test/properties 23:16:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:16:02 INFO - Writing to file /builds/slave/test/properties/build_url 23:16:02 INFO - Contents: 23:16:02 INFO - build_url:https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:03 INFO - Running post-action listener: _resource_record_post_action 23:16:03 INFO - Running post-action listener: set_extra_try_arguments 23:16:03 INFO - [mozharness: 2016-10-17 06:16:03.289734Z] Finished download-and-extract step (success) 23:16:03 INFO - [mozharness: 2016-10-17 06:16:03.289960Z] Running populate-webroot step. 23:16:03 INFO - Running pre-action listener: _resource_record_pre_action 23:16:03 INFO - Running main action method: populate_webroot 23:16:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:16:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:16:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:16:03 INFO - '--tppagecycles', 23:16:03 INFO - '7'], 23:16:03 INFO - 'tests': ['tsvgm']}}, 23:16:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:16:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:16:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:16:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:16:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['damp', 'tps']}, 23:16:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'tests': ['damp', 'tps']}, 23:16:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['dromaeo_dom']}, 23:16:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:16:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['basic_compositor_video']}, 23:16:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:16:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['a11yr', 23:16:03 INFO - 'ts_paint', 23:16:03 INFO - 'tpaint', 23:16:03 INFO - 'sessionrestore', 23:16:03 INFO - 'sessionrestore_no_auto_restore', 23:16:03 INFO - 'tabpaint']}, 23:16:03 INFO - 'other-e10s': {'tests': ['a11yr', 23:16:03 INFO - 'ts_paint', 23:16:03 INFO - 'tpaint', 23:16:03 INFO - 'sessionrestore', 23:16:03 INFO - 'sessionrestore_no_auto_restore', 23:16:03 INFO - 'tabpaint']}, 23:16:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:16:03 INFO - 'ts_paint', 23:16:03 INFO - 'tpaint', 23:16:03 INFO - 'sessionrestore', 23:16:03 INFO - 'sessionrestore_no_auto_restore', 23:16:03 INFO - 'tabpaint']}, 23:16:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:16:03 INFO - 'ts_paint', 23:16:03 INFO - 'tpaint', 23:16:03 INFO - 'sessionrestore', 23:16:03 INFO - 'sessionrestore_no_auto_restore', 23:16:03 INFO - 'tabpaint']}, 23:16:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['a11yr', 23:16:03 INFO - 'ts_paint', 23:16:03 INFO - 'tpaint', 23:16:03 INFO - 'sessionrestore', 23:16:03 INFO - 'sessionrestore_no_auto_restore', 23:16:03 INFO - 'tabpaint']}, 23:16:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['a11yr', 23:16:03 INFO - 'ts_paint', 23:16:03 INFO - 'tpaint', 23:16:03 INFO - 'sessionrestore', 23:16:03 INFO - 'sessionrestore_no_auto_restore', 23:16:03 INFO - 'tabpaint']}, 23:16:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['tsvgx', 23:16:03 INFO - 'tsvgr_opacity', 23:16:03 INFO - 'tart', 23:16:03 INFO - 'tscrollx', 23:16:03 INFO - 'cart']}, 23:16:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:16:03 INFO - 'tsvgr_opacity', 23:16:03 INFO - 'tart', 23:16:03 INFO - 'tscrollx', 23:16:03 INFO - 'cart']}, 23:16:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'talos_options': ['--disable-e10s'], 23:16:03 INFO - 'tests': ['tp5o']}, 23:16:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'tests': ['tp5o']}, 23:16:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'talos_options': ['--disable-e10s', 23:16:03 INFO - '--xperf_path', 23:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:03 INFO - 'tests': ['tp5n']}, 23:16:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:03 INFO - 'talos_options': ['--xperf_path', 23:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:03 INFO - 'tests': ['tp5n']}}, 23:16:03 INFO - 'talos.zip': {'path': '', 23:16:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:16:03 INFO - Running post-action listener: _resource_record_post_action 23:16:03 INFO - [mozharness: 2016-10-17 06:16:03.307449Z] Finished populate-webroot step (success) 23:16:03 INFO - [mozharness: 2016-10-17 06:16:03.307537Z] Running create-virtualenv step. 23:16:03 INFO - Running pre-action listener: _resource_record_pre_action 23:16:03 INFO - Running main action method: create_virtualenv 23:16:03 INFO - Creating virtualenv /builds/slave/test/build/venv 23:16:03 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 23:16:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:16:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:16:03 INFO - Using real prefix '/usr' 23:16:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:16:03 INFO - Installing distribute.............................................................................................................................................................................................done. 23:16:05 INFO - Installing pip.................done. 23:16:05 INFO - Return code: 0 23:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:16:06 INFO - Reading from file tmpfile_stdout 23:16:06 INFO - Output received: 23:16:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 23:16:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:16:06 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')]} 23:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:06 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')]} 23:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:06 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:06 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 23:16:06 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 23:16:06 INFO - Using env: {'DISPLAY': ':0', 23:16:06 INFO - 'HOME': '/home/cltbld', 23:16:06 INFO - 'LANG': 'en_US.UTF-8', 23:16:06 INFO - 'LANGUAGE': 'en_US:en', 23:16:06 INFO - 'LOGNAME': 'cltbld', 23:16:06 INFO - 'MAIL': '/var/mail/cltbld', 23:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:06 INFO - 'MOZ_NO_REMOTE': '1', 23:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:06 INFO - 'NO_EM_RESTART': '1', 23:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:06 INFO - 'PWD': '/builds/slave/test', 23:16:06 INFO - 'SHELL': '/bin/bash', 23:16:06 INFO - 'SHLVL': '1', 23:16:06 INFO - 'TERM': 'linux', 23:16:06 INFO - 'TMOUT': '86400', 23:16:06 INFO - 'USER': 'cltbld', 23:16:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:06 INFO - '_': '/tools/buildbot/bin/python'} 23:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:06 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 23:16:06 INFO - Cleaning up... 23:16:06 INFO - Return code: 0 23:16:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:16:06 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')]} 23:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:06 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')]} 23:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:06 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:06 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 23:16:06 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 23:16:06 INFO - Using env: {'DISPLAY': ':0', 23:16:06 INFO - 'HOME': '/home/cltbld', 23:16:06 INFO - 'LANG': 'en_US.UTF-8', 23:16:06 INFO - 'LANGUAGE': 'en_US:en', 23:16:06 INFO - 'LOGNAME': 'cltbld', 23:16:06 INFO - 'MAIL': '/var/mail/cltbld', 23:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:06 INFO - 'MOZ_NO_REMOTE': '1', 23:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:06 INFO - 'NO_EM_RESTART': '1', 23:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:06 INFO - 'PWD': '/builds/slave/test', 23:16:06 INFO - 'SHELL': '/bin/bash', 23:16:06 INFO - 'SHLVL': '1', 23:16:06 INFO - 'TERM': 'linux', 23:16:06 INFO - 'TMOUT': '86400', 23:16:06 INFO - 'USER': 'cltbld', 23:16:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:06 INFO - '_': '/tools/buildbot/bin/python'} 23:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:06 INFO - Downloading/unpacking psutil>=3.1.1 23:16:06 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 23:16:06 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 23:16:06 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 23:16:06 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 23:16:06 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 23:16:06 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 23:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:08 INFO - Installing collected packages: psutil 23:16:08 INFO - Running setup.py install for psutil 23:16:08 INFO - building 'psutil._psutil_linux' extension 23:16:08 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 23:16:08 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 23:16:08 INFO - building 'psutil._psutil_posix' extension 23:16:08 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 23:16:08 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 23:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:09 INFO - Successfully installed psutil 23:16:09 INFO - Cleaning up... 23:16:09 INFO - Return code: 0 23:16:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:16:09 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')]} 23:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:09 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')]} 23:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:09 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:09 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 23:16:09 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 23:16:09 INFO - Using env: {'DISPLAY': ':0', 23:16:09 INFO - 'HOME': '/home/cltbld', 23:16:09 INFO - 'LANG': 'en_US.UTF-8', 23:16:09 INFO - 'LANGUAGE': 'en_US:en', 23:16:09 INFO - 'LOGNAME': 'cltbld', 23:16:09 INFO - 'MAIL': '/var/mail/cltbld', 23:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:09 INFO - 'MOZ_NO_REMOTE': '1', 23:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:09 INFO - 'NO_EM_RESTART': '1', 23:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:09 INFO - 'PWD': '/builds/slave/test', 23:16:09 INFO - 'SHELL': '/bin/bash', 23:16:09 INFO - 'SHLVL': '1', 23:16:09 INFO - 'TERM': 'linux', 23:16:09 INFO - 'TMOUT': '86400', 23:16:09 INFO - 'USER': 'cltbld', 23:16:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:09 INFO - '_': '/tools/buildbot/bin/python'} 23:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:16:09 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 23:16:09 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 23:16:09 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 23:16:09 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 23:16:09 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 23:16:09 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 23:16:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:16:11 INFO - Installing collected packages: mozsystemmonitor 23:16:11 INFO - Running setup.py install for mozsystemmonitor 23:16:11 INFO - Successfully installed mozsystemmonitor 23:16:11 INFO - Cleaning up... 23:16:11 INFO - Return code: 0 23:16:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:16:11 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')]} 23:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:11 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')]} 23:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:11 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:11 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 23:16:11 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 23:16:11 INFO - Using env: {'DISPLAY': ':0', 23:16:11 INFO - 'HOME': '/home/cltbld', 23:16:11 INFO - 'LANG': 'en_US.UTF-8', 23:16:11 INFO - 'LANGUAGE': 'en_US:en', 23:16:11 INFO - 'LOGNAME': 'cltbld', 23:16:11 INFO - 'MAIL': '/var/mail/cltbld', 23:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:11 INFO - 'MOZ_NO_REMOTE': '1', 23:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:11 INFO - 'NO_EM_RESTART': '1', 23:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:11 INFO - 'PWD': '/builds/slave/test', 23:16:11 INFO - 'SHELL': '/bin/bash', 23:16:11 INFO - 'SHLVL': '1', 23:16:11 INFO - 'TERM': 'linux', 23:16:11 INFO - 'TMOUT': '86400', 23:16:11 INFO - 'USER': 'cltbld', 23:16:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:11 INFO - '_': '/tools/buildbot/bin/python'} 23:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:11 INFO - Downloading/unpacking jsonschema==2.5.1 23:16:11 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 23:16:11 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 23:16:11 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 23:16:11 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 23:16:11 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 23:16:11 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 23:16:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:16:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:16:13 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 23:16:13 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 23:16:13 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 23:16:13 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 23:16:13 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 23:16:13 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 23:16:13 INFO - Downloading functools32-3.2.3-2.tar.gz 23:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:16:13 INFO - warning: no files found matching '*.txt' 23:16:13 INFO - no previously-included directories found matching 'build' 23:16:13 INFO - no previously-included directories found matching 'dist' 23:16:13 INFO - no previously-included directories found matching '.git*' 23:16:13 INFO - Installing collected packages: jsonschema, functools32 23:16:13 INFO - Running setup.py install for functools32 23:16:13 INFO - warning: no files found matching '*.txt' 23:16:13 INFO - no previously-included directories found matching 'build' 23:16:13 INFO - no previously-included directories found matching 'dist' 23:16:13 INFO - no previously-included directories found matching '.git*' 23:16:14 INFO - Successfully installed jsonschema functools32 23:16:14 INFO - Cleaning up... 23:16:14 INFO - Return code: 0 23:16:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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', '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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:16: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 functools32==3.2.3-2 23:16:14 INFO - Using env: {'DISPLAY': ':0', 23:16:14 INFO - 'HOME': '/home/cltbld', 23:16:14 INFO - 'LANG': 'en_US.UTF-8', 23:16:14 INFO - 'LANGUAGE': 'en_US:en', 23:16:14 INFO - 'LOGNAME': 'cltbld', 23:16:14 INFO - 'MAIL': '/var/mail/cltbld', 23:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:14 INFO - 'MOZ_NO_REMOTE': '1', 23:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:14 INFO - 'NO_EM_RESTART': '1', 23:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:14 INFO - 'PWD': '/builds/slave/test', 23:16:14 INFO - 'SHELL': '/bin/bash', 23:16:14 INFO - 'SHLVL': '1', 23:16:14 INFO - 'TERM': 'linux', 23:16:14 INFO - 'TMOUT': '86400', 23:16:14 INFO - 'USER': 'cltbld', 23:16:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:14 INFO - '_': '/tools/buildbot/bin/python'} 23:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:16:14 INFO - Cleaning up... 23:16:14 INFO - Return code: 0 23:16:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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', '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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:16: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 blobuploader==1.2.4 23:16:14 INFO - Using env: {'DISPLAY': ':0', 23:16:14 INFO - 'HOME': '/home/cltbld', 23:16:14 INFO - 'LANG': 'en_US.UTF-8', 23:16:14 INFO - 'LANGUAGE': 'en_US:en', 23:16:14 INFO - 'LOGNAME': 'cltbld', 23:16:14 INFO - 'MAIL': '/var/mail/cltbld', 23:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:14 INFO - 'MOZ_NO_REMOTE': '1', 23:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:14 INFO - 'NO_EM_RESTART': '1', 23:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:14 INFO - 'PWD': '/builds/slave/test', 23:16:14 INFO - 'SHELL': '/bin/bash', 23:16:14 INFO - 'SHLVL': '1', 23:16:14 INFO - 'TERM': 'linux', 23:16:14 INFO - 'TMOUT': '86400', 23:16:14 INFO - 'USER': 'cltbld', 23:16:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:14 INFO - '_': '/tools/buildbot/bin/python'} 23:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:14 INFO - Downloading/unpacking blobuploader==1.2.4 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:16 INFO - Downloading blobuploader-1.2.4.tar.gz 23:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:16:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:16:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:17 INFO - Downloading docopt-0.6.1.tar.gz 23:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:17 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:17 INFO - Running setup.py install for blobuploader 23:16:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:17 INFO - Running setup.py install for requests 23:16:17 INFO - Running setup.py install for docopt 23:16:17 INFO - Successfully installed blobuploader requests docopt 23:16:17 INFO - Cleaning up... 23:16:17 INFO - Return code: 0 23:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:17 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')]} 23:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:17 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')]} 23:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:17 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:17 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 23:16:17 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 23:16:17 INFO - Using env: {'DISPLAY': ':0', 23:16:17 INFO - 'HOME': '/home/cltbld', 23:16:17 INFO - 'LANG': 'en_US.UTF-8', 23:16:17 INFO - 'LANGUAGE': 'en_US:en', 23:16:17 INFO - 'LOGNAME': 'cltbld', 23:16:17 INFO - 'MAIL': '/var/mail/cltbld', 23:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:17 INFO - 'MOZ_NO_REMOTE': '1', 23:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:17 INFO - 'NO_EM_RESTART': '1', 23:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:17 INFO - 'PWD': '/builds/slave/test', 23:16:17 INFO - 'SHELL': '/bin/bash', 23:16:17 INFO - 'SHLVL': '1', 23:16:17 INFO - 'TERM': 'linux', 23:16:17 INFO - 'TMOUT': '86400', 23:16:17 INFO - 'USER': 'cltbld', 23:16:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:17 INFO - '_': '/tools/buildbot/bin/python'} 23:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:18 INFO - Running setup.py (path:/tmp/pip-_ceIUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:18 INFO - Running setup.py (path:/tmp/pip-OHfqud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:18 INFO - Running setup.py (path:/tmp/pip-ZZitxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:18 INFO - Running setup.py (path:/tmp/pip-DV0hsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:18 INFO - Running setup.py (path:/tmp/pip-6tq4xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:18 INFO - Running setup.py (path:/tmp/pip-wC9EOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:18 INFO - Running setup.py (path:/tmp/pip-ZaZGZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:18 INFO - Running setup.py (path:/tmp/pip-DKVjOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:18 INFO - Running setup.py (path:/tmp/pip-YHQwo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:18 INFO - Running setup.py (path:/tmp/pip-JVOFBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:18 INFO - Running setup.py (path:/tmp/pip-F66sTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:18 INFO - Running setup.py (path:/tmp/pip-QRGrG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:18 INFO - Running setup.py (path:/tmp/pip-8wygt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:18 INFO - Running setup.py (path:/tmp/pip-OTPG_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:19 INFO - Running setup.py (path:/tmp/pip-LbLgM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:19 INFO - Running setup.py (path:/tmp/pip-3M2Y6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:19 INFO - Running setup.py (path:/tmp/pip-KlF_L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:19 INFO - Running setup.py install for manifestparser 23:16:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:19 INFO - Running setup.py install for mozcrash 23:16:19 INFO - Running setup.py install for mozdebug 23:16:19 INFO - Running setup.py install for mozdevice 23:16:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:19 INFO - Running setup.py install for mozfile 23:16:19 INFO - Running setup.py install for mozhttpd 23:16:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:19 INFO - Running setup.py install for mozinfo 23:16:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:19 INFO - Running setup.py install for mozInstall 23:16:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Running setup.py install for mozleak 23:16:20 INFO - Running setup.py install for mozlog 23:16:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Running setup.py install for moznetwork 23:16:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Running setup.py install for mozprocess 23:16:20 INFO - Running setup.py install for mozprofile 23:16:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Running setup.py install for mozrunner 23:16:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:20 INFO - Running setup.py install for mozscreenshot 23:16:20 INFO - Running setup.py install for moztest 23:16:20 INFO - Running setup.py install for mozversion 23:16:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:21 INFO - Cleaning up... 23:16:21 INFO - Return code: 0 23:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:21 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:21 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 23:16:21 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 23:16:21 INFO - Using env: {'DISPLAY': ':0', 23:16:21 INFO - 'HOME': '/home/cltbld', 23:16:21 INFO - 'LANG': 'en_US.UTF-8', 23:16:21 INFO - 'LANGUAGE': 'en_US:en', 23:16:21 INFO - 'LOGNAME': 'cltbld', 23:16:21 INFO - 'MAIL': '/var/mail/cltbld', 23:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:21 INFO - 'MOZ_NO_REMOTE': '1', 23:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:21 INFO - 'NO_EM_RESTART': '1', 23:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:21 INFO - 'PWD': '/builds/slave/test', 23:16:21 INFO - 'SHELL': '/bin/bash', 23:16:21 INFO - 'SHLVL': '1', 23:16:21 INFO - 'TERM': 'linux', 23:16:21 INFO - 'TMOUT': '86400', 23:16:21 INFO - 'USER': 'cltbld', 23:16:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:21 INFO - '_': '/tools/buildbot/bin/python'} 23:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:21 INFO - Running setup.py (path:/tmp/pip-zXKnxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:21 INFO - Running setup.py (path:/tmp/pip-EeyrjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:21 INFO - Running setup.py (path:/tmp/pip-QhqM2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:21 INFO - Running setup.py (path:/tmp/pip-HVkzEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:21 INFO - Running setup.py (path:/tmp/pip-bNxLYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:21 INFO - Running setup.py (path:/tmp/pip-PY9JOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:21 INFO - Running setup.py (path:/tmp/pip-klBESf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:21 INFO - Running setup.py (path:/tmp/pip-igp_wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:21 INFO - Running setup.py (path:/tmp/pip-5nfMxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:21 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)) 23:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:21 INFO - Running setup.py (path:/tmp/pip-0HYFbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 23:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:22 INFO - Running setup.py (path:/tmp/pip-g69C8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:22 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)) 23:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:22 INFO - Running setup.py (path:/tmp/pip-T77R_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:22 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)) 23:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:22 INFO - Running setup.py (path:/tmp/pip-TMOWsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:22 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)) 23:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:22 INFO - Running setup.py (path:/tmp/pip-I28fdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:22 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)) 23:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:22 INFO - Running setup.py (path:/tmp/pip-uvbK_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:22 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)) 23:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:22 INFO - Running setup.py (path:/tmp/pip-d_slOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:22 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)) 23:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:22 INFO - Running setup.py (path:/tmp/pip-edMVsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:22 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)) 23:16:22 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)) 23:16:22 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)) 23:16:22 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)) 23:16:22 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)) 23:16:22 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)) 23:16:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:24 INFO - Downloading blessings-1.6.tar.gz 23:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:16:24 INFO - Installing collected packages: blessings 23:16:24 INFO - Running setup.py install for blessings 23:16:24 INFO - Successfully installed blessings 23:16:24 INFO - Cleaning up... 23:16:24 INFO - Return code: 0 23:16:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:16:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:24 INFO - Reading from file tmpfile_stdout 23:16:24 INFO - Current package versions: 23:16:24 INFO - argparse == 1.2.1 23:16:24 INFO - blessings == 1.6 23:16:24 INFO - blobuploader == 1.2.4 23:16:24 INFO - docopt == 0.6.1 23:16:24 INFO - functools32 == 3.2.3-2 23:16:24 INFO - jsonschema == 2.5.1 23:16:24 INFO - manifestparser == 1.1 23:16:24 INFO - mozInstall == 1.12 23:16:24 INFO - mozcrash == 0.17 23:16:24 INFO - mozdebug == 0.1 23:16:24 INFO - mozdevice == 0.48 23:16:24 INFO - mozfile == 1.2 23:16:24 INFO - mozhttpd == 0.7 23:16:24 INFO - mozinfo == 0.9 23:16:24 INFO - mozleak == 0.1 23:16:24 INFO - mozlog == 3.4 23:16:24 INFO - moznetwork == 0.27 23:16:24 INFO - mozprocess == 0.23 23:16:24 INFO - mozprofile == 0.28 23:16:24 INFO - mozrunner == 6.12 23:16:24 INFO - mozscreenshot == 0.1 23:16:24 INFO - mozsystemmonitor == 0.3 23:16:24 INFO - moztest == 0.7 23:16:24 INFO - mozversion == 1.4 23:16:24 INFO - psutil == 3.1.1 23:16:24 INFO - requests == 1.2.3 23:16:24 INFO - wsgiref == 0.1.2 23:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:24 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')]} 23:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:24 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')]} 23:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:24 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:24 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 23:16:24 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 23:16:24 INFO - Using env: {'DISPLAY': ':0', 23:16:24 INFO - 'HOME': '/home/cltbld', 23:16:24 INFO - 'LANG': 'en_US.UTF-8', 23:16:24 INFO - 'LANGUAGE': 'en_US:en', 23:16:24 INFO - 'LOGNAME': 'cltbld', 23:16:24 INFO - 'MAIL': '/var/mail/cltbld', 23:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:24 INFO - 'MOZ_NO_REMOTE': '1', 23:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:24 INFO - 'NO_EM_RESTART': '1', 23:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:24 INFO - 'PWD': '/builds/slave/test', 23:16:24 INFO - 'SHELL': '/bin/bash', 23:16:24 INFO - 'SHLVL': '1', 23:16:24 INFO - 'TERM': 'linux', 23:16:24 INFO - 'TMOUT': '86400', 23:16:24 INFO - 'USER': 'cltbld', 23:16:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:24 INFO - '_': '/tools/buildbot/bin/python'} 23:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 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)) 23:16:25 INFO - Cleaning up... 23:16:25 INFO - Return code: 0 23:16:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:25 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 0x7fe622f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', '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 23:16:25 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 23:16:25 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 23:16:25 INFO - Using env: {'DISPLAY': ':0', 23:16:25 INFO - 'HOME': '/home/cltbld', 23:16:25 INFO - 'LANG': 'en_US.UTF-8', 23:16:25 INFO - 'LANGUAGE': 'en_US:en', 23:16:25 INFO - 'LOGNAME': 'cltbld', 23:16:25 INFO - 'MAIL': '/var/mail/cltbld', 23:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:25 INFO - 'MOZ_NO_REMOTE': '1', 23:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:25 INFO - 'NO_EM_RESTART': '1', 23:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:25 INFO - 'PWD': '/builds/slave/test', 23:16:25 INFO - 'SHELL': '/bin/bash', 23:16:25 INFO - 'SHLVL': '1', 23:16:25 INFO - 'TERM': 'linux', 23:16:25 INFO - 'TMOUT': '86400', 23:16:25 INFO - 'USER': 'cltbld', 23:16:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:25 INFO - '_': '/tools/buildbot/bin/python'} 23:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:16:25 INFO - Cleaning up... 23:16:25 INFO - Return code: 0 23:16:25 INFO - Running post-action listener: _resource_record_post_action 23:16:25 INFO - Running post-action listener: _start_resource_monitoring 23:16:25 INFO - Starting resource monitoring. 23:16:25 INFO - [mozharness: 2016-10-17 06:16:25.428151Z] Finished create-virtualenv step (success) 23:16:25 INFO - [mozharness: 2016-10-17 06:16:25.428805Z] Running install step. 23:16:25 INFO - Running pre-action listener: _resource_record_pre_action 23:16:25 INFO - Running main action method: install 23:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:25 INFO - Reading from file tmpfile_stdout 23:16:25 INFO - Detecting whether we're running mozinstall >=1.0... 23:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:16:25 INFO - Reading from file tmpfile_stdout 23:16:25 INFO - Output received: 23:16:25 INFO - Usage: mozinstall [options] installer 23:16:25 INFO - Options: 23:16:25 INFO - -h, --help show this help message and exit 23:16:25 INFO - -d DEST, --destination=DEST 23:16:25 INFO - Directory to install application into. [default: 23:16:25 INFO - "/builds/slave/test"] 23:16:25 INFO - --app=APP Application being installed. [default: firefox] 23:16:25 INFO - mkdir: /builds/slave/test/build/application 23:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:16:42 INFO - Reading from file tmpfile_stdout 23:16:42 INFO - Output received: 23:16:42 INFO - /builds/slave/test/build/application/firefox/firefox 23:16:42 INFO - Running post-action listener: _resource_record_post_action 23:16:42 INFO - [mozharness: 2016-10-17 06:16:42.746857Z] Finished install step (success) 23:16:42 INFO - [mozharness: 2016-10-17 06:16:42.747101Z] Running run-tests step. 23:16:42 INFO - Running pre-action listener: _resource_record_pre_action 23:16:42 INFO - Running main action method: run_tests 23:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:16:42 INFO - Python 2.7.3 23:16:42 INFO - Return code: 0 23:16:42 INFO - grabbing minidump binary from tooltool 23:16:42 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')]} 23:16:42 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 0x2a0d930>, '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 0x2a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0ecc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:16:42 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 23:16:42 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 23:16:42 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 23:16:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:16:42 INFO - Return code: 0 23:16:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:16:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:16:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:16:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:16:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 23:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 23:16:42 INFO - Using env: {'DISPLAY': ':0', 23:16:42 INFO - 'HOME': '/home/cltbld', 23:16:42 INFO - 'LANG': 'en_US.UTF-8', 23:16:42 INFO - 'LANGUAGE': 'en_US:en', 23:16:42 INFO - 'LOGNAME': 'cltbld', 23:16:42 INFO - 'MAIL': '/var/mail/cltbld', 23:16:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:16:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:42 INFO - 'MOZ_NO_REMOTE': '1', 23:16:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:42 INFO - 'NO_EM_RESTART': '1', 23:16:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:42 INFO - 'PWD': '/builds/slave/test', 23:16:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:16:42 INFO - 'SHELL': '/bin/bash', 23:16:42 INFO - 'SHLVL': '1', 23:16:42 INFO - 'TERM': 'linux', 23:16:42 INFO - 'TMOUT': '86400', 23:16:42 INFO - 'USER': 'cltbld', 23:16:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712', 23:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:42 INFO - '_': '/tools/buildbot/bin/python'} 23:16:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 23:16:43 INFO - mozversion application_buildid: 20161016201455 23:16:43 INFO - mozversion application_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 23:16:43 INFO - mozversion application_display_name: Nightly 23:16:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:16:43 INFO - mozversion application_name: Firefox 23:16:43 INFO - mozversion application_remotingname: firefox 23:16:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:16:43 INFO - mozversion application_vendor: Mozilla 23:16:43 INFO - mozversion application_version: 52.0a1 23:16:43 INFO - mozversion platform_buildid: 20161016201455 23:16:43 INFO - mozversion platform_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 23:16:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:16:43 INFO - mozversion platform_version: 52.0a1 23:16:43 INFO - using testdate: 1476685003 23:16:43 INFO - actual date: 1476685003 23:16:43 INFO - starting webserver on 'localhost:50410' 23:16:43 INFO - SUITE-START | Running 2 tests 23:16:43 INFO - TEST-START | dromaeo_css 23:16:43 INFO - operating with platform_type : linux_ 23:16:43 INFO - Initialising browser for dromaeo_css test... 23:16:43 INFO - TEST-INFO | started process 22647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZtV79/profile http://localhost:50410/getInfo.html) 23:16:47 INFO - PROCESS | 22647 | __metrics Screen width/height:1600/1200 23:16:47 INFO - PROCESS | 22647 | colorDepth:24 23:16:47 INFO - PROCESS | 22647 | Browser inner width/height: 1024/697 23:16:47 INFO - PROCESS | 22647 | __metrics 23:16:48 ERROR - PROCESS | 22647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 23:16:49 INFO - TEST-INFO | 22647: exit 0 23:16:49 INFO - Browser initialized. 23:16:49 INFO - Running cycle 1/1 for dromaeo_css test... 23:16:49 INFO - TEST-INFO | started process 22773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZtV79/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:01 INFO - PROCESS | 22773 | RSS: Main: 185233408 23:17:01 INFO - PROCESS | 22773 | 23:17:51 INFO - PROCESS | 22773 | 1476685071367 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] 23:20:02 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50410/tests/dromaeo/cssquery-ext.html) 23:20:03 INFO - PROCESS | 22773 | RSS: Main: 197992448 23:20:03 INFO - PROCESS | 22773 | 23:23:06 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-ext.html (next: http://localhost:50410/tests/dromaeo/cssquery-jquery.html) 23:23:06 INFO - PROCESS | 22773 | RSS: Main: 199028736 23:23:06 INFO - PROCESS | 22773 | 23:26:08 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50410/tests/dromaeo/cssquery-mootools.html) 23:26:09 INFO - PROCESS | 22773 | RSS: Main: 200310784 23:26:09 INFO - PROCESS | 22773 | 23:29:11 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50410/tests/dromaeo/cssquery-prototype.html) 23:29:11 INFO - PROCESS | 22773 | RSS: Main: 194678784 23:29:11 INFO - PROCESS | 22773 | 23:32:14 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50410/tests/dromaeo/cssquery-yui.html) 23:32:15 INFO - PROCESS | 22773 | RSS: Main: 198451200 23:32:15 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-yui.html (next: http://localhost:50410/tests/dromaeo/cssquery-dojo.html) 23:35:18 INFO - PROCESS | 22773 | RSS: Main: 198647808 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | __start_tp_report 23:35:18 INFO - PROCESS | 22773 | _x_x_mozilla_page_load 23:35:18 INFO - PROCESS | 22773 | _x_x_mozilla_page_load_details 23:35:18 INFO - PROCESS | 22773 | |i|pagename|runs| 23:35:18 INFO - PROCESS | 22773 | |0;dojo.html;3017.698230176982;3056.1137270191643;3079.8306093164874;3081.5685803987444;3102.2089367211356;5191.299174611436;5323.467653234675;5372.22102795095;5388.730563471825;5474.644148130379;5216.843494695156;5251.5798736101115;5275.657082289648;5324.893502129955;5351.331083614548;4726.692764970266;4761.928571071437;4832.589229915444;4834.9516504834855;4894.192458244385;4711.623070154396;4734.739589322586;4778.402699662543;4791.041791641668;4794.9280760788615;4673.649476289258;4725.952740472586;4879.902401951977;4890.266460030988;4922.55696987271;4798.0643774464;4821.252705830602;4831.106245344622;4874.53691899269;4898.828541001048;4790;4793.257045157971;4794.904101917942;4802.615790736732;4850.248211527219;5152.896942061137;5183.688978661255;5198.662086964373;5214.426413094557;5310.60170487215;5468.535174510132;5581.665100093966;5619.887602247973;5626.352969408488;5714.9714251428895;5657.264555607745;5667.376588575254;5677.205191273184;5687.175359572881;5702.059160238556;5298.629095963284;5307.336582927134;5327.627066105335;5348.411674715778;5359.22291267764;5494.587905907073;5560.833175004756;5691.516221121251;5708.857278568069;5778.3354914184565;5558.944410555923;5566.693831839207;5566.805161819398;5593.188987596775;5614.157876318585;5550.834324791839;5593.105103183552;5607.551395888319;5615.298087739033;5660.5471562274915;5352.143657014859;5415.296011518478;5536.667799932017;5594.9720251398485;5617.38208797032;5614.045612245928;5644.491995720405;5653.095504719226;5654.943450565442;5693.231413759089;4267.829286828554;4316.44670504616;4326.891827704269;4334.653227741773;4377;3777.433384992273;3797.145642230476;3804.068003339144;3823.541175058955;3897.7661340319673;5293.100172970528;5330.880515091874;5342.252084708144;5382.407935127133;5391.433899440581;5584.246126772834;5595.328560572757;5626.099824028136;5639.689817060019;5643.633163844337;5155.7679904404395;5205.609579281569;5213.374395072616;5280.339957505312;5336.866578335573;4724.622030237572;4771.618270538349;4783;4790.544898234732;4796.304535842283;5780.5953583248765;5784.074548072288;5789.421057894261;5792.0732682771395;5797.971010144923;5559.33288005442;5568.693721845338;5573.721313934206;5575.944240557543;5576.804811831566;5721.427857214246;5751.309842818889;5760.1935728998815;5763.913541296968;5772.7690892363835;5324.680519168863;5349.812756553502;5360.383555891122;5362.436944120811;5366.6779993200535;5439.0753571893665;5445.373782015119;5448.264484294728;5636.267285252891;5657.207990881362;5589.55283577321;5591.860203494945;5596.888062238814;5604.187392827936;5605.215269862304;5342.439043900335;5509;5515.4760297771645;5538.949612114967;5562.2212890196215;5323.441038690882;5333.173358129496;5337.946620533745;5368.087425137658;5428;5441.891162176814;5483.369412517612;5487.890242195213;5491.0939694951485;5497.615166938276;5357.70532620694;5363.946360536344;5368.141097424394;5379.704116273642;5443.537299329443 23:35:18 INFO - PROCESS | 22773 | |1;ext.html;544.241411907231;577.7746678795268;580.9709514524274;585.5608293779666;591.5977135547827;42417.151656966846;43758;43770.781146094305;46730.29904551426;46824;43032.569674303246;43440.13119737603;43725;43740.34389484152;43800;8849.380543361967;8984;9019.143181397756;9037.864432033524;9083;8880.46717196967;8929.821403571957;8946.552672366388;8962.910370896305;8997.865032024525;8908.287337013024;8968.865467018;8992.775180620503;9002.954985225097;9032.322575806807;8977;9015.774605634846;9034.412763170372;9037.954810225972;9050;8762.255208307302;8859.025507194203;8869.2017718405;8878.200961913459;8883.822323553493;42329.365059524134;42529.78735106336;42584.361234581505;42868;42987.78506107481;3436.1581412553833;3552.928941421157;3859.5754467008605;3979.4826672532677;4001.7598944063448;31326.686733132607;31343;31641;31753.682463175304;31779.364412711617;4282.700210985232;4305.763183024932;4333.761643109628;4473.686841921034;4511.2330903746115;335303;337241.99999999756;339002;340094;341845;57833;58192.709036454544;58295.70852145712;58377;58425.415745841994;61347;61588;61661.69169154126;61921.69039154775;61964;16478.2584783685;16493.917530412273;16551.586210344838;16723;16740.41408550695;13293.06948513614;13430.9255259579;13450.394732237073;13464.663383415493;13521.864781352257;16552.668946621;17667.293308267526;17756.55608609769;17819.821801782076;18033;5637.605367624309;5747.85630359236;5892.1161825726485;5986.760529578768;6093.216824792606;874.3529787956866;962.7737481691797;1012.3268026762121;1023.698009087321;1041.7551875309296;31329.68670313313;31378.52932206019;31426;31467.52798708021;32008.67991320057;1052.1582733813073;1052.3317693264833;1072.3190773858655;1100.9614663486739;1119.4962266979892;16225.51323460298;16688.499345019667;16717.83282167187;16721.907195910986;16841.6631667366;499058;502037;503958;504626;504739;56673.149902751495;57487.42512574821;57495.42504574984;57532.424675753544;57945.420545794004;1280.8527019392702;1339.5378594384922;1344.7915573086186;1351.4459071780523;1361.4282001559368;29172.708272917;30484.866059376516;30615.2346191347;30966.845165774026;31285.843570782912;50718;51228;51473.7426312866;51591.226131607305;51913.7404312976;312459;315035;315138;315224;316165;27037.86481067582;28254.293642659097;28358.149255522367;29823;41390.58609413867;44075;44946.550534494236;45178.77410612926;45223.773881130386;45830.08339833118;36757.44863827098;37479.25041499209;37567.43648845324;37685.623143768215;37787.24425511529;37686.434703480016;37946.43080353852;37978.43032354461;38066.85799425911;38430.964748700986;33997.49003764995;34668.30663386769;37102.814485927396;38420.42369364406;39230.215395692496;34445.48331775075;36691.266174675824;36877.44683829798;37400.812995934844;37533.62466375301;33563;34698.826505867306;35970.640293597775;36007.27985440329;36254.637453625124 23:35:18 INFO - PROCESS | 22773 | |2;jquery.html;372.8657683234037;383.0863390812914;397.6560275361812;405.83766493402646;417.9540250572438;14071.366788494517;18029.639407211864;18682.159302831373;19681.704774428377;19754.111065002056;18530.846427571858;18731.25074997002;18960.241590336405;19077.618447631074;19186;5627.6904770237625;5670.262865827437;5768.682722450264;5812.709364531777;5865.824025279248;5714.885702285952;5802.5938184327115;5803.912941305884;5808.738606762706;5825.766969321222;5527.309086364205;5735.827925162252;5745.971270143644;5749.080147176453;5754.395788442195;5516.338039435253;5722.456366645162;5753.884922301572;5766.682832444235;5782.913256301159;5107.1828507439;5112.616553758483;5120.948790512084;5140.74296285188;5172.224166375074;21532.569348613095;22104.88947555268;22214.222502212506;22340.776592234033;22556;2401.7117945846435;2421.539907417585;2783.832970021805;3051.786374953754;3055.908322750299;13332.933335333359;13794.93102534491;14018.649533761738;14420.206888621122;14656.853431465655;1905.2914281742865;2001.3995801259564;2030.1168991488603;2054.1783286685295;2056.259746491262;81301;81865.59067204685;82506.17493825045;83145.58427207886;83568;10411.947940260401;10639.893601064045;10654.283157794713;11005.394703291397;11075.889241107487;13005.739885202433;14859.554213373616;14953.02805317651;15042.774358384633;15094.924525377523;7701.422393320523;7885.2114788520685;8232.958835205785;8335.541545215072;8380.8742868857;8035.678572857137;8227.13615070421;8243.422960392714;8369.414141010071;8440.11378805229;6274.372562743689;6329.810105696836;6391.456726178327;6440.420362167334;6572.539922205496;1958.5005823515198;1994.3917105282737;1998.7701414337537;2019.9899000504904;2040.3980825656467;872.4242000279785;950.8098380323963;1020.3877673395903;1020.5560581147224;1024.4416792847917;19069.141888615046;19191.712124318146;19352.129154188096;19368.515787105436;19671.508212294808;990.895955924632;1009.4347165587294;1031.6904928521415;1061.596593294543;1078.0513148429332;10098.343607665478;10400.427976461217;10885.129189664807;11013.83479247812;11346.235485079285;415344;451818;473681;480832;482642;92824;93039;93383;94671;94966;1000.0799264676515;1045.581767293089;1054.2778196935124;1064.462446464546;1087.7171935296722;16400.589985250463;16461.917690411472;16931.32274709047;17481.737773933146;17782.822171778633;41448.58551414447;41637;42116.36825447682;42168;42771.7861410691;52509.737451312496;53164.4683553175;53204.2019369702;57798;61459;6921.965390173017;7158;7178.748743793943;7540.509866858856;8145.144759800136;11185.272957258077;12732.23606583608;12786.232826030468;12885.613431597067;13068.215907045607;11311.547538098384;11384.37385943781;11399.715007124889;11511.985402554352;11529.538818447169;5235.65968212065;5272.156454967187;7178.856422871618;8210.548419836967;11311.151663625096;11100.333979961228;11181.385023823768;11380.772384552098;11385.886141138482;11702.648920532398;7442.590657513889;7515.586642734702;7547.018887544584;7741.264579864904;8085.191480852103;11012.17408694335;11059.783423823534;11302.4913878874;11314.208005439541;11479.36863472517 23:35:18 INFO - PROCESS | 22773 | |3;mootools.html;1466.8459811719772;1494.8878834087445;1645.5639255597268;1735.9739603905937;1747.0565894417016;7561.2060733623;7820.06159260888;8078.636461359239;8550.486970781749;8744.912550874496;7916.366690664748;8175.959120204406;8278.254957053863;8513.404061715682;8517.957410212955;2270.5004898922252;2305.608046632068;2314.375118717945;2321.6865723127416;2332.1137967572386;2210.812080973119;2241.540484200735;2251.470904337479;2252.042881775247;2264.501809601893;2312.8727919964394;2325;2342.5783358995373;2346.4133966508375;2348.5302939412186;2221.1115553778454;2223.8665680059166;2226.7773222677765;2234.307364716935;2246.4383904023994;2204.790544898232;2220.6113930062174;2228.320362289501;2228.320362289501;2246.696695946043;8626.611802468904;8674.175953284428;8698.521581313025;8732.51971141587;8739.645354969989;5014.924776128361;5175.430702622709;5176.301199338116;5181.248718935733;5192.3249977503065;3202.455582550972;3277.147941535194;3365.528825964367;3379.290349026707;3419.059758566389;1208.7401208740164;1217.5738491527895;2143.528423746773;2205.614017546939;2206.7572567017614;11991.400429978466;12041.277523348626;12096.455659495345;12148.9673377763;12168.57409990655;4278.229918614679;4409;4411.801468933906;4582.1293954148605;4629.560191781776;9485;9498.192653624381;9498.572564234626;9510.762230944143;9523.380980236263;5074.568661663726;5078.923816142761;5079;5080.441151473335;5083.212102124176;4197.412362269285;4321.027768752006;4658.836940707059;4786.8085276589245;4788.592969597554;3666.9083272917856;3759.793211373401;3787.2046870157023;3801.954462522773;3824.9808750956067;1023.4473384372504;1033.5762337441613;1043.0768769638773;1048.6172547020435;1049.8372752223418;864.8659457784054;876.8246350729879;887.2414085956543;927.1701826865053;930.6040938592112;5549.556035517149;5616.157576363496;5650.915236271459;5706.9429305707245;5777.451142141574;933.8365785987424;935.8315503209487;968.7771812483169;973.3429934793986;1003.2976916158718;3697.7041836653;3784.7918364489665;3837.827297771607;3873.96126038736;3882.417637354363;10488.160947124212;10820.458977051116;10886.29239099456;10910.127189824794;10921.180911431675;10722.035016848366;10750.73123171927;10756;10797.08224800885;10805.405702686428;7566.886496702554;7903.826447726921;8048.758537243892;8103.594820258963;8202.38482113844;5478.534324582296;5575.414581468887;5631.915521267102;5684.573656975661;5710.314762228559;9571.856422153813;9643;9846.45844478532;9907.554160062959;9966.202703783534;9932.255080869108;9997.750056248651;10022.599096036078;10028.548715307974;10099.091081802673;6612.801615951529;6817.829554261183;7214.819629509304;7354.521956072838;7405;8027;8359.58202089881;8388.161183881562;8409.117042710428;8427.789305267417;7276.8908466374105;7439.107307123179;7487.962560187382;7494;7567.772966811004;7004.684789184601;7041.788746337618;7128.85742285141;7280.635968201675;7371.262873712586;6412.743490260337;6495.642739649365;6551.770688026087;6589.143411356493;6605.438537724347;4584.358189853357;4644.047970166175;4678.766061696833;4709.317149013443;4758.952410475989;4908;4933.112039832865;4953.900921981613;5016.59867210615;5021.221710634857 23:35:18 INFO - PROCESS | 22773 | |4;prototype.html;320.73539330052705;326.4874147588286;327.74927180706766;333.8747969511433;336.04060407536497;5353.946460535393;5397.649152805065;5413.756380962856;5430.53840423564;5440.782368705252;5302.787888484466;5304.946950530493;5310.0972834618115;5313.751268451911;5322.733863306838;3941.8226179821977;4006.759594424344;4071.694622903279;4160.979195104021;4176.97911510442;4157.334826427772;4159.2721273777115;4170.70805043647;4174.352975288835;4192.790360481964;4128.360104183841;4132.524759652649;4139.523954745197;4142.109446469009;4145.834166633331;4047.069174089961;4100.339362558168;4105.486814148231;4131.8967025824295;4161.313383291753;3645.3620616392027;3647.8176091195332;3653.214558869829;3656.213914008501;3656.469811877263;5125.718085505296;5152.768125434364;5182.352205974254;5191.8182863599595;5212.739363031833;4643.535646435364;4659.580637742585;4727.487204094691;4761.357216775726;4761.619070474354;5504.339479262474;5511.090670039439;5523.889522209533;5529.419410961831;5538.972305138489;3997.7401468904427;4001.919961600781;4002.639762421396;4006.278869803434;4011.3782363733667;5510.925369552939;5716.79991200306;5738.713064346766;5745.770169193227;5792.333881603628;4111.759091295192;4113.4035564843525;4115.403266526337;4120.651228799616;4120.825564714102;4157.417961485395;4158.91682166355;4160.105577300835;4166.500019997619;4168.541460439349;4409.867703968886;4735.976320118378;4736.64475164364;4737.531365276775;4758.571728544448;5587.38538760736;5606.6916319602;5612.410696876851;5628.324601047819;5633.408492108351;1403.487726979645;1424.5655075202162;1424.950126745559;1427.4432971141264;1427.5931359562476;822.7943014246439;859.9140085991351;863.9632441070614;877.5875338590852;895.1272509303377;5140.691558506502;5196.194589838581;5389.434109418533;5390;5423.511883930465;5728.54171666274;5770.134479827975;5771.797987070432;5783.479486846204;5789.478946894716;5242.151010315519;5313.601479889024;5345.893082138413;5367.409584945653;5376.440832158708;3026.0028381268257;3067.8619462124257;3075.3234288456506;3078.3997120561276;3088;5949.286085669747;5955.493783028404;5958.910616340759;5984.401559843981;6001.549883758736;5538.6122971391615;5869.647821130746;5944.138099975566;5954.196183515257;5954.315253745788;6076.511254742616;6084.787032453932;6084.939150608526;6087.208662873887;6103.9694801527485;5577.247071645276;5718;5743.798967036134;5757.913631295618;5782.17861373666;5706.28671416073;5707.429257074259;5708;5709.8287051388525;5714.20001199824;5883.558733094949;5992.221011268682;5992.400759923973;6003.759849606142;6004.799040191891;4107.835686572504;4124.731892427103;4168.916621667489;4183.644390226865;4186.979065104655;5824.70876456167;5829.038208695518;5835.854103647443;5837.182794408701;5843.7370318336625;5392.865178370415;5569.916451253153;5691.601587888974;5691.630044047124;5714.514226301275;5619.80330688424;5633.549316054624;5643.209950606836;5667;5672.971635141798;5526.419725928719;5533.833984980457;5564.803567233064;5583.637063590853;5596.972015139898;5303.628745987744;5405.945840561053;5689.829305120853;5705.800296989585;5732.226149469769;5581.35350071738;5587.245721827501;5590.468905453975;5594.888102237851;5595.956367123578 23:35:18 INFO - PROCESS | 22773 | |5;yui.html;653.9934600653995;692.3837784371909;724.0551080839506;729.8613263479936;815.5677490929808;14618.195999220039;15673.294701738421;15696.450624228155;15716.292766825492;15725.877006604105;14731.92634036831;14813.925930370333;14824.258787060659;14836.109833410002;14857.554273371788;647.6696884588846;663.8871391863371;777.3081957058223;784.4391260248921;788.5702292250709;797.4696826610298;810.8945837041206;813.0527934955769;813.5728742410223;813.6135335715547;848.3213429256601;855.7090589199671;856.3919617071887;858.2404571953834;859.2653281444369;847.089378917666;851.7061613743249;853.9573021348939;854.2311919272643;854.7692123126752;627.604609096271;628.789355565886;628.8207860759661;629.1726379810534;629.804760524239;14977.775333369898;15076.698466030728;15125.54623361301;15142.621434464116;15161.772573411408;15467.226638668135;15524.61188470286;15695.215239238107;15701.92149039259;15702.76445853313;11349.43252837363;11479;11734.354610496419;11774.882251177463;12289.631311060682;3673.7244706646843;3767.1147280389087;3821.216650586623;3876.0503676599415;3939.074317535377;62912.37087629111;79606;79728.60135699285;81033.59483202605;81705;11500.827487587525;11672.474738636782;11755.823662645067;11880.465379057963;11929.522819087313;19541.218351266074;19572.510687232934;19579.60840783205;19585.608287834162;19592.21631134767;8276.955078995568;8368.37237207212;8487.575621218914;8594;8715.346349023848;4608.953910460919;4659.347691323217;4743.596794272526;4768.499307572655;4808.422989241313;3615.1504396467335;3749.6625303722794;3774.301754175486;3776.1126135358168;3796.7721936683333;655.2857385449787;667.302668711198;700.9824754381079;704.4047779626208;735.3528894572742;677.9050932869402;697.5570512724456;738.3023043224209;745.6793578761185;761.588742079282;10007.649732259337;10296;10372.481375931173;10599.417032063311;10869.565217391215;590.5983930926925;707.5825263094799;716.6524235745659;747.1519824998666;776.9922847249424;4230.555791641895;4753.239481682914;4945.975270123627;4993.901341704819;5015.448300686921;104634;105302.4734876336;105909.47045264725;109932.4503377494;110087.44956275167;91599;94245.52877235707;94675.52662236782;95845;96523.51738241264;80231.19768802355;82678;83177;84690.15309846945;85035;9092.318076144447;9189.86215206759;9196.448213107235;9532.52337383142;9547.570359333708;47798.5220147808;47918.52081479141;48749.268760969324;49554.25668615046;49912.25131623101;67091.66454167698;68155.65922170358;72827.98892121969;73624.26375736174;74479.25520744723;11838.638556566106;11867.465964031466;11895.286282823059;11920.582779602672;12020.75958480808;13632.113912595649;13823.239721815396;13839.723205536035;14009.649758756113;14013.859861401255;12791.616251512469;12972.481100755864;13298.069135160833;13343.132696374705;13881.42167025443;12253.571125010938;12463.813042804184;13077.019223558462;13205.669858253235;13490.325483725579;12227.44976476043;12261.632151035483;12407.131500795218;12756.29840358752;13505.459781608626;9863.260255480724;9970.451625160686;10113.494325283853;10136.543855526666;10162.237832162766;9185.862212066691;9447.763805904633;9853.704388868346;10018.248631352531;10760.3543787373 23:35:18 INFO - PROCESS | 22773 | __end_tp_report 23:35:18 INFO - PROCESS | 22773 | __start_cc_report 23:35:18 INFO - PROCESS | 22773 | _x_x_mozilla_cycle_collect,315 23:35:18 INFO - PROCESS | 22773 | __end_cc_report 23:35:18 INFO - PROCESS | 22773 | __startTimestamp1476686118332__endTimestamp 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | ------- Summary: start ------- 23:35:18 INFO - PROCESS | 22773 | Number of tests: 6 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | [#0] dojo.html Cycles:165 Average:5211.44 Median:5368.09 stddev:579.07 (10.8%) stddev-sans-first:554.68 23:35:18 INFO - PROCESS | 22773 | Values: 3017.7 3056.1 3079.8 3081.6 3102.2 5191.3 5323.5 5372.2 5388.7 5474.6 5216.8 5251.6 5275.7 5324.9 5351.3 4726.7 4761.9 4832.6 4835.0 4894.2 4711.6 4734.7 4778.4 4791.0 4794.9 4673.6 4726.0 4879.9 4890.3 4922.6 4798.1 4821.3 4831.1 4874.5 4898.8 4790.0 4793.3 4794.9 4802.6 4850.2 5152.9 5183.7 5198.7 5214.4 5310.6 5468.5 5581.7 5619.9 5626.4 5715.0 5657.3 5667.4 5677.2 5687.2 5702.1 5298.6 5307.3 5327.6 5348.4 5359.2 5494.6 5560.8 5691.5 5708.9 5778.3 5558.9 5566.7 5566.8 5593.2 5614.2 5550.8 5593.1 5607.6 5615.3 5660.5 5352.1 5415.3 5536.7 5595.0 5617.4 5614.0 5644.5 5653.1 5654.9 5693.2 4267.8 4316.4 4326.9 4334.7 4377.0 3777.4 3797.1 3804.1 3823.5 3897.8 5293.1 5330.9 5342.3 5382.4 5391.4 5584.2 5595.3 5626.1 5639.7 5643.6 5155.8 5205.6 5213.4 5280.3 5336.9 4724.6 4771.6 4783.0 4790.5 4796.3 5780.6 5784.1 5789.4 5792.1 5798.0 5559.3 5568.7 5573.7 5575.9 5576.8 5721.4 5751.3 5760.2 5763.9 5772.8 5324.7 5349.8 5360.4 5362.4 5366.7 5439.1 5445.4 5448.3 5636.3 5657.2 5589.6 5591.9 5596.9 5604.2 5605.2 5342.4 5509.0 5515.5 5538.9 5562.2 5323.4 5333.2 5337.9 5368.1 5428.0 5441.9 5483.4 5487.9 5491.1 5497.6 5357.7 5363.9 5368.1 5379.7 5443.5 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | [#1] ext.html Cycles:180 Average:55464.31 Median:3990.62 stddev:104248.65 (2612.3%) stddev-sans-first:104459.54 23:35:18 INFO - PROCESS | 22773 | Values: 544.2 577.8 581.0 585.6 591.6 42417.2 43758.0 43770.8 46730.3 46824.0 43032.6 43440.1 43725.0 43740.3 43800.0 8849.4 8984.0 9019.1 9037.9 9083.0 8880.5 8929.8 8946.6 8962.9 8997.9 8908.3 8968.9 8992.8 9003.0 9032.3 8977.0 9015.8 9034.4 9038.0 9050.0 8762.3 8859.0 8869.2 8878.2 8883.8 42329.4 42529.8 42584.4 42868.0 42987.8 3436.2 3552.9 3859.6 3979.5 4001.8 31326.7 31343.0 31641.0 31753.7 31779.4 4282.7 4305.8 4333.8 4473.7 4511.2 335303.0 337242.0 339002.0 340094.0 341845.0 57833.0 58192.7 58295.7 58377.0 58425.4 61347.0 61588.0 61661.7 61921.7 61964.0 16478.3 16493.9 16551.6 16723.0 16740.4 13293.1 13430.9 13450.4 13464.7 13521.9 16552.7 17667.3 17756.6 17819.8 18033.0 5637.6 5747.9 5892.1 5986.8 6093.2 874.4 962.8 1012.3 1023.7 1041.8 31329.7 31378.5 31426.0 31467.5 32008.7 1052.2 1052.3 1072.3 1101.0 1119.5 16225.5 16688.5 16717.8 16721.9 16841.7 499058.0 502037.0 503958.0 504626.0 504739.0 56673.1 57487.4 57495.4 57532.4 57945.4 1280.9 1339.5 1344.8 1351.4 1361.4 29172.7 30484.9 30615.2 30966.8 31285.8 50718.0 51228.0 51473.7 51591.2 51913.7 312459.0 315035.0 315138.0 315224.0 316165.0 27037.9 28254.3 28358.1 29823.0 41390.6 44075.0 44946.6 45178.8 45223.8 45830.1 36757.4 37479.3 37567.4 37685.6 37787.2 37686.4 37946.4 37978.4 38066.9 38431.0 33997.5 34668.3 37102.8 38420.4 39230.2 34445.5 36691.3 36877.4 37400.8 37533.6 33563.0 34698.8 35970.6 36007.3 36254.6 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | [#2] jquery.html Cycles:180 Average:28068.17 Median:2917.81 stddev:76351.11 (2616.7%) stddev-sans-first:76536.97 23:35:18 INFO - PROCESS | 22773 | Values: 372.9 383.1 397.7 405.8 418.0 14071.4 18029.6 18682.2 19681.7 19754.1 18530.8 18731.3 18960.2 19077.6 19186.0 5627.7 5670.3 5768.7 5812.7 5865.8 5714.9 5802.6 5803.9 5808.7 5825.8 5527.3 5735.8 5746.0 5749.1 5754.4 5516.3 5722.5 5753.9 5766.7 5782.9 5107.2 5112.6 5120.9 5140.7 5172.2 21532.6 22104.9 22214.2 22340.8 22556.0 2401.7 2421.5 2783.8 3051.8 3055.9 13332.9 13794.9 14018.6 14420.2 14656.9 1905.3 2001.4 2030.1 2054.2 2056.3 81301.0 81865.6 82506.2 83145.6 83568.0 10411.9 10639.9 10654.3 11005.4 11075.9 13005.7 14859.6 14953.0 15042.8 15094.9 7701.4 7885.2 8233.0 8335.5 8380.9 8035.7 8227.1 8243.4 8369.4 8440.1 6274.4 6329.8 6391.5 6440.4 6572.5 1958.5 1994.4 1998.8 2020.0 2040.4 872.4 950.8 1020.4 1020.6 1024.4 19069.1 19191.7 19352.1 19368.5 19671.5 990.9 1009.4 1031.7 1061.6 1078.1 10098.3 10400.4 10885.1 11013.8 11346.2 415344.0 451818.0 473681.0 480832.0 482642.0 92824.0 93039.0 93383.0 94671.0 94966.0 1000.1 1045.6 1054.3 1064.5 1087.7 16400.6 16461.9 16931.3 17481.7 17782.8 41448.6 41637.0 42116.4 42168.0 42771.8 52509.7 53164.5 53204.2 57798.0 61459.0 6922.0 7158.0 7178.7 7540.5 8145.1 11185.3 12732.2 12786.2 12885.6 13068.2 11311.5 11384.4 11399.7 11512.0 11529.5 5235.7 5272.2 7178.9 8210.5 11311.2 11100.3 11181.4 11380.8 11385.9 11702.6 7442.6 7515.6 7547.0 7741.3 8085.2 11012.2 11059.8 11302.5 11314.2 11479.4 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | [#3] mootools.html Cycles:180 Average:5592.77 Median:4943.51 stddev:3172.44 (64.2%) stddev-sans-first:3166.18 23:35:18 INFO - PROCESS | 22773 | Values: 1466.8 1494.9 1645.6 1736.0 1747.1 7561.2 7820.1 8078.6 8550.5 8744.9 7916.4 8176.0 8278.3 8513.4 8518.0 2270.5 2305.6 2314.4 2321.7 2332.1 2210.8 2241.5 2251.5 2252.0 2264.5 2312.9 2325.0 2342.6 2346.4 2348.5 2221.1 2223.9 2226.8 2234.3 2246.4 2204.8 2220.6 2228.3 2228.3 2246.7 8626.6 8674.2 8698.5 8732.5 8739.6 5014.9 5175.4 5176.3 5181.2 5192.3 3202.5 3277.1 3365.5 3379.3 3419.1 1208.7 1217.6 2143.5 2205.6 2206.8 11991.4 12041.3 12096.5 12149.0 12168.6 4278.2 4409.0 4411.8 4582.1 4629.6 9485.0 9498.2 9498.6 9510.8 9523.4 5074.6 5078.9 5079.0 5080.4 5083.2 4197.4 4321.0 4658.8 4786.8 4788.6 3666.9 3759.8 3787.2 3802.0 3825.0 1023.4 1033.6 1043.1 1048.6 1049.8 864.9 876.8 887.2 927.2 930.6 5549.6 5616.2 5650.9 5706.9 5777.5 933.8 935.8 968.8 973.3 1003.3 3697.7 3784.8 3837.8 3874.0 3882.4 10488.2 10820.5 10886.3 10910.1 10921.2 10722.0 10750.7 10756.0 10797.1 10805.4 7566.9 7903.8 8048.8 8103.6 8202.4 5478.5 5575.4 5631.9 5684.6 5710.3 9571.9 9643.0 9846.5 9907.6 9966.2 9932.3 9997.8 10022.6 10028.5 10099.1 6612.8 6817.8 7214.8 7354.5 7405.0 8027.0 8359.6 8388.2 8409.1 8427.8 7276.9 7439.1 7488.0 7494.0 7567.8 7004.7 7041.8 7128.9 7280.6 7371.3 6412.7 6495.6 6551.8 6589.1 6605.4 4584.4 4644.0 4678.8 4709.3 4759.0 4908.0 4933.1 4953.9 5016.6 5021.2 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | [#4] prototype.html Cycles:180 Average:4719.49 Median:5391.43 stddev:1404.05 (26.0%) stddev-sans-first:1368.62 23:35:18 INFO - PROCESS | 22773 | Values: 320.7 326.5 327.7 333.9 336.0 5353.9 5397.6 5413.8 5430.5 5440.8 5302.8 5304.9 5310.1 5313.8 5322.7 3941.8 4006.8 4071.7 4161.0 4177.0 4157.3 4159.3 4170.7 4174.4 4192.8 4128.4 4132.5 4139.5 4142.1 4145.8 4047.1 4100.3 4105.5 4131.9 4161.3 3645.4 3647.8 3653.2 3656.2 3656.5 5125.7 5152.8 5182.4 5191.8 5212.7 4643.5 4659.6 4727.5 4761.4 4761.6 5504.3 5511.1 5523.9 5529.4 5539.0 3997.7 4001.9 4002.6 4006.3 4011.4 5510.9 5716.8 5738.7 5745.8 5792.3 4111.8 4113.4 4115.4 4120.7 4120.8 4157.4 4158.9 4160.1 4166.5 4168.5 4409.9 4736.0 4736.6 4737.5 4758.6 5587.4 5606.7 5612.4 5628.3 5633.4 1403.5 1424.6 1425.0 1427.4 1427.6 822.8 859.9 864.0 877.6 895.1 5140.7 5196.2 5389.4 5390.0 5423.5 5728.5 5770.1 5771.8 5783.5 5789.5 5242.2 5313.6 5345.9 5367.4 5376.4 3026.0 3067.9 3075.3 3078.4 3088.0 5949.3 5955.5 5958.9 5984.4 6001.5 5538.6 5869.6 5944.1 5954.2 5954.3 6076.5 6084.8 6084.9 6087.2 6104.0 5577.2 5718.0 5743.8 5757.9 5782.2 5706.3 5707.4 5708.0 5709.8 5714.2 5883.6 5992.2 5992.4 6003.8 6004.8 4107.8 4124.7 4168.9 4183.6 4187.0 5824.7 5829.0 5835.9 5837.2 5843.7 5392.9 5569.9 5691.6 5691.6 5714.5 5619.8 5633.5 5643.2 5667.0 5673.0 5526.4 5533.8 5564.8 5583.6 5597.0 5303.6 5405.9 5689.8 5705.8 5732.2 5581.4 5587.2 5590.5 5594.9 5596.0 23:35:18 INFO - PROCESS | 22773 | 23:35:18 INFO - PROCESS | 22773 | [#5] yui.html Cycles:180 Average:20068.75 Median:26283.51 stddev:28595.50 (108.8%) stddev-sans-first:28638.55 23:35:18 INFO - PROCESS | 22773 | Values: 654.0 692.4 724.1 729.9 815.6 14618.2 15673.3 15696.5 15716.3 15725.9 14731.9 14813.9 14824.3 14836.1 14857.6 647.7 663.9 777.3 784.4 788.6 797.5 810.9 813.1 813.6 813.6 848.3 855.7 856.4 858.2 859.3 847.1 851.7 854.0 854.2 854.8 627.6 628.8 628.8 629.2 629.8 14977.8 15076.7 15125.5 15142.6 15161.8 15467.2 15524.6 15695.2 15701.9 15702.8 11349.4 11479.0 11734.4 11774.9 12289.6 3673.7 3767.1 3821.2 3876.1 3939.1 62912.4 79606.0 79728.6 81033.6 81705.0 11500.8 11672.5 11755.8 11880.5 11929.5 19541.2 19572.5 19579.6 19585.6 19592.2 8277.0 8368.4 8487.6 8594.0 8715.3 4609.0 4659.3 4743.6 4768.5 4808.4 3615.2 3749.7 3774.3 3776.1 3796.8 655.3 667.3 701.0 704.4 735.4 677.9 697.6 738.3 745.7 761.6 10007.6 10296.0 10372.5 10599.4 10869.6 590.6 707.6 716.7 747.2 777.0 4230.6 4753.2 4946.0 4993.9 5015.4 104634.0 105302.5 105909.5 109932.5 110087.4 91599.0 94245.5 94675.5 95845.0 96523.5 80231.2 82678.0 83177.0 84690.2 85035.0 9092.3 9189.9 9196.4 9532.5 9547.6 47798.5 47918.5 48749.3 49554.3 49912.3 67091.7 68155.7 72828.0 73624.3 74479.3 11838.6 11867.5 11895.3 11920.6 12020.8 13632.1 13823.2 13839.7 14009.6 14013.9 12791.6 12972.5 13298.1 13343.1 13881.4 12253.6 12463.8 13077.0 13205.7 13490.3 12227.4 12261.6 12407.1 12756.3 13505.5 9863.3 9970.5 10113.5 10136.5 10162.2 9185.9 9447.8 9853.7 10018.2 10760.4 23:35:18 INFO - PROCESS | 22773 | -------- Summary: end -------- 23:35:18 INFO - PROCESS | 22773 | 23:35:19 INFO - TEST-INFO | 22773: exit 0 23:35:19 INFO - TEST-OK | dromaeo_css | took 1116347ms 23:35:19 INFO - TEST-START | kraken 23:35:19 INFO - operating with platform_type : linux_ 23:35:19 INFO - Initialising browser for kraken test... 23:35:19 INFO - TEST-INFO | started process 23143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq2nbAp/profile http://localhost:50410/getInfo.html) 23:35:24 INFO - PROCESS | 23143 | __metrics Screen width/height:1600/1200 23:35:24 INFO - PROCESS | 23143 | colorDepth:24 23:35:24 INFO - PROCESS | 23143 | Browser inner width/height: 1024/697 23:35:24 INFO - PROCESS | 23143 | __metrics 23:35:24 ERROR - PROCESS | 23143 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 23:35:25 INFO - TEST-INFO | 23143: exit 0 23:35:25 INFO - Browser initialized. 23:35:25 INFO - Running cycle 1/1 for kraken test... 23:35:25 INFO - TEST-INFO | started process 23267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq2nbAp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:35:37 INFO - PROCESS | 23267 | RSS: Main: 184516608 23:35:37 INFO - PROCESS | 23267 | 23:35:40 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-beat-detection) 23:35:41 INFO - PROCESS | 23267 | RSS: Main: 198795264 23:35:41 INFO - PROCESS | 23267 | 23:35:44 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-dft) 23:35:44 INFO - PROCESS | 23267 | RSS: Main: 196743168 23:35:44 INFO - PROCESS | 23267 | 23:35:47 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-fft) 23:35:48 INFO - PROCESS | 23267 | RSS: Main: 192696320 23:35:48 INFO - PROCESS | 23267 | 23:35:50 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-oscillator) 23:35:51 INFO - PROCESS | 23267 | RSS: Main: 192970752 23:35:51 INFO - PROCESS | 23267 | 23:35:53 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:35:53 INFO - PROCESS | 23267 | RSS: Main: 193245184 23:35:53 INFO - PROCESS | 23267 | 23:35:57 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50410/tests/kraken/driver.html?testName=imaging-darkroom) 23:35:57 INFO - PROCESS | 23267 | RSS: Main: 193273856 23:35:57 INFO - PROCESS | 23267 | 23:36:01 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50410/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:01 INFO - PROCESS | 23267 | RSS: Main: 191148032 23:36:01 INFO - PROCESS | 23267 | 23:36:04 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50410/tests/kraken/driver.html?testName=json-parse-financial) 23:36:05 INFO - PROCESS | 23267 | RSS: Main: 192765952 23:36:05 INFO - PROCESS | 23267 | 23:36:06 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:36:07 INFO - PROCESS | 23267 | RSS: Main: 193105920 23:36:07 INFO - PROCESS | 23267 | 23:36:09 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:36:09 INFO - PROCESS | 23267 | RSS: Main: 193425408 23:36:09 INFO - PROCESS | 23267 | 23:36:11 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:36:12 INFO - PROCESS | 23267 | RSS: Main: 192921600 23:36:12 INFO - PROCESS | 23267 | 23:36:15 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:36:16 INFO - PROCESS | 23267 | RSS: Main: 193372160 23:36:16 INFO - PROCESS | 23267 | 23:36:18 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:19 INFO - PROCESS | 23267 | RSS: Main: 193613824 23:36:19 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50410/tests/kraken/driver.html?testName=ai-astar) 23:36:21 INFO - PROCESS | 23267 | RSS: Main: 194674688 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | __start_tp_report 23:36:21 INFO - PROCESS | 23267 | _x_x_mozilla_page_load 23:36:21 INFO - PROCESS | 23267 | _x_x_mozilla_page_load_details 23:36:21 INFO - PROCESS | 23267 | |i|pagename|runs| 23:36:21 INFO - PROCESS | 23267 | |0;ai-astar;104;110;114;112;113;110;112;111;110;111 23:36:21 INFO - PROCESS | 23267 | |1;audio-beat-detection;156;129;125;173;124;123;128;126;152;124 23:36:21 INFO - PROCESS | 23267 | |2;audio-dft;164;166;165;167;169;164;162;165;163;164 23:36:21 INFO - PROCESS | 23267 | |3;audio-fft;77;76;76;107;77;77;76;76;100;76 23:36:21 INFO - PROCESS | 23267 | |4;audio-oscillator;83;83;117;83;83;82;106;83;82;115 23:36:21 INFO - PROCESS | 23267 | |5;imaging-gaussian-blur;117;119;117;118;118;117;117;118;118;117 23:36:21 INFO - PROCESS | 23267 | |6;imaging-darkroom;146;147;147;148;147;147;147;147;148;147 23:36:21 INFO - PROCESS | 23267 | |7;imaging-desaturate;97;96;96;96;97;96;95;96;96;97 23:36:21 INFO - PROCESS | 23267 | |8;json-parse-financial;55;60;54;55;56;55;55;56;55;56 23:36:21 INFO - PROCESS | 23267 | |9;json-stringify-tinderbox;61;60;60;60;61;61;60;61;60;61 23:36:21 INFO - PROCESS | 23267 | |10;stanford-crypto-aes;81;86;88;80;81;83;82;86;81;80 23:36:21 INFO - PROCESS | 23267 | |11;stanford-crypto-ccm;129;140;139;142;135;133;146;133;175;149 23:36:21 INFO - PROCESS | 23267 | |12;stanford-crypto-pbkdf2;168;168;167;167;165;167;163;166;165;175 23:36:21 INFO - PROCESS | 23267 | |13;stanford-crypto-sha256-iterative;67;66;73;68;68;67;67;70;68;66 23:36:21 INFO - PROCESS | 23267 | __end_tp_report 23:36:21 INFO - PROCESS | 23267 | __start_cc_report 23:36:21 INFO - PROCESS | 23267 | _x_x_mozilla_cycle_collect,824 23:36:21 INFO - PROCESS | 23267 | __end_cc_report 23:36:21 INFO - PROCESS | 23267 | __startTimestamp1476686181530__endTimestamp 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | ------- Summary: start ------- 23:36:21 INFO - PROCESS | 23267 | Number of tests: 14 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.71 (2.4%) stddev-sans-first:1.42 23:36:21 INFO - PROCESS | 23267 | Values: 104.0 110.0 114.0 112.0 113.0 110.0 112.0 111.0 110.0 111.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.50 stddev:17.69 (13.8%) stddev-sans-first:17.22 23:36:21 INFO - PROCESS | 23267 | Values: 156.0 129.0 125.0 173.0 124.0 123.0 128.0 126.0 152.0 124.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.02 (1.2%) stddev-sans-first:2.12 23:36:21 INFO - PROCESS | 23267 | Values: 164.0 166.0 165.0 167.0 169.0 164.0 162.0 165.0 163.0 164.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:11.56 (15.2%) stddev-sans-first:12.13 23:36:21 INFO - PROCESS | 23267 | Values: 77.0 76.0 76.0 107.0 77.0 77.0 76.0 76.0 100.0 76.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:14.74 (17.8%) stddev-sans-first:15.29 23:36:21 INFO - PROCESS | 23267 | Values: 83.0 83.0 117.0 83.0 83.0 82.0 106.0 83.0 82.0 115.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 23:36:21 INFO - PROCESS | 23267 | Values: 117.0 119.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 23:36:21 INFO - PROCESS | 23267 | Values: 146.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 23:36:21 INFO - PROCESS | 23267 | Values: 97.0 96.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 97.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:1.64 (2.9%) stddev-sans-first:1.72 23:36:21 INFO - PROCESS | 23267 | Values: 55.0 60.0 54.0 55.0 56.0 55.0 55.0 56.0 55.0 56.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 23:36:21 INFO - PROCESS | 23267 | Values: 61.0 60.0 60.0 60.0 61.0 61.0 60.0 61.0 60.0 61.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.86 (3.5%) stddev-sans-first:2.96 23:36:21 INFO - PROCESS | 23267 | Values: 81.0 86.0 88.0 80.0 81.0 83.0 82.0 86.0 81.0 80.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:141.00 stddev:13.11 (9.3%) stddev-sans-first:13.02 23:36:21 INFO - PROCESS | 23267 | Values: 129.0 140.0 139.0 142.0 135.0 133.0 146.0 133.0 175.0 149.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.00 stddev:3.18 (1.9%) stddev-sans-first:3.35 23:36:21 INFO - PROCESS | 23267 | Values: 168.0 168.0 167.0 167.0 165.0 167.0 163.0 166.0 165.0 175.0 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.11 (3.1%) stddev-sans-first:2.20 23:36:21 INFO - PROCESS | 23267 | Values: 67.0 66.0 73.0 68.0 68.0 67.0 67.0 70.0 68.0 66.0 23:36:21 INFO - PROCESS | 23267 | -------- Summary: end -------- 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | 23:36:21 INFO - PROCESS | 23267 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:36:21 INFO - PROCESS | 23267 | 23:36:22 INFO - TEST-INFO | 23267: exit 0 23:36:22 INFO - TEST-OK | kraken | took 63344ms 23:36:22 INFO - SUITE-END | took 1179s 23:36:23 INFO - Completed test suite (00:19:40) 23:36:23 INFO - javascript benchmark 23:36:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7147.914932939366, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.698230176982, 3056.1137270191643, 3079.8306093164874, 3081.5685803987444, 3102.2089367211356, 5191.299174611436, 5323.467653234675, 5372.22102795095, 5388.730563471825, 5474.644148130379, 5216.843494695156, 5251.5798736101115, 5275.657082289648, 5324.893502129955, 5351.331083614548, 4726.692764970266, 4761.928571071437, 4832.589229915444, 4834.9516504834855, 4894.192458244385, 4711.623070154396, 4734.739589322586, 4778.402699662543, 4791.041791641668, 4794.9280760788615, 4673.649476289258, 4725.952740472586, 4879.902401951977, 4890.266460030988, 4922.55696987271, 4798.0643774464, 4821.252705830602, 4831.106245344622, 4874.53691899269, 4898.828541001048, 4790.0, 4793.257045157971, 4794.904101917942, 4802.615790736732, 4850.248211527219, 5152.896942061137, 5183.688978661255, 5198.662086964373, 5214.426413094557, 5310.60170487215, 5468.535174510132, 5581.665100093966, 5619.887602247973, 5626.352969408488, 5714.9714251428895, 5657.264555607745, 5667.376588575254, 5677.205191273184, 5687.175359572881, 5702.059160238556, 5298.629095963284, 5307.336582927134, 5327.627066105335, 5348.411674715778, 5359.22291267764, 5494.587905907073, 5560.833175004756, 5691.516221121251, 5708.857278568069, 5778.3354914184565, 5558.944410555923, 5566.693831839207, 5566.805161819398, 5593.188987596775, 5614.157876318585, 5550.834324791839, 5593.105103183552, 5607.551395888319, 5615.298087739033, 5660.5471562274915, 5352.143657014859, 5415.296011518478, 5536.667799932017, 5594.9720251398485, 5617.38208797032, 5614.045612245928, 5644.491995720405, 5653.095504719226, 5654.943450565442, 5693.231413759089, 4267.829286828554, 4316.44670504616, 4326.891827704269, 4334.653227741773, 4377.0, 3777.433384992273, 3797.145642230476, 3804.068003339144, 3823.541175058955, 3897.7661340319673, 5293.100172970528, 5330.880515091874, 5342.252084708144, 5382.407935127133, 5391.433899440581, 5584.246126772834, 5595.328560572757, 5626.099824028136, 5639.689817060019, 5643.633163844337, 5155.7679904404395, 5205.609579281569, 5213.374395072616, 5280.339957505312, 5336.866578335573, 4724.622030237572, 4771.618270538349, 4783.0, 4790.544898234732, 4796.304535842283, 5780.5953583248765, 5784.074548072288, 5789.421057894261, 5792.0732682771395, 5797.971010144923, 5559.33288005442, 5568.693721845338, 5573.721313934206, 5575.944240557543, 5576.804811831566, 5721.427857214246, 5751.309842818889, 5760.1935728998815, 5763.913541296968, 5772.7690892363835, 5324.680519168863, 5349.812756553502, 5360.383555891122, 5362.436944120811, 5366.6779993200535, 5439.0753571893665, 5445.373782015119, 5448.264484294728, 5636.267285252891, 5657.207990881362, 5589.55283577321, 5591.860203494945, 5596.888062238814, 5604.187392827936, 5605.215269862304, 5342.439043900335, 5509.0, 5515.4760297771645, 5538.949612114967, 5562.2212890196215, 5323.441038690882, 5333.173358129496, 5337.946620533745, 5368.087425137658, 5428.0, 5441.891162176814, 5483.369412517612, 5487.890242195213, 5491.0939694951485, 5497.615166938276, 5357.70532620694, 5363.946360536344, 5368.141097424394, 5379.704116273642, 5443.537299329443], "value": 5173.168179854989, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.241411907231, 577.7746678795268, 580.9709514524274, 585.5608293779666, 591.5977135547827, 42417.151656966846, 43758.0, 43770.781146094305, 46730.29904551426, 46824.0, 43032.569674303246, 43440.13119737603, 43725.0, 43740.34389484152, 43800.0, 8849.380543361967, 8984.0, 9019.143181397756, 9037.864432033524, 9083.0, 8880.46717196967, 8929.821403571957, 8946.552672366388, 8962.910370896305, 8997.865032024525, 8908.287337013024, 8968.865467018, 8992.775180620503, 9002.954985225097, 9032.322575806807, 8977.0, 9015.774605634846, 9034.412763170372, 9037.954810225972, 9050.0, 8762.255208307302, 8859.025507194203, 8869.2017718405, 8878.200961913459, 8883.822323553493, 42329.365059524134, 42529.78735106336, 42584.361234581505, 42868.0, 42987.78506107481, 3436.1581412553833, 3552.928941421157, 3859.5754467008605, 3979.4826672532677, 4001.7598944063448, 31326.686733132607, 31343.0, 31641.0, 31753.682463175304, 31779.364412711617, 4282.700210985232, 4305.763183024932, 4333.761643109628, 4473.686841921034, 4511.2330903746115, 335303.0, 337241.99999999756, 339002.0, 340094.0, 341845.0, 57833.0, 58192.709036454544, 58295.70852145712, 58377.0, 58425.415745841994, 61347.0, 61588.0, 61661.69169154126, 61921.69039154775, 61964.0, 16478.2584783685, 16493.917530412273, 16551.586210344838, 16723.0, 16740.41408550695, 13293.06948513614, 13430.9255259579, 13450.394732237073, 13464.663383415493, 13521.864781352257, 16552.668946621, 17667.293308267526, 17756.55608609769, 17819.821801782076, 18033.0, 5637.605367624309, 5747.85630359236, 5892.1161825726485, 5986.760529578768, 6093.216824792606, 874.3529787956866, 962.7737481691797, 1012.3268026762121, 1023.698009087321, 1041.7551875309296, 31329.68670313313, 31378.52932206019, 31426.0, 31467.52798708021, 32008.67991320057, 1052.1582733813073, 1052.3317693264833, 1072.3190773858655, 1100.9614663486739, 1119.4962266979892, 16225.51323460298, 16688.499345019667, 16717.83282167187, 16721.907195910986, 16841.6631667366, 499058.0, 502037.0, 503958.0, 504626.0, 504739.0, 56673.149902751495, 57487.42512574821, 57495.42504574984, 57532.424675753544, 57945.420545794004, 1280.8527019392702, 1339.5378594384922, 1344.7915573086186, 1351.4459071780523, 1361.4282001559368, 29172.708272917, 30484.866059376516, 30615.2346191347, 30966.845165774026, 31285.843570782912, 50718.0, 51228.0, 51473.7426312866, 51591.226131607305, 51913.7404312976, 312459.0, 315035.0, 315138.0, 315224.0, 316165.0, 27037.86481067582, 28254.293642659097, 28358.149255522367, 29823.0, 41390.58609413867, 44075.0, 44946.550534494236, 45178.77410612926, 45223.773881130386, 45830.08339833118, 36757.44863827098, 37479.25041499209, 37567.43648845324, 37685.623143768215, 37787.24425511529, 37686.434703480016, 37946.43080353852, 37978.43032354461, 38066.85799425911, 38430.964748700986, 33997.49003764995, 34668.30663386769, 37102.814485927396, 38420.42369364406, 39230.215395692496, 34445.48331775075, 36691.266174675824, 36877.44683829798, 37400.812995934844, 37533.62466375301, 33563.0, 34698.826505867306, 35970.640293597775, 36007.27985440329, 36254.637453625124], "value": 19705.56750849677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8657683234037, 383.0863390812914, 397.6560275361812, 405.83766493402646, 417.9540250572438, 14071.366788494517, 18029.639407211864, 18682.159302831373, 19681.704774428377, 19754.111065002056, 18530.846427571858, 18731.25074997002, 18960.241590336405, 19077.618447631074, 19186.0, 5627.6904770237625, 5670.262865827437, 5768.682722450264, 5812.709364531777, 5865.824025279248, 5714.885702285952, 5802.5938184327115, 5803.912941305884, 5808.738606762706, 5825.766969321222, 5527.309086364205, 5735.827925162252, 5745.971270143644, 5749.080147176453, 5754.395788442195, 5516.338039435253, 5722.456366645162, 5753.884922301572, 5766.682832444235, 5782.913256301159, 5107.1828507439, 5112.616553758483, 5120.948790512084, 5140.74296285188, 5172.224166375074, 21532.569348613095, 22104.88947555268, 22214.222502212506, 22340.776592234033, 22556.0, 2401.7117945846435, 2421.539907417585, 2783.832970021805, 3051.786374953754, 3055.908322750299, 13332.933335333359, 13794.93102534491, 14018.649533761738, 14420.206888621122, 14656.853431465655, 1905.2914281742865, 2001.3995801259564, 2030.1168991488603, 2054.1783286685295, 2056.259746491262, 81301.0, 81865.59067204685, 82506.17493825045, 83145.58427207886, 83568.0, 10411.947940260401, 10639.893601064045, 10654.283157794713, 11005.394703291397, 11075.889241107487, 13005.739885202433, 14859.554213373616, 14953.02805317651, 15042.774358384633, 15094.924525377523, 7701.422393320523, 7885.2114788520685, 8232.958835205785, 8335.541545215072, 8380.8742868857, 8035.678572857137, 8227.13615070421, 8243.422960392714, 8369.414141010071, 8440.11378805229, 6274.372562743689, 6329.810105696836, 6391.456726178327, 6440.420362167334, 6572.539922205496, 1958.5005823515198, 1994.3917105282737, 1998.7701414337537, 2019.9899000504904, 2040.3980825656467, 872.4242000279785, 950.8098380323963, 1020.3877673395903, 1020.5560581147224, 1024.4416792847917, 19069.141888615046, 19191.712124318146, 19352.129154188096, 19368.515787105436, 19671.508212294808, 990.895955924632, 1009.4347165587294, 1031.6904928521415, 1061.596593294543, 1078.0513148429332, 10098.343607665478, 10400.427976461217, 10885.129189664807, 11013.83479247812, 11346.235485079285, 415344.0, 451818.0, 473681.0, 480832.0, 482642.0, 92824.0, 93039.0, 93383.0, 94671.0, 94966.0, 1000.0799264676515, 1045.581767293089, 1054.2778196935124, 1064.462446464546, 1087.7171935296722, 16400.589985250463, 16461.917690411472, 16931.32274709047, 17481.737773933146, 17782.822171778633, 41448.58551414447, 41637.0, 42116.36825447682, 42168.0, 42771.7861410691, 52509.737451312496, 53164.4683553175, 53204.2019369702, 57798.0, 61459.0, 6921.965390173017, 7158.0, 7178.748743793943, 7540.509866858856, 8145.144759800136, 11185.272957258077, 12732.23606583608, 12786.232826030468, 12885.613431597067, 13068.215907045607, 11311.547538098384, 11384.37385943781, 11399.715007124889, 11511.985402554352, 11529.538818447169, 5235.65968212065, 5272.156454967187, 7178.856422871618, 8210.548419836967, 11311.151663625096, 11100.333979961228, 11181.385023823768, 11380.772384552098, 11385.886141138482, 11702.648920532398, 7442.590657513889, 7515.586642734702, 7547.018887544584, 7741.264579864904, 8085.191480852103, 11012.17408694335, 11059.783423823534, 11302.4913878874, 11314.208005439541, 11479.36863472517], "value": 9156.922798385636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.8459811719772, 1494.8878834087445, 1645.5639255597268, 1735.9739603905937, 1747.0565894417016, 7561.2060733623, 7820.06159260888, 8078.636461359239, 8550.486970781749, 8744.912550874496, 7916.366690664748, 8175.959120204406, 8278.254957053863, 8513.404061715682, 8517.957410212955, 2270.5004898922252, 2305.608046632068, 2314.375118717945, 2321.6865723127416, 2332.1137967572386, 2210.812080973119, 2241.540484200735, 2251.470904337479, 2252.042881775247, 2264.501809601893, 2312.8727919964394, 2325.0, 2342.5783358995373, 2346.4133966508375, 2348.5302939412186, 2221.1115553778454, 2223.8665680059166, 2226.7773222677765, 2234.307364716935, 2246.4383904023994, 2204.790544898232, 2220.6113930062174, 2228.320362289501, 2228.320362289501, 2246.696695946043, 8626.611802468904, 8674.175953284428, 8698.521581313025, 8732.51971141587, 8739.645354969989, 5014.924776128361, 5175.430702622709, 5176.301199338116, 5181.248718935733, 5192.3249977503065, 3202.455582550972, 3277.147941535194, 3365.528825964367, 3379.290349026707, 3419.059758566389, 1208.7401208740164, 1217.5738491527895, 2143.528423746773, 2205.614017546939, 2206.7572567017614, 11991.400429978466, 12041.277523348626, 12096.455659495345, 12148.9673377763, 12168.57409990655, 4278.229918614679, 4409.0, 4411.801468933906, 4582.1293954148605, 4629.560191781776, 9485.0, 9498.192653624381, 9498.572564234626, 9510.762230944143, 9523.380980236263, 5074.568661663726, 5078.923816142761, 5079.0, 5080.441151473335, 5083.212102124176, 4197.412362269285, 4321.027768752006, 4658.836940707059, 4786.8085276589245, 4788.592969597554, 3666.9083272917856, 3759.793211373401, 3787.2046870157023, 3801.954462522773, 3824.9808750956067, 1023.4473384372504, 1033.5762337441613, 1043.0768769638773, 1048.6172547020435, 1049.8372752223418, 864.8659457784054, 876.8246350729879, 887.2414085956543, 927.1701826865053, 930.6040938592112, 5549.556035517149, 5616.157576363496, 5650.915236271459, 5706.9429305707245, 5777.451142141574, 933.8365785987424, 935.8315503209487, 968.7771812483169, 973.3429934793986, 1003.2976916158718, 3697.7041836653, 3784.7918364489665, 3837.827297771607, 3873.96126038736, 3882.417637354363, 10488.160947124212, 10820.458977051116, 10886.29239099456, 10910.127189824794, 10921.180911431675, 10722.035016848366, 10750.73123171927, 10756.0, 10797.08224800885, 10805.405702686428, 7566.886496702554, 7903.826447726921, 8048.758537243892, 8103.594820258963, 8202.38482113844, 5478.534324582296, 5575.414581468887, 5631.915521267102, 5684.573656975661, 5710.314762228559, 9571.856422153813, 9643.0, 9846.45844478532, 9907.554160062959, 9966.202703783534, 9932.255080869108, 9997.750056248651, 10022.599096036078, 10028.548715307974, 10099.091081802673, 6612.801615951529, 6817.829554261183, 7214.819629509304, 7354.521956072838, 7405.0, 8027.0, 8359.58202089881, 8388.161183881562, 8409.117042710428, 8427.789305267417, 7276.8908466374105, 7439.107307123179, 7487.962560187382, 7494.0, 7567.772966811004, 7004.684789184601, 7041.788746337618, 7128.85742285141, 7280.635968201675, 7371.262873712586, 6412.743490260337, 6495.642739649365, 6551.770688026087, 6589.143411356493, 6605.438537724347, 4584.358189853357, 4644.047970166175, 4678.766061696833, 4709.317149013443, 4758.952410475989, 4908.0, 4933.112039832865, 4953.900921981613, 5016.59867210615, 5021.221710634857], "value": 4515.585599419394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.73539330052705, 326.4874147588286, 327.74927180706766, 333.8747969511433, 336.04060407536497, 5353.946460535393, 5397.649152805065, 5413.756380962856, 5430.53840423564, 5440.782368705252, 5302.787888484466, 5304.946950530493, 5310.0972834618115, 5313.751268451911, 5322.733863306838, 3941.8226179821977, 4006.759594424344, 4071.694622903279, 4160.979195104021, 4176.97911510442, 4157.334826427772, 4159.2721273777115, 4170.70805043647, 4174.352975288835, 4192.790360481964, 4128.360104183841, 4132.524759652649, 4139.523954745197, 4142.109446469009, 4145.834166633331, 4047.069174089961, 4100.339362558168, 4105.486814148231, 4131.8967025824295, 4161.313383291753, 3645.3620616392027, 3647.8176091195332, 3653.214558869829, 3656.213914008501, 3656.469811877263, 5125.718085505296, 5152.768125434364, 5182.352205974254, 5191.8182863599595, 5212.739363031833, 4643.535646435364, 4659.580637742585, 4727.487204094691, 4761.357216775726, 4761.619070474354, 5504.339479262474, 5511.090670039439, 5523.889522209533, 5529.419410961831, 5538.972305138489, 3997.7401468904427, 4001.919961600781, 4002.639762421396, 4006.278869803434, 4011.3782363733667, 5510.925369552939, 5716.79991200306, 5738.713064346766, 5745.770169193227, 5792.333881603628, 4111.759091295192, 4113.4035564843525, 4115.403266526337, 4120.651228799616, 4120.825564714102, 4157.417961485395, 4158.91682166355, 4160.105577300835, 4166.500019997619, 4168.541460439349, 4409.867703968886, 4735.976320118378, 4736.64475164364, 4737.531365276775, 4758.571728544448, 5587.38538760736, 5606.6916319602, 5612.410696876851, 5628.324601047819, 5633.408492108351, 1403.487726979645, 1424.5655075202162, 1424.950126745559, 1427.4432971141264, 1427.5931359562476, 822.7943014246439, 859.9140085991351, 863.9632441070614, 877.5875338590852, 895.1272509303377, 5140.691558506502, 5196.194589838581, 5389.434109418533, 5390.0, 5423.511883930465, 5728.54171666274, 5770.134479827975, 5771.797987070432, 5783.479486846204, 5789.478946894716, 5242.151010315519, 5313.601479889024, 5345.893082138413, 5367.409584945653, 5376.440832158708, 3026.0028381268257, 3067.8619462124257, 3075.3234288456506, 3078.3997120561276, 3088.0, 5949.286085669747, 5955.493783028404, 5958.910616340759, 5984.401559843981, 6001.549883758736, 5538.6122971391615, 5869.647821130746, 5944.138099975566, 5954.196183515257, 5954.315253745788, 6076.511254742616, 6084.787032453932, 6084.939150608526, 6087.208662873887, 6103.9694801527485, 5577.247071645276, 5718.0, 5743.798967036134, 5757.913631295618, 5782.17861373666, 5706.28671416073, 5707.429257074259, 5708.0, 5709.8287051388525, 5714.20001199824, 5883.558733094949, 5992.221011268682, 5992.400759923973, 6003.759849606142, 6004.799040191891, 4107.835686572504, 4124.731892427103, 4168.916621667489, 4183.644390226865, 4186.979065104655, 5824.70876456167, 5829.038208695518, 5835.854103647443, 5837.182794408701, 5843.7370318336625, 5392.865178370415, 5569.916451253153, 5691.601587888974, 5691.630044047124, 5714.514226301275, 5619.80330688424, 5633.549316054624, 5643.209950606836, 5667.0, 5672.971635141798, 5526.419725928719, 5533.833984980457, 5564.803567233064, 5583.637063590853, 5596.972015139898, 5303.628745987744, 5405.945840561053, 5689.829305120853, 5705.800296989585, 5732.226149469769, 5581.35350071738, 5587.245721827501, 5590.468905453975, 5594.888102237851, 5595.956367123578], "value": 4263.076239453083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9934600653995, 692.3837784371909, 724.0551080839506, 729.8613263479936, 815.5677490929808, 14618.195999220039, 15673.294701738421, 15696.450624228155, 15716.292766825492, 15725.877006604105, 14731.92634036831, 14813.925930370333, 14824.258787060659, 14836.109833410002, 14857.554273371788, 647.6696884588846, 663.8871391863371, 777.3081957058223, 784.4391260248921, 788.5702292250709, 797.4696826610298, 810.8945837041206, 813.0527934955769, 813.5728742410223, 813.6135335715547, 848.3213429256601, 855.7090589199671, 856.3919617071887, 858.2404571953834, 859.2653281444369, 847.089378917666, 851.7061613743249, 853.9573021348939, 854.2311919272643, 854.7692123126752, 627.604609096271, 628.789355565886, 628.8207860759661, 629.1726379810534, 629.804760524239, 14977.775333369898, 15076.698466030728, 15125.54623361301, 15142.621434464116, 15161.772573411408, 15467.226638668135, 15524.61188470286, 15695.215239238107, 15701.92149039259, 15702.76445853313, 11349.43252837363, 11479.0, 11734.354610496419, 11774.882251177463, 12289.631311060682, 3673.7244706646843, 3767.1147280389087, 3821.216650586623, 3876.0503676599415, 3939.074317535377, 62912.37087629111, 79606.0, 79728.60135699285, 81033.59483202605, 81705.0, 11500.827487587525, 11672.474738636782, 11755.823662645067, 11880.465379057963, 11929.522819087313, 19541.218351266074, 19572.510687232934, 19579.60840783205, 19585.608287834162, 19592.21631134767, 8276.955078995568, 8368.37237207212, 8487.575621218914, 8594.0, 8715.346349023848, 4608.953910460919, 4659.347691323217, 4743.596794272526, 4768.499307572655, 4808.422989241313, 3615.1504396467335, 3749.6625303722794, 3774.301754175486, 3776.1126135358168, 3796.7721936683333, 655.2857385449787, 667.302668711198, 700.9824754381079, 704.4047779626208, 735.3528894572742, 677.9050932869402, 697.5570512724456, 738.3023043224209, 745.6793578761185, 761.588742079282, 10007.649732259337, 10296.0, 10372.481375931173, 10599.417032063311, 10869.565217391215, 590.5983930926925, 707.5825263094799, 716.6524235745659, 747.1519824998666, 776.9922847249424, 4230.555791641895, 4753.239481682914, 4945.975270123627, 4993.901341704819, 5015.448300686921, 104634.0, 105302.4734876336, 105909.47045264725, 109932.4503377494, 110087.44956275167, 91599.0, 94245.52877235707, 94675.52662236782, 95845.0, 96523.51738241264, 80231.19768802355, 82678.0, 83177.0, 84690.15309846945, 85035.0, 9092.318076144447, 9189.86215206759, 9196.448213107235, 9532.52337383142, 9547.570359333708, 47798.5220147808, 47918.52081479141, 48749.268760969324, 49554.25668615046, 49912.25131623101, 67091.66454167698, 68155.65922170358, 72827.98892121969, 73624.26375736174, 74479.25520744723, 11838.638556566106, 11867.465964031466, 11895.286282823059, 11920.582779602672, 12020.75958480808, 13632.113912595649, 13823.239721815396, 13839.723205536035, 14009.649758756113, 14013.859861401255, 12791.616251512469, 12972.481100755864, 13298.069135160833, 13343.132696374705, 13881.42167025443, 12253.571125010938, 12463.813042804184, 13077.019223558462, 13205.669858253235, 13490.325483725579, 12227.44976476043, 12261.632151035483, 12407.131500795218, 12756.29840358752, 13505.459781608626, 9863.260255480724, 9970.451625160686, 10113.494325283853, 10136.543855526666, 10162.237832162766, 9185.862212066691, 9447.763805904633, 9853.704388868346, 10018.248631352531, 10760.3543787373], "value": 7421.617221802852, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 114.0, 112.0, 113.0, 110.0, 112.0, 111.0, 110.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 125.0, 173.0, 124.0, 123.0, 128.0, 126.0, 152.0, 124.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 167.0, 169.0, 164.0, 162.0, 165.0, 163.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 107.0, 77.0, 77.0, 76.0, 76.0, 100.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 83.0, 83.0, 82.0, 106.0, 83.0, 82.0, 115.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 54.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 88.0, 80.0, 81.0, 83.0, 82.0, 86.0, 81.0, 80.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 140.0, 139.0, 142.0, 135.0, 133.0, 146.0, 133.0, 175.0, 149.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 167.0, 167.0, 165.0, 167.0, 163.0, 166.0, 165.0, 175.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 73.0, 68.0, 68.0, 67.0, 67.0, 70.0, 68.0, 66.0], "value": 68.0, "unit": "score"}]}]} 23:36:23 INFO - Return code: 0 23:36:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:36:23 ERROR - # TBPL SUCCESS # 23:36:23 INFO - Running post-action listener: _resource_record_post_action 23:36:23 INFO - [mozharness: 2016-10-17 06:36:23.354444Z] Finished run-tests step (success) 23:36:23 INFO - Running post-run listener: _resource_record_post_run 23:36:23 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 393351168; Read time: 0; Write time: 401784 23:36:23 INFO - TinderboxPrint: CPU usage
13.4% 23:36:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:36:23 INFO - TinderboxPrint: I/O write bytes / time
393,351,168 / 401,784 23:36:23 INFO - TinderboxPrint: CPU idle
8,267.3 (86.6%) 23:36:23 INFO - TinderboxPrint: CPU user
1,213.3 (12.7%) 23:36:23 INFO - TinderboxPrint: Swap in / out
0 / 0 23:36:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103927808; Read time: 0; Write time: 141168 23:36:23 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289423360; Read time: 0; Write time: 260616 23:36:24 INFO - Running post-run listener: _upload_blobber_files 23:36:24 INFO - Blob upload gear active. 23:36:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:36:24 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 23:36:24 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:36:24 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:36:24 INFO - (blobuploader) - INFO - Open directory for files ... 23:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:25 INFO - (blobuploader) - INFO - Done attempting. 23:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:26 INFO - (blobuploader) - INFO - Done attempting. 23:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:36:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:29 INFO - (blobuploader) - INFO - Done attempting. 23:36:29 INFO - (blobuploader) - INFO - Iteration through files over. 23:36:29 INFO - Return code: 0 23:36:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:36:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:36:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30dd0d270da2e7a6207975b7e619afecea129acfe68902ed1b7b8b9b8469f55a6567c48999ae18652a10a865454a2e6ba1ebe593b7aa9c10ebe60ffb8155c210", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4bc66cfd2a9e21853314cfe41311484af25ad2b3f0c3d837b0994841735a6f768cf14b8dcbaa5b4fa75d429d068712c632fdb1a8a58a46f6d3b691f81bd7512", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9575a52757a85a829b64d883fba344bab7f6cc98f9498a8f8075d25d46f26642b4358096372d7a14938c4b58b4ed81b684879d07b018f9fe03c95101b019d074"} 23:36:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:36:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:36:29 INFO - Contents: 23:36:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30dd0d270da2e7a6207975b7e619afecea129acfe68902ed1b7b8b9b8469f55a6567c48999ae18652a10a865454a2e6ba1ebe593b7aa9c10ebe60ffb8155c210", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4bc66cfd2a9e21853314cfe41311484af25ad2b3f0c3d837b0994841735a6f768cf14b8dcbaa5b4fa75d429d068712c632fdb1a8a58a46f6d3b691f81bd7512", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9575a52757a85a829b64d883fba344bab7f6cc98f9498a8f8075d25d46f26642b4358096372d7a14938c4b58b4ed81b684879d07b018f9fe03c95101b019d074"} 23:36:30 INFO - Running post-run listener: copy_logs_to_upload_dir 23:36:30 INFO - Copying logs to upload dir... 23:36:30 INFO - mkdir: /builds/slave/test/build/upload/logs 23:36:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.876215 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-16 23:36:28.814120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:28.818150) ========= 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=fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712 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/Fx-Team/sha512/30dd0d270da2e7a6207975b7e619afecea129acfe68902ed1b7b8b9b8469f55a6567c48999ae18652a10a865454a2e6ba1ebe593b7aa9c10ebe60ffb8155c210", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4bc66cfd2a9e21853314cfe41311484af25ad2b3f0c3d837b0994841735a6f768cf14b8dcbaa5b4fa75d429d068712c632fdb1a8a58a46f6d3b691f81bd7512", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9575a52757a85a829b64d883fba344bab7f6cc98f9498a8f8075d25d46f26642b4358096372d7a14938c4b58b4ed81b684879d07b018f9fe03c95101b019d074"} build_url:https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30dd0d270da2e7a6207975b7e619afecea129acfe68902ed1b7b8b9b8469f55a6567c48999ae18652a10a865454a2e6ba1ebe593b7aa9c10ebe60ffb8155c210", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4bc66cfd2a9e21853314cfe41311484af25ad2b3f0c3d837b0994841735a6f768cf14b8dcbaa5b4fa75d429d068712c632fdb1a8a58a46f6d3b691f81bd7512", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9575a52757a85a829b64d883fba344bab7f6cc98f9498a8f8075d25d46f26642b4358096372d7a14938c4b58b4ed81b684879d07b018f9fe03c95101b019d074"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:28.848318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:28.848662) ========= 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=fa44defc139c4ba8574fe040000001db-1476684869.347836-1885780712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:28.930016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:36:28.930377) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:36:28.930750) ========= ========= Total master_lag: 0.18 =========