builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1477629187.38 results: success (0) buildid: 20161027183022 builduid: f4099652650e48c2ba08552189163d30 revision: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.377206) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.377785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.378114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.393037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.393319) ========= 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=836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 21:33:08-- 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% 212K=0.06s 2016-10-27 21:33:08 (212 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.592122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.592887) ========= 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=836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021706 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.645490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:07.645835) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 --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 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 --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=836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 21:33:08,374 truncating revision to first 12 chars 2016-10-27 21:33:08,374 Setting DEBUG logging. 2016-10-27 21:33:08,374 attempt 1/10 2016-10-27 21:33:08,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9272c247ecf1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 21:33:08,686 unpacking tar archive at: fx-team-9272c247ecf1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636470 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:08.295664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:08.296027) ========= script_repo_revision: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:08.296419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:08.296699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 21:33:08.306312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-27 21:33:08.306663) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:33:09 INFO - MultiFileLogger online at 20161027 21:33:09 in /builds/slave/test 21:33:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:33:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:33:09 INFO - {'append_to_log': False, 21:33:09 INFO - 'base_work_dir': '/builds/slave/test', 21:33:09 INFO - 'blob_upload_branch': 'Fx-Team', 21:33:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:33:09 INFO - 'branch': 'Fx-Team', 21:33:09 INFO - 'buildbot_json_path': 'buildprops.json', 21:33:09 INFO - 'config_files': ('talos/linux_config.py',), 21:33:09 INFO - 'default_actions': ('clobber', 21:33:09 INFO - 'read-buildbot-config', 21:33:09 INFO - 'download-and-extract', 21:33:09 INFO - 'populate-webroot', 21:33:09 INFO - 'create-virtualenv', 21:33:09 INFO - 'install', 21:33:09 INFO - 'run-tests'), 21:33:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:33:09 INFO - 'download_minidump_stackwalk': True, 21:33:09 INFO - 'download_symbols': 'ondemand', 21:33:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:33:09 INFO - 'tooltool.py': '/tools/tooltool.py', 21:33:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:33:09 INFO - '/tools/misc-python/virtualenv.py')}, 21:33:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:33:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:33:09 INFO - 'installer_path': 'installer.exe', 21:33:09 INFO - 'log_level': 'info', 21:33:09 INFO - 'log_name': 'talos', 21:33:09 INFO - 'log_to_console': True, 21:33:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:33:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:33:09 INFO - 'opt_config_files': (), 21:33:09 INFO - 'pip_index': False, 21:33:09 INFO - 'sps_profile': False, 21:33:09 INFO - 'sps_profile_interval': 0, 21:33:09 INFO - 'suite': 'dromaeojs', 21:33:09 INFO - 'system_bits': '32', 21:33:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:33:09 INFO - 'title': 'talos-linux64-ix-028', 21:33:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:33:09 INFO - 'use_talos_json': True, 21:33:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:33:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:33:09 INFO - 'work_dir': 'build'} 21:33:09 INFO - [mozharness: 2016-10-28 04:33:09.128742Z] Running clobber step. 21:33:09 INFO - Running pre-action listener: _resource_record_pre_action 21:33:09 INFO - Running main action method: clobber 21:33:09 INFO - rmtree: /builds/slave/test/build 21:33:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:33:09 INFO - Running post-action listener: _resource_record_post_action 21:33:09 INFO - [mozharness: 2016-10-28 04:33:09.598850Z] Finished clobber step (success) 21:33:09 INFO - [mozharness: 2016-10-28 04:33:09.598952Z] Running read-buildbot-config step. 21:33:09 INFO - Running pre-action listener: _resource_record_pre_action 21:33:09 INFO - Running main action method: read_buildbot_config 21:33:09 INFO - Using buildbot properties: 21:33:09 INFO - { 21:33:09 INFO - "project": "", 21:33:09 INFO - "product": "firefox", 21:33:09 INFO - "script_repo_revision": "production", 21:33:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:33:09 INFO - "repository": "", 21:33:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:33:09 INFO - "buildid": "20161027183022", 21:33:09 INFO - "pgo_build": "True", 21:33:09 INFO - "basedir": "/builds/slave/test", 21:33:09 INFO - "buildnumber": 1169, 21:33:09 INFO - "slavename": "talos-linux64-ix-028", 21:33:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:33:09 INFO - "platform": "ubuntu64_hw", 21:33:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:33:09 INFO - "branch": "fx-team", 21:33:09 INFO - "repo_path": "integration/fx-team", 21:33:09 INFO - "revision": "9272c247ecf1fc24a72b4ef3181d95c12b2063d2", 21:33:09 INFO - "stage_platform": "linux64-pgo", 21:33:09 INFO - "builduid": "f4099652650e48c2ba08552189163d30", 21:33:09 INFO - "slavebuilddir": "test" 21:33:09 INFO - } 21:33:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:33:09 INFO - Running post-action listener: _resource_record_post_action 21:33:09 INFO - [mozharness: 2016-10-28 04:33:09.601398Z] Finished read-buildbot-config step (success) 21:33:09 INFO - [mozharness: 2016-10-28 04:33:09.601487Z] Running download-and-extract step. 21:33:09 INFO - Running pre-action listener: _resource_record_pre_action 21:33:09 INFO - Running main action method: download_and_extract 21:33:09 INFO - mkdir: /builds/slave/test/build/tests 21:33: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')]} 21:33:09 INFO - trying https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:33:09 INFO - Downloading https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/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 21:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/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 21:33:10 INFO - Downloaded 1361 bytes. 21:33:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:33:10 INFO - Using the following test package requirements: 21:33:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:33:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:33:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:33:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'jsshell-linux-x86_64.zip'], 21:33:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:33:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:33:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:33:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:33:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:33:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:33:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:33:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:33:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:33:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:33:10 INFO - Fetch https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:33:10 INFO - Http code: 200 21:33:10 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 21:33:10 INFO - x-amz-cf-id: pVaPY7cG4ZFDEWHW2o7o57xEEXO-uZqiwgBp8J_aqYmIcd9aFPElqQ== 21:33:10 INFO - x-amz-version-id: mSNjWMmvVxAWYUarfR5xXXDyLhXd0U58 21:33:11 INFO - Expected file size: 21992577 21:33:11 INFO - Obtained file size: 21992577 21:33:15 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 21:33:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:33:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:33:15 INFO - Fetch https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:33:15 INFO - Http code: 200 21:33:15 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 21:33:15 INFO - x-amz-cf-id: U9_t3OSRvwNJoEqbgF_An3J_ukwgXitzn1p22rCAYKRghz5f36ieAw== 21:33:15 INFO - x-amz-version-id: mSNjWMmvVxAWYUarfR5xXXDyLhXd0U58 21:33:15 INFO - Expected file size: 21992577 21:33:15 INFO - Obtained file size: 21992577 21:33:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:33:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:33:20 INFO - Fetch https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:33:20 INFO - Http code: 200 21:33:20 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 21:33:20 INFO - x-amz-cf-id: SaRG6coD_8twEav5Z1STx_QKsZ16hD86nz5QdVD4q1NtalOlIBKbNQ== 21:33:20 INFO - x-amz-version-id: XEB.f4ZZ7RiMfdawFeyUg.MIN.eEK2AL 21:33:21 INFO - Expected file size: 14409028 21:33:21 INFO - Obtained file size: 14409028 21:33: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')]} 21:33:21 INFO - trying https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:33:21 INFO - Downloading https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/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 21:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/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 21:33:22 INFO - Downloaded 59366889 bytes. 21:33:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:33:22 INFO - mkdir: /builds/slave/test/properties 21:33:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:33:22 INFO - Writing to file /builds/slave/test/properties/build_url 21:33:22 INFO - Contents: 21:33:22 INFO - build_url:https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:33:23 INFO - Running post-action listener: _resource_record_post_action 21:33:23 INFO - Running post-action listener: set_extra_try_arguments 21:33:23 INFO - [mozharness: 2016-10-28 04:33:23.290916Z] Finished download-and-extract step (success) 21:33:23 INFO - [mozharness: 2016-10-28 04:33:23.291145Z] Running populate-webroot step. 21:33:23 INFO - Running pre-action listener: _resource_record_pre_action 21:33:23 INFO - Running main action method: populate_webroot 21:33:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:33:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:33:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:33:23 INFO - '--tppagecycles', 21:33:23 INFO - '7'], 21:33:23 INFO - 'tests': ['tsvgm']}}, 21:33:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:33:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:33:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:33:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:33:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:33:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:33:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['damp', 'tps']}, 21:33:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'tests': ['damp', 'tps']}, 21:33:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['dromaeo_dom']}, 21:33:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:33:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['basic_compositor_video']}, 21:33:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:33:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['a11yr', 21:33:23 INFO - 'ts_paint', 21:33:23 INFO - 'tpaint', 21:33:23 INFO - 'sessionrestore', 21:33:23 INFO - 'sessionrestore_no_auto_restore', 21:33:23 INFO - 'tabpaint']}, 21:33:23 INFO - 'other-e10s': {'tests': ['a11yr', 21:33:23 INFO - 'ts_paint', 21:33:23 INFO - 'tpaint', 21:33:23 INFO - 'sessionrestore', 21:33:23 INFO - 'sessionrestore_no_auto_restore', 21:33:23 INFO - 'tabpaint']}, 21:33:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:33:23 INFO - 'ts_paint', 21:33:23 INFO - 'tpaint', 21:33:23 INFO - 'sessionrestore', 21:33:23 INFO - 'sessionrestore_no_auto_restore', 21:33:23 INFO - 'tabpaint']}, 21:33:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:33:23 INFO - 'ts_paint', 21:33:23 INFO - 'tpaint', 21:33:23 INFO - 'sessionrestore', 21:33:23 INFO - 'sessionrestore_no_auto_restore', 21:33:23 INFO - 'tabpaint']}, 21:33:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['a11yr', 21:33:23 INFO - 'ts_paint', 21:33:23 INFO - 'tpaint', 21:33:23 INFO - 'sessionrestore', 21:33:23 INFO - 'sessionrestore_no_auto_restore', 21:33:23 INFO - 'tabpaint']}, 21:33:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['a11yr', 21:33:23 INFO - 'ts_paint', 21:33:23 INFO - 'tpaint', 21:33:23 INFO - 'sessionrestore', 21:33:23 INFO - 'sessionrestore_no_auto_restore', 21:33:23 INFO - 'tabpaint']}, 21:33:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['tsvgx', 21:33:23 INFO - 'tsvgr_opacity', 21:33:23 INFO - 'tart', 21:33:23 INFO - 'tscrollx', 21:33:23 INFO - 'cart']}, 21:33:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:33:23 INFO - 'tsvgr_opacity', 21:33:23 INFO - 'tart', 21:33:23 INFO - 'tscrollx', 21:33:23 INFO - 'cart']}, 21:33:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'talos_options': ['--disable-e10s'], 21:33:23 INFO - 'tests': ['tp5o']}, 21:33:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'tests': ['tp5o']}, 21:33:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'talos_options': ['--disable-e10s', 21:33:23 INFO - '--xperf_path', 21:33:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:33:23 INFO - 'tests': ['tp5n']}, 21:33:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:23 INFO - 'talos_options': ['--xperf_path', 21:33:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:33:23 INFO - 'tests': ['tp5n']}}, 21:33:23 INFO - 'talos.zip': {'path': '', 21:33:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:33:23 INFO - Running post-action listener: _resource_record_post_action 21:33:23 INFO - [mozharness: 2016-10-28 04:33:23.308446Z] Finished populate-webroot step (success) 21:33:23 INFO - [mozharness: 2016-10-28 04:33:23.308536Z] Running create-virtualenv step. 21:33:23 INFO - Running pre-action listener: _resource_record_pre_action 21:33:23 INFO - Running main action method: create_virtualenv 21:33:23 INFO - Creating virtualenv /builds/slave/test/build/venv 21:33:23 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 21:33:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:33:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:33:23 INFO - Using real prefix '/usr' 21:33:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:33:23 INFO - Installing distribute.............................................................................................................................................................................................done. 21:33:25 INFO - Installing pip.................done. 21:33:25 INFO - Return code: 0 21:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:33:26 INFO - Reading from file tmpfile_stdout 21:33:26 INFO - Output received: 21:33:26 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) 21:33:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:33:26 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')]} 21:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:26 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')]} 21:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:26 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:26 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 21:33:26 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 21:33:26 INFO - Using env: {'DISPLAY': ':0', 21:33:26 INFO - 'HOME': '/home/cltbld', 21:33:26 INFO - 'LANG': 'en_US.UTF-8', 21:33:26 INFO - 'LANGUAGE': 'en_US:en', 21:33:26 INFO - 'LOGNAME': 'cltbld', 21:33:26 INFO - 'MAIL': '/var/mail/cltbld', 21:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:26 INFO - 'MOZ_NO_REMOTE': '1', 21:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:26 INFO - 'NO_EM_RESTART': '1', 21:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:26 INFO - 'PWD': '/builds/slave/test', 21:33:26 INFO - 'SHELL': '/bin/bash', 21:33:26 INFO - 'SHLVL': '1', 21:33:26 INFO - 'TERM': 'linux', 21:33:26 INFO - 'TMOUT': '86400', 21:33:26 INFO - 'USER': 'cltbld', 21:33:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:26 INFO - '_': '/tools/buildbot/bin/python'} 21:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:26 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 21:33:26 INFO - Cleaning up... 21:33:26 INFO - Return code: 0 21:33:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:33:26 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')]} 21:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:26 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')]} 21:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:26 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:26 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 21:33:26 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 21:33:26 INFO - Using env: {'DISPLAY': ':0', 21:33:26 INFO - 'HOME': '/home/cltbld', 21:33:26 INFO - 'LANG': 'en_US.UTF-8', 21:33:26 INFO - 'LANGUAGE': 'en_US:en', 21:33:26 INFO - 'LOGNAME': 'cltbld', 21:33:26 INFO - 'MAIL': '/var/mail/cltbld', 21:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:26 INFO - 'MOZ_NO_REMOTE': '1', 21:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:26 INFO - 'NO_EM_RESTART': '1', 21:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:26 INFO - 'PWD': '/builds/slave/test', 21:33:26 INFO - 'SHELL': '/bin/bash', 21:33:26 INFO - 'SHLVL': '1', 21:33:26 INFO - 'TERM': 'linux', 21:33:26 INFO - 'TMOUT': '86400', 21:33:26 INFO - 'USER': 'cltbld', 21:33:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:26 INFO - '_': '/tools/buildbot/bin/python'} 21:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:26 INFO - Downloading/unpacking psutil>=3.1.1 21:33:26 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 21:33:26 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 21:33:26 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 21:33:26 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 21:33:26 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 21:33:26 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 21:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:33:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:33:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:33:28 INFO - Installing collected packages: psutil 21:33:28 INFO - Running setup.py install for psutil 21:33:28 INFO - building 'psutil._psutil_linux' extension 21:33:28 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 21:33:28 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 21:33:28 INFO - building 'psutil._psutil_posix' extension 21:33:28 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 21:33:28 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 21:33:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:33:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:33:29 INFO - Successfully installed psutil 21:33:29 INFO - Cleaning up... 21:33:29 INFO - Return code: 0 21:33:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:33:29 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')]} 21:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:29 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')]} 21:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:29 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:29 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 21:33:29 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 21:33:29 INFO - Using env: {'DISPLAY': ':0', 21:33:29 INFO - 'HOME': '/home/cltbld', 21:33:29 INFO - 'LANG': 'en_US.UTF-8', 21:33:29 INFO - 'LANGUAGE': 'en_US:en', 21:33:29 INFO - 'LOGNAME': 'cltbld', 21:33:29 INFO - 'MAIL': '/var/mail/cltbld', 21:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:29 INFO - 'MOZ_NO_REMOTE': '1', 21:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:29 INFO - 'NO_EM_RESTART': '1', 21:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:29 INFO - 'PWD': '/builds/slave/test', 21:33:29 INFO - 'SHELL': '/bin/bash', 21:33:29 INFO - 'SHLVL': '1', 21:33:29 INFO - 'TERM': 'linux', 21:33:29 INFO - 'TMOUT': '86400', 21:33:29 INFO - 'USER': 'cltbld', 21:33:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:29 INFO - '_': '/tools/buildbot/bin/python'} 21:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:33:29 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 21:33:29 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 21:33:29 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 21:33:29 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 21:33:29 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 21:33:29 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 21:33:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:33:31 INFO - Installing collected packages: mozsystemmonitor 21:33:31 INFO - Running setup.py install for mozsystemmonitor 21:33:31 INFO - Successfully installed mozsystemmonitor 21:33:31 INFO - Cleaning up... 21:33:31 INFO - Return code: 0 21:33:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:33:31 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')]} 21:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:31 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')]} 21:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:31 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:31 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 21:33:31 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 21:33:31 INFO - Using env: {'DISPLAY': ':0', 21:33:31 INFO - 'HOME': '/home/cltbld', 21:33:31 INFO - 'LANG': 'en_US.UTF-8', 21:33:31 INFO - 'LANGUAGE': 'en_US:en', 21:33:31 INFO - 'LOGNAME': 'cltbld', 21:33:31 INFO - 'MAIL': '/var/mail/cltbld', 21:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:31 INFO - 'MOZ_NO_REMOTE': '1', 21:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:31 INFO - 'NO_EM_RESTART': '1', 21:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:31 INFO - 'PWD': '/builds/slave/test', 21:33:31 INFO - 'SHELL': '/bin/bash', 21:33:31 INFO - 'SHLVL': '1', 21:33:31 INFO - 'TERM': 'linux', 21:33:31 INFO - 'TMOUT': '86400', 21:33:31 INFO - 'USER': 'cltbld', 21:33:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:31 INFO - '_': '/tools/buildbot/bin/python'} 21:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:31 INFO - Downloading/unpacking jsonschema==2.5.1 21:33:31 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 21:33:31 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 21:33:31 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 21:33:31 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 21:33:31 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 21:33:31 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 21:33:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:33:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:33:33 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 21:33:33 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 21:33:33 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 21:33:33 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 21:33:33 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 21:33:33 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 21:33:33 INFO - Downloading functools32-3.2.3-2.tar.gz 21:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:33:33 INFO - warning: no files found matching '*.txt' 21:33:33 INFO - no previously-included directories found matching 'build' 21:33:33 INFO - no previously-included directories found matching 'dist' 21:33:33 INFO - no previously-included directories found matching '.git*' 21:33:33 INFO - Installing collected packages: jsonschema, functools32 21:33:33 INFO - Running setup.py install for functools32 21:33:34 INFO - warning: no files found matching '*.txt' 21:33:34 INFO - no previously-included directories found matching 'build' 21:33:34 INFO - no previously-included directories found matching 'dist' 21:33:34 INFO - no previously-included directories found matching '.git*' 21:33:34 INFO - Successfully installed jsonschema functools32 21:33:34 INFO - Cleaning up... 21:33:34 INFO - Return code: 0 21:33:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:33:34 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')]} 21:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:34 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')]} 21:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:34 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:34 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 21:33:34 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 21:33:34 INFO - Using env: {'DISPLAY': ':0', 21:33:34 INFO - 'HOME': '/home/cltbld', 21:33:34 INFO - 'LANG': 'en_US.UTF-8', 21:33:34 INFO - 'LANGUAGE': 'en_US:en', 21:33:34 INFO - 'LOGNAME': 'cltbld', 21:33:34 INFO - 'MAIL': '/var/mail/cltbld', 21:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:34 INFO - 'MOZ_NO_REMOTE': '1', 21:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:34 INFO - 'NO_EM_RESTART': '1', 21:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:34 INFO - 'PWD': '/builds/slave/test', 21:33:34 INFO - 'SHELL': '/bin/bash', 21:33:34 INFO - 'SHLVL': '1', 21:33:34 INFO - 'TERM': 'linux', 21:33:34 INFO - 'TMOUT': '86400', 21:33:34 INFO - 'USER': 'cltbld', 21:33:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:34 INFO - '_': '/tools/buildbot/bin/python'} 21:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:33:34 INFO - Cleaning up... 21:33:34 INFO - Return code: 0 21:33:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:33:34 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')]} 21:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:34 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')]} 21:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:34 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:34 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 21:33:34 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 21:33:34 INFO - Using env: {'DISPLAY': ':0', 21:33:34 INFO - 'HOME': '/home/cltbld', 21:33:34 INFO - 'LANG': 'en_US.UTF-8', 21:33:34 INFO - 'LANGUAGE': 'en_US:en', 21:33:34 INFO - 'LOGNAME': 'cltbld', 21:33:34 INFO - 'MAIL': '/var/mail/cltbld', 21:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:34 INFO - 'MOZ_NO_REMOTE': '1', 21:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:34 INFO - 'NO_EM_RESTART': '1', 21:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:34 INFO - 'PWD': '/builds/slave/test', 21:33:34 INFO - 'SHELL': '/bin/bash', 21:33:34 INFO - 'SHLVL': '1', 21:33:34 INFO - 'TERM': 'linux', 21:33:34 INFO - 'TMOUT': '86400', 21:33:34 INFO - 'USER': 'cltbld', 21:33:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:34 INFO - '_': '/tools/buildbot/bin/python'} 21:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:34 INFO - Downloading/unpacking blobuploader==1.2.4 21:33:34 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 21:33:34 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 21:33:34 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 21:33:34 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 21:33:34 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 21:33:34 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 21:33:36 INFO - Downloading blobuploader-1.2.4.tar.gz 21:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:33:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:33:36 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 21:33:36 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 21:33:36 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 21:33:36 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 21:33:36 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 21:33:36 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 21:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:33:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:33:36 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 21:33:36 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 21:33:36 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 21:33:36 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 21:33:36 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 21:33:36 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 21:33:37 INFO - Downloading docopt-0.6.1.tar.gz 21:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:33:37 INFO - Installing collected packages: blobuploader, requests, docopt 21:33:37 INFO - Running setup.py install for blobuploader 21:33:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:33:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:33:37 INFO - Running setup.py install for requests 21:33:37 INFO - Running setup.py install for docopt 21:33:37 INFO - Successfully installed blobuploader requests docopt 21:33:37 INFO - Cleaning up... 21:33:37 INFO - Return code: 0 21:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:37 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')]} 21:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:37 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')]} 21:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:37 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:37 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 21:33:37 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 21:33:37 INFO - Using env: {'DISPLAY': ':0', 21:33:37 INFO - 'HOME': '/home/cltbld', 21:33:37 INFO - 'LANG': 'en_US.UTF-8', 21:33:37 INFO - 'LANGUAGE': 'en_US:en', 21:33:37 INFO - 'LOGNAME': 'cltbld', 21:33:37 INFO - 'MAIL': '/var/mail/cltbld', 21:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:37 INFO - 'MOZ_NO_REMOTE': '1', 21:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:37 INFO - 'NO_EM_RESTART': '1', 21:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:37 INFO - 'PWD': '/builds/slave/test', 21:33:37 INFO - 'SHELL': '/bin/bash', 21:33:37 INFO - 'SHLVL': '1', 21:33:37 INFO - 'TERM': 'linux', 21:33:37 INFO - 'TMOUT': '86400', 21:33:37 INFO - 'USER': 'cltbld', 21:33:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:37 INFO - '_': '/tools/buildbot/bin/python'} 21:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:33:38 INFO - Running setup.py (path:/tmp/pip-AZ2RRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:33:38 INFO - Running setup.py (path:/tmp/pip-ckQl4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:33:38 INFO - Running setup.py (path:/tmp/pip-MzSOcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:33:38 INFO - Running setup.py (path:/tmp/pip-ystUWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:33:38 INFO - Running setup.py (path:/tmp/pip-AfHWOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:33:38 INFO - Running setup.py (path:/tmp/pip-JafOd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:33:38 INFO - Running setup.py (path:/tmp/pip-BdzeRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:33:38 INFO - Running setup.py (path:/tmp/pip-DJ6cd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:33:38 INFO - Running setup.py (path:/tmp/pip-684D0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:33:38 INFO - Running setup.py (path:/tmp/pip-waVESI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:33:38 INFO - Running setup.py (path:/tmp/pip-dQP_Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:33:38 INFO - Running setup.py (path:/tmp/pip-0DxHo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:33:38 INFO - Running setup.py (path:/tmp/pip-QwyVpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:33:39 INFO - Running setup.py (path:/tmp/pip-53tI13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:39 INFO - Running setup.py (path:/tmp/pip-fvHXRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:33:39 INFO - Running setup.py (path:/tmp/pip-xEDi08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:33:39 INFO - Running setup.py (path:/tmp/pip-3aP529-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:33:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:33:39 INFO - Running setup.py install for manifestparser 21:33:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:33:39 INFO - Running setup.py install for mozcrash 21:33:39 INFO - Running setup.py install for mozdebug 21:33:39 INFO - Running setup.py install for mozdevice 21:33:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:33:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:33:39 INFO - Running setup.py install for mozfile 21:33:39 INFO - Running setup.py install for mozhttpd 21:33:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:33:39 INFO - Running setup.py install for mozinfo 21:33:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Running setup.py install for mozInstall 21:33:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Running setup.py install for mozleak 21:33:40 INFO - Running setup.py install for mozlog 21:33:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Running setup.py install for moznetwork 21:33:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Running setup.py install for mozprocess 21:33:40 INFO - Running setup.py install for mozprofile 21:33:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Running setup.py install for mozrunner 21:33:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:33:40 INFO - Running setup.py install for mozscreenshot 21:33:40 INFO - Running setup.py install for moztest 21:33:41 INFO - Running setup.py install for mozversion 21:33:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:33:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:33:41 INFO - Cleaning up... 21:33:41 INFO - Return code: 0 21:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:41 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')]} 21:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:41 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')]} 21:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:41 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:41 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 21:33:41 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 21:33:41 INFO - Using env: {'DISPLAY': ':0', 21:33:41 INFO - 'HOME': '/home/cltbld', 21:33:41 INFO - 'LANG': 'en_US.UTF-8', 21:33:41 INFO - 'LANGUAGE': 'en_US:en', 21:33:41 INFO - 'LOGNAME': 'cltbld', 21:33:41 INFO - 'MAIL': '/var/mail/cltbld', 21:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:41 INFO - 'MOZ_NO_REMOTE': '1', 21:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:41 INFO - 'NO_EM_RESTART': '1', 21:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:41 INFO - 'PWD': '/builds/slave/test', 21:33:41 INFO - 'SHELL': '/bin/bash', 21:33:41 INFO - 'SHLVL': '1', 21:33:41 INFO - 'TERM': 'linux', 21:33:41 INFO - 'TMOUT': '86400', 21:33:41 INFO - 'USER': 'cltbld', 21:33:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:41 INFO - '_': '/tools/buildbot/bin/python'} 21:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:33:41 INFO - Running setup.py (path:/tmp/pip-RgKnri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:33:41 INFO - Running setup.py (path:/tmp/pip-qtSiu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:33:41 INFO - Running setup.py (path:/tmp/pip-yLQTZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:33:41 INFO - Running setup.py (path:/tmp/pip-mdb2AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:33:41 INFO - Running setup.py (path:/tmp/pip-EBNjAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:33:41 INFO - Running setup.py (path:/tmp/pip-zSQN_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:33:41 INFO - Running setup.py (path:/tmp/pip-sXOQab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:33:41 INFO - Running setup.py (path:/tmp/pip-0bGRHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:33:41 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)) 21:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:33:41 INFO - Running setup.py (path:/tmp/pip-h4r92S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:33:42 INFO - Running setup.py (path:/tmp/pip-4rDEKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:33:42 INFO - Running setup.py (path:/tmp/pip-HNmaLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:33:42 INFO - Running setup.py (path:/tmp/pip-Sm5H2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:33:42 INFO - Running setup.py (path:/tmp/pip-gDXaJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:33:42 INFO - Running setup.py (path:/tmp/pip-Dh6J5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:42 INFO - Running setup.py (path:/tmp/pip-ogUO39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:33:42 INFO - Running setup.py (path:/tmp/pip-laL30k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:33:42 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)) 21:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:33:42 INFO - Running setup.py (path:/tmp/pip-P3j9_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:33:42 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)) 21:33:42 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)) 21:33:42 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)) 21:33:42 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)) 21:33:42 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)) 21:33:42 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)) 21:33:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:33:42 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 21:33:42 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 21:33:42 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 21:33:42 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 21:33:42 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 21:33:42 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 21:33:44 INFO - Downloading blessings-1.6.tar.gz 21:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:33:44 INFO - Installing collected packages: blessings 21:33:44 INFO - Running setup.py install for blessings 21:33:44 INFO - Successfully installed blessings 21:33:44 INFO - Cleaning up... 21:33:44 INFO - Return code: 0 21:33:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:33:45 INFO - Reading from file tmpfile_stdout 21:33:45 INFO - Current package versions: 21:33:45 INFO - argparse == 1.2.1 21:33:45 INFO - blessings == 1.6 21:33:45 INFO - blobuploader == 1.2.4 21:33:45 INFO - docopt == 0.6.1 21:33:45 INFO - functools32 == 3.2.3-2 21:33:45 INFO - jsonschema == 2.5.1 21:33:45 INFO - manifestparser == 1.1 21:33:45 INFO - mozInstall == 1.12 21:33:45 INFO - mozcrash == 0.17 21:33:45 INFO - mozdebug == 0.1 21:33:45 INFO - mozdevice == 0.48 21:33:45 INFO - mozfile == 1.2 21:33:45 INFO - mozhttpd == 0.7 21:33:45 INFO - mozinfo == 0.9 21:33:45 INFO - mozleak == 0.1 21:33:45 INFO - mozlog == 3.4 21:33:45 INFO - moznetwork == 0.27 21:33:45 INFO - mozprocess == 0.23 21:33:45 INFO - mozprofile == 0.28 21:33:45 INFO - mozrunner == 6.12 21:33:45 INFO - mozscreenshot == 0.1 21:33:45 INFO - mozsystemmonitor == 0.3 21:33:45 INFO - moztest == 0.7 21:33:45 INFO - mozversion == 1.4 21:33:45 INFO - psutil == 3.1.1 21:33:45 INFO - requests == 1.2.3 21:33:45 INFO - wsgiref == 0.1.2 21:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:45 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')]} 21:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:45 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')]} 21:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:45 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:45 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 21:33:45 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 21:33:45 INFO - Using env: {'DISPLAY': ':0', 21:33:45 INFO - 'HOME': '/home/cltbld', 21:33:45 INFO - 'LANG': 'en_US.UTF-8', 21:33:45 INFO - 'LANGUAGE': 'en_US:en', 21:33:45 INFO - 'LOGNAME': 'cltbld', 21:33:45 INFO - 'MAIL': '/var/mail/cltbld', 21:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:45 INFO - 'MOZ_NO_REMOTE': '1', 21:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:45 INFO - 'NO_EM_RESTART': '1', 21:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:45 INFO - 'PWD': '/builds/slave/test', 21:33:45 INFO - 'SHELL': '/bin/bash', 21:33:45 INFO - 'SHLVL': '1', 21:33:45 INFO - 'TERM': 'linux', 21:33:45 INFO - 'TMOUT': '86400', 21:33:45 INFO - 'USER': 'cltbld', 21:33:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:45 INFO - '_': '/tools/buildbot/bin/python'} 21:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 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)) 21:33:45 INFO - Cleaning up... 21:33:45 INFO - Return code: 0 21:33:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:33:45 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')]} 21:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:45 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')]} 21:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:45 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 0x7ffabe77bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', '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 21:33:45 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 21:33:45 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 21:33:45 INFO - Using env: {'DISPLAY': ':0', 21:33:45 INFO - 'HOME': '/home/cltbld', 21:33:45 INFO - 'LANG': 'en_US.UTF-8', 21:33:45 INFO - 'LANGUAGE': 'en_US:en', 21:33:45 INFO - 'LOGNAME': 'cltbld', 21:33:45 INFO - 'MAIL': '/var/mail/cltbld', 21:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:45 INFO - 'MOZ_NO_REMOTE': '1', 21:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:45 INFO - 'NO_EM_RESTART': '1', 21:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:45 INFO - 'PWD': '/builds/slave/test', 21:33:45 INFO - 'SHELL': '/bin/bash', 21:33:45 INFO - 'SHLVL': '1', 21:33:45 INFO - 'TERM': 'linux', 21:33:45 INFO - 'TMOUT': '86400', 21:33:45 INFO - 'USER': 'cltbld', 21:33:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:45 INFO - '_': '/tools/buildbot/bin/python'} 21:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:33:45 INFO - Cleaning up... 21:33:45 INFO - Return code: 0 21:33:45 INFO - Running post-action listener: _resource_record_post_action 21:33:45 INFO - Running post-action listener: _start_resource_monitoring 21:33:45 INFO - Starting resource monitoring. 21:33:45 INFO - [mozharness: 2016-10-28 04:33:45.535161Z] Finished create-virtualenv step (success) 21:33:45 INFO - [mozharness: 2016-10-28 04:33:45.535627Z] Running install step. 21:33:45 INFO - Running pre-action listener: _resource_record_pre_action 21:33:45 INFO - Running main action method: install 21:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:33:45 INFO - Reading from file tmpfile_stdout 21:33:45 INFO - Detecting whether we're running mozinstall >=1.0... 21:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:33:45 INFO - Reading from file tmpfile_stdout 21:33:45 INFO - Output received: 21:33:45 INFO - Usage: mozinstall [options] installer 21:33:45 INFO - Options: 21:33:45 INFO - -h, --help show this help message and exit 21:33:45 INFO - -d DEST, --destination=DEST 21:33:45 INFO - Directory to install application into. [default: 21:33:45 INFO - "/builds/slave/test"] 21:33:45 INFO - --app=APP Application being installed. [default: firefox] 21:33:45 INFO - mkdir: /builds/slave/test/build/application 21:33:45 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'] 21:33:45 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 21:34:02 INFO - Reading from file tmpfile_stdout 21:34:02 INFO - Output received: 21:34:02 INFO - /builds/slave/test/build/application/firefox/firefox 21:34:02 INFO - Running post-action listener: _resource_record_post_action 21:34:02 INFO - [mozharness: 2016-10-28 04:34:02.720355Z] Finished install step (success) 21:34:02 INFO - [mozharness: 2016-10-28 04:34:02.720601Z] Running run-tests step. 21:34:02 INFO - Running pre-action listener: _resource_record_pre_action 21:34:02 INFO - Running main action method: run_tests 21:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:34:02 INFO - Python 2.7.3 21:34:02 INFO - Return code: 0 21:34:02 INFO - grabbing minidump binary from tooltool 21:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:02 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 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:34:02 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 21:34:02 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 21:34:02 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 21:34:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:34:02 INFO - Return code: 0 21:34:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:34:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:34:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:34:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:34:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:34:02 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:34:02 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:34:02 INFO - Using env: {'DISPLAY': ':0', 21:34:02 INFO - 'HOME': '/home/cltbld', 21:34:02 INFO - 'LANG': 'en_US.UTF-8', 21:34:02 INFO - 'LANGUAGE': 'en_US:en', 21:34:02 INFO - 'LOGNAME': 'cltbld', 21:34:02 INFO - 'MAIL': '/var/mail/cltbld', 21:34:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:34:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:02 INFO - 'MOZ_NO_REMOTE': '1', 21:34:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:02 INFO - 'NO_EM_RESTART': '1', 21:34:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:02 INFO - 'PWD': '/builds/slave/test', 21:34:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:34:02 INFO - 'SHELL': '/bin/bash', 21:34:02 INFO - 'SHLVL': '1', 21:34:02 INFO - 'TERM': 'linux', 21:34:02 INFO - 'TMOUT': '86400', 21:34:02 INFO - 'USER': 'cltbld', 21:34:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583', 21:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:02 INFO - '_': '/tools/buildbot/bin/python'} 21:34:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:34:02 INFO - mozversion application_buildid: 20161027183022 21:34:02 INFO - mozversion application_changeset: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 21:34:02 INFO - mozversion application_display_name: Nightly 21:34:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:34:02 INFO - mozversion application_name: Firefox 21:34:02 INFO - mozversion application_remotingname: firefox 21:34:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:34:02 INFO - mozversion application_vendor: Mozilla 21:34:02 INFO - mozversion application_version: 52.0a1 21:34:02 INFO - mozversion platform_buildid: 20161027183022 21:34:02 INFO - mozversion platform_changeset: 9272c247ecf1fc24a72b4ef3181d95c12b2063d2 21:34:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:34:02 INFO - mozversion platform_version: 52.0a1 21:34:02 INFO - using testdate: 1477629242 21:34:02 INFO - actual date: 1477629242 21:34:02 INFO - starting webserver on 'localhost:39180' 21:34:02 INFO - SUITE-START | Running 2 tests 21:34:02 INFO - TEST-START | dromaeo_css 21:34:02 INFO - operating with platform_type : linux_ 21:34:02 INFO - Initialising browser for dromaeo_css test... 21:34:02 INFO - TEST-INFO | started process 16489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpft2jd1/profile http://localhost:39180/getInfo.html) 21:34:07 INFO - PROCESS | 16489 | __metrics Screen width/height:1600/1200 21:34:07 INFO - PROCESS | 16489 | colorDepth:24 21:34:07 INFO - PROCESS | 16489 | Browser inner width/height: 1024/697 21:34:07 INFO - PROCESS | 16489 | __metrics 21:34:07 INFO - PROCESS | 16489 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:34:07 INFO - PROCESS | 16489 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:34:08 INFO - PROCESS | 16489 | console.error: PushService: 21:34:08 INFO - PROCESS | 16489 | stateChangeProcessEnqueue: Error transitioning state 21:34:08 INFO - PROCESS | 16489 | UnknownError 21:34:09 INFO - TEST-INFO | 16489: exit 0 21:34:09 INFO - Browser initialized. 21:34:09 INFO - Running cycle 1/1 for dromaeo_css test... 21:34:09 INFO - TEST-INFO | started process 16574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpft2jd1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:34:21 INFO - PROCESS | 16574 | RSS: Main: 172089344 21:34:21 INFO - PROCESS | 16574 | 21:35:12 INFO - PROCESS | 16574 | 1477629312416 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] 21:37:23 INFO - PROCESS | 16574 | Cycle 1(1): loaded http://localhost:39180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39180/tests/dromaeo/cssquery-ext.html) 21:37:26 INFO - PROCESS | 16574 | RSS: Main: 397078528 21:37:26 INFO - PROCESS | 16574 | 21:40:29 INFO - PROCESS | 16574 | Cycle 1(1): loaded http://localhost:39180/tests/dromaeo/cssquery-ext.html (next: http://localhost:39180/tests/dromaeo/cssquery-jquery.html) 21:40:29 INFO - PROCESS | 16574 | RSS: Main: 284549120 21:40:29 INFO - PROCESS | 16574 | 21:43:31 INFO - PROCESS | 16574 | Cycle 1(1): loaded http://localhost:39180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39180/tests/dromaeo/cssquery-mootools.html) 21:43:32 INFO - PROCESS | 16574 | RSS: Main: 288759808 21:43:32 INFO - PROCESS | 16574 | 21:46:34 INFO - PROCESS | 16574 | Cycle 1(1): loaded http://localhost:39180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39180/tests/dromaeo/cssquery-prototype.html) 21:46:34 INFO - PROCESS | 16574 | RSS: Main: 220442624 21:46:34 INFO - PROCESS | 16574 | 21:49:37 INFO - PROCESS | 16574 | Cycle 1(1): loaded http://localhost:39180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39180/tests/dromaeo/cssquery-yui.html) 21:49:38 INFO - PROCESS | 16574 | RSS: Main: 220303360 21:49:38 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | Cycle 1(1): loaded http://localhost:39180/tests/dromaeo/cssquery-yui.html (next: http://localhost:39180/tests/dromaeo/cssquery-dojo.html) 21:52:41 INFO - PROCESS | 16574 | RSS: Main: 312344576 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | __start_tp_report 21:52:41 INFO - PROCESS | 16574 | _x_x_mozilla_page_load 21:52:41 INFO - PROCESS | 16574 | _x_x_mozilla_page_load_details 21:52:41 INFO - PROCESS | 16574 | |i|pagename|runs| 21:52:41 INFO - PROCESS | 16574 | |0;dojo.html;3037.635483741951;3066.049524647361;3093.164845491718;3108.797928134671;3109.95335069974;5269.6311258211845;5328.973355133224;5333;5374.758135883885;5398.838034858951;5367.329083864517;5380.0046991306635;5392.78428862845;5396.568274538037;5401.4328495508;4847.103285892113;4860.854174374775;4881.731504767236;4904.313396124546;4957.429895562021;5005.824796132136;5065.79736810529;5071.1886098224295;5073.1122053640465;5075.340205773263;4922.827701030465;4941.876453088666;4978.477259887714;4982.875428114308;5053.949460505385;5013.423456302536;5037.823676171353;5042.39491261051;5044.772985215674;5102.056119617882;4876.195427754416;4891.755412229374;4918.655694101414;4938.308636790852;4946.653734238605;5409.648372855751;5414.052540805344;5425;5453;5516.613837031409;5824;5852.034414321632;5856.736446859902;5857.092150716646;5865.384134665841;5701.629394089371;5741.167530708066;5779.9422005779825;5917.082852157922;5922.230110085661;5441.727913604304;5444.945550544523;5444.972775136099;5445.401005889349;5447.428020057877;5841.824745257649;5892.057270836732;5895.204147440127;5899.085641725454;5904.527637788967;5638.774449022075;5682.886342273131;5685.857853553694;5689.77240910359;5692.601517893708;5759.971200143972;5766.192733017381;5767.452092051249;5767.913481297784;5774.971125144348;5752.942470575241;5768.3654797972185;5773.913391299134;5774.48029677331;5775;5727.341355744143;5746;5761.452661997104;5793.652380857077;5795.797147099831;4403.119376124788;4415.84544540946;4470.955290447054;4471.28459446487;4525.977370113128;3938.7636741795586;3987.7407968481957;3996.3406038003986;4014.698897582693;4094.795260237036;5337.626366154332;5341.332333458317;5341.839744807662;5382.892342153135;5390.838274851761;5806.361300256968;5847.8245652630485;5850.912236316459;5853.7365818538265;5857.941420585825;5257.710825904612;5478.808241711521;5478.972605136949;5479.205515200274;5479.287692600016;4973.303737476756;5011.423686276052;5053;5060.49395060491;5141.640085194075;6043.335233124353;6046.455818976313;6049.818505444756;6055.424734650202;6055.515558755377;5871.354151043467;5876.970615146897;5877.94122058774;5878.353381128158;5881.32364778056;5624.606277560695;5850.385709500441;5906;5964.8807023860145;5977.731002104829;5653.038983372919;5729.885402291848;5736.6558006519745;5747.224124743273;5805.245318108618;5870.9412905870395;5885.73514191871;5913.793017244376;5929.792457263975;5932;5560.499555040065;5609.971950140223;5613;5667.829965101054;5692.31692196939;5665.49010589049;5672.517835983987;5677.318721753416;5679.119736440858;5679.460451257124;5647.548196144381;5649.039663257338;5655.604107712421;5661.094224923992;5662.546996240373;5663.461971112738;5698.088305871041;5701.116326969326;5705.857353566194;5710.086386178192;5575.080111781511;5575.721213939206;5589.245451864109;5589.5807814413265;5597.916031259453 21:52:41 INFO - PROCESS | 16574 | |1;ext.html;572.9455701708338;605.6789901352284;605.8243109498246;608.8477880529866;612.2591664086456;31391.68608313916;41453;42936.57063429365;43136.56863431365;46312.30531542029;42385.15229695412;42663.36004959921;42708.14583708324;42740.14519709604;42763.78618106913;8607.91392086079;8755.868661970075;8756.737297881042;8757.693480728176;8764.079771623983;7866.921330786676;8047.879281810778;10287.12559432449;10505.527251273672;10510.842337364946;10646.78706425871;10694.572217111307;10696.197785166105;10698.732531686732;10707.946460267687;10467.476626168662;10513.369197848153;10539.894601054044;10539.947300263526;10547.261691681586;10413.895861041368;10471.476426178737;10471.895281047167;10478.056974872221;10480.213983951158;40385;40650.79674601638;40651.7967410164;40751.388729169084;40784.184316313505;3426.3489936911906;3505.4216054351;3653.4337177737493;3841.78870162141;3960.4653371794725;30994.690053099406;31018.534721979187;31038.379232415224;31114;31559.36881262385;4260.275753121946;4271.8077686503875;4513.097380523908;4556;4593.173228818811;310708;311554;312644.99999999773;313115;313749;30456.238594034883;31272.21819454532;31278.84360578228;56822;57652.42347576471;36248.45627315593;36450.45324320137;36458.8177059113;36495.63504364975;36499.452508212395;13407.329633518286;13520.59438216855;13524.729505409836;13529.526466573623;13530.661733456742;10646.361218326925;10978.835317470244;11001.119910407147;11008.229423940407;11079.778404431867;7779.7666070017995;7827.334676552443;7950.920490795133;8158.714444994397;8210.466319689202;3134.200778801391;3169.556262123305;3186.9362612747614;3194.5687332209855;3235.7573182011442;1037.0296436770197;1040.1262939131016;1046.6964580271635;1054.0433141267572;1065.5950738719237;31739.68260317367;32281.677183228338;32326.19184520406;32350.676493235238;32650.836745816596;1053.599632139782;1056.9101626361692;1063.4204358624568;1080.7244152741;1094.874089479704;16394.754078688828;17151.313947441962;17158;17272.481825545256;17315.56711082233;468801;473112;473961;474014;474198;55347.723261383435;55596;55878.44121558814;55951;56027.15959260614;1180.5690922813112;1225.4424236972156;1263.4377701922924;1314.3822403470544;1339.504383378137;29044.56433153547;31726.841365793025;32090.35819283648;32958.17604559905;32985;49252.75373623109;49803.50196498133;49817;49864.25203622021;49903;372822;374884;377405;378183;378466;26695.733042669326;27731.584026240027;27796.166115016582;28796.568051479662;29082.41835163327;45803.31295030644;46267;46355;46870.29694554653;46893.66935463669;39116;39576.2084758309;39613.60386396099;39701.20597587974;41807.790961045;39477.40783888302;39812.40281395723;40000.599994000855;40589;41659.7917010413;39902.60097398989;40882.79558602307;41483.792581036905;41588;41686.791566041975;32585;35321.6444437778;35518.46722299116;36207.81896090608;36825.97457139883;27578.310542236606;27630.585541216496;27780.44439111247;27986.720132799226;28120.156395308175 21:52:41 INFO - PROCESS | 16574 | |2;jquery.html;364.8139448881073;377.41500673955363;391.68665067945653;398.64321432318076;417.9456670632819;13961.650958726024;15608.687826243467;18495.44513664589;19045.14296856643;19078.523036924085;18712.438626841184;18760.437186884414;18845.24619015238;19032.429027129172;19061.14224859881;4202.579742025803;5562.972185139069;5798.971005144968;5805.796797112102;5806.18713380125;4362.520122786491;6379.649119298437;6505.609663420186;6600.636964966925;6604.504662150334;6284.277308109557;6473.6763161841955;6520.869582608345;6551.508636852255;6559.639219842907;6441.227052753676;6482.902756458657;6503.772367967098;6506.089147519304;6506.837329066788;5074.923876141824;5344.679319240858;5393.568514518829;5487.204355368489;5502.779888804443;13623.386947587283;13903.582892513241;16895.493135205965;22378.55242895133;22611.434714132112;2312.17917639239;2337;2448.4980578981267;2476.628505724138;2898.5507246376847;9975.25185611082;10349.637762678345;10596.576136954513;11831.053515718722;13491.865081349159;1882.1436246507806;1924.3841970569424;1926.6628340040577;1927.296536764085;1968.7145363922293;74387.62806185988;86950.56524717336;87188.5640571793;88302.55848720779;89056.55471722665;10447.84328235077;10590.947045264724;10688.412137332365;10850.457477126112;11004.779904401867;15268.770968435483;15278.38886444552;15287.847121528643;15293.388264469297;15330.463433779763;7233.8553228935125;7416.22129676387;7431.702731890664;7554.357879580297;7606.505577137468;6864.759733409406;6896.172459304815;6906;7060.7881763547175;7097.680604372816;4581.79381927814;4654.745855616957;4691.601213896789;4692.178868697964;4801.95198048015;1850.7779066512105;1920.3374835681668;1941.7281580578447;1950.697641865513;1992;859.3769517100052;914.2046419614977;919.6321471411355;965.5172413793103;1012.1801340913884;17926.462206133838;19124;19429.22283108688;19619.509512262022;19707.368768339427;950.843110886696;965.285688590438;967.086103632075;993.7167907146429;1001.9448930308903;10163.390196588229;10647.414392208348;10830.133589312836;10869.184811139196;10929.234953553334;420817;433941;438432.1471682681;439143;442577;81133.59433202796;91262.54368728114;91507.54246228727;93910.53044734732;94046.52976735073;995.2732009962854;1048.5072016152396;1054.6835949215206;1060;1060.5068643081004;17005.319787208373;17228.483145505656;17814;17982.640347193246;18167.27330906802;29393.412131757672;33283.667163329024;38010;40633.187336252515;42141.36787948122;49959.18936136258;56524.71737641285;59158;60440.395596043476;60652.69673651604;8182.7954301142945;8447.535385553607;8453.154684531497;8705.564721764013;8769.693060742844;9629;11984.580539681418;12680;12793.936030319788;13443.260620665957;5704.11586204139;11718.183681529377;11802.76394472123;11934;11994.820077698667;11350.60272890478;11453.713657158638;11461.770764584828;11849.822252666389;11938.22401543897;11374.886251137714;11636.418179090842;11771.587994420497;11893.881061189277;12114.454849531616;8299.29455996247;8559.315254779727;8691.608877600396;8732.388732788644;8848.601812918563;9946.801063978824;11456.885431145914;11504.25222360544;11563.768724625628;11617.128715346214 21:52:41 INFO - PROCESS | 16574 | |3;mootools.html;1343.892488600912;1476.5348915091745;1482.3107255126365;1639.1967935711498;1774.2725482552157;7323.926760732391;8148.3888708346885;8496.235338819504;8522.275606573448;8748.956255218714;8506.957465212665;8574.91425085749;8583.87124193136;8584.785380365494;8606.655733770658;2318.8376813623054;2347.0377145370403;2347.6595893595418;2348.495073559184;2353.035255545227;2319.22306027481;2365.207655435431;2379.4646204604;2380.5119950410126;2384.535015671936;2298.402415371999;2317.8261630377706;2322.9419264518438;2322.976770232293;2340;2193.352960876537;2207.9889600552056;2210.6573481110454;2211.834112441565;2212.070930209316;2257.2551058150934;2272.1479445208047;2275.4311422144465;2276.9981208268473;2278.4190031541852;8482.448640838387;8504.532250726208;8522.659093636246;8594.785130371729;8733.388662793606;5323.627346085776;5449.291592093042;5453.23654688344;5459.044667183267;5460.535854452376;3287.572615559962;3327.184839714261;3382.797032178077;3391.9660803392144;3501.19472521319;1067.1676092647747;1078.1805827571102;1081.697124805048;1099.8515200447916;1111.0667039686703;11701.122415818847;11731.589394371156;11760;11763.764724705457;11777.88222117785;4280.614744672995;4452.131834292347;4534.6599005074095;4537.523560026149;4622.306654001926;9452.669156579486;9455.763605909908;9458.95270523643;9459.52702364879;9481.525923703788;5075.746212689351;5100.846974590768;5106.923396149061;5107.233914912718;5114.87212819675;4162.7502349859105;4310.267254566731;4430.955690443118;4558.635309175258;4684.8756298488115;3668.4497325401403;3721.813909304524;3811.3901775715754;3812.14226798968;3821.560520540118;1146.094585277638;1163.1450883600546;1179.0862081886607;1180.5631916191064;1196.6529706385052;826.8093944719704;830.6967956695884;895.1898531828706;960.6973803251954;982.4841957972122;5591.804286850022;5870.412958704181;5930.377310382434;5946.762129514857;6194.38056194386;441.28732097662686;442.67905768318354;450.4639479019956;456.59819358964563;456.7145534041224;4061.3095773718537;4092.590740925943;4145.937810932838;4162.313218318944;4170.145120250341;10232.334898231591;10786.946065269623;10800.08199303068;10803.189760767973;10833.78332433347;10419.739506512245;10499.47502624881;10667.413292268844;10676.572937082585;10757.731056723487;7900.2889739923685;8161.26548610616;8161.428699991063;8220.424570280142;8226.218509241733;5779.711014449176;5780.479756821906;5820.854478638068;5869.119632055226;6004.159417681615;9708.5145742714;9734.123928846439;9797.21622270231;9819.607215711292;9854.507274636382;9300.767480813034;9495.715128546155;9666.371685840399;9878;9884.456354900549;6796;7003.26465721092;7439.293267139613;7675.846483070419;7831.412644051833;8188.631511582113;8351.665933362598;8376.162383761575;8381.790455238424;8403.453775504573;7344.9632751838035;7468.10382754073;7469.775906722807;7631.198724133886;7680.6543705534505;7362.226966168475;7557.886631700639;7580.090389153116;7585.2035536267895;7588.734394296173;6632.568883022588;6779.661016949034;6784.253732089565;6791.762288320083;6836.5214434989075;4830.951690483191;4977;4995.400551933792;5005.899882002267;5210.765515551733;4755.738434386142;4860.927086093782;4863.537963893425;4876.512348765095;4960.305557222064 21:52:41 INFO - PROCESS | 16574 | |4;prototype.html;335.52020610526944;341.8547117475072;347.1650680114326;347.1806536573684;352.49593081892897;5273.367195936488;5379.919301210485;5383.596230282725;5397.4332695067;5399.946000539993;5307.442718514559;5334.973325133378;5350.170723537858;5350.571954243661;5359.222912677659;3975.3043217436975;4077.531083925357;4093.2427500912277;4107.568705285947;4202.159568086379;4155.854545090922;4194.8112334945;4206.26390381682;4207.537170911212;4220.556841531641;4150.875473735793;4165.229777344632;4165.354370072629;4176.767853483215;4183.3226734889695;3958.782266975315;3986.441898134249;4154.335306350969;4167.124903770212;4182.247195504808;3675.889723308305;3695.113172838526;3710.9814450927574;3712.684421824148;3720.813959302051;5128.410232823236;5128.769205385766;5146.305248791403;5157.69053856766;5183.159978207757;4660.273739862185;4748.287756836467;4773.546513081252;4791;4799.760011999421;5489.862753431156;5508.834734957958;5516.531094856942;5518.91721624176;5560.277163968658;4077.959220407817;4087.509498860126;4093.89765255868;4105.835766569334;4125.91748165038;5537.58468114889;5804.361520232771;5807.970960145214;5812.680302583356;5855.502282306009;4094.61101195386;4113.095119073859;4116.468371951229;4129.380592911088;4130.56629053951;4153.937690934638;4171.395147703566;4176.477940257468;4179.017930786263;4186.267403204427;4524.796384162721;4734.763261836894;4768.713877167381;4814.9518504815205;4815.855524334275;5596.636218645775;5608;5627.634203776742;5627.662340259598;5643.887122257614;1424.7221791750717;1447.6887469194173;1447.8914081443934;1453.7237924794256;1454.6508837878832;890.8050079230371;918.1874041473344;925.8564922437033;934.4907025671025;947.1475671895349;5036.866704991347;5122.641415100908;5246.31797866275;5251.973740131275;5255.76349064293;5730.541556675539;5733.104782085021;5733.140028995684;5741.971290143522;5742.478243265538;5180.300659411007;5235.607329450307;5283.471652834763;5308.814191503356;5317.202419637086;3005.233665415305;3024.2137044368624;3030.5908702325346;3030.9545356819667;3040.4493708208975;5829.679367634736;5843.620164689281;5846.4153584642045;5864.2083318752275;5893.554175017405;5579.581531385163;5791.8552036199435;5799.840031993618;5817.243758311392;5850.736716847752;5830.006445584788;5835.270591176103;5837.532997360286;5880.206172166874;5884.852878677982;5428.67427954324;5685.431456854281;5703.344115426613;5725.570582206268;5740.90922724681;5725.8568535786935;5726.856828579319;5737;5737.168110623853;5753.367129615823;5848.181254624271;5905.940940590539;5918;5933.643981361132;5950;3977.1449138435373;4123.731957422758;4137.524184718796;4138.213739389506;4158.251514727257;5698.31620205578;5736.627119237236;5743.195952566561;5753.769849205984;5766.509846662912;5437.510624043855;5643.830685079454;5649.4633009864;5663.490285874291;5665.263515742927;5579.6652200868075;5580;5588.469095435927;5603.579731520071;5619.719014049363;5560.110382338807;5568.77724891016;5603.607747457639;5622.971885140548;5625.578081643811;5428.37573679032;5441.809536666197;5542.140968149782;5623.803166889139;5638.464345887298;5502.761878577288;5541.695206763667;5547.583931205095;5552;5558.221848941233 21:52:41 INFO - PROCESS | 16574 | |5;yui.html;672.13630484827;685.7874059041694;688.4458011300904;713.7787285941357;765.770268919324;14368.71262574748;14678.339474723636;14713.705725885477;14801.037932534391;14845.257737113141;14176.432942682306;14280.71438571228;14326.71346573068;14334.784978225309;14345.78481322781;656.9835754106161;678.2844099475077;776.669915286004;793.3970182661176;806.1495122645606;817.3338728935928;817.3747083481112;820.2986446588171;820.8030072782519;820.9096999330069;865.7056600755742;866.7746385939638;868.0885070675797;869.3783944479695;869.4088020146298;694.0942070597893;710.1123595505618;833.8832563441123;859.1666083898608;860.4708104515709;623.7536173211556;629.8267976306506;630.4263120560269;630.6121735132906;630.8265227062549;14438.783418248735;14483.1310121392;14486.42054317826;14487.855121448756;14492.782608260884;13394.665133371645;13452.32738363078;13475.86524134756;13492.865071349259;13551.864481355258;12573.937130314382;12652.493900243979;12778.872211277861;12912.289824059673;13064;4350.15172041452;4416.3596278539435;4453.755043472608;4492.52828453011;4520.88697782558;64049;64349.35650643527;65565.67217163931;66324;66767.66616166888;10290.639827605997;10321.09749361829;10451.425171615634;10605.89394106049;10633.89366106329;16942;16956;16966.830331696772;17002.48992530226;17073.317067317417;7463.328300452877;7464.489274413329;7682.116556595951;7862.646180921873;8008.079070906804;4360.215161271001;4390.692651514363;4484.551544845489;4501.909961800811;4504.009117994036;3318.435865902802;3434.3989801785087;3436.278381539905;3436.381451338733;3541.557305336833;650.8600650860088;655.7540922154192;662;672.2504407585604;678.1455366238575;688.0185067006988;696.8779866199454;706.7844307486266;707.7912015955305;719.9021492224296;8736.737897863075;9052.683156089506;9163.679271225476;9196.35625506208;9315.906840931639;623.2489849731063;644.4522156167315;704.2499737779351;726.0706295941204;732.7984804178786;4016.457778199964;4340;4375.584319489643;4387.846425375096;4401.119776044804;51220.74389628028;51224.74387628038;85330.57334713287;86949.56525217333;88106;73033.26966730371;73465.63267183737;73686;75221.62389188129;75596.24403756003;68063.31936680668;69048.6547567269;70241;72763.63618181876;73641.2635873645;8227.547484888388;8422.915770842214;8630.525321107149;8653.30773538128;8789.560521974003;48492.5150748488;48721.51278487311;48971.755141224065;49080.263796042374;49346.50653493563;59565.7021714906;63908.680456597416;66145.00782488362;66689;66875.66562167158;11295.265807722471;11494.080473562262;11573.942130289295;11732.648020559396;11762.94118529402;12736.490540378281;12946.676333091747;13498.257595832323;13724.176549407068;13903.374348154559;12879.35603219854;12989.350532473527;13490.730185396433;14110.788338175142;14133.293335333397;13148.671283217996;13364.398602062736;13582.79625805594;14316.57050288493;14355.282235888373;12800.807987880375;13085.149465284727;13262.93368533151;13603.319834008458;13761.830244429335;10406.58373665045;10768.246222764332;11017.173711971474;11203.663890083311;11318.773624527299;11496.655100347003;11689;11815.468303926173;11893;11972.521099155936 21:52:41 INFO - PROCESS | 16574 | __end_tp_report 21:52:41 INFO - PROCESS | 16574 | __start_cc_report 21:52:41 INFO - PROCESS | 16574 | _x_x_mozilla_cycle_collect,2369 21:52:41 INFO - PROCESS | 16574 | __end_cc_report 21:52:41 INFO - PROCESS | 16574 | __startTimestamp1477630361404__endTimestamp 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | ------- Summary: start ------- 21:52:41 INFO - PROCESS | 16574 | Number of tests: 6 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | [#0] dojo.html Cycles:165 Average:5392.06 Median:5613.00 stddev:608.46 (10.8%) stddev-sans-first:581.62 21:52:41 INFO - PROCESS | 16574 | Values: 3037.6 3066.0 3093.2 3108.8 3110.0 5269.6 5329.0 5333.0 5374.8 5398.8 5367.3 5380.0 5392.8 5396.6 5401.4 4847.1 4860.9 4881.7 4904.3 4957.4 5005.8 5065.8 5071.2 5073.1 5075.3 4922.8 4941.9 4978.5 4982.9 5053.9 5013.4 5037.8 5042.4 5044.8 5102.1 4876.2 4891.8 4918.7 4938.3 4946.7 5409.6 5414.1 5425.0 5453.0 5516.6 5824.0 5852.0 5856.7 5857.1 5865.4 5701.6 5741.2 5779.9 5917.1 5922.2 5441.7 5444.9 5445.0 5445.4 5447.4 5841.8 5892.1 5895.2 5899.1 5904.5 5638.8 5682.9 5685.9 5689.8 5692.6 5760.0 5766.2 5767.5 5767.9 5775.0 5752.9 5768.4 5773.9 5774.5 5775.0 5727.3 5746.0 5761.5 5793.7 5795.8 4403.1 4415.8 4471.0 4471.3 4526.0 3938.8 3987.7 3996.3 4014.7 4094.8 5337.6 5341.3 5341.8 5382.9 5390.8 5806.4 5847.8 5850.9 5853.7 5857.9 5257.7 5478.8 5479.0 5479.2 5479.3 4973.3 5011.4 5053.0 5060.5 5141.6 6043.3 6046.5 6049.8 6055.4 6055.5 5871.4 5877.0 5877.9 5878.4 5881.3 5624.6 5850.4 5906.0 5964.9 5977.7 5653.0 5729.9 5736.7 5747.2 5805.2 5870.9 5885.7 5913.8 5929.8 5932.0 5560.5 5610.0 5613.0 5667.8 5692.3 5665.5 5672.5 5677.3 5679.1 5679.5 5647.5 5649.0 5655.6 5661.1 5662.5 5663.5 5698.1 5701.1 5705.9 5710.1 5575.1 5575.7 5589.2 5589.6 5597.9 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | [#1] ext.html Cycles:180 Average:53834.05 Median:35420.06 stddev:103907.57 (293.4%) stddev-sans-first:104122.10 21:52:41 INFO - PROCESS | 16574 | Values: 572.9 605.7 605.8 608.8 612.3 31391.7 41453.0 42936.6 43136.6 46312.3 42385.2 42663.4 42708.1 42740.1 42763.8 8607.9 8755.9 8756.7 8757.7 8764.1 7866.9 8047.9 10287.1 10505.5 10510.8 10646.8 10694.6 10696.2 10698.7 10707.9 10467.5 10513.4 10539.9 10539.9 10547.3 10413.9 10471.5 10471.9 10478.1 10480.2 40385.0 40650.8 40651.8 40751.4 40784.2 3426.3 3505.4 3653.4 3841.8 3960.5 30994.7 31018.5 31038.4 31114.0 31559.4 4260.3 4271.8 4513.1 4556.0 4593.2 310708.0 311554.0 312645.0 313115.0 313749.0 30456.2 31272.2 31278.8 56822.0 57652.4 36248.5 36450.5 36458.8 36495.6 36499.5 13407.3 13520.6 13524.7 13529.5 13530.7 10646.4 10978.8 11001.1 11008.2 11079.8 7779.8 7827.3 7950.9 8158.7 8210.5 3134.2 3169.6 3186.9 3194.6 3235.8 1037.0 1040.1 1046.7 1054.0 1065.6 31739.7 32281.7 32326.2 32350.7 32650.8 1053.6 1056.9 1063.4 1080.7 1094.9 16394.8 17151.3 17158.0 17272.5 17315.6 468801.0 473112.0 473961.0 474014.0 474198.0 55347.7 55596.0 55878.4 55951.0 56027.2 1180.6 1225.4 1263.4 1314.4 1339.5 29044.6 31726.8 32090.4 32958.2 32985.0 49252.8 49803.5 49817.0 49864.3 49903.0 372822.0 374884.0 377405.0 378183.0 378466.0 26695.7 27731.6 27796.2 28796.6 29082.4 45803.3 46267.0 46355.0 46870.3 46893.7 39116.0 39576.2 39613.6 39701.2 41807.8 39477.4 39812.4 40000.6 40589.0 41659.8 39902.6 40882.8 41483.8 41588.0 41686.8 32585.0 35321.6 35518.5 36207.8 36826.0 27578.3 27630.6 27780.4 27986.7 28120.2 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | [#2] jquery.html Cycles:180 Average:27122.98 Median:19193.71 stddev:72144.31 (375.9%) stddev-sans-first:72318.72 21:52:41 INFO - PROCESS | 16574 | Values: 364.8 377.4 391.7 398.6 417.9 13961.7 15608.7 18495.4 19045.1 19078.5 18712.4 18760.4 18845.2 19032.4 19061.1 4202.6 5563.0 5799.0 5805.8 5806.2 4362.5 6379.6 6505.6 6600.6 6604.5 6284.3 6473.7 6520.9 6551.5 6559.6 6441.2 6482.9 6503.8 6506.1 6506.8 5074.9 5344.7 5393.6 5487.2 5502.8 13623.4 13903.6 16895.5 22378.6 22611.4 2312.2 2337.0 2448.5 2476.6 2898.6 9975.3 10349.6 10596.6 11831.1 13491.9 1882.1 1924.4 1926.7 1927.3 1968.7 74387.6 86950.6 87188.6 88302.6 89056.6 10447.8 10590.9 10688.4 10850.5 11004.8 15268.8 15278.4 15287.8 15293.4 15330.5 7233.9 7416.2 7431.7 7554.4 7606.5 6864.8 6896.2 6906.0 7060.8 7097.7 4581.8 4654.7 4691.6 4692.2 4802.0 1850.8 1920.3 1941.7 1950.7 1992.0 859.4 914.2 919.6 965.5 1012.2 17926.5 19124.0 19429.2 19619.5 19707.4 950.8 965.3 967.1 993.7 1001.9 10163.4 10647.4 10830.1 10869.2 10929.2 420817.0 433941.0 438432.1 439143.0 442577.0 81133.6 91262.5 91507.5 93910.5 94046.5 995.3 1048.5 1054.7 1060.0 1060.5 17005.3 17228.5 17814.0 17982.6 18167.3 29393.4 33283.7 38010.0 40633.2 42141.4 49959.2 56524.7 59158.0 60440.4 60652.7 8182.8 8447.5 8453.2 8705.6 8769.7 9629.0 11984.6 12680.0 12793.9 13443.3 5704.1 11718.2 11802.8 11934.0 11994.8 11350.6 11453.7 11461.8 11849.8 11938.2 11374.9 11636.4 11771.6 11893.9 12114.5 8299.3 8559.3 8691.6 8732.4 8848.6 9946.8 11456.9 11504.3 11563.8 11617.1 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | [#3] mootools.html Cycles:180 Average:5610.11 Median:4968.65 stddev:3182.24 (64.0%) stddev-sans-first:3175.02 21:52:41 INFO - PROCESS | 16574 | Values: 1343.9 1476.5 1482.3 1639.2 1774.3 7323.9 8148.4 8496.2 8522.3 8749.0 8507.0 8574.9 8583.9 8584.8 8606.7 2318.8 2347.0 2347.7 2348.5 2353.0 2319.2 2365.2 2379.5 2380.5 2384.5 2298.4 2317.8 2322.9 2323.0 2340.0 2193.4 2208.0 2210.7 2211.8 2212.1 2257.3 2272.1 2275.4 2277.0 2278.4 8482.4 8504.5 8522.7 8594.8 8733.4 5323.6 5449.3 5453.2 5459.0 5460.5 3287.6 3327.2 3382.8 3392.0 3501.2 1067.2 1078.2 1081.7 1099.9 1111.1 11701.1 11731.6 11760.0 11763.8 11777.9 4280.6 4452.1 4534.7 4537.5 4622.3 9452.7 9455.8 9459.0 9459.5 9481.5 5075.7 5100.8 5106.9 5107.2 5114.9 4162.8 4310.3 4431.0 4558.6 4684.9 3668.4 3721.8 3811.4 3812.1 3821.6 1146.1 1163.1 1179.1 1180.6 1196.7 826.8 830.7 895.2 960.7 982.5 5591.8 5870.4 5930.4 5946.8 6194.4 441.3 442.7 450.5 456.6 456.7 4061.3 4092.6 4145.9 4162.3 4170.1 10232.3 10786.9 10800.1 10803.2 10833.8 10419.7 10499.5 10667.4 10676.6 10757.7 7900.3 8161.3 8161.4 8220.4 8226.2 5779.7 5780.5 5820.9 5869.1 6004.2 9708.5 9734.1 9797.2 9819.6 9854.5 9300.8 9495.7 9666.4 9878.0 9884.5 6796.0 7003.3 7439.3 7675.8 7831.4 8188.6 8351.7 8376.2 8381.8 8403.5 7345.0 7468.1 7469.8 7631.2 7680.7 7362.2 7557.9 7580.1 7585.2 7588.7 6632.6 6779.7 6784.3 6791.8 6836.5 4831.0 4977.0 4995.4 5005.9 5210.8 4755.7 4860.9 4863.5 4876.5 4960.3 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | [#4] prototype.html Cycles:180 Average:4703.15 Median:5369.57 stddev:1376.66 (25.6%) stddev-sans-first:1340.92 21:52:41 INFO - PROCESS | 16574 | Values: 335.5 341.9 347.2 347.2 352.5 5273.4 5379.9 5383.6 5397.4 5399.9 5307.4 5335.0 5350.2 5350.6 5359.2 3975.3 4077.5 4093.2 4107.6 4202.2 4155.9 4194.8 4206.3 4207.5 4220.6 4150.9 4165.2 4165.4 4176.8 4183.3 3958.8 3986.4 4154.3 4167.1 4182.2 3675.9 3695.1 3711.0 3712.7 3720.8 5128.4 5128.8 5146.3 5157.7 5183.2 4660.3 4748.3 4773.5 4791.0 4799.8 5489.9 5508.8 5516.5 5518.9 5560.3 4078.0 4087.5 4093.9 4105.8 4125.9 5537.6 5804.4 5808.0 5812.7 5855.5 4094.6 4113.1 4116.5 4129.4 4130.6 4153.9 4171.4 4176.5 4179.0 4186.3 4524.8 4734.8 4768.7 4815.0 4815.9 5596.6 5608.0 5627.6 5627.7 5643.9 1424.7 1447.7 1447.9 1453.7 1454.7 890.8 918.2 925.9 934.5 947.1 5036.9 5122.6 5246.3 5252.0 5255.8 5730.5 5733.1 5733.1 5742.0 5742.5 5180.3 5235.6 5283.5 5308.8 5317.2 3005.2 3024.2 3030.6 3031.0 3040.4 5829.7 5843.6 5846.4 5864.2 5893.6 5579.6 5791.9 5799.8 5817.2 5850.7 5830.0 5835.3 5837.5 5880.2 5884.9 5428.7 5685.4 5703.3 5725.6 5740.9 5725.9 5726.9 5737.0 5737.2 5753.4 5848.2 5905.9 5918.0 5933.6 5950.0 3977.1 4123.7 4137.5 4138.2 4158.3 5698.3 5736.6 5743.2 5753.8 5766.5 5437.5 5643.8 5649.5 5663.5 5665.3 5579.7 5580.0 5588.5 5603.6 5619.7 5560.1 5568.8 5603.6 5623.0 5625.6 5428.4 5441.8 5542.1 5623.8 5638.5 5502.8 5541.7 5547.6 5552.0 5558.2 21:52:41 INFO - PROCESS | 16574 | 21:52:41 INFO - PROCESS | 16574 | [#5] yui.html Cycles:180 Average:17512.84 Median:48607.01 stddev:22847.83 (47.0%) stddev-sans-first:22876.93 21:52:41 INFO - PROCESS | 16574 | Values: 672.1 685.8 688.4 713.8 765.8 14368.7 14678.3 14713.7 14801.0 14845.3 14176.4 14280.7 14326.7 14334.8 14345.8 657.0 678.3 776.7 793.4 806.1 817.3 817.4 820.3 820.8 820.9 865.7 866.8 868.1 869.4 869.4 694.1 710.1 833.9 859.2 860.5 623.8 629.8 630.4 630.6 630.8 14438.8 14483.1 14486.4 14487.9 14492.8 13394.7 13452.3 13475.9 13492.9 13551.9 12573.9 12652.5 12778.9 12912.3 13064.0 4350.2 4416.4 4453.8 4492.5 4520.9 64049.0 64349.4 65565.7 66324.0 66767.7 10290.6 10321.1 10451.4 10605.9 10633.9 16942.0 16956.0 16966.8 17002.5 17073.3 7463.3 7464.5 7682.1 7862.6 8008.1 4360.2 4390.7 4484.6 4501.9 4504.0 3318.4 3434.4 3436.3 3436.4 3541.6 650.9 655.8 662.0 672.3 678.1 688.0 696.9 706.8 707.8 719.9 8736.7 9052.7 9163.7 9196.4 9315.9 623.2 644.5 704.2 726.1 732.8 4016.5 4340.0 4375.6 4387.8 4401.1 51220.7 51224.7 85330.6 86949.6 88106.0 73033.3 73465.6 73686.0 75221.6 75596.2 68063.3 69048.7 70241.0 72763.6 73641.3 8227.5 8422.9 8630.5 8653.3 8789.6 48492.5 48721.5 48971.8 49080.3 49346.5 59565.7 63908.7 66145.0 66689.0 66875.7 11295.3 11494.1 11573.9 11732.6 11762.9 12736.5 12946.7 13498.3 13724.2 13903.4 12879.4 12989.4 13490.7 14110.8 14133.3 13148.7 13364.4 13582.8 14316.6 14355.3 12800.8 13085.1 13262.9 13603.3 13761.8 10406.6 10768.2 11017.2 11203.7 11318.8 11496.7 11689.0 11815.5 11893.0 11972.5 21:52:41 INFO - PROCESS | 16574 | -------- Summary: end -------- 21:52:41 INFO - PROCESS | 16574 | 21:52:42 INFO - TEST-INFO | 16574: exit 0 21:52:42 INFO - TEST-OK | dromaeo_css | took 1119363ms 21:52:42 INFO - TEST-START | kraken 21:52:42 INFO - operating with platform_type : linux_ 21:52:42 INFO - Initialising browser for kraken test... 21:52:42 INFO - TEST-INFO | started process 16877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwqg3J/profile http://localhost:39180/getInfo.html) 21:52:46 INFO - PROCESS | 16877 | __metrics Screen width/height:1600/1200 21:52:46 INFO - PROCESS | 16877 | colorDepth:24 21:52:46 INFO - PROCESS | 16877 | Browser inner width/height: 1024/697 21:52:46 INFO - PROCESS | 16877 | __metrics 21:52:46 INFO - PROCESS | 16877 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:52:46 INFO - PROCESS | 16877 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:52:47 INFO - PROCESS | 16877 | console.error: PushService: 21:52:47 INFO - PROCESS | 16877 | stateChangeProcessEnqueue: Error transitioning state 21:52:47 INFO - PROCESS | 16877 | UnknownError 21:52:48 INFO - TEST-INFO | 16877: exit 0 21:52:48 INFO - Browser initialized. 21:52:48 INFO - Running cycle 1/1 for kraken test... 21:52:48 INFO - TEST-INFO | started process 16959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwqg3J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:53:00 INFO - PROCESS | 16959 | RSS: Main: 172232704 21:53:00 INFO - PROCESS | 16959 | 21:53:02 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39180/tests/kraken/driver.html?testName=audio-beat-detection) 21:53:03 INFO - PROCESS | 16959 | RSS: Main: 228675584 21:53:03 INFO - PROCESS | 16959 | 21:53:06 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39180/tests/kraken/driver.html?testName=audio-dft) 21:53:06 INFO - PROCESS | 16959 | RSS: Main: 216244224 21:53:06 INFO - PROCESS | 16959 | 21:53:10 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39180/tests/kraken/driver.html?testName=audio-fft) 21:53:10 INFO - PROCESS | 16959 | RSS: Main: 297607168 21:53:10 INFO - PROCESS | 16959 | 21:53:12 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39180/tests/kraken/driver.html?testName=audio-oscillator) 21:53:13 INFO - PROCESS | 16959 | RSS: Main: 207097856 21:53:13 INFO - PROCESS | 16959 | 21:53:15 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:53:16 INFO - PROCESS | 16959 | RSS: Main: 211148800 21:53:16 INFO - PROCESS | 16959 | 21:53:19 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39180/tests/kraken/driver.html?testName=imaging-darkroom) 21:53:19 INFO - PROCESS | 16959 | RSS: Main: 247717888 21:53:19 INFO - PROCESS | 16959 | 21:53:23 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39180/tests/kraken/driver.html?testName=imaging-desaturate) 21:53:23 INFO - PROCESS | 16959 | RSS: Main: 247570432 21:53:23 INFO - PROCESS | 16959 | 21:53:26 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39180/tests/kraken/driver.html?testName=json-parse-financial) 21:53:26 INFO - PROCESS | 16959 | RSS: Main: 247050240 21:53:26 INFO - PROCESS | 16959 | 21:53:28 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:53:29 INFO - PROCESS | 16959 | RSS: Main: 209014784 21:53:29 INFO - PROCESS | 16959 | 21:53:30 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:53:31 INFO - PROCESS | 16959 | RSS: Main: 216535040 21:53:31 INFO - PROCESS | 16959 | 21:53:33 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:53:34 INFO - PROCESS | 16959 | RSS: Main: 226574336 21:53:34 INFO - PROCESS | 16959 | 21:53:36 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:53:37 INFO - PROCESS | 16959 | RSS: Main: 234348544 21:53:37 INFO - PROCESS | 16959 | 21:53:40 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:53:40 INFO - PROCESS | 16959 | RSS: Main: 231579648 21:53:40 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | Cycle 1(1): loaded http://localhost:39180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39180/tests/kraken/driver.html?testName=ai-astar) 21:53:42 INFO - PROCESS | 16959 | RSS: Main: 281374720 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | __start_tp_report 21:53:42 INFO - PROCESS | 16959 | _x_x_mozilla_page_load 21:53:42 INFO - PROCESS | 16959 | _x_x_mozilla_page_load_details 21:53:42 INFO - PROCESS | 16959 | |i|pagename|runs| 21:53:42 INFO - PROCESS | 16959 | |0;ai-astar;103;111;112;110;111;112;112;113;110;110 21:53:42 INFO - PROCESS | 16959 | |1;audio-beat-detection;164;122;122;172;122;123;121;124;150;125 21:53:42 INFO - PROCESS | 16959 | |2;audio-dft;162;162;162;161;163;162;163;162;161;162 21:53:42 INFO - PROCESS | 16959 | |3;audio-fft;77;76;76;115;75;77;75;75;106;75 21:53:42 INFO - PROCESS | 16959 | |4;audio-oscillator;82;82;111;83;83;83;103;82;83;114 21:53:42 INFO - PROCESS | 16959 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;117;117;116 21:53:42 INFO - PROCESS | 16959 | |6;imaging-darkroom;146;146;146;146;146;147;147;147;147;147 21:53:42 INFO - PROCESS | 16959 | |7;imaging-desaturate;84;85;85;85;85;84;84;85;84;86 21:53:42 INFO - PROCESS | 16959 | |8;json-parse-financial;53;51;52;52;53;53;53;53;55;53 21:53:42 INFO - PROCESS | 16959 | |9;json-stringify-tinderbox;61;61;61;61;62;61;62;65;61;61 21:53:42 INFO - PROCESS | 16959 | |10;stanford-crypto-aes;90;87;80;80;80;79;86;79;79;87 21:53:42 INFO - PROCESS | 16959 | |11;stanford-crypto-ccm;130;147;131;143;129;128;134;133;166;147 21:53:42 INFO - PROCESS | 16959 | |12;stanford-crypto-pbkdf2;169;166;174;168;167;165;164;163;165;162 21:53:42 INFO - PROCESS | 16959 | |13;stanford-crypto-sha256-iterative;66;66;66;65;63;65;66;66;65;63 21:53:42 INFO - PROCESS | 16959 | __end_tp_report 21:53:42 INFO - PROCESS | 16959 | __start_cc_report 21:53:42 INFO - PROCESS | 16959 | _x_x_mozilla_cycle_collect,1691 21:53:42 INFO - PROCESS | 16959 | __end_cc_report 21:53:42 INFO - PROCESS | 16959 | __startTimestamp1477630422734__endTimestamp 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | ------- Summary: start ------- 21:53:42 INFO - PROCESS | 16959 | Number of tests: 14 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:1.09 21:53:42 INFO - PROCESS | 16959 | Values: 103.0 111.0 112.0 110.0 111.0 112.0 112.0 113.0 110.0 110.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:124.50 stddev:19.72 (15.8%) stddev-sans-first:17.80 21:53:42 INFO - PROCESS | 16959 | Values: 164.0 122.0 122.0 172.0 122.0 123.0 121.0 124.0 150.0 125.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 21:53:42 INFO - PROCESS | 16959 | Values: 162.0 162.0 162.0 161.0 163.0 162.0 163.0 162.0 161.0 162.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:14.83 (19.6%) stddev-sans-first:15.58 21:53:42 INFO - PROCESS | 16959 | Values: 77.0 76.0 76.0 115.0 75.0 77.0 75.0 75.0 106.0 75.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.50 stddev:13.21 (16.0%) stddev-sans-first:13.64 21:53:42 INFO - PROCESS | 16959 | Values: 82.0 82.0 111.0 83.0 83.0 83.0 103.0 82.0 83.0 114.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:53:42 INFO - PROCESS | 16959 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:53:42 INFO - PROCESS | 16959 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 21:53:42 INFO - PROCESS | 16959 | Values: 84.0 85.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 86.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 21:53:42 INFO - PROCESS | 16959 | Values: 53.0 51.0 52.0 52.0 53.0 53.0 53.0 53.0 55.0 53.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.32 21:53:42 INFO - PROCESS | 16959 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 62.0 65.0 61.0 61.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:4.27 (5.1%) stddev-sans-first:3.62 21:53:42 INFO - PROCESS | 16959 | Values: 90.0 87.0 80.0 80.0 80.0 79.0 86.0 79.0 79.0 87.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:138.50 stddev:12.02 (8.7%) stddev-sans-first:12.32 21:53:42 INFO - PROCESS | 16959 | Values: 130.0 147.0 131.0 143.0 129.0 128.0 134.0 133.0 166.0 147.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:3.47 (2.1%) stddev-sans-first:3.54 21:53:42 INFO - PROCESS | 16959 | Values: 169.0 166.0 174.0 168.0 167.0 165.0 164.0 163.0 165.0 162.0 21:53:42 INFO - PROCESS | 16959 | 21:53:42 INFO - PROCESS | 16959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 21:53:42 INFO - PROCESS | 16959 | Values: 66.0 66.0 66.0 65.0 63.0 65.0 66.0 66.0 65.0 63.0 21:53:42 INFO - PROCESS | 16959 | -------- Summary: end -------- 21:53:42 INFO - PROCESS | 16959 | 21:53:43 INFO - TEST-INFO | 16959: exit 0 21:53:43 INFO - TEST-OK | kraken | took 61616ms 21:53:43 INFO - SUITE-END | took 1180s 21:53:44 INFO - Completed test suite (00:19:41) 21:53:44 INFO - javascript benchmark 21:53:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.635483741951, 3066.049524647361, 3093.164845491718, 3108.797928134671, 3109.95335069974, 5269.6311258211845, 5328.973355133224, 5333.0, 5374.758135883885, 5398.838034858951, 5367.329083864517, 5380.0046991306635, 5392.78428862845, 5396.568274538037, 5401.4328495508, 4847.103285892113, 4860.854174374775, 4881.731504767236, 4904.313396124546, 4957.429895562021, 5005.824796132136, 5065.79736810529, 5071.1886098224295, 5073.1122053640465, 5075.340205773263, 4922.827701030465, 4941.876453088666, 4978.477259887714, 4982.875428114308, 5053.949460505385, 5013.423456302536, 5037.823676171353, 5042.39491261051, 5044.772985215674, 5102.056119617882, 4876.195427754416, 4891.755412229374, 4918.655694101414, 4938.308636790852, 4946.653734238605, 5409.648372855751, 5414.052540805344, 5425.0, 5453.0, 5516.613837031409, 5824.0, 5852.034414321632, 5856.736446859902, 5857.092150716646, 5865.384134665841, 5701.629394089371, 5741.167530708066, 5779.9422005779825, 5917.082852157922, 5922.230110085661, 5441.727913604304, 5444.945550544523, 5444.972775136099, 5445.401005889349, 5447.428020057877, 5841.824745257649, 5892.057270836732, 5895.204147440127, 5899.085641725454, 5904.527637788967, 5638.774449022075, 5682.886342273131, 5685.857853553694, 5689.77240910359, 5692.601517893708, 5759.971200143972, 5766.192733017381, 5767.452092051249, 5767.913481297784, 5774.971125144348, 5752.942470575241, 5768.3654797972185, 5773.913391299134, 5774.48029677331, 5775.0, 5727.341355744143, 5746.0, 5761.452661997104, 5793.652380857077, 5795.797147099831, 4403.119376124788, 4415.84544540946, 4470.955290447054, 4471.28459446487, 4525.977370113128, 3938.7636741795586, 3987.7407968481957, 3996.3406038003986, 4014.698897582693, 4094.795260237036, 5337.626366154332, 5341.332333458317, 5341.839744807662, 5382.892342153135, 5390.838274851761, 5806.361300256968, 5847.8245652630485, 5850.912236316459, 5853.7365818538265, 5857.941420585825, 5257.710825904612, 5478.808241711521, 5478.972605136949, 5479.205515200274, 5479.287692600016, 4973.303737476756, 5011.423686276052, 5053.0, 5060.49395060491, 5141.640085194075, 6043.335233124353, 6046.455818976313, 6049.818505444756, 6055.424734650202, 6055.515558755377, 5871.354151043467, 5876.970615146897, 5877.94122058774, 5878.353381128158, 5881.32364778056, 5624.606277560695, 5850.385709500441, 5906.0, 5964.8807023860145, 5977.731002104829, 5653.038983372919, 5729.885402291848, 5736.6558006519745, 5747.224124743273, 5805.245318108618, 5870.9412905870395, 5885.73514191871, 5913.793017244376, 5929.792457263975, 5932.0, 5560.499555040065, 5609.971950140223, 5613.0, 5667.829965101054, 5692.31692196939, 5665.49010589049, 5672.517835983987, 5677.318721753416, 5679.119736440858, 5679.460451257124, 5647.548196144381, 5649.039663257338, 5655.604107712421, 5661.094224923992, 5662.546996240373, 5663.461971112738, 5698.088305871041, 5701.116326969326, 5705.857353566194, 5710.086386178192, 5575.080111781511, 5575.721213939206, 5589.245451864109, 5589.5807814413265, 5597.916031259453], "value": 5350.690137849256, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.9455701708338, 605.6789901352284, 605.8243109498246, 608.8477880529866, 612.2591664086456, 31391.68608313916, 41453.0, 42936.57063429365, 43136.56863431365, 46312.30531542029, 42385.15229695412, 42663.36004959921, 42708.14583708324, 42740.14519709604, 42763.78618106913, 8607.91392086079, 8755.868661970075, 8756.737297881042, 8757.693480728176, 8764.079771623983, 7866.921330786676, 8047.879281810778, 10287.12559432449, 10505.527251273672, 10510.842337364946, 10646.78706425871, 10694.572217111307, 10696.197785166105, 10698.732531686732, 10707.946460267687, 10467.476626168662, 10513.369197848153, 10539.894601054044, 10539.947300263526, 10547.261691681586, 10413.895861041368, 10471.476426178737, 10471.895281047167, 10478.056974872221, 10480.213983951158, 40385.0, 40650.79674601638, 40651.7967410164, 40751.388729169084, 40784.184316313505, 3426.3489936911906, 3505.4216054351, 3653.4337177737493, 3841.78870162141, 3960.4653371794725, 30994.690053099406, 31018.534721979187, 31038.379232415224, 31114.0, 31559.36881262385, 4260.275753121946, 4271.8077686503875, 4513.097380523908, 4556.0, 4593.173228818811, 310708.0, 311554.0, 312644.99999999773, 313115.0, 313749.0, 30456.238594034883, 31272.21819454532, 31278.84360578228, 56822.0, 57652.42347576471, 36248.45627315593, 36450.45324320137, 36458.8177059113, 36495.63504364975, 36499.452508212395, 13407.329633518286, 13520.59438216855, 13524.729505409836, 13529.526466573623, 13530.661733456742, 10646.361218326925, 10978.835317470244, 11001.119910407147, 11008.229423940407, 11079.778404431867, 7779.7666070017995, 7827.334676552443, 7950.920490795133, 8158.714444994397, 8210.466319689202, 3134.200778801391, 3169.556262123305, 3186.9362612747614, 3194.5687332209855, 3235.7573182011442, 1037.0296436770197, 1040.1262939131016, 1046.6964580271635, 1054.0433141267572, 1065.5950738719237, 31739.68260317367, 32281.677183228338, 32326.19184520406, 32350.676493235238, 32650.836745816596, 1053.599632139782, 1056.9101626361692, 1063.4204358624568, 1080.7244152741, 1094.874089479704, 16394.754078688828, 17151.313947441962, 17158.0, 17272.481825545256, 17315.56711082233, 468801.0, 473112.0, 473961.0, 474014.0, 474198.0, 55347.723261383435, 55596.0, 55878.44121558814, 55951.0, 56027.15959260614, 1180.5690922813112, 1225.4424236972156, 1263.4377701922924, 1314.3822403470544, 1339.504383378137, 29044.56433153547, 31726.841365793025, 32090.35819283648, 32958.17604559905, 32985.0, 49252.75373623109, 49803.50196498133, 49817.0, 49864.25203622021, 49903.0, 372822.0, 374884.0, 377405.0, 378183.0, 378466.0, 26695.733042669326, 27731.584026240027, 27796.166115016582, 28796.568051479662, 29082.41835163327, 45803.31295030644, 46267.0, 46355.0, 46870.29694554653, 46893.66935463669, 39116.0, 39576.2084758309, 39613.60386396099, 39701.20597587974, 41807.790961045, 39477.40783888302, 39812.40281395723, 40000.599994000855, 40589.0, 41659.7917010413, 39902.60097398989, 40882.79558602307, 41483.792581036905, 41588.0, 41686.791566041975, 32585.0, 35321.6444437778, 35518.46722299116, 36207.81896090608, 36825.97457139883, 27578.310542236606, 27630.585541216496, 27780.44439111247, 27986.720132799226, 28120.156395308175], "value": 18466.951453990638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.8139448881073, 377.41500673955363, 391.68665067945653, 398.64321432318076, 417.9456670632819, 13961.650958726024, 15608.687826243467, 18495.44513664589, 19045.14296856643, 19078.523036924085, 18712.438626841184, 18760.437186884414, 18845.24619015238, 19032.429027129172, 19061.14224859881, 4202.579742025803, 5562.972185139069, 5798.971005144968, 5805.796797112102, 5806.18713380125, 4362.520122786491, 6379.649119298437, 6505.609663420186, 6600.636964966925, 6604.504662150334, 6284.277308109557, 6473.6763161841955, 6520.869582608345, 6551.508636852255, 6559.639219842907, 6441.227052753676, 6482.902756458657, 6503.772367967098, 6506.089147519304, 6506.837329066788, 5074.923876141824, 5344.679319240858, 5393.568514518829, 5487.204355368489, 5502.779888804443, 13623.386947587283, 13903.582892513241, 16895.493135205965, 22378.55242895133, 22611.434714132112, 2312.17917639239, 2337.0, 2448.4980578981267, 2476.628505724138, 2898.5507246376847, 9975.25185611082, 10349.637762678345, 10596.576136954513, 11831.053515718722, 13491.865081349159, 1882.1436246507806, 1924.3841970569424, 1926.6628340040577, 1927.296536764085, 1968.7145363922293, 74387.62806185988, 86950.56524717336, 87188.5640571793, 88302.55848720779, 89056.55471722665, 10447.84328235077, 10590.947045264724, 10688.412137332365, 10850.457477126112, 11004.779904401867, 15268.770968435483, 15278.38886444552, 15287.847121528643, 15293.388264469297, 15330.463433779763, 7233.8553228935125, 7416.22129676387, 7431.702731890664, 7554.357879580297, 7606.505577137468, 6864.759733409406, 6896.172459304815, 6906.0, 7060.7881763547175, 7097.680604372816, 4581.79381927814, 4654.745855616957, 4691.601213896789, 4692.178868697964, 4801.95198048015, 1850.7779066512105, 1920.3374835681668, 1941.7281580578447, 1950.697641865513, 1992.0, 859.3769517100052, 914.2046419614977, 919.6321471411355, 965.5172413793103, 1012.1801340913884, 17926.462206133838, 19124.0, 19429.22283108688, 19619.509512262022, 19707.368768339427, 950.843110886696, 965.285688590438, 967.086103632075, 993.7167907146429, 1001.9448930308903, 10163.390196588229, 10647.414392208348, 10830.133589312836, 10869.184811139196, 10929.234953553334, 420817.0, 433941.0, 438432.1471682681, 439143.0, 442577.0, 81133.59433202796, 91262.54368728114, 91507.54246228727, 93910.53044734732, 94046.52976735073, 995.2732009962854, 1048.5072016152396, 1054.6835949215206, 1060.0, 1060.5068643081004, 17005.319787208373, 17228.483145505656, 17814.0, 17982.640347193246, 18167.27330906802, 29393.412131757672, 33283.667163329024, 38010.0, 40633.187336252515, 42141.36787948122, 49959.18936136258, 56524.71737641285, 59158.0, 60440.395596043476, 60652.69673651604, 8182.7954301142945, 8447.535385553607, 8453.154684531497, 8705.564721764013, 8769.693060742844, 9629.0, 11984.580539681418, 12680.0, 12793.936030319788, 13443.260620665957, 5704.11586204139, 11718.183681529377, 11802.76394472123, 11934.0, 11994.820077698667, 11350.60272890478, 11453.713657158638, 11461.770764584828, 11849.822252666389, 11938.22401543897, 11374.886251137714, 11636.418179090842, 11771.587994420497, 11893.881061189277, 12114.454849531616, 8299.29455996247, 8559.315254779727, 8691.608877600396, 8732.388732788644, 8848.601812918563, 9946.801063978824, 11456.885431145914, 11504.25222360544, 11563.768724625628, 11617.128715346214], "value": 9024.157922810558, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.892488600912, 1476.5348915091745, 1482.3107255126365, 1639.1967935711498, 1774.2725482552157, 7323.926760732391, 8148.3888708346885, 8496.235338819504, 8522.275606573448, 8748.956255218714, 8506.957465212665, 8574.91425085749, 8583.87124193136, 8584.785380365494, 8606.655733770658, 2318.8376813623054, 2347.0377145370403, 2347.6595893595418, 2348.495073559184, 2353.035255545227, 2319.22306027481, 2365.207655435431, 2379.4646204604, 2380.5119950410126, 2384.535015671936, 2298.402415371999, 2317.8261630377706, 2322.9419264518438, 2322.976770232293, 2340.0, 2193.352960876537, 2207.9889600552056, 2210.6573481110454, 2211.834112441565, 2212.070930209316, 2257.2551058150934, 2272.1479445208047, 2275.4311422144465, 2276.9981208268473, 2278.4190031541852, 8482.448640838387, 8504.532250726208, 8522.659093636246, 8594.785130371729, 8733.388662793606, 5323.627346085776, 5449.291592093042, 5453.23654688344, 5459.044667183267, 5460.535854452376, 3287.572615559962, 3327.184839714261, 3382.797032178077, 3391.9660803392144, 3501.19472521319, 1067.1676092647747, 1078.1805827571102, 1081.697124805048, 1099.8515200447916, 1111.0667039686703, 11701.122415818847, 11731.589394371156, 11760.0, 11763.764724705457, 11777.88222117785, 4280.614744672995, 4452.131834292347, 4534.6599005074095, 4537.523560026149, 4622.306654001926, 9452.669156579486, 9455.763605909908, 9458.95270523643, 9459.52702364879, 9481.525923703788, 5075.746212689351, 5100.846974590768, 5106.923396149061, 5107.233914912718, 5114.87212819675, 4162.7502349859105, 4310.267254566731, 4430.955690443118, 4558.635309175258, 4684.8756298488115, 3668.4497325401403, 3721.813909304524, 3811.3901775715754, 3812.14226798968, 3821.560520540118, 1146.094585277638, 1163.1450883600546, 1179.0862081886607, 1180.5631916191064, 1196.6529706385052, 826.8093944719704, 830.6967956695884, 895.1898531828706, 960.6973803251954, 982.4841957972122, 5591.804286850022, 5870.412958704181, 5930.377310382434, 5946.762129514857, 6194.38056194386, 441.28732097662686, 442.67905768318354, 450.4639479019956, 456.59819358964563, 456.7145534041224, 4061.3095773718537, 4092.590740925943, 4145.937810932838, 4162.313218318944, 4170.145120250341, 10232.334898231591, 10786.946065269623, 10800.08199303068, 10803.189760767973, 10833.78332433347, 10419.739506512245, 10499.47502624881, 10667.413292268844, 10676.572937082585, 10757.731056723487, 7900.2889739923685, 8161.26548610616, 8161.428699991063, 8220.424570280142, 8226.218509241733, 5779.711014449176, 5780.479756821906, 5820.854478638068, 5869.119632055226, 6004.159417681615, 9708.5145742714, 9734.123928846439, 9797.21622270231, 9819.607215711292, 9854.507274636382, 9300.767480813034, 9495.715128546155, 9666.371685840399, 9878.0, 9884.456354900549, 6796.0, 7003.26465721092, 7439.293267139613, 7675.846483070419, 7831.412644051833, 8188.631511582113, 8351.665933362598, 8376.162383761575, 8381.790455238424, 8403.453775504573, 7344.9632751838035, 7468.10382754073, 7469.775906722807, 7631.198724133886, 7680.6543705534505, 7362.226966168475, 7557.886631700639, 7580.090389153116, 7585.2035536267895, 7588.734394296173, 6632.568883022588, 6779.661016949034, 6784.253732089565, 6791.762288320083, 6836.5214434989075, 4830.951690483191, 4977.0, 4995.400551933792, 5005.899882002267, 5210.765515551733, 4755.738434386142, 4860.927086093782, 4863.537963893425, 4876.512348765095, 4960.305557222064], "value": 4420.340872499632, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.52020610526944, 341.8547117475072, 347.1650680114326, 347.1806536573684, 352.49593081892897, 5273.367195936488, 5379.919301210485, 5383.596230282725, 5397.4332695067, 5399.946000539993, 5307.442718514559, 5334.973325133378, 5350.170723537858, 5350.571954243661, 5359.222912677659, 3975.3043217436975, 4077.531083925357, 4093.2427500912277, 4107.568705285947, 4202.159568086379, 4155.854545090922, 4194.8112334945, 4206.26390381682, 4207.537170911212, 4220.556841531641, 4150.875473735793, 4165.229777344632, 4165.354370072629, 4176.767853483215, 4183.3226734889695, 3958.782266975315, 3986.441898134249, 4154.335306350969, 4167.124903770212, 4182.247195504808, 3675.889723308305, 3695.113172838526, 3710.9814450927574, 3712.684421824148, 3720.813959302051, 5128.410232823236, 5128.769205385766, 5146.305248791403, 5157.69053856766, 5183.159978207757, 4660.273739862185, 4748.287756836467, 4773.546513081252, 4791.0, 4799.760011999421, 5489.862753431156, 5508.834734957958, 5516.531094856942, 5518.91721624176, 5560.277163968658, 4077.959220407817, 4087.509498860126, 4093.89765255868, 4105.835766569334, 4125.91748165038, 5537.58468114889, 5804.361520232771, 5807.970960145214, 5812.680302583356, 5855.502282306009, 4094.61101195386, 4113.095119073859, 4116.468371951229, 4129.380592911088, 4130.56629053951, 4153.937690934638, 4171.395147703566, 4176.477940257468, 4179.017930786263, 4186.267403204427, 4524.796384162721, 4734.763261836894, 4768.713877167381, 4814.9518504815205, 4815.855524334275, 5596.636218645775, 5608.0, 5627.634203776742, 5627.662340259598, 5643.887122257614, 1424.7221791750717, 1447.6887469194173, 1447.8914081443934, 1453.7237924794256, 1454.6508837878832, 890.8050079230371, 918.1874041473344, 925.8564922437033, 934.4907025671025, 947.1475671895349, 5036.866704991347, 5122.641415100908, 5246.31797866275, 5251.973740131275, 5255.76349064293, 5730.541556675539, 5733.104782085021, 5733.140028995684, 5741.971290143522, 5742.478243265538, 5180.300659411007, 5235.607329450307, 5283.471652834763, 5308.814191503356, 5317.202419637086, 3005.233665415305, 3024.2137044368624, 3030.5908702325346, 3030.9545356819667, 3040.4493708208975, 5829.679367634736, 5843.620164689281, 5846.4153584642045, 5864.2083318752275, 5893.554175017405, 5579.581531385163, 5791.8552036199435, 5799.840031993618, 5817.243758311392, 5850.736716847752, 5830.006445584788, 5835.270591176103, 5837.532997360286, 5880.206172166874, 5884.852878677982, 5428.67427954324, 5685.431456854281, 5703.344115426613, 5725.570582206268, 5740.90922724681, 5725.8568535786935, 5726.856828579319, 5737.0, 5737.168110623853, 5753.367129615823, 5848.181254624271, 5905.940940590539, 5918.0, 5933.643981361132, 5950.0, 3977.1449138435373, 4123.731957422758, 4137.524184718796, 4138.213739389506, 4158.251514727257, 5698.31620205578, 5736.627119237236, 5743.195952566561, 5753.769849205984, 5766.509846662912, 5437.510624043855, 5643.830685079454, 5649.4633009864, 5663.490285874291, 5665.263515742927, 5579.6652200868075, 5580.0, 5588.469095435927, 5603.579731520071, 5619.719014049363, 5560.110382338807, 5568.77724891016, 5603.607747457639, 5622.971885140548, 5625.578081643811, 5428.37573679032, 5441.809536666197, 5542.140968149782, 5623.803166889139, 5638.464345887298, 5502.761878577288, 5541.695206763667, 5547.583931205095, 5552.0, 5558.221848941233], "value": 4265.4293236259455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.13630484827, 685.7874059041694, 688.4458011300904, 713.7787285941357, 765.770268919324, 14368.71262574748, 14678.339474723636, 14713.705725885477, 14801.037932534391, 14845.257737113141, 14176.432942682306, 14280.71438571228, 14326.71346573068, 14334.784978225309, 14345.78481322781, 656.9835754106161, 678.2844099475077, 776.669915286004, 793.3970182661176, 806.1495122645606, 817.3338728935928, 817.3747083481112, 820.2986446588171, 820.8030072782519, 820.9096999330069, 865.7056600755742, 866.7746385939638, 868.0885070675797, 869.3783944479695, 869.4088020146298, 694.0942070597893, 710.1123595505618, 833.8832563441123, 859.1666083898608, 860.4708104515709, 623.7536173211556, 629.8267976306506, 630.4263120560269, 630.6121735132906, 630.8265227062549, 14438.783418248735, 14483.1310121392, 14486.42054317826, 14487.855121448756, 14492.782608260884, 13394.665133371645, 13452.32738363078, 13475.86524134756, 13492.865071349259, 13551.864481355258, 12573.937130314382, 12652.493900243979, 12778.872211277861, 12912.289824059673, 13064.0, 4350.15172041452, 4416.3596278539435, 4453.755043472608, 4492.52828453011, 4520.88697782558, 64049.0, 64349.35650643527, 65565.67217163931, 66324.0, 66767.66616166888, 10290.639827605997, 10321.09749361829, 10451.425171615634, 10605.89394106049, 10633.89366106329, 16942.0, 16956.0, 16966.830331696772, 17002.48992530226, 17073.317067317417, 7463.328300452877, 7464.489274413329, 7682.116556595951, 7862.646180921873, 8008.079070906804, 4360.215161271001, 4390.692651514363, 4484.551544845489, 4501.909961800811, 4504.009117994036, 3318.435865902802, 3434.3989801785087, 3436.278381539905, 3436.381451338733, 3541.557305336833, 650.8600650860088, 655.7540922154192, 662.0, 672.2504407585604, 678.1455366238575, 688.0185067006988, 696.8779866199454, 706.7844307486266, 707.7912015955305, 719.9021492224296, 8736.737897863075, 9052.683156089506, 9163.679271225476, 9196.35625506208, 9315.906840931639, 623.2489849731063, 644.4522156167315, 704.2499737779351, 726.0706295941204, 732.7984804178786, 4016.457778199964, 4340.0, 4375.584319489643, 4387.846425375096, 4401.119776044804, 51220.74389628028, 51224.74387628038, 85330.57334713287, 86949.56525217333, 88106.0, 73033.26966730371, 73465.63267183737, 73686.0, 75221.62389188129, 75596.24403756003, 68063.31936680668, 69048.6547567269, 70241.0, 72763.63618181876, 73641.2635873645, 8227.547484888388, 8422.915770842214, 8630.525321107149, 8653.30773538128, 8789.560521974003, 48492.5150748488, 48721.51278487311, 48971.755141224065, 49080.263796042374, 49346.50653493563, 59565.7021714906, 63908.680456597416, 66145.00782488362, 66689.0, 66875.66562167158, 11295.265807722471, 11494.080473562262, 11573.942130289295, 11732.648020559396, 11762.94118529402, 12736.490540378281, 12946.676333091747, 13498.257595832323, 13724.176549407068, 13903.374348154559, 12879.35603219854, 12989.350532473527, 13490.730185396433, 14110.788338175142, 14133.293335333397, 13148.671283217996, 13364.398602062736, 13582.79625805594, 14316.57050288493, 14355.282235888373, 12800.807987880375, 13085.149465284727, 13262.93368533151, 13603.319834008458, 13761.830244429335, 10406.58373665045, 10768.246222764332, 11017.173711971474, 11203.663890083311, 11318.773624527299, 11496.655100347003, 11689.0, 11815.468303926173, 11893.0, 11972.521099155936], "value": 7069.846733883335, "unit": "score"}], "name": "dromaeo_css", "value": 7012.084613693495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 110.0, 111.0, 112.0, 112.0, 113.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 122.0, 122.0, 172.0, 122.0, 123.0, 121.0, 124.0, 150.0, 125.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 163.0, 162.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 115.0, 75.0, 77.0, 75.0, 75.0, 106.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 83.0, 83.0, 83.0, 103.0, 82.0, 83.0, 114.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 55.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 65.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 80.0, 80.0, 80.0, 79.0, 86.0, 79.0, 79.0, 87.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 147.0, 131.0, 143.0, 129.0, 128.0, 134.0, 133.0, 166.0, 147.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 174.0, 168.0, 167.0, 165.0, 164.0, 163.0, 165.0, 162.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 63.0, 65.0, 66.0, 66.0, 65.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1495.2999999999997, "alertThreshold": 2.0}]} 21:53:44 INFO - Return code: 0 21:53:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:53:44 INFO - # TBPL SUCCESS # 21:53:44 INFO - Running post-action listener: _resource_record_post_action 21:53:44 INFO - [mozharness: 2016-10-28 04:53:44.568581Z] Finished run-tests step (success) 21:53:44 INFO - Running post-run listener: _resource_record_post_run 21:53:44 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390270976; Read time: 12; Write time: 354816 21:53:44 INFO - TinderboxPrint: CPU usage
13.0% 21:53:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:53:44 INFO - TinderboxPrint: I/O write bytes / time
390,270,976 / 354,816 21:53:44 INFO - TinderboxPrint: CPU idle
8,313.6 (87.0%) 21:53:44 INFO - TinderboxPrint: CPU user
1,194.9 (12.5%) 21:53:44 INFO - TinderboxPrint: Swap in / out
0 / 0 21:53:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102707200; Read time: 0; Write time: 86072 21:53:44 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286285824; Read time: 0; Write time: 268444 21:53:45 INFO - Running post-run listener: _upload_blobber_files 21:53:45 INFO - Blob upload gear active. 21:53:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:53:45 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 21:53:45 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'] 21:53:45 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 21:53:45 INFO - (blobuploader) - INFO - Open directory for files ... 21:53:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:53:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:53:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:46 INFO - (blobuploader) - INFO - Done attempting. 21:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:49 INFO - (blobuploader) - INFO - Done attempting. 21:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:50 INFO - (blobuploader) - INFO - Done attempting. 21:53:50 INFO - (blobuploader) - INFO - Iteration through files over. 21:53:50 INFO - Return code: 0 21:53:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:53:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:53:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b310c15023b5b66e2d1cb335f1d59cbabfa008149c1bcf542571041b872713642a0ac2dd61f67107c70b507a15f53b5b34d5daadecd446492d8efae7e84229e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9eac70cba305523df8af17b6dd512d0db64efe85712275fcbee8efaeca62f65ac57912d68ba23decd0d4e52f1ac1127fde0e3e924ffa0630928a09499c00ff00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c19447d12ac08c19fd8d2e7221d255f70941b720a5073fc7110be68e1a369f41e9eea80070e39ec3cbb600e5facb33fc2735cb5666a815ec084b4a7db620c53f"} 21:53:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:53:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:53:50 INFO - Contents: 21:53:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b310c15023b5b66e2d1cb335f1d59cbabfa008149c1bcf542571041b872713642a0ac2dd61f67107c70b507a15f53b5b34d5daadecd446492d8efae7e84229e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9eac70cba305523df8af17b6dd512d0db64efe85712275fcbee8efaeca62f65ac57912d68ba23decd0d4e52f1ac1127fde0e3e924ffa0630928a09499c00ff00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c19447d12ac08c19fd8d2e7221d255f70941b720a5073fc7110be68e1a369f41e9eea80070e39ec3cbb600e5facb33fc2735cb5666a815ec084b4a7db620c53f"} 21:53:50 INFO - Running post-run listener: copy_logs_to_upload_dir 21:53:50 INFO - Copying logs to upload dir... 21:53:50 INFO - mkdir: /builds/slave/test/build/upload/logs 21:53:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.484740 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-27 21:53:49.800348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 21:53:49.803916) ========= 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=836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b310c15023b5b66e2d1cb335f1d59cbabfa008149c1bcf542571041b872713642a0ac2dd61f67107c70b507a15f53b5b34d5daadecd446492d8efae7e84229e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9eac70cba305523df8af17b6dd512d0db64efe85712275fcbee8efaeca62f65ac57912d68ba23decd0d4e52f1ac1127fde0e3e924ffa0630928a09499c00ff00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c19447d12ac08c19fd8d2e7221d255f70941b720a5073fc7110be68e1a369f41e9eea80070e39ec3cbb600e5facb33fc2735cb5666a815ec084b4a7db620c53f"} build_url:https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011576 build_url: 'https://queue.taskcluster.net/v1/task/A18X-sgfSEOz2Q0fwhHj3Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b310c15023b5b66e2d1cb335f1d59cbabfa008149c1bcf542571041b872713642a0ac2dd61f67107c70b507a15f53b5b34d5daadecd446492d8efae7e84229e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9eac70cba305523df8af17b6dd512d0db64efe85712275fcbee8efaeca62f65ac57912d68ba23decd0d4e52f1ac1127fde0e3e924ffa0630928a09499c00ff00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c19447d12ac08c19fd8d2e7221d255f70941b720a5073fc7110be68e1a369f41e9eea80070e39ec3cbb600e5facb33fc2735cb5666a815ec084b4a7db620c53f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 21:53:49.829789) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:53:49.830118) ========= 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=836cfdc75598d54cb747368e000001a9-1477629187.285598-1349530583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004359 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 21:53:49.913519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 21:53:49.913835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 21:53:49.914236) ========= ========= Total master_lag: 0.16 =========