builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1475730677.92 results: success (0) buildid: 20161005204800 builduid: a5dc905817e24269a6f38b1d1990da22 revision: c7d62e6d052c5d2638b08d480a720254ea09ff2d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:17.920740) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:17.921329) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:17.921676) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:17.936775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:17.937094) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 22:11:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-10-05 22:11:18 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086761 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.064257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.064588) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.115665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.116074) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c7d62e6d052c5d2638b08d480a720254ea09ff2d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c7d62e6d052c5d2638b08d480a720254ea09ff2d --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=03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 22:11:18,280 truncating revision to first 12 chars 2016-10-05 22:11:18,280 Setting DEBUG logging. 2016-10-05 22:11:18,280 attempt 1/10 2016-10-05 22:11:18,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c7d62e6d052c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 22:11:18,584 unpacking tar archive at: mozilla-central-c7d62e6d052c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622544 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.756597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.757350) ========= script_repo_revision: c7d62e6d052c5d2638b08d480a720254ea09ff2d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.758282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.758938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 22:11:18.772529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-05 22:11:18.773292) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:11:19 INFO - MultiFileLogger online at 20161005 22:11:19 in /builds/slave/test 22:11:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:11:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:11:19 INFO - {'append_to_log': False, 22:11:19 INFO - 'base_work_dir': '/builds/slave/test', 22:11:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:11:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:11:19 INFO - 'branch': 'Firefox-Non-PGO', 22:11:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:11:19 INFO - 'config_files': ('talos/linux_config.py',), 22:11:19 INFO - 'default_actions': ('clobber', 22:11:19 INFO - 'read-buildbot-config', 22:11:19 INFO - 'download-and-extract', 22:11:19 INFO - 'populate-webroot', 22:11:19 INFO - 'create-virtualenv', 22:11:19 INFO - 'install', 22:11:19 INFO - 'run-tests'), 22:11:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:11:19 INFO - 'download_minidump_stackwalk': True, 22:11:19 INFO - 'download_symbols': 'ondemand', 22:11:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:11:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:11:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:11:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:11:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:11:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:11:19 INFO - 'installer_path': 'installer.exe', 22:11:19 INFO - 'log_level': 'info', 22:11:19 INFO - 'log_name': 'talos', 22:11:19 INFO - 'log_to_console': True, 22:11:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:11:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:11:19 INFO - 'opt_config_files': (), 22:11:19 INFO - 'pip_index': False, 22:11:19 INFO - 'sps_profile': False, 22:11:19 INFO - 'sps_profile_interval': 0, 22:11:19 INFO - 'suite': 'dromaeojs', 22:11:19 INFO - 'system_bits': '32', 22:11:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:11:19 INFO - 'title': 'talos-linux64-ix-047', 22:11:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:11:19 INFO - 'use_talos_json': True, 22:11:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:11:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:11:19 INFO - 'work_dir': 'build'} 22:11:19 INFO - [mozharness: 2016-10-06 05:11:19.040151Z] Running clobber step. 22:11:19 INFO - Running pre-action listener: _resource_record_pre_action 22:11:19 INFO - Running main action method: clobber 22:11:19 INFO - rmtree: /builds/slave/test/build 22:11:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:11:19 INFO - Running post-action listener: _resource_record_post_action 22:11:19 INFO - [mozharness: 2016-10-06 05:11:19.492073Z] Finished clobber step (success) 22:11:19 INFO - [mozharness: 2016-10-06 05:11:19.492173Z] Running read-buildbot-config step. 22:11:19 INFO - Running pre-action listener: _resource_record_pre_action 22:11:19 INFO - Running main action method: read_buildbot_config 22:11:19 INFO - Using buildbot properties: 22:11:19 INFO - { 22:11:19 INFO - "project": "", 22:11:19 INFO - "product": "firefox", 22:11:19 INFO - "script_repo_revision": "production", 22:11:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:11:19 INFO - "repository": "", 22:11:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 22:11:19 INFO - "buildid": "20161005204800", 22:11:19 INFO - "pgo_build": "False", 22:11:19 INFO - "basedir": "/builds/slave/test", 22:11:19 INFO - "buildnumber": 768, 22:11:19 INFO - "slavename": "talos-linux64-ix-047", 22:11:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:11:19 INFO - "platform": "ubuntu64_hw", 22:11:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:11:19 INFO - "branch": "mozilla-central", 22:11:19 INFO - "repo_path": "mozilla-central", 22:11:19 INFO - "revision": "c7d62e6d052c5d2638b08d480a720254ea09ff2d", 22:11:19 INFO - "stage_platform": "linux64", 22:11:19 INFO - "builduid": "a5dc905817e24269a6f38b1d1990da22", 22:11:19 INFO - "slavebuilddir": "test" 22:11:19 INFO - } 22:11:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:11:19 INFO - Running post-action listener: _resource_record_post_action 22:11:19 INFO - [mozharness: 2016-10-06 05:11:19.494683Z] Finished read-buildbot-config step (success) 22:11:19 INFO - [mozharness: 2016-10-06 05:11:19.494770Z] Running download-and-extract step. 22:11:19 INFO - Running pre-action listener: _resource_record_pre_action 22:11:19 INFO - Running main action method: download_and_extract 22:11:19 INFO - mkdir: /builds/slave/test/build/tests 22:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:11:19 INFO - trying https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:11:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/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 22:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/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 22:11:20 INFO - Downloaded 1361 bytes. 22:11:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:11:20 INFO - Using the following test package requirements: 22:11:20 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:11:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:11:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'jsshell-linux-x86_64.zip'], 22:11:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:11:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:11:20 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:11:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:11:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:11:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:11:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:11:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:11:20 INFO - Http code: 200 22:11:20 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 22:11:20 INFO - x-amz-cf-id: o_JD5fcenziSQHAm5yUPi8vHMz5_qtLXP_P8ni_-au-GycG_MUGFow== 22:11:20 INFO - x-amz-version-id: H.tT3HnQhD7N5or7MMWrqLUtd6KKm09O 22:11:20 INFO - Expected file size: 20421139 22:11:20 INFO - Obtained file size: 20421139 22:11:24 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 22:11:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:11:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:11:25 INFO - Http code: 200 22:11:25 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 22:11:25 INFO - x-amz-cf-id: ubH61F8RRTvrxR5EU8k7__Zqm4EsRmIo0pbwJuPPM4yMJYu0XYxM2A== 22:11:25 INFO - x-amz-version-id: H.tT3HnQhD7N5or7MMWrqLUtd6KKm09O 22:11:25 INFO - Expected file size: 20421139 22:11:25 INFO - Obtained file size: 20421139 22:11:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:11:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:11:30 INFO - Http code: 200 22:11:30 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 22:11:30 INFO - x-amz-cf-id: nyHKi_rql-fYXy-a-0nyS3CZpIeVA_7wOrsw-ZzcPf8-o4Kzu0jnfA== 22:11:30 INFO - x-amz-version-id: coWBjzEyHZmB_YOJ4sUT6u9yltf6dt3P 22:11:31 INFO - Expected file size: 14409006 22:11:31 INFO - Obtained file size: 14409006 22:11: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')]} 22:11:31 INFO - trying https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:11:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/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 22:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/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 22:11:32 INFO - Downloaded 55813640 bytes. 22:11:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:11:32 INFO - mkdir: /builds/slave/test/properties 22:11:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:11:32 INFO - Writing to file /builds/slave/test/properties/build_url 22:11:32 INFO - Contents: 22:11:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:11:33 INFO - Running post-action listener: _resource_record_post_action 22:11:33 INFO - Running post-action listener: set_extra_try_arguments 22:11:33 INFO - [mozharness: 2016-10-06 05:11:33.631929Z] Finished download-and-extract step (success) 22:11:33 INFO - [mozharness: 2016-10-06 05:11:33.632228Z] Running populate-webroot step. 22:11:33 INFO - Running pre-action listener: _resource_record_pre_action 22:11:33 INFO - Running main action method: populate_webroot 22:11:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:11:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:11:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:11:33 INFO - '--tppagecycles', 22:11:33 INFO - '7'], 22:11:33 INFO - 'tests': ['tsvgm']}}, 22:11:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:11:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:11:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:11:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:11:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['damp', 'tps']}, 22:11:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'tests': ['damp', 'tps']}, 22:11:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['dromaeo_dom']}, 22:11:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:11:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['basic_compositor_video']}, 22:11:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:11:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['a11yr', 22:11:33 INFO - 'ts_paint', 22:11:33 INFO - 'tpaint', 22:11:33 INFO - 'sessionrestore', 22:11:33 INFO - 'sessionrestore_no_auto_restore', 22:11:33 INFO - 'tabpaint']}, 22:11:33 INFO - 'other-e10s': {'tests': ['a11yr', 22:11:33 INFO - 'ts_paint', 22:11:33 INFO - 'tpaint', 22:11:33 INFO - 'sessionrestore', 22:11:33 INFO - 'sessionrestore_no_auto_restore', 22:11:33 INFO - 'tabpaint']}, 22:11:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:11:33 INFO - 'ts_paint', 22:11:33 INFO - 'tpaint', 22:11:33 INFO - 'sessionrestore', 22:11:33 INFO - 'sessionrestore_no_auto_restore', 22:11:33 INFO - 'tabpaint']}, 22:11:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:11:33 INFO - 'ts_paint', 22:11:33 INFO - 'tpaint', 22:11:33 INFO - 'sessionrestore', 22:11:33 INFO - 'sessionrestore_no_auto_restore', 22:11:33 INFO - 'tabpaint']}, 22:11:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['a11yr', 22:11:33 INFO - 'ts_paint', 22:11:33 INFO - 'tpaint', 22:11:33 INFO - 'sessionrestore', 22:11:33 INFO - 'sessionrestore_no_auto_restore', 22:11:33 INFO - 'tabpaint']}, 22:11:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['a11yr', 22:11:33 INFO - 'ts_paint', 22:11:33 INFO - 'tpaint', 22:11:33 INFO - 'sessionrestore', 22:11:33 INFO - 'sessionrestore_no_auto_restore', 22:11:33 INFO - 'tabpaint']}, 22:11:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['tsvgx', 22:11:33 INFO - 'tsvgr_opacity', 22:11:33 INFO - 'tart', 22:11:33 INFO - 'tscrollx', 22:11:33 INFO - 'cart']}, 22:11:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:11:33 INFO - 'tsvgr_opacity', 22:11:33 INFO - 'tart', 22:11:33 INFO - 'tscrollx', 22:11:33 INFO - 'cart']}, 22:11:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'talos_options': ['--disable-e10s'], 22:11:33 INFO - 'tests': ['tp5o']}, 22:11:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'tests': ['tp5o']}, 22:11:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'talos_options': ['--disable-e10s', 22:11:33 INFO - '--xperf_path', 22:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:33 INFO - 'tests': ['tp5n']}, 22:11:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:33 INFO - 'talos_options': ['--xperf_path', 22:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:33 INFO - 'tests': ['tp5n']}}, 22:11:33 INFO - 'talos.zip': {'path': '', 22:11:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:11:33 INFO - Running post-action listener: _resource_record_post_action 22:11:33 INFO - [mozharness: 2016-10-06 05:11:33.652561Z] Finished populate-webroot step (success) 22:11:33 INFO - [mozharness: 2016-10-06 05:11:33.652652Z] Running create-virtualenv step. 22:11:33 INFO - Running pre-action listener: _resource_record_pre_action 22:11:33 INFO - Running main action method: create_virtualenv 22:11:33 INFO - Creating virtualenv /builds/slave/test/build/venv 22:11:33 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 22:11:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:11:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:11:33 INFO - Using real prefix '/usr' 22:11:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:11:34 INFO - Installing distribute.............................................................................................................................................................................................done. 22:11:36 INFO - Installing pip.................done. 22:11:36 INFO - Return code: 0 22:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:11:36 INFO - Reading from file tmpfile_stdout 22:11:36 INFO - Output received: 22:11:36 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) 22:11:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:11:36 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')]} 22:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:36 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')]} 22:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:36 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:36 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 22:11:36 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 22:11:36 INFO - Using env: {'DISPLAY': ':0', 22:11:36 INFO - 'HOME': '/home/cltbld', 22:11:36 INFO - 'LANG': 'en_US.UTF-8', 22:11:36 INFO - 'LANGUAGE': 'en_US:en', 22:11:36 INFO - 'LOGNAME': 'cltbld', 22:11:36 INFO - 'MAIL': '/var/mail/cltbld', 22:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:36 INFO - 'MOZ_NO_REMOTE': '1', 22:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:36 INFO - 'NO_EM_RESTART': '1', 22:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:36 INFO - 'PWD': '/builds/slave/test', 22:11:36 INFO - 'SHELL': '/bin/bash', 22:11:36 INFO - 'SHLVL': '1', 22:11:36 INFO - 'TERM': 'linux', 22:11:36 INFO - 'TMOUT': '86400', 22:11:36 INFO - 'USER': 'cltbld', 22:11:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:36 INFO - '_': '/tools/buildbot/bin/python'} 22:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:36 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 22:11:36 INFO - Cleaning up... 22:11:36 INFO - Return code: 0 22:11:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:11:36 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')]} 22:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:36 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')]} 22:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:36 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:36 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 22:11:36 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 22:11:36 INFO - Using env: {'DISPLAY': ':0', 22:11:36 INFO - 'HOME': '/home/cltbld', 22:11:36 INFO - 'LANG': 'en_US.UTF-8', 22:11:36 INFO - 'LANGUAGE': 'en_US:en', 22:11:36 INFO - 'LOGNAME': 'cltbld', 22:11:36 INFO - 'MAIL': '/var/mail/cltbld', 22:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:36 INFO - 'MOZ_NO_REMOTE': '1', 22:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:36 INFO - 'NO_EM_RESTART': '1', 22:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:36 INFO - 'PWD': '/builds/slave/test', 22:11:36 INFO - 'SHELL': '/bin/bash', 22:11:36 INFO - 'SHLVL': '1', 22:11:36 INFO - 'TERM': 'linux', 22:11:36 INFO - 'TMOUT': '86400', 22:11:36 INFO - 'USER': 'cltbld', 22:11:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:36 INFO - '_': '/tools/buildbot/bin/python'} 22:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:36 INFO - Downloading/unpacking psutil>=3.1.1 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:38 INFO - Installing collected packages: psutil 22:11:38 INFO - Running setup.py install for psutil 22:11:38 INFO - building 'psutil._psutil_linux' extension 22:11:38 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 22:11:39 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 22:11:39 INFO - building 'psutil._psutil_posix' extension 22:11:39 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 22:11:39 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 22:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:39 INFO - Successfully installed psutil 22:11:39 INFO - Cleaning up... 22:11:39 INFO - Return code: 0 22:11:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:11:39 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')]} 22:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:39 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')]} 22:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:39 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:39 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 22:11:39 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 22:11:39 INFO - Using env: {'DISPLAY': ':0', 22:11:39 INFO - 'HOME': '/home/cltbld', 22:11:39 INFO - 'LANG': 'en_US.UTF-8', 22:11:39 INFO - 'LANGUAGE': 'en_US:en', 22:11:39 INFO - 'LOGNAME': 'cltbld', 22:11:39 INFO - 'MAIL': '/var/mail/cltbld', 22:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:39 INFO - 'MOZ_NO_REMOTE': '1', 22:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:39 INFO - 'NO_EM_RESTART': '1', 22:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:39 INFO - 'PWD': '/builds/slave/test', 22:11:39 INFO - 'SHELL': '/bin/bash', 22:11:39 INFO - 'SHLVL': '1', 22:11:39 INFO - 'TERM': 'linux', 22:11:39 INFO - 'TMOUT': '86400', 22:11:39 INFO - 'USER': 'cltbld', 22:11:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:39 INFO - '_': '/tools/buildbot/bin/python'} 22:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:11:39 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 22:11:39 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 22:11:39 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 22:11:39 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 22:11:39 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 22:11:39 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 22:11:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:11:41 INFO - Installing collected packages: mozsystemmonitor 22:11:41 INFO - Running setup.py install for mozsystemmonitor 22:11:41 INFO - Successfully installed mozsystemmonitor 22:11:41 INFO - Cleaning up... 22:11:41 INFO - Return code: 0 22:11:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:11: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')]} 22:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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')]} 22:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:41 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:41 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 22:11:41 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 22:11:41 INFO - Using env: {'DISPLAY': ':0', 22:11:41 INFO - 'HOME': '/home/cltbld', 22:11:41 INFO - 'LANG': 'en_US.UTF-8', 22:11:41 INFO - 'LANGUAGE': 'en_US:en', 22:11:41 INFO - 'LOGNAME': 'cltbld', 22:11:41 INFO - 'MAIL': '/var/mail/cltbld', 22:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:41 INFO - 'MOZ_NO_REMOTE': '1', 22:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:41 INFO - 'NO_EM_RESTART': '1', 22:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:41 INFO - 'PWD': '/builds/slave/test', 22:11:41 INFO - 'SHELL': '/bin/bash', 22:11:41 INFO - 'SHLVL': '1', 22:11:41 INFO - 'TERM': 'linux', 22:11:41 INFO - 'TMOUT': '86400', 22:11:41 INFO - 'USER': 'cltbld', 22:11:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:41 INFO - '_': '/tools/buildbot/bin/python'} 22:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:41 INFO - Downloading/unpacking jsonschema==2.5.1 22:11:41 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 22:11:41 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 22:11:41 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 22:11:41 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 22:11:41 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 22:11:41 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 22:11:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:11:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:11:43 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 22:11:43 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 22:11:43 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 22:11:43 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 22:11:43 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 22:11:43 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 22:11:44 INFO - Downloading functools32-3.2.3-2.tar.gz 22:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:11:44 INFO - warning: no files found matching '*.txt' 22:11:44 INFO - no previously-included directories found matching 'build' 22:11:44 INFO - no previously-included directories found matching 'dist' 22:11:44 INFO - no previously-included directories found matching '.git*' 22:11:44 INFO - Installing collected packages: jsonschema, functools32 22:11:44 INFO - Running setup.py install for functools32 22:11:44 INFO - warning: no files found matching '*.txt' 22:11:44 INFO - no previously-included directories found matching 'build' 22:11:44 INFO - no previously-included directories found matching 'dist' 22:11:44 INFO - no previously-included directories found matching '.git*' 22:11:44 INFO - Successfully installed jsonschema functools32 22:11:44 INFO - Cleaning up... 22:11:44 INFO - Return code: 0 22:11:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:11:44 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')]} 22:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:44 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')]} 22:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:44 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:44 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 22:11:44 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 22:11:44 INFO - Using env: {'DISPLAY': ':0', 22:11:44 INFO - 'HOME': '/home/cltbld', 22:11:44 INFO - 'LANG': 'en_US.UTF-8', 22:11:44 INFO - 'LANGUAGE': 'en_US:en', 22:11:44 INFO - 'LOGNAME': 'cltbld', 22:11:44 INFO - 'MAIL': '/var/mail/cltbld', 22:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:44 INFO - 'MOZ_NO_REMOTE': '1', 22:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:44 INFO - 'NO_EM_RESTART': '1', 22:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:44 INFO - 'PWD': '/builds/slave/test', 22:11:44 INFO - 'SHELL': '/bin/bash', 22:11:44 INFO - 'SHLVL': '1', 22:11:44 INFO - 'TERM': 'linux', 22:11:44 INFO - 'TMOUT': '86400', 22:11:44 INFO - 'USER': 'cltbld', 22:11:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:44 INFO - '_': '/tools/buildbot/bin/python'} 22:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:11:44 INFO - Cleaning up... 22:11:44 INFO - Return code: 0 22:11:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:11:44 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')]} 22:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:44 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')]} 22:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:44 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:44 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 22:11:44 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 22:11:44 INFO - Using env: {'DISPLAY': ':0', 22:11:44 INFO - 'HOME': '/home/cltbld', 22:11:44 INFO - 'LANG': 'en_US.UTF-8', 22:11:44 INFO - 'LANGUAGE': 'en_US:en', 22:11:44 INFO - 'LOGNAME': 'cltbld', 22:11:44 INFO - 'MAIL': '/var/mail/cltbld', 22:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:44 INFO - 'MOZ_NO_REMOTE': '1', 22:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:44 INFO - 'NO_EM_RESTART': '1', 22:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:44 INFO - 'PWD': '/builds/slave/test', 22:11:44 INFO - 'SHELL': '/bin/bash', 22:11:44 INFO - 'SHLVL': '1', 22:11:44 INFO - 'TERM': 'linux', 22:11:44 INFO - 'TMOUT': '86400', 22:11:44 INFO - 'USER': 'cltbld', 22:11:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:44 INFO - '_': '/tools/buildbot/bin/python'} 22:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:44 INFO - Downloading/unpacking blobuploader==1.2.4 22:11:44 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 22:11:44 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 22:11:44 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 22:11:44 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 22:11:44 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 22:11:44 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 22:11:46 INFO - Downloading blobuploader-1.2.4.tar.gz 22:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:11:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:11:46 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 22:11:46 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 22:11:46 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 22:11:46 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 22:11:46 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 22:11:46 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 22:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:11:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:11:47 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 22:11:47 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 22:11:47 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 22:11:47 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 22:11:47 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 22:11:47 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 22:11:47 INFO - Downloading docopt-0.6.1.tar.gz 22:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:11:47 INFO - Installing collected packages: blobuploader, requests, docopt 22:11:47 INFO - Running setup.py install for blobuploader 22:11:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:11:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:11:47 INFO - Running setup.py install for requests 22:11:47 INFO - Running setup.py install for docopt 22:11:47 INFO - Successfully installed blobuploader requests docopt 22:11:47 INFO - Cleaning up... 22:11:48 INFO - Return code: 0 22:11:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:48 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')]} 22:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:48 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')]} 22:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:48 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:48 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 22:11:48 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 22:11:48 INFO - Using env: {'DISPLAY': ':0', 22:11:48 INFO - 'HOME': '/home/cltbld', 22:11:48 INFO - 'LANG': 'en_US.UTF-8', 22:11:48 INFO - 'LANGUAGE': 'en_US:en', 22:11:48 INFO - 'LOGNAME': 'cltbld', 22:11:48 INFO - 'MAIL': '/var/mail/cltbld', 22:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:48 INFO - 'MOZ_NO_REMOTE': '1', 22:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:48 INFO - 'NO_EM_RESTART': '1', 22:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:48 INFO - 'PWD': '/builds/slave/test', 22:11:48 INFO - 'SHELL': '/bin/bash', 22:11:48 INFO - 'SHLVL': '1', 22:11:48 INFO - 'TERM': 'linux', 22:11:48 INFO - 'TMOUT': '86400', 22:11:48 INFO - 'USER': 'cltbld', 22:11:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:48 INFO - '_': '/tools/buildbot/bin/python'} 22:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:48 INFO - Running setup.py (path:/tmp/pip-1Xnxlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:48 INFO - Running setup.py (path:/tmp/pip-ucjLB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:48 INFO - Running setup.py (path:/tmp/pip-H4cGGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:48 INFO - Running setup.py (path:/tmp/pip-wwmTbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:48 INFO - Running setup.py (path:/tmp/pip-0VwiYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:11:48 INFO - Running setup.py (path:/tmp/pip-4zhsNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:11:48 INFO - Running setup.py (path:/tmp/pip-ur1kS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:11:48 INFO - Running setup.py (path:/tmp/pip-7T211e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:11:48 INFO - Running setup.py (path:/tmp/pip-jXznuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:11:48 INFO - Running setup.py (path:/tmp/pip-KMbIgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:11:48 INFO - Running setup.py (path:/tmp/pip-Zj15AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:11:49 INFO - Running setup.py (path:/tmp/pip-0arhxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:11:49 INFO - Running setup.py (path:/tmp/pip-RoEV9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:11:49 INFO - Running setup.py (path:/tmp/pip-LtpgY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:49 INFO - Running setup.py (path:/tmp/pip-rrsZD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:11:49 INFO - Running setup.py (path:/tmp/pip-5wqZUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:11:49 INFO - Running setup.py (path:/tmp/pip-fTqjUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:11:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:11:49 INFO - Running setup.py install for manifestparser 22:11:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:11:49 INFO - Running setup.py install for mozcrash 22:11:49 INFO - Running setup.py install for mozdebug 22:11:49 INFO - Running setup.py install for mozdevice 22:11:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:11:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:11:49 INFO - Running setup.py install for mozfile 22:11:49 INFO - Running setup.py install for mozhttpd 22:11:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Running setup.py install for mozinfo 22:11:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Running setup.py install for mozInstall 22:11:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Running setup.py install for mozleak 22:11:50 INFO - Running setup.py install for mozlog 22:11:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Running setup.py install for moznetwork 22:11:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Running setup.py install for mozprocess 22:11:50 INFO - Running setup.py install for mozprofile 22:11:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Running setup.py install for mozrunner 22:11:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:11:50 INFO - Running setup.py install for mozscreenshot 22:11:51 INFO - Running setup.py install for moztest 22:11:51 INFO - Running setup.py install for mozversion 22:11:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:11:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:11:51 INFO - Cleaning up... 22:11:51 INFO - Return code: 0 22:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:51 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')]} 22:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:51 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')]} 22:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:51 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:51 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 22:11:51 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 22:11:51 INFO - Using env: {'DISPLAY': ':0', 22:11:51 INFO - 'HOME': '/home/cltbld', 22:11:51 INFO - 'LANG': 'en_US.UTF-8', 22:11:51 INFO - 'LANGUAGE': 'en_US:en', 22:11:51 INFO - 'LOGNAME': 'cltbld', 22:11:51 INFO - 'MAIL': '/var/mail/cltbld', 22:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:51 INFO - 'MOZ_NO_REMOTE': '1', 22:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:51 INFO - 'NO_EM_RESTART': '1', 22:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:51 INFO - 'PWD': '/builds/slave/test', 22:11:51 INFO - 'SHELL': '/bin/bash', 22:11:51 INFO - 'SHLVL': '1', 22:11:51 INFO - 'TERM': 'linux', 22:11:51 INFO - 'TMOUT': '86400', 22:11:51 INFO - 'USER': 'cltbld', 22:11:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:51 INFO - '_': '/tools/buildbot/bin/python'} 22:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:51 INFO - Running setup.py (path:/tmp/pip-0oPUeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:51 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)) 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:51 INFO - Running setup.py (path:/tmp/pip-siJRsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:51 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)) 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:51 INFO - Running setup.py (path:/tmp/pip-obHiF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:51 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)) 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:51 INFO - Running setup.py (path:/tmp/pip-mx2742-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:51 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)) 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:51 INFO - Running setup.py (path:/tmp/pip-sJtYgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:51 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)) 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:11:51 INFO - Running setup.py (path:/tmp/pip-OXXwOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:11:51 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)) 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:11:51 INFO - Running setup.py (path:/tmp/pip-HqI4Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:11:51 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)) 22:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:11:51 INFO - Running setup.py (path:/tmp/pip-83PNLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:11:52 INFO - Running setup.py (path:/tmp/pip-zMgf7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:11:52 INFO - Running setup.py (path:/tmp/pip-fLTSEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:11:52 INFO - Running setup.py (path:/tmp/pip-REelVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:11:52 INFO - Running setup.py (path:/tmp/pip-TblH0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:11:52 INFO - Running setup.py (path:/tmp/pip-JDnlW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:11:52 INFO - Running setup.py (path:/tmp/pip-T0U9AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:52 INFO - Running setup.py (path:/tmp/pip-Q9Ynd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:11:52 INFO - Running setup.py (path:/tmp/pip-2qRIeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:11:52 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)) 22:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:11:52 INFO - Running setup.py (path:/tmp/pip-bLTBe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:11:52 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)) 22:11:52 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)) 22:11:52 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)) 22:11:52 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)) 22:11:52 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)) 22:11:52 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)) 22:11:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:11:52 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 22:11:52 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 22:11:52 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 22:11:52 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 22:11:52 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 22:11:52 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 22:11:54 INFO - Downloading blessings-1.6.tar.gz 22:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:11:54 INFO - Installing collected packages: blessings 22:11:54 INFO - Running setup.py install for blessings 22:11:54 INFO - Successfully installed blessings 22:11:54 INFO - Cleaning up... 22:11:54 INFO - Return code: 0 22:11:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:11:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:55 INFO - Reading from file tmpfile_stdout 22:11:55 INFO - Current package versions: 22:11:55 INFO - argparse == 1.2.1 22:11:55 INFO - blessings == 1.6 22:11:55 INFO - blobuploader == 1.2.4 22:11:55 INFO - docopt == 0.6.1 22:11:55 INFO - functools32 == 3.2.3-2 22:11:55 INFO - jsonschema == 2.5.1 22:11:55 INFO - manifestparser == 1.1 22:11:55 INFO - mozInstall == 1.12 22:11:55 INFO - mozcrash == 0.17 22:11:55 INFO - mozdebug == 0.1 22:11:55 INFO - mozdevice == 0.48 22:11:55 INFO - mozfile == 1.2 22:11:55 INFO - mozhttpd == 0.7 22:11:55 INFO - mozinfo == 0.9 22:11:55 INFO - mozleak == 0.1 22:11:55 INFO - mozlog == 3.4 22:11:55 INFO - moznetwork == 0.27 22:11:55 INFO - mozprocess == 0.23 22:11:55 INFO - mozprofile == 0.28 22:11:55 INFO - mozrunner == 6.12 22:11:55 INFO - mozscreenshot == 0.1 22:11:55 INFO - mozsystemmonitor == 0.3 22:11:55 INFO - moztest == 0.7 22:11:55 INFO - mozversion == 1.4 22:11:55 INFO - psutil == 3.1.1 22:11:55 INFO - requests == 1.2.3 22:11:55 INFO - wsgiref == 0.1.2 22:11:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:55 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')]} 22:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:55 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')]} 22:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:55 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:55 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 22:11:55 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 22:11:55 INFO - Using env: {'DISPLAY': ':0', 22:11:55 INFO - 'HOME': '/home/cltbld', 22:11:55 INFO - 'LANG': 'en_US.UTF-8', 22:11:55 INFO - 'LANGUAGE': 'en_US:en', 22:11:55 INFO - 'LOGNAME': 'cltbld', 22:11:55 INFO - 'MAIL': '/var/mail/cltbld', 22:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:55 INFO - 'MOZ_NO_REMOTE': '1', 22:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:55 INFO - 'NO_EM_RESTART': '1', 22:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:55 INFO - 'PWD': '/builds/slave/test', 22:11:55 INFO - 'SHELL': '/bin/bash', 22:11:55 INFO - 'SHLVL': '1', 22:11:55 INFO - 'TERM': 'linux', 22:11:55 INFO - 'TMOUT': '86400', 22:11:55 INFO - 'USER': 'cltbld', 22:11:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:55 INFO - '_': '/tools/buildbot/bin/python'} 22:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 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)) 22:11:55 INFO - Cleaning up... 22:11:55 INFO - Return code: 0 22:11:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:11:55 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')]} 22:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:55 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')]} 22:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:55 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 0x7f1de40d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', '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 22:11:55 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 22:11:55 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 22:11:55 INFO - Using env: {'DISPLAY': ':0', 22:11:55 INFO - 'HOME': '/home/cltbld', 22:11:55 INFO - 'LANG': 'en_US.UTF-8', 22:11:55 INFO - 'LANGUAGE': 'en_US:en', 22:11:55 INFO - 'LOGNAME': 'cltbld', 22:11:55 INFO - 'MAIL': '/var/mail/cltbld', 22:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:55 INFO - 'MOZ_NO_REMOTE': '1', 22:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:55 INFO - 'NO_EM_RESTART': '1', 22:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:55 INFO - 'PWD': '/builds/slave/test', 22:11:55 INFO - 'SHELL': '/bin/bash', 22:11:55 INFO - 'SHLVL': '1', 22:11:55 INFO - 'TERM': 'linux', 22:11:55 INFO - 'TMOUT': '86400', 22:11:55 INFO - 'USER': 'cltbld', 22:11:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:55 INFO - '_': '/tools/buildbot/bin/python'} 22:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:11:55 INFO - Cleaning up... 22:11:55 INFO - Return code: 0 22:11:55 INFO - Running post-action listener: _resource_record_post_action 22:11:55 INFO - Running post-action listener: _start_resource_monitoring 22:11:55 INFO - Starting resource monitoring. 22:11:55 INFO - [mozharness: 2016-10-06 05:11:55.569145Z] Finished create-virtualenv step (success) 22:11:55 INFO - [mozharness: 2016-10-06 05:11:55.569707Z] Running install step. 22:11:55 INFO - Running pre-action listener: _resource_record_pre_action 22:11:55 INFO - Running main action method: install 22:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:55 INFO - Reading from file tmpfile_stdout 22:11:55 INFO - Detecting whether we're running mozinstall >=1.0... 22:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:11:55 INFO - Reading from file tmpfile_stdout 22:11:55 INFO - Output received: 22:11:55 INFO - Usage: mozinstall [options] installer 22:11:55 INFO - Options: 22:11:55 INFO - -h, --help show this help message and exit 22:11:55 INFO - -d DEST, --destination=DEST 22:11:55 INFO - Directory to install application into. [default: 22:11:55 INFO - "/builds/slave/test"] 22:11:55 INFO - --app=APP Application being installed. [default: firefox] 22:11:55 INFO - mkdir: /builds/slave/test/build/application 22:11:55 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'] 22:11:55 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 22:12:11 INFO - Reading from file tmpfile_stdout 22:12:11 INFO - Output received: 22:12:11 INFO - /builds/slave/test/build/application/firefox/firefox 22:12:11 INFO - Running post-action listener: _resource_record_post_action 22:12:11 INFO - [mozharness: 2016-10-06 05:12:11.993902Z] Finished install step (success) 22:12:11 INFO - [mozharness: 2016-10-06 05:12:11.994144Z] Running run-tests step. 22:12:11 INFO - Running pre-action listener: _resource_record_pre_action 22:12:11 INFO - Running main action method: run_tests 22:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:12:12 INFO - Python 2.7.3 22:12:12 INFO - Return code: 0 22:12:12 INFO - grabbing minidump binary from tooltool 22:12:12 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')]} 22:12:12 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 0x23f7f60>, '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 0x23f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:12:12 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 22:12:12 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 22:12:12 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 22:12:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:12:12 INFO - Return code: 0 22:12:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:12:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:12:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:12:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:12:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 22:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 22:12:12 INFO - Using env: {'DISPLAY': ':0', 22:12:12 INFO - 'HOME': '/home/cltbld', 22:12:12 INFO - 'LANG': 'en_US.UTF-8', 22:12:12 INFO - 'LANGUAGE': 'en_US:en', 22:12:12 INFO - 'LOGNAME': 'cltbld', 22:12:12 INFO - 'MAIL': '/var/mail/cltbld', 22:12:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:12:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:12 INFO - 'MOZ_NO_REMOTE': '1', 22:12:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:12 INFO - 'NO_EM_RESTART': '1', 22:12:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:12 INFO - 'PWD': '/builds/slave/test', 22:12:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:12:12 INFO - 'SHELL': '/bin/bash', 22:12:12 INFO - 'SHLVL': '1', 22:12:12 INFO - 'TERM': 'linux', 22:12:12 INFO - 'TMOUT': '86400', 22:12:12 INFO - 'USER': 'cltbld', 22:12:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780', 22:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:12 INFO - '_': '/tools/buildbot/bin/python'} 22:12:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 22:12:12 INFO - mozversion application_buildid: 20161005204800 22:12:12 INFO - mozversion application_changeset: c7d62e6d052c5d2638b08d480a720254ea09ff2d 22:12:12 INFO - mozversion application_display_name: Nightly 22:12:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:12:12 INFO - mozversion application_name: Firefox 22:12:12 INFO - mozversion application_remotingname: firefox 22:12:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:12:12 INFO - mozversion application_vendor: Mozilla 22:12:12 INFO - mozversion application_version: 52.0a1 22:12:12 INFO - mozversion platform_buildid: 20161005204800 22:12:12 INFO - mozversion platform_changeset: c7d62e6d052c5d2638b08d480a720254ea09ff2d 22:12:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:12:12 INFO - mozversion platform_version: 52.0a1 22:12:12 INFO - using testdate: 1475730732 22:12:12 INFO - actual date: 1475730732 22:12:12 INFO - starting webserver on 'localhost:54553' 22:12:12 INFO - SUITE-START | Running 2 tests 22:12:12 INFO - TEST-START | dromaeo_css 22:12:12 INFO - operating with platform_type : linux_ 22:12:12 INFO - Initialising browser for dromaeo_css test... 22:12:12 INFO - TEST-INFO | started process 4803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVzqqD/profile http://localhost:54553/getInfo.html) 22:12:16 INFO - PROCESS | 4803 | __metrics Screen width/height:1600/1200 22:12:16 INFO - PROCESS | 4803 | colorDepth:24 22:12:16 INFO - PROCESS | 4803 | Browser inner width/height: 1024/697 22:12:16 INFO - PROCESS | 4803 | __metrics 22:12:17 INFO - PROCESS | 4803 | 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" 22:12:17 INFO - PROCESS | 4803 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:12:17 INFO - PROCESS | 4803 | console.error: PushService: 22:12:17 INFO - PROCESS | 4803 | stateChangeProcessEnqueue: Error transitioning state 22:12:17 INFO - PROCESS | 4803 | UnknownError 22:12:18 INFO - TEST-INFO | 4803: exit 0 22:12:18 INFO - Browser initialized. 22:12:18 INFO - Running cycle 1/1 for dromaeo_css test... 22:12:18 INFO - TEST-INFO | started process 4883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVzqqD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:31 INFO - PROCESS | 4883 | RSS: Main: 175570944 22:12:31 INFO - PROCESS | 4883 | 22:13:22 INFO - PROCESS | 4883 | 1475730802579 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] 22:15:34 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54553/tests/dromaeo/cssquery-ext.html) 22:15:36 INFO - PROCESS | 4883 | RSS: Main: 329445376 22:15:36 INFO - PROCESS | 4883 | 22:18:39 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-ext.html (next: http://localhost:54553/tests/dromaeo/cssquery-jquery.html) 22:18:39 INFO - PROCESS | 4883 | RSS: Main: 274313216 22:18:39 INFO - PROCESS | 4883 | 22:21:42 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54553/tests/dromaeo/cssquery-mootools.html) 22:21:42 INFO - PROCESS | 4883 | RSS: Main: 219607040 22:21:42 INFO - PROCESS | 4883 | 22:24:45 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54553/tests/dromaeo/cssquery-prototype.html) 22:24:45 INFO - PROCESS | 4883 | RSS: Main: 219860992 22:24:45 INFO - PROCESS | 4883 | 22:27:48 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54553/tests/dromaeo/cssquery-yui.html) 22:27:49 INFO - PROCESS | 4883 | RSS: Main: 222859264 22:27:49 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-yui.html (next: http://localhost:54553/tests/dromaeo/cssquery-dojo.html) 22:30:52 INFO - PROCESS | 4883 | RSS: Main: 297078784 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | __start_tp_report 22:30:52 INFO - PROCESS | 4883 | _x_x_mozilla_page_load 22:30:52 INFO - PROCESS | 4883 | _x_x_mozilla_page_load_details 22:30:52 INFO - PROCESS | 4883 | |i|pagename|runs| 22:30:52 INFO - PROCESS | 4883 | |0;dojo.html;2548.0699544666195;2558.9360265993346;2567.4351642638635;2594.857282849444;2610.699769526504;4569.086182763444;4602.631789456844;4624.8150073997;4625.491195968445;4629.62962962963;4670.252759558472;4676.415448068991;4685.578297953183;4700.55344742249;4702.24764037754;4266.573342665732;4292.570742925698;4304.698671093025;4319.37369081483;4380.08018316154;4177.248095342837;4264.957350426503;4315.913681726363;4369.410129632507;4374.147041326943;4372.2785740352965;4381.715188512752;4410.867673969786;4431.224535706255;4432.689711720181;312.7743986463531;4349.8375775424165;4378.16814805186;4378.562143785628;4412.75729834859;3702.500162478058;4228.1966426378885;4271.231178387889;4277.337012763027;4315.093830295642;4635.721856688576;4641.071785642851;4643.442786865564;4654.069186162781;4708.434987801452;5001.17480615698;5010.096163457899;5019.723915184663;5064.11378008847;5097.974510127426;4841.661083724141;4927.679700819435;4948.925766113512;5000.249962505617;5025.296458495814;4724.527547245248;4734.834280800155;4735.100330937111;4751.429828420577;4797.136515427256;5174.404943431478;5175.275461435402;5175.327207463006;5183.818566350235;5239.345081864691;4736;4815.133276010281;4836.709797412166;4960.70235785854;5028.572571331405;4935.827246046371;4956;4957.330760347307;5012.724300163453;5018.447970723218;4871.683340582851;4875.658703890694;4900.681455705368;4917.803287868517;4939.580135688435;4800.783964721596;4831.73425461603;4870.853874383774;4872.585830204473;4931.235658472942;4145.66834653227;4199.643030342455;4212.473440819897;4218.388333691598;4285.142971405669;3755.7183211259266;3760.2479504099288;3760.6239376062176;3799.031247031989;3804.7336686431686;4382.07976324969;4392.648588112943;4394.1651086293505;4415.889602759957;4433.069055498317;4855.635827312965;4956.727379994135;4977.203647416396;5019.824306149268;5100.51545103222;4329.545397733255;4330.437043184366;4384.912301753947;4386.539413361615;4408.448943882015;4528.049109686936;4528.343390208402;4532.478764942008;4534.79593418297;4586.403767510203;4522.660800440046;4566.520515345841;4675.667434781071;4701.247800351859;4704.176769065469;5022.924656130234;5086.7710953007945;5108.3103780989095;5120.18077107661;5120.820771273136;4724.149653062482;4725.338452616567;4732.337472753886;4736;4793.856184314476;4974.129527332775;4983.725895075806;4989.575886049726;4993.950060499494;5053.166227572557;4878.463369029475;4935.679180853233;4954.702717836942;4980.153373926513;4995.975020124876;4886.682365646222;4888.804447822047;4890.070886531547;4932.383452068491;4942.703437793743;4889.731064791471;4894.314795928502;4895.7062576245535;4896.094222568836;4954.826581069645;4682.92975605373;4769.30845027476;4770.761461926821;4778.665493415567;4791.9281210782565;4921.6062714982;4927.753612319298;4942;5001.449840517467;5020.899582008266;4670.9766451167525;4717.528247175255;4718.386609740712;4812.975935120302;4894.804207831647 22:30:52 INFO - PROCESS | 4883 | |1;ext.html;560.4059696721478;561.4217356123193;570.7317560746449;578.0375674501954;581.4156772443695;27609;38330.42504362437;39826.99999999996;40094.19811603766;43457.348139777925;38725.806370968174;39102.60897391025;39128.413073803844;39132.41301380481;39169.41245881307;7009.12385951756;7616.162222155558;7763.22367763222;7767.262110099531;7773.028371453568;7026.156861176666;9643.180329671952;9857.95071024644;9879.16027137694;10236.84644730326;10047.447390393525;10136.13842823361;10136.847947280796;10140.23948203884;10153.441560714158;9891;9946.602135914554;9958.701238962843;9962.651307204213;9967.152792012688;9851.50742462874;9930.751731206705;9932.801343973153;9936.105750482418;9939.55272012761;37067;37343;37373.06567335811;37417.43873841895;37454.43818342727;2836.234216761463;2976.925576860574;2984.4627966965936;3102.7362674172723;3228.596425446819;27866.442671146462;28412.573811392846;28812.85593572019;28833.135005949855;28907.855460722563;3470.9479357809655;3515.6484351564895;3541.5041894134843;3656;3810.8094595270127;204176;206934;208374;258254;258989;55435.722821385636;56115.87768244694;56217;56253.71873140608;56265;33458.49812252818;34460.13849653779;34583.13542161466;36323.27353452916;36391.63608363883;14074.577762667137;14267.286635668175;14290.857091429161;14291.356888940023;14297.714045719027;9600.807983840425;9626.614935402506;9920.851187232198;9980.401175929468;10001.899981000242;16303.673926521404;16479.505614831574;16561.585960351087;18068.63862722738;18635;7119;7228.891566626505;7337.816554586178;7377.151627562792;7427.85144297111;790.6876783670418;905.8097799462055;942.0061834764252;986.2110311750571;992.3549692699803;27102.457950841268;27606;27694;28055.158345249674;28158.15525534237;927.0636656976502;945.111595100617;953.3707752883203;962.9541204090655;987.4667679453158;13750.724985500434;14927.776083358758;14942.25288735559;14956.51653269873;15061.246937653073;372275;376920;377642;377802;378233;46862;47158.292625610644;47258.14756860236;47297;47337.05325893532;1117.4301106435776;1147.472162805119;1160.1704781081398;1165.3532289579364;1184.9407529623484;25084.372890677878;26432;26688;27384.58923116115;27507.58738618882;40617.1876562473;40982.38526422166;40986.590134098275;41034.794826026875;41072.38391424191;314180;315392;316608;317493;318435;22118.889405553513;22838.42903927415;24502.26493205207;25496.362590935376;25850.482990340464;37319.44020839744;40017;40578.79710601546;40672;41338.79330603328;34071.82964085164;34110.65889341075;34505.309893802485;34578.48132277968;35061.12347191341;33564.32871342608;33914.32171356608;34291.65708342884;35109;35220.47169292411;33663.83168084144;34015.14962125967;34174.82912585421;34195;34414.82792586021;26932;26959.46081078407;30558.388832222787;30707.2323191922;31104.688953111083;23503.647445288676;24279.51440971206;24301.878490607432;24353.43211974298;24922.626160607244 22:30:52 INFO - PROCESS | 4883 | |2;jquery.html;356.2696472231926;364.74285628631816;365.6562830938917;372.1682040639169;385.07965961352375;15244.466443674473;16568.502944911656;17255.91372043141;17337.566560835985;17352;16290.83709162908;16594.253258603363;16634.168291585403;16934.23795929183;17048.659026819456;4800.447948485925;5046.848594542152;5050.974745126269;5051.696898186121;5051.848444546669;3584.946225806615;3777.7544459610176;4989.675671081368;5080.288759573663;5586.13414920688;5798.449147330997;5939.1388248703915;5942.1680964664765;5948.494377977855;5952.4047595240345;5620.185073164389;5902.144189092601;5915.497182739472;5928.555358348098;5932.584719069645;5213.165893457029;5217.58259339252;5220.29526013987;5223.373195216598;5224.738763061831;19941.80058199414;20702.275420360365;20709.792902070938;20820.687689684666;20977.21693656041;1924.393815947986;2027.9860069965018;2029.4926268432891;2038.8878611676353;2151.752548456932;12304;13027.674308142277;13063.99453881379;13698.109622874581;13744.931275343559;1678.3622223555094;1752.3603884582035;1788.0791392432777;1803.0712744052223;1822.2164469278337;67973.66013169903;68907;70988.29011709869;71146;72927;8054.751513515414;8502.44734092282;8845.380823342304;8850.867236991451;9723.15935205604;11793.056555475541;11804.46879890407;11828.408579570987;11832.230904991147;11842.585509507126;6285.465735412541;6386.8722625547225;6487.318831522716;6666.200055993312;6703.463722902156;6085.817425477243;6087.908681369783;6236.126942228092;6378.904316435257;6423.710933008026;3538.9469157962653;3616.294822509638;3628.7822730636244;3727.459518369821;3791.545014598266;1548.3651702801797;1638.2218446237941;1811.5471132216946;1845.1327875898307;1860.8604354673453;786.2609147401539;793.2741541489472;834.1908348901555;860.8450478913855;892.4422236102436;16207.918960405123;16340.264688088826;16574.64084946908;17211.56971075708;17537.123143842757;851.246646717647;852.2968550945495;862.642003568512;868.8045189832237;932.98475293366;9240.907590924138;9818.852717209247;9822.116009559031;9842;10021.148202402877;359794;362970;364227;370406;371822;77340;79446;79861.60069199617;79908.60045699734;80667;865.233350812796;883.4610887358706;901.3510272603714;907.2016625369632;910.776859669372;11707.941460292644;14090.647733806736;14575.927120364331;15518.84481155174;15801.36794528252;35757.46363804493;36475;36544.26911461809;36605.450918235714;37246.813765930994;46758.53241467542;46911.53088469208;47622.76188619035;47694.28458573055;48518.75740621416;7219.061522002106;7344.596047217455;7352.70589176427;7596.506227095221;8181.836363272821;10407.739806504898;11692.883071169179;11715.824262635897;11877.287362758263;12098.939505302416;9865.457399843077;10217.1826253901;10248.948755256177;10362.119219866396;10737.087347575543;10217.23370747182;10302.742431439274;10311.175105991653;10464.162866970777;10663.200259980378;10287.53706083213;10427.232402306774;10563.366198028143;10694.732631683959;11094.944525277322;7355.852882942204;7360.595167265852;7403.481756277009;7530.585817780075;7587.430942679211;9625.903740962782;10359.171266298526;10399.740006499898;10577.841332379867;11057.06014988735 22:30:52 INFO - PROCESS | 4883 | |3;mootools.html;1295.9092863499552;1362.7410791949528;1403.4877269796527;1675.849173574378;1700.1499250374814;6797.150356205474;7040.47196460265;7268.3095105964985;7873.724419645314;7874.645640946157;7241.275872412756;7489.9625501872415;7493.812654683636;7774.766756997285;7781.68873245071;2091.989540052305;2122.5224324526935;2123.6920646506323;2125.51113243954;2127.6702111172795;1771.3977247735768;1842.6498965196636;2033.9389818305401;2077.5117847305946;2093.549886774343;2019.989900050505;2101.422108920044;2105.1789801977243;2114.6510825713817;2116.7354080739906;1924.4996300961782;1932.5168707823045;1936.1384184038038;1993.9302124425722;2054.7226124473154;2073.9377818665466;2074.95850082999;2076.09689784944;2082.822960048398;2088.6866969954476;7841.059072911287;7872.685092596289;7890.605469726548;7891.171427000198;7893.329067029309;4384.758838263894;4479.081788233437;4552.658550608718;4552.817887284505;4553.77231138445;2723.087765598527;2764.1983824690815;2884.1059271625863;2895.898643547466;2899.60855284536;891.6923661336829;897.6274845938927;905.6649039855296;910.1490106750209;920.7237828651445;10565.260431769779;10589.15286777056;10602.469876506144;10606.363618182933;10607.469626518721;3707.14735610811;3887.591802860659;4053.047533829548;4063.3701776224734;4085.632293093636;8982.955085224532;8989.55052247398;8996.730098097067;8999.910000899907;9005.324600654978;4572.359869618256;4574.268117101248;4577.61090307321;4579.977100114545;4580.931286030712;4109.0549173690215;4172.332426811696;4193.056562273525;4195.685323600742;4199.181159673895;3514.5958214805623;3547.1309529165005;3631.291898079849;3648.288583726201;3670.33933891902;1057.582255009267;1103.4372470040337;1170.5259369955181;1183.1303991566192;1208.4320369426355;645.7578408096964;703.6481759120439;718.9209186989427;734.0933946575974;823.201305148253;4766.523347665206;4776.307435421844;4876.195427754381;4905.117078925828;4987.925181122286;773.3349319585152;792.540326610576;796.4663675337538;799.1449149410191;837.2883049407955;3235.320582677664;3338.6327503974544;3358.5633867597057;3375.915602109918;3379.831008449568;9315.813683726423;9728.610855565697;9735.756606084762;9743.025697430201;9743.9025609743;9669.419834809934;9689;9710.611575537041;9715.854262186072;9722.465264410524;7087.92912070883;7252.093488313961;7269.127704675473;7281.781546553612;7385.81535461607;4690.085433340466;4801.399825021872;4816.903661926812;4910.410750709938;5082.237664350229;8589.184027517376;8660.740177794676;8711.869321960303;8744.737657870273;8748.737537873874;8853.867191991996;8881.689140880038;8930.285577153682;8934.106589341274;8990.415622984485;6285.560010799383;6356.841078973062;6390.360963903572;6403.455706265019;6460.3862633049785;7204.135503739585;7326.560406375635;7335.193128755939;7362.815929601803;7363.374113200438;6513.576617519846;6585.176852893388;6649.667516624053;6752.223494298219;6952.895706564506;6477.805665830033;6595.8021259362295;6621;6727.663616819042;6745.258021617717;5991.101334799815;6131.110988906495;6141.15765270426;6141.324454309933;6148.569600127948;4306.655467562525;4384.145091707086;4443.178012067778;4447.377367168534;4484.8430304940475;4430.955690443183;4448.555144485655;4449.310356894686;4481.789916722401;4516.774161291988 22:30:52 INFO - PROCESS | 4883 | |4;prototype.html;280.4881092007086;283.72903876797653;288.6406424002118;290.9781766367523;292.3991198087928;4938.407391113067;4939.913219091803;4955.925661115086;4974.751262436873;4979.128652485814;4860.274602516109;4868.4401293851215;4871.732054736988;4874.512548745124;4897.657163998521;3831.3486707259694;3833.7891415972113;3840.788756618385;3842.8270727817317;3859.517560304962;3847.442120892469;3850.7304488685804;3851.094992676719;3855.8264878080554;3857.787821669807;3509.3332266869343;3737.009692431508;3748.2316125194407;3778.622137786213;3786.2048969716393;3721.237146385012;3721.832517536717;3736.5329333833133;3744.569374521938;3744.794036328001;3058.287359078923;3135.717785399325;3284.5894263217097;3286.819224942627;3290.6215785184772;4650.86047418578;4780.772978239709;4783.665143439961;4785.641076919245;4790;4261.254280500931;4261.637760790337;4263.104748002892;4263.189993901149;4264.317709166549;4724.433068031858;4794.5924596408995;5132.486751324875;5136.280920671109;5138.073222541547;3505.91235219119;3523.5243242162237;3530.135116896351;3530.3645343838098;3544.4506101554302;5279.577633789288;5314.282571852789;5350.197470379435;5357.4106848246665;5357.491038351351;3597.1546686528645;3604.6575575320303;3610.6389361063684;3621.420572708354;3624.474451204613;3473.044912648991;3658.4329428938026;3667.4865518827387;3703.277860817169;3709.350863598859;4216.156768646283;4223.21870453967;4226.366045093199;4247.97876010618;4249.68127390447;5115.258287548285;5126.231065340155;5129.410117836496;5147.356580427447;5148.176291793295;1221.4442428694922;1262.9179103358435;1281.1608396500308;1282.2370689439767;1293.6869077885954;789.9769798111345;809.1382677448498;824.5217773691245;824.6866190847439;826.4917075998218;4043.353063509824;4046.9595304046584;4052.1576715824895;4065.6340929316502;4070.531888832763;4638.657477973669;4657.4876763555985;4657.650676199299;4664.55686709762;4671.04243630055;4032.9798351008058;4038.374052021941;4054.8378064877666;4054.918901621951;4070.185962807391;2382.332946774906;2479.776820086201;2488.2783992642294;2488.626705994079;2490.8007359411204;4356.194104090753;4356.803943822536;4721.748736584807;4825.324454576362;4881.243407271879;5406.216098665672;5407.756650950638;5410.3507579090765;5416.539594134542;5423.322084739408;4948.331975183304;4951.702897826142;4953.67801092935;4958.628102892298;4961.454240033666;5057.533315338511;5230.529252367305;5270.604704647243;5270.631055826056;5303.814366497154;5158.277841102174;5180.792768289377;5188.455212202664;5189.922151167811;5192.350956130484;4920.950790492049;4924.8768780780765;4937.654364194472;4943.431505376928;4949.950500494949;3587.4260118380935;3685.207680348738;3688.2992231475932;3690.9446358305186;3695.1870588470492;5301.1783173608155;5311.309529761261;5311.973440132774;5347.411784703757;5349.545288650353;5156.802782275014;5171.844844654666;5177.456367081402;5184.714840683799;5211.244369566468;4878.902421951612;5089.26205700164;5117.385913690232;5145.948540514697;5149.588032957429;5038;5038.798448062036;5049.671771334852;5058.9494105058475;5086.796528138833;4997.425296090851;5124.615653826053;5136.460671629425;5136.486351364833;5203.973980130075;5003.348894864759;5004.197649316395;5005.899882002267;5023.648344615842;5032.647714659939 22:30:52 INFO - PROCESS | 4883 | |5;yui.html;614.9231346081739;630.2877748144596;657.7073202424923;696.6621188723468;741.3809469093309;12161.27032378058;12894.80657790134;12995.155314904549;13099.607011789638;13122.278274694889;12923;12964;12997.220166789999;13059.869401305985;13063;608.6044071353612;620.9782657606985;735.5366119344832;737.6827963975488;758.4880205861049;750.8348163404042;768.3891306411416;768.5849641193748;768.8654485465021;769.3921801776589;806.6571707024491;807.019471342319;809.0130041349573;812.7846120777998;813.4712436915993;642.5181114164377;654.8166513376215;757.9658915348823;804.4087595617187;808.3977436809556;577.8006587727227;578.129914478711;582.7698059266565;583.0496291045611;583.5098517245534;13334.733305333935;13358.265295408748;13384.996125290545;13393.263370514618;13393.933030334883;12415.44130514129;12530.81203781944;12761.170523915916;12999;13429.798553021712;10999.725006874813;11046.226764126515;11395.145364097725;11471.827922581084;11676;3998.1803730235233;4036.576159503239;4120.876373708794;4124.628783409477;4147.937780933258;59833.700831496;59944.400555994755;59950.10074848881;60312.39687603112;60340;9814.607415703435;9918.900810991798;10257.538410771533;10457.215708821717;10568.947155264175;18270;18279.54301142482;18364.63270734578;18421.447356579323;18441.53896152607;5920.437558431942;6196.628202307786;6356.364363563699;6456.225252969673;6620.271770105381;3512.877049303262;3558.288342331544;3582.5342705448124;3593.3352329819068;3595.460680897886;2640.2343320436858;2753.2153336299057;2762.9915080995293;2771.7366850149206;2780;472.6478773313834;479.78409715628106;487.86095962651183;490.6663468841222;495.86115887551546;533.2614329154072;562.1399259133451;571.4913726783167;577.2178697864417;639.0701529274894;8752.387332886765;8809.42738721981;8845;9133.269338452908;9486;491.8549028036738;529.75631209644;550.6310771782915;569.6126633888913;581.6713556840372;3749.043993781568;3993.4209539617173;4053.6554392876346;4104.384342348671;4247.957520424818;88121.86598541122;95280;100349;102657;104018.47990759998;48711.75644121828;87504.56247718721;92502.0749792507;93126;93318.53340733254;57115.42884571101;76962;78488;78955;80230.19769802345;7937.32532734724;8043.652992656244;8088.433809633269;8524.27543658796;8591.269742071743;40276.194476109726;41425.585744142176;42358.78820605877;43157.56842431535;43573.346399804665;56968.43031569797;63897;66358.66820665865;68611.31388686049;69858.30141698518;10580.36517808934;10616;10756.408397537898;10810.756782960416;11486;12434.316112613893;12612.684682883002;12785.36073196355;12972.610821675366;13181.736365272449;12102.46157690866;12288.385580721108;12308.753824923631;12656.493740250287;13042;11738.119641026786;11792.469338879599;12240.877591223974;12679.366031698562;12710.809337860124;11627.302361858316;11917;12185.478073328668;12498.625041248777;12517.186382885084;9838.950805245928;10150.223710850423;10292.897071029493;10785.838212426663;10828.24202305831;9429.58556216573;9928.652497162564;10145.28982971185;10715.410652414192;10795.98887338023 22:30:52 INFO - PROCESS | 4883 | __end_tp_report 22:30:52 INFO - PROCESS | 4883 | __start_cc_report 22:30:52 INFO - PROCESS | 4883 | _x_x_mozilla_cycle_collect,1527 22:30:52 INFO - PROCESS | 4883 | __end_cc_report 22:30:52 INFO - PROCESS | 4883 | __startTimestamp1475731852502__endTimestamp 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | ------- Summary: start ------- 22:30:52 INFO - PROCESS | 4883 | Number of tests: 6 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | [#0] dojo.html Cycles:165 Average:4600.37 Median:4732.34 stddev:589.28 (12.5%) stddev-sans-first:568.67 22:30:52 INFO - PROCESS | 4883 | Values: 2548.1 2558.9 2567.4 2594.9 2610.7 4569.1 4602.6 4624.8 4625.5 4629.6 4670.3 4676.4 4685.6 4700.6 4702.2 4266.6 4292.6 4304.7 4319.4 4380.1 4177.2 4265.0 4315.9 4369.4 4374.1 4372.3 4381.7 4410.9 4431.2 4432.7 312.8 4349.8 4378.2 4378.6 4412.8 3702.5 4228.2 4271.2 4277.3 4315.1 4635.7 4641.1 4643.4 4654.1 4708.4 5001.2 5010.1 5019.7 5064.1 5098.0 4841.7 4927.7 4948.9 5000.2 5025.3 4724.5 4734.8 4735.1 4751.4 4797.1 5174.4 5175.3 5175.3 5183.8 5239.3 4736.0 4815.1 4836.7 4960.7 5028.6 4935.8 4956.0 4957.3 5012.7 5018.4 4871.7 4875.7 4900.7 4917.8 4939.6 4800.8 4831.7 4870.9 4872.6 4931.2 4145.7 4199.6 4212.5 4218.4 4285.1 3755.7 3760.2 3760.6 3799.0 3804.7 4382.1 4392.6 4394.2 4415.9 4433.1 4855.6 4956.7 4977.2 5019.8 5100.5 4329.5 4330.4 4384.9 4386.5 4408.4 4528.0 4528.3 4532.5 4534.8 4586.4 4522.7 4566.5 4675.7 4701.2 4704.2 5022.9 5086.8 5108.3 5120.2 5120.8 4724.1 4725.3 4732.3 4736.0 4793.9 4974.1 4983.7 4989.6 4994.0 5053.2 4878.5 4935.7 4954.7 4980.2 4996.0 4886.7 4888.8 4890.1 4932.4 4942.7 4889.7 4894.3 4895.7 4896.1 4954.8 4682.9 4769.3 4770.8 4778.7 4791.9 4921.6 4927.8 4942.0 5001.4 5020.9 4671.0 4717.5 4718.4 4813.0 4894.8 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | [#1] ext.html Cycles:180 Average:45494.54 Median:19312.32 stddev:82425.82 (426.8%) stddev-sans-first:82588.00 22:30:52 INFO - PROCESS | 4883 | Values: 560.4 561.4 570.7 578.0 581.4 27609.0 38330.4 39827.0 40094.2 43457.3 38725.8 39102.6 39128.4 39132.4 39169.4 7009.1 7616.2 7763.2 7767.3 7773.0 7026.2 9643.2 9858.0 9879.2 10236.8 10047.4 10136.1 10136.8 10140.2 10153.4 9891.0 9946.6 9958.7 9962.7 9967.2 9851.5 9930.8 9932.8 9936.1 9939.6 37067.0 37343.0 37373.1 37417.4 37454.4 2836.2 2976.9 2984.5 3102.7 3228.6 27866.4 28412.6 28812.9 28833.1 28907.9 3470.9 3515.6 3541.5 3656.0 3810.8 204176.0 206934.0 208374.0 258254.0 258989.0 55435.7 56115.9 56217.0 56253.7 56265.0 33458.5 34460.1 34583.1 36323.3 36391.6 14074.6 14267.3 14290.9 14291.4 14297.7 9600.8 9626.6 9920.9 9980.4 10001.9 16303.7 16479.5 16561.6 18068.6 18635.0 7119.0 7228.9 7337.8 7377.2 7427.9 790.7 905.8 942.0 986.2 992.4 27102.5 27606.0 27694.0 28055.2 28158.2 927.1 945.1 953.4 963.0 987.5 13750.7 14927.8 14942.3 14956.5 15061.2 372275.0 376920.0 377642.0 377802.0 378233.0 46862.0 47158.3 47258.1 47297.0 47337.1 1117.4 1147.5 1160.2 1165.4 1184.9 25084.4 26432.0 26688.0 27384.6 27507.6 40617.2 40982.4 40986.6 41034.8 41072.4 314180.0 315392.0 316608.0 317493.0 318435.0 22118.9 22838.4 24502.3 25496.4 25850.5 37319.4 40017.0 40578.8 40672.0 41338.8 34071.8 34110.7 34505.3 34578.5 35061.1 33564.3 33914.3 34291.7 35109.0 35220.5 33663.8 34015.1 34174.8 34195.0 34414.8 26932.0 26959.5 30558.4 30707.2 31104.7 23503.6 24279.5 24301.9 24353.4 24922.6 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | [#2] jquery.html Cycles:180 Average:23560.96 Median:18809.49 stddev:60637.56 (322.4%) stddev-sans-first:60782.63 22:30:52 INFO - PROCESS | 4883 | Values: 356.3 364.7 365.7 372.2 385.1 15244.5 16568.5 17255.9 17337.6 17352.0 16290.8 16594.3 16634.2 16934.2 17048.7 4800.4 5046.8 5051.0 5051.7 5051.8 3584.9 3777.8 4989.7 5080.3 5586.1 5798.4 5939.1 5942.2 5948.5 5952.4 5620.2 5902.1 5915.5 5928.6 5932.6 5213.2 5217.6 5220.3 5223.4 5224.7 19941.8 20702.3 20709.8 20820.7 20977.2 1924.4 2028.0 2029.5 2038.9 2151.8 12304.0 13027.7 13064.0 13698.1 13744.9 1678.4 1752.4 1788.1 1803.1 1822.2 67973.7 68907.0 70988.3 71146.0 72927.0 8054.8 8502.4 8845.4 8850.9 9723.2 11793.1 11804.5 11828.4 11832.2 11842.6 6285.5 6386.9 6487.3 6666.2 6703.5 6085.8 6087.9 6236.1 6378.9 6423.7 3538.9 3616.3 3628.8 3727.5 3791.5 1548.4 1638.2 1811.5 1845.1 1860.9 786.3 793.3 834.2 860.8 892.4 16207.9 16340.3 16574.6 17211.6 17537.1 851.2 852.3 862.6 868.8 933.0 9240.9 9818.9 9822.1 9842.0 10021.1 359794.0 362970.0 364227.0 370406.0 371822.0 77340.0 79446.0 79861.6 79908.6 80667.0 865.2 883.5 901.4 907.2 910.8 11707.9 14090.6 14575.9 15518.8 15801.4 35757.5 36475.0 36544.3 36605.5 37246.8 46758.5 46911.5 47622.8 47694.3 48518.8 7219.1 7344.6 7352.7 7596.5 8181.8 10407.7 11692.9 11715.8 11877.3 12098.9 9865.5 10217.2 10248.9 10362.1 10737.1 10217.2 10302.7 10311.2 10464.2 10663.2 10287.5 10427.2 10563.4 10694.7 11094.9 7355.9 7360.6 7403.5 7530.6 7587.4 9625.9 10359.2 10399.7 10577.8 11057.1 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | [#3] mootools.html Cycles:180 Average:5017.20 Median:4890.66 stddev:2874.66 (58.8%) stddev-sans-first:2869.12 22:30:52 INFO - PROCESS | 4883 | Values: 1295.9 1362.7 1403.5 1675.8 1700.1 6797.2 7040.5 7268.3 7873.7 7874.6 7241.3 7490.0 7493.8 7774.8 7781.7 2092.0 2122.5 2123.7 2125.5 2127.7 1771.4 1842.6 2033.9 2077.5 2093.5 2020.0 2101.4 2105.2 2114.7 2116.7 1924.5 1932.5 1936.1 1993.9 2054.7 2073.9 2075.0 2076.1 2082.8 2088.7 7841.1 7872.7 7890.6 7891.2 7893.3 4384.8 4479.1 4552.7 4552.8 4553.8 2723.1 2764.2 2884.1 2895.9 2899.6 891.7 897.6 905.7 910.1 920.7 10565.3 10589.2 10602.5 10606.4 10607.5 3707.1 3887.6 4053.0 4063.4 4085.6 8983.0 8989.6 8996.7 8999.9 9005.3 4572.4 4574.3 4577.6 4580.0 4580.9 4109.1 4172.3 4193.1 4195.7 4199.2 3514.6 3547.1 3631.3 3648.3 3670.3 1057.6 1103.4 1170.5 1183.1 1208.4 645.8 703.6 718.9 734.1 823.2 4766.5 4776.3 4876.2 4905.1 4987.9 773.3 792.5 796.5 799.1 837.3 3235.3 3338.6 3358.6 3375.9 3379.8 9315.8 9728.6 9735.8 9743.0 9743.9 9669.4 9689.0 9710.6 9715.9 9722.5 7087.9 7252.1 7269.1 7281.8 7385.8 4690.1 4801.4 4816.9 4910.4 5082.2 8589.2 8660.7 8711.9 8744.7 8748.7 8853.9 8881.7 8930.3 8934.1 8990.4 6285.6 6356.8 6390.4 6403.5 6460.4 7204.1 7326.6 7335.2 7362.8 7363.4 6513.6 6585.2 6649.7 6752.2 6952.9 6477.8 6595.8 6621.0 6727.7 6745.3 5991.1 6131.1 6141.2 6141.3 6148.6 4306.7 4384.1 4443.2 4447.4 4484.8 4431.0 4448.6 4449.3 4481.8 4516.8 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | [#4] prototype.html Cycles:180 Average:4167.96 Median:4782.22 stddev:1249.99 (26.1%) stddev-sans-first:1218.96 22:30:52 INFO - PROCESS | 4883 | Values: 280.5 283.7 288.6 291.0 292.4 4938.4 4939.9 4955.9 4974.8 4979.1 4860.3 4868.4 4871.7 4874.5 4897.7 3831.3 3833.8 3840.8 3842.8 3859.5 3847.4 3850.7 3851.1 3855.8 3857.8 3509.3 3737.0 3748.2 3778.6 3786.2 3721.2 3721.8 3736.5 3744.6 3744.8 3058.3 3135.7 3284.6 3286.8 3290.6 4650.9 4780.8 4783.7 4785.6 4790.0 4261.3 4261.6 4263.1 4263.2 4264.3 4724.4 4794.6 5132.5 5136.3 5138.1 3505.9 3523.5 3530.1 3530.4 3544.5 5279.6 5314.3 5350.2 5357.4 5357.5 3597.2 3604.7 3610.6 3621.4 3624.5 3473.0 3658.4 3667.5 3703.3 3709.4 4216.2 4223.2 4226.4 4248.0 4249.7 5115.3 5126.2 5129.4 5147.4 5148.2 1221.4 1262.9 1281.2 1282.2 1293.7 790.0 809.1 824.5 824.7 826.5 4043.4 4047.0 4052.2 4065.6 4070.5 4638.7 4657.5 4657.7 4664.6 4671.0 4033.0 4038.4 4054.8 4054.9 4070.2 2382.3 2479.8 2488.3 2488.6 2490.8 4356.2 4356.8 4721.7 4825.3 4881.2 5406.2 5407.8 5410.4 5416.5 5423.3 4948.3 4951.7 4953.7 4958.6 4961.5 5057.5 5230.5 5270.6 5270.6 5303.8 5158.3 5180.8 5188.5 5189.9 5192.4 4921.0 4924.9 4937.7 4943.4 4950.0 3587.4 3685.2 3688.3 3690.9 3695.2 5301.2 5311.3 5312.0 5347.4 5349.5 5156.8 5171.8 5177.5 5184.7 5211.2 4878.9 5089.3 5117.4 5145.9 5149.6 5038.0 5038.8 5049.7 5058.9 5086.8 4997.4 5124.6 5136.5 5136.5 5204.0 5003.3 5004.2 5005.9 5023.6 5032.6 22:30:52 INFO - PROCESS | 4883 | 22:30:52 INFO - PROCESS | 4883 | [#5] yui.html Cycles:180 Average:17769.42 Median:23702.76 stddev:25443.80 (107.3%) stddev-sans-first:25482.57 22:30:52 INFO - PROCESS | 4883 | Values: 614.9 630.3 657.7 696.7 741.4 12161.3 12894.8 12995.2 13099.6 13122.3 12923.0 12964.0 12997.2 13059.9 13063.0 608.6 621.0 735.5 737.7 758.5 750.8 768.4 768.6 768.9 769.4 806.7 807.0 809.0 812.8 813.5 642.5 654.8 758.0 804.4 808.4 577.8 578.1 582.8 583.0 583.5 13334.7 13358.3 13385.0 13393.3 13393.9 12415.4 12530.8 12761.2 12999.0 13429.8 10999.7 11046.2 11395.1 11471.8 11676.0 3998.2 4036.6 4120.9 4124.6 4147.9 59833.7 59944.4 59950.1 60312.4 60340.0 9814.6 9918.9 10257.5 10457.2 10568.9 18270.0 18279.5 18364.6 18421.4 18441.5 5920.4 6196.6 6356.4 6456.2 6620.3 3512.9 3558.3 3582.5 3593.3 3595.5 2640.2 2753.2 2763.0 2771.7 2780.0 472.6 479.8 487.9 490.7 495.9 533.3 562.1 571.5 577.2 639.1 8752.4 8809.4 8845.0 9133.3 9486.0 491.9 529.8 550.6 569.6 581.7 3749.0 3993.4 4053.7 4104.4 4248.0 88121.9 95280.0 100349.0 102657.0 104018.5 48711.8 87504.6 92502.1 93126.0 93318.5 57115.4 76962.0 78488.0 78955.0 80230.2 7937.3 8043.7 8088.4 8524.3 8591.3 40276.2 41425.6 42358.8 43157.6 43573.3 56968.4 63897.0 66358.7 68611.3 69858.3 10580.4 10616.0 10756.4 10810.8 11486.0 12434.3 12612.7 12785.4 12972.6 13181.7 12102.5 12288.4 12308.8 12656.5 13042.0 11738.1 11792.5 12240.9 12679.4 12710.8 11627.3 11917.0 12185.5 12498.6 12517.2 9839.0 10150.2 10292.9 10785.8 10828.2 9429.6 9928.7 10145.3 10715.4 10796.0 22:30:52 INFO - PROCESS | 4883 | -------- Summary: end -------- 22:30:52 INFO - PROCESS | 4883 | 22:30:53 INFO - TEST-INFO | 4883: exit 0 22:30:53 INFO - TEST-OK | dromaeo_css | took 1121205ms 22:30:53 INFO - TEST-START | kraken 22:30:53 INFO - operating with platform_type : linux_ 22:30:53 INFO - Initialising browser for kraken test... 22:30:53 INFO - TEST-INFO | started process 5191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprodZZI/profile http://localhost:54553/getInfo.html) 22:30:58 INFO - PROCESS | 5191 | __metrics Screen width/height:1600/1200 22:30:58 INFO - PROCESS | 5191 | colorDepth:24 22:30:58 INFO - PROCESS | 5191 | Browser inner width/height: 1024/697 22:30:58 INFO - PROCESS | 5191 | __metrics 22:30:58 INFO - PROCESS | 5191 | 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" 22:30:58 INFO - PROCESS | 5191 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:30:59 INFO - PROCESS | 5191 | console.error: PushService: 22:30:59 INFO - PROCESS | 5191 | stateChangeProcessEnqueue: Error transitioning state 22:30:59 INFO - PROCESS | 5191 | UnknownError 22:30:59 INFO - TEST-INFO | 5191: exit 0 22:30:59 INFO - Browser initialized. 22:30:59 INFO - Running cycle 1/1 for kraken test... 22:30:59 INFO - TEST-INFO | started process 5272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprodZZI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:11 INFO - PROCESS | 5272 | RSS: Main: 174804992 22:31:11 INFO - PROCESS | 5272 | 22:31:14 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-beat-detection) 22:31:15 INFO - PROCESS | 5272 | RSS: Main: 234209280 22:31:15 INFO - PROCESS | 5272 | 22:31:18 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-dft) 22:31:19 INFO - PROCESS | 5272 | RSS: Main: 218583040 22:31:19 INFO - PROCESS | 5272 | 22:31:22 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-fft) 22:31:22 INFO - PROCESS | 5272 | RSS: Main: 301170688 22:31:22 INFO - PROCESS | 5272 | 22:31:25 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-oscillator) 22:31:25 INFO - PROCESS | 5272 | RSS: Main: 211992576 22:31:25 INFO - PROCESS | 5272 | 22:31:27 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:31:28 INFO - PROCESS | 5272 | RSS: Main: 215138304 22:31:28 INFO - PROCESS | 5272 | 22:31:31 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-darkroom) 22:31:32 INFO - PROCESS | 5272 | RSS: Main: 250773504 22:31:32 INFO - PROCESS | 5272 | 22:31:35 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-desaturate) 22:31:36 INFO - PROCESS | 5272 | RSS: Main: 245157888 22:31:36 INFO - PROCESS | 5272 | 22:31:39 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54553/tests/kraken/driver.html?testName=json-parse-financial) 22:31:39 INFO - PROCESS | 5272 | RSS: Main: 247271424 22:31:39 INFO - PROCESS | 5272 | 22:31:41 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:31:42 INFO - PROCESS | 5272 | RSS: Main: 211144704 22:31:42 INFO - PROCESS | 5272 | 22:31:44 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:31:44 INFO - PROCESS | 5272 | RSS: Main: 218554368 22:31:44 INFO - PROCESS | 5272 | 22:31:46 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:31:47 INFO - PROCESS | 5272 | RSS: Main: 227938304 22:31:47 INFO - PROCESS | 5272 | 22:31:50 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:31:51 INFO - PROCESS | 5272 | RSS: Main: 236339200 22:31:51 INFO - PROCESS | 5272 | 22:31:54 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:31:54 INFO - PROCESS | 5272 | RSS: Main: 232271872 22:31:54 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54553/tests/kraken/driver.html?testName=ai-astar) 22:31:56 INFO - PROCESS | 5272 | RSS: Main: 283668480 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | __start_tp_report 22:31:56 INFO - PROCESS | 5272 | _x_x_mozilla_page_load 22:31:56 INFO - PROCESS | 5272 | _x_x_mozilla_page_load_details 22:31:56 INFO - PROCESS | 5272 | |i|pagename|runs| 22:31:56 INFO - PROCESS | 5272 | |0;ai-astar;111;117;116;115;115;116;114;116;116;114 22:31:56 INFO - PROCESS | 5272 | |1;audio-beat-detection;152;125;124;169;133;126;128;129;157;131 22:31:56 INFO - PROCESS | 5272 | |2;audio-dft;161;162;161;162;163;162;162;160;161;162 22:31:56 INFO - PROCESS | 5272 | |3;audio-fft;77;76;76;103;77;79;77;77;102;75 22:31:56 INFO - PROCESS | 5272 | |4;audio-oscillator;85;84;121;85;83;84;105;84;83;116 22:31:56 INFO - PROCESS | 5272 | |5;imaging-gaussian-blur;118;118;118;118;117;117;118;118;118;118 22:31:56 INFO - PROCESS | 5272 | |6;imaging-darkroom;146;147;146;146;145;146;146;145;146;146 22:31:56 INFO - PROCESS | 5272 | |7;imaging-desaturate;95;95;95;95;94;94;95;94;95;95 22:31:56 INFO - PROCESS | 5272 | |8;json-parse-financial;72;63;64;63;65;66;66;64;64;64 22:31:56 INFO - PROCESS | 5272 | |9;json-stringify-tinderbox;66;66;66;66;67;65;66;67;66;66 22:31:56 INFO - PROCESS | 5272 | |10;stanford-crypto-aes;82;82;84;83;82;82;82;89;85;83 22:31:56 INFO - PROCESS | 5272 | |11;stanford-crypto-ccm;140;146;144;136;135;136;140;139;178;137 22:31:56 INFO - PROCESS | 5272 | |12;stanford-crypto-pbkdf2;178;176;181;181;178;174;171;179;176;172 22:31:56 INFO - PROCESS | 5272 | |13;stanford-crypto-sha256-iterative;69;68;78;70;71;71;69;72;71;69 22:31:56 INFO - PROCESS | 5272 | __end_tp_report 22:31:56 INFO - PROCESS | 5272 | __start_cc_report 22:31:56 INFO - PROCESS | 5272 | _x_x_mozilla_cycle_collect,1951 22:31:56 INFO - PROCESS | 5272 | __end_cc_report 22:31:56 INFO - PROCESS | 5272 | __startTimestamp1475731916795__endTimestamp 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | ------- Summary: start ------- 22:31:56 INFO - PROCESS | 5272 | Number of tests: 14 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:1.70 (1.5%) stddev-sans-first:1.01 22:31:56 INFO - PROCESS | 5272 | Values: 111.0 117.0 116.0 115.0 115.0 116.0 114.0 116.0 116.0 114.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:132.00 stddev:15.91 (12.1%) stddev-sans-first:15.97 22:31:56 INFO - PROCESS | 5272 | Values: 152.0 125.0 124.0 169.0 133.0 126.0 128.0 129.0 157.0 131.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 22:31:56 INFO - PROCESS | 5272 | Values: 161.0 162.0 161.0 162.0 163.0 162.0 162.0 160.0 161.0 162.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:10.91 (14.2%) stddev-sans-first:11.42 22:31:56 INFO - PROCESS | 5272 | Values: 77.0 76.0 76.0 103.0 77.0 79.0 77.0 77.0 102.0 75.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:84.00 stddev:15.01 (17.9%) stddev-sans-first:15.64 22:31:56 INFO - PROCESS | 5272 | Values: 85.0 84.0 121.0 85.0 83.0 84.0 105.0 84.0 83.0 116.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:31:56 INFO - PROCESS | 5272 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:31:56 INFO - PROCESS | 5272 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:31:56 INFO - PROCESS | 5272 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.50 stddev:2.64 (4.1%) stddev-sans-first:1.12 22:31:56 INFO - PROCESS | 5272 | Values: 72.0 63.0 64.0 63.0 65.0 66.0 66.0 64.0 64.0 64.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:31:56 INFO - PROCESS | 5272 | Values: 66.0 66.0 66.0 66.0 67.0 65.0 66.0 67.0 66.0 66.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.22 (2.7%) stddev-sans-first:2.30 22:31:56 INFO - PROCESS | 5272 | Values: 82.0 82.0 84.0 83.0 82.0 82.0 82.0 89.0 85.0 83.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:140.00 stddev:12.77 (9.1%) stddev-sans-first:13.49 22:31:56 INFO - PROCESS | 5272 | Values: 140.0 146.0 144.0 136.0 135.0 136.0 140.0 139.0 178.0 137.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:178.00 stddev:3.47 (1.9%) stddev-sans-first:3.64 22:31:56 INFO - PROCESS | 5272 | Values: 178.0 176.0 181.0 181.0 178.0 174.0 171.0 179.0 176.0 172.0 22:31:56 INFO - PROCESS | 5272 | 22:31:56 INFO - PROCESS | 5272 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:2.82 (4.0%) stddev-sans-first:2.92 22:31:56 INFO - PROCESS | 5272 | Values: 69.0 68.0 78.0 70.0 71.0 71.0 69.0 72.0 71.0 69.0 22:31:56 INFO - PROCESS | 5272 | -------- Summary: end -------- 22:31:56 INFO - PROCESS | 5272 | 22:31:58 INFO - TEST-INFO | 5272: exit 0 22:31:58 INFO - TEST-OK | kraken | took 64844ms 22:31:58 INFO - SUITE-END | took 1186s 22:31:58 INFO - Completed test suite (00:19:46) 22:31:58 INFO - javascript benchmark 22:31:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.0699544666195, 2558.9360265993346, 2567.4351642638635, 2594.857282849444, 2610.699769526504, 4569.086182763444, 4602.631789456844, 4624.8150073997, 4625.491195968445, 4629.62962962963, 4670.252759558472, 4676.415448068991, 4685.578297953183, 4700.55344742249, 4702.24764037754, 4266.573342665732, 4292.570742925698, 4304.698671093025, 4319.37369081483, 4380.08018316154, 4177.248095342837, 4264.957350426503, 4315.913681726363, 4369.410129632507, 4374.147041326943, 4372.2785740352965, 4381.715188512752, 4410.867673969786, 4431.224535706255, 4432.689711720181, 312.7743986463531, 4349.8375775424165, 4378.16814805186, 4378.562143785628, 4412.75729834859, 3702.500162478058, 4228.1966426378885, 4271.231178387889, 4277.337012763027, 4315.093830295642, 4635.721856688576, 4641.071785642851, 4643.442786865564, 4654.069186162781, 4708.434987801452, 5001.17480615698, 5010.096163457899, 5019.723915184663, 5064.11378008847, 5097.974510127426, 4841.661083724141, 4927.679700819435, 4948.925766113512, 5000.249962505617, 5025.296458495814, 4724.527547245248, 4734.834280800155, 4735.100330937111, 4751.429828420577, 4797.136515427256, 5174.404943431478, 5175.275461435402, 5175.327207463006, 5183.818566350235, 5239.345081864691, 4736.0, 4815.133276010281, 4836.709797412166, 4960.70235785854, 5028.572571331405, 4935.827246046371, 4956.0, 4957.330760347307, 5012.724300163453, 5018.447970723218, 4871.683340582851, 4875.658703890694, 4900.681455705368, 4917.803287868517, 4939.580135688435, 4800.783964721596, 4831.73425461603, 4870.853874383774, 4872.585830204473, 4931.235658472942, 4145.66834653227, 4199.643030342455, 4212.473440819897, 4218.388333691598, 4285.142971405669, 3755.7183211259266, 3760.2479504099288, 3760.6239376062176, 3799.031247031989, 3804.7336686431686, 4382.07976324969, 4392.648588112943, 4394.1651086293505, 4415.889602759957, 4433.069055498317, 4855.635827312965, 4956.727379994135, 4977.203647416396, 5019.824306149268, 5100.51545103222, 4329.545397733255, 4330.437043184366, 4384.912301753947, 4386.539413361615, 4408.448943882015, 4528.049109686936, 4528.343390208402, 4532.478764942008, 4534.79593418297, 4586.403767510203, 4522.660800440046, 4566.520515345841, 4675.667434781071, 4701.247800351859, 4704.176769065469, 5022.924656130234, 5086.7710953007945, 5108.3103780989095, 5120.18077107661, 5120.820771273136, 4724.149653062482, 4725.338452616567, 4732.337472753886, 4736.0, 4793.856184314476, 4974.129527332775, 4983.725895075806, 4989.575886049726, 4993.950060499494, 5053.166227572557, 4878.463369029475, 4935.679180853233, 4954.702717836942, 4980.153373926513, 4995.975020124876, 4886.682365646222, 4888.804447822047, 4890.070886531547, 4932.383452068491, 4942.703437793743, 4889.731064791471, 4894.314795928502, 4895.7062576245535, 4896.094222568836, 4954.826581069645, 4682.92975605373, 4769.30845027476, 4770.761461926821, 4778.665493415567, 4791.9281210782565, 4921.6062714982, 4927.753612319298, 4942.0, 5001.449840517467, 5020.899582008266, 4670.9766451167525, 4717.528247175255, 4718.386609740712, 4812.975935120302, 4894.804207831647], "value": 4565.418824406254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.4059696721478, 561.4217356123193, 570.7317560746449, 578.0375674501954, 581.4156772443695, 27609.0, 38330.42504362437, 39826.99999999996, 40094.19811603766, 43457.348139777925, 38725.806370968174, 39102.60897391025, 39128.413073803844, 39132.41301380481, 39169.41245881307, 7009.12385951756, 7616.162222155558, 7763.22367763222, 7767.262110099531, 7773.028371453568, 7026.156861176666, 9643.180329671952, 9857.95071024644, 9879.16027137694, 10236.84644730326, 10047.447390393525, 10136.13842823361, 10136.847947280796, 10140.23948203884, 10153.441560714158, 9891.0, 9946.602135914554, 9958.701238962843, 9962.651307204213, 9967.152792012688, 9851.50742462874, 9930.751731206705, 9932.801343973153, 9936.105750482418, 9939.55272012761, 37067.0, 37343.0, 37373.06567335811, 37417.43873841895, 37454.43818342727, 2836.234216761463, 2976.925576860574, 2984.4627966965936, 3102.7362674172723, 3228.596425446819, 27866.442671146462, 28412.573811392846, 28812.85593572019, 28833.135005949855, 28907.855460722563, 3470.9479357809655, 3515.6484351564895, 3541.5041894134843, 3656.0, 3810.8094595270127, 204176.0, 206934.0, 208374.0, 258254.0, 258989.0, 55435.722821385636, 56115.87768244694, 56217.0, 56253.71873140608, 56265.0, 33458.49812252818, 34460.13849653779, 34583.13542161466, 36323.27353452916, 36391.63608363883, 14074.577762667137, 14267.286635668175, 14290.857091429161, 14291.356888940023, 14297.714045719027, 9600.807983840425, 9626.614935402506, 9920.851187232198, 9980.401175929468, 10001.899981000242, 16303.673926521404, 16479.505614831574, 16561.585960351087, 18068.63862722738, 18635.0, 7119.0, 7228.891566626505, 7337.816554586178, 7377.151627562792, 7427.85144297111, 790.6876783670418, 905.8097799462055, 942.0061834764252, 986.2110311750571, 992.3549692699803, 27102.457950841268, 27606.0, 27694.0, 28055.158345249674, 28158.15525534237, 927.0636656976502, 945.111595100617, 953.3707752883203, 962.9541204090655, 987.4667679453158, 13750.724985500434, 14927.776083358758, 14942.25288735559, 14956.51653269873, 15061.246937653073, 372275.0, 376920.0, 377642.0, 377802.0, 378233.0, 46862.0, 47158.292625610644, 47258.14756860236, 47297.0, 47337.05325893532, 1117.4301106435776, 1147.472162805119, 1160.1704781081398, 1165.3532289579364, 1184.9407529623484, 25084.372890677878, 26432.0, 26688.0, 27384.58923116115, 27507.58738618882, 40617.1876562473, 40982.38526422166, 40986.590134098275, 41034.794826026875, 41072.38391424191, 314180.0, 315392.0, 316608.0, 317493.0, 318435.0, 22118.889405553513, 22838.42903927415, 24502.26493205207, 25496.362590935376, 25850.482990340464, 37319.44020839744, 40017.0, 40578.79710601546, 40672.0, 41338.79330603328, 34071.82964085164, 34110.65889341075, 34505.309893802485, 34578.48132277968, 35061.12347191341, 33564.32871342608, 33914.32171356608, 34291.65708342884, 35109.0, 35220.47169292411, 33663.83168084144, 34015.14962125967, 34174.82912585421, 34195.0, 34414.82792586021, 26932.0, 26959.46081078407, 30558.388832222787, 30707.2323191922, 31104.688953111083, 23503.647445288676, 24279.51440971206, 24301.878490607432, 24353.43211974298, 24922.626160607244], "value": 17318.76582751774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2696472231926, 364.74285628631816, 365.6562830938917, 372.1682040639169, 385.07965961352375, 15244.466443674473, 16568.502944911656, 17255.91372043141, 17337.566560835985, 17352.0, 16290.83709162908, 16594.253258603363, 16634.168291585403, 16934.23795929183, 17048.659026819456, 4800.447948485925, 5046.848594542152, 5050.974745126269, 5051.696898186121, 5051.848444546669, 3584.946225806615, 3777.7544459610176, 4989.675671081368, 5080.288759573663, 5586.13414920688, 5798.449147330997, 5939.1388248703915, 5942.1680964664765, 5948.494377977855, 5952.4047595240345, 5620.185073164389, 5902.144189092601, 5915.497182739472, 5928.555358348098, 5932.584719069645, 5213.165893457029, 5217.58259339252, 5220.29526013987, 5223.373195216598, 5224.738763061831, 19941.80058199414, 20702.275420360365, 20709.792902070938, 20820.687689684666, 20977.21693656041, 1924.393815947986, 2027.9860069965018, 2029.4926268432891, 2038.8878611676353, 2151.752548456932, 12304.0, 13027.674308142277, 13063.99453881379, 13698.109622874581, 13744.931275343559, 1678.3622223555094, 1752.3603884582035, 1788.0791392432777, 1803.0712744052223, 1822.2164469278337, 67973.66013169903, 68907.0, 70988.29011709869, 71146.0, 72927.0, 8054.751513515414, 8502.44734092282, 8845.380823342304, 8850.867236991451, 9723.15935205604, 11793.056555475541, 11804.46879890407, 11828.408579570987, 11832.230904991147, 11842.585509507126, 6285.465735412541, 6386.8722625547225, 6487.318831522716, 6666.200055993312, 6703.463722902156, 6085.817425477243, 6087.908681369783, 6236.126942228092, 6378.904316435257, 6423.710933008026, 3538.9469157962653, 3616.294822509638, 3628.7822730636244, 3727.459518369821, 3791.545014598266, 1548.3651702801797, 1638.2218446237941, 1811.5471132216946, 1845.1327875898307, 1860.8604354673453, 786.2609147401539, 793.2741541489472, 834.1908348901555, 860.8450478913855, 892.4422236102436, 16207.918960405123, 16340.264688088826, 16574.64084946908, 17211.56971075708, 17537.123143842757, 851.246646717647, 852.2968550945495, 862.642003568512, 868.8045189832237, 932.98475293366, 9240.907590924138, 9818.852717209247, 9822.116009559031, 9842.0, 10021.148202402877, 359794.0, 362970.0, 364227.0, 370406.0, 371822.0, 77340.0, 79446.0, 79861.60069199617, 79908.60045699734, 80667.0, 865.233350812796, 883.4610887358706, 901.3510272603714, 907.2016625369632, 910.776859669372, 11707.941460292644, 14090.647733806736, 14575.927120364331, 15518.84481155174, 15801.36794528252, 35757.46363804493, 36475.0, 36544.26911461809, 36605.450918235714, 37246.813765930994, 46758.53241467542, 46911.53088469208, 47622.76188619035, 47694.28458573055, 48518.75740621416, 7219.061522002106, 7344.596047217455, 7352.70589176427, 7596.506227095221, 8181.836363272821, 10407.739806504898, 11692.883071169179, 11715.824262635897, 11877.287362758263, 12098.939505302416, 9865.457399843077, 10217.1826253901, 10248.948755256177, 10362.119219866396, 10737.087347575543, 10217.23370747182, 10302.742431439274, 10311.175105991653, 10464.162866970777, 10663.200259980378, 10287.53706083213, 10427.232402306774, 10563.366198028143, 10694.732631683959, 11094.944525277322, 7355.852882942204, 7360.595167265852, 7403.481756277009, 7530.585817780075, 7587.430942679211, 9625.903740962782, 10359.171266298526, 10399.740006499898, 10577.841332379867, 11057.06014988735], "value": 8083.638028723089, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.9092863499552, 1362.7410791949528, 1403.4877269796527, 1675.849173574378, 1700.1499250374814, 6797.150356205474, 7040.47196460265, 7268.3095105964985, 7873.724419645314, 7874.645640946157, 7241.275872412756, 7489.9625501872415, 7493.812654683636, 7774.766756997285, 7781.68873245071, 2091.989540052305, 2122.5224324526935, 2123.6920646506323, 2125.51113243954, 2127.6702111172795, 1771.3977247735768, 1842.6498965196636, 2033.9389818305401, 2077.5117847305946, 2093.549886774343, 2019.989900050505, 2101.422108920044, 2105.1789801977243, 2114.6510825713817, 2116.7354080739906, 1924.4996300961782, 1932.5168707823045, 1936.1384184038038, 1993.9302124425722, 2054.7226124473154, 2073.9377818665466, 2074.95850082999, 2076.09689784944, 2082.822960048398, 2088.6866969954476, 7841.059072911287, 7872.685092596289, 7890.605469726548, 7891.171427000198, 7893.329067029309, 4384.758838263894, 4479.081788233437, 4552.658550608718, 4552.817887284505, 4553.77231138445, 2723.087765598527, 2764.1983824690815, 2884.1059271625863, 2895.898643547466, 2899.60855284536, 891.6923661336829, 897.6274845938927, 905.6649039855296, 910.1490106750209, 920.7237828651445, 10565.260431769779, 10589.15286777056, 10602.469876506144, 10606.363618182933, 10607.469626518721, 3707.14735610811, 3887.591802860659, 4053.047533829548, 4063.3701776224734, 4085.632293093636, 8982.955085224532, 8989.55052247398, 8996.730098097067, 8999.910000899907, 9005.324600654978, 4572.359869618256, 4574.268117101248, 4577.61090307321, 4579.977100114545, 4580.931286030712, 4109.0549173690215, 4172.332426811696, 4193.056562273525, 4195.685323600742, 4199.181159673895, 3514.5958214805623, 3547.1309529165005, 3631.291898079849, 3648.288583726201, 3670.33933891902, 1057.582255009267, 1103.4372470040337, 1170.5259369955181, 1183.1303991566192, 1208.4320369426355, 645.7578408096964, 703.6481759120439, 718.9209186989427, 734.0933946575974, 823.201305148253, 4766.523347665206, 4776.307435421844, 4876.195427754381, 4905.117078925828, 4987.925181122286, 773.3349319585152, 792.540326610576, 796.4663675337538, 799.1449149410191, 837.2883049407955, 3235.320582677664, 3338.6327503974544, 3358.5633867597057, 3375.915602109918, 3379.831008449568, 9315.813683726423, 9728.610855565697, 9735.756606084762, 9743.025697430201, 9743.9025609743, 9669.419834809934, 9689.0, 9710.611575537041, 9715.854262186072, 9722.465264410524, 7087.92912070883, 7252.093488313961, 7269.127704675473, 7281.781546553612, 7385.81535461607, 4690.085433340466, 4801.399825021872, 4816.903661926812, 4910.410750709938, 5082.237664350229, 8589.184027517376, 8660.740177794676, 8711.869321960303, 8744.737657870273, 8748.737537873874, 8853.867191991996, 8881.689140880038, 8930.285577153682, 8934.106589341274, 8990.415622984485, 6285.560010799383, 6356.841078973062, 6390.360963903572, 6403.455706265019, 6460.3862633049785, 7204.135503739585, 7326.560406375635, 7335.193128755939, 7362.815929601803, 7363.374113200438, 6513.576617519846, 6585.176852893388, 6649.667516624053, 6752.223494298219, 6952.895706564506, 6477.805665830033, 6595.8021259362295, 6621.0, 6727.663616819042, 6745.258021617717, 5991.101334799815, 6131.110988906495, 6141.15765270426, 6141.324454309933, 6148.569600127948, 4306.655467562525, 4384.145091707086, 4443.178012067778, 4447.377367168534, 4484.8430304940475, 4430.955690443183, 4448.555144485655, 4449.310356894686, 4481.789916722401, 4516.774161291988], "value": 4002.12973235039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.4881092007086, 283.72903876797653, 288.6406424002118, 290.9781766367523, 292.3991198087928, 4938.407391113067, 4939.913219091803, 4955.925661115086, 4974.751262436873, 4979.128652485814, 4860.274602516109, 4868.4401293851215, 4871.732054736988, 4874.512548745124, 4897.657163998521, 3831.3486707259694, 3833.7891415972113, 3840.788756618385, 3842.8270727817317, 3859.517560304962, 3847.442120892469, 3850.7304488685804, 3851.094992676719, 3855.8264878080554, 3857.787821669807, 3509.3332266869343, 3737.009692431508, 3748.2316125194407, 3778.622137786213, 3786.2048969716393, 3721.237146385012, 3721.832517536717, 3736.5329333833133, 3744.569374521938, 3744.794036328001, 3058.287359078923, 3135.717785399325, 3284.5894263217097, 3286.819224942627, 3290.6215785184772, 4650.86047418578, 4780.772978239709, 4783.665143439961, 4785.641076919245, 4790.0, 4261.254280500931, 4261.637760790337, 4263.104748002892, 4263.189993901149, 4264.317709166549, 4724.433068031858, 4794.5924596408995, 5132.486751324875, 5136.280920671109, 5138.073222541547, 3505.91235219119, 3523.5243242162237, 3530.135116896351, 3530.3645343838098, 3544.4506101554302, 5279.577633789288, 5314.282571852789, 5350.197470379435, 5357.4106848246665, 5357.491038351351, 3597.1546686528645, 3604.6575575320303, 3610.6389361063684, 3621.420572708354, 3624.474451204613, 3473.044912648991, 3658.4329428938026, 3667.4865518827387, 3703.277860817169, 3709.350863598859, 4216.156768646283, 4223.21870453967, 4226.366045093199, 4247.97876010618, 4249.68127390447, 5115.258287548285, 5126.231065340155, 5129.410117836496, 5147.356580427447, 5148.176291793295, 1221.4442428694922, 1262.9179103358435, 1281.1608396500308, 1282.2370689439767, 1293.6869077885954, 789.9769798111345, 809.1382677448498, 824.5217773691245, 824.6866190847439, 826.4917075998218, 4043.353063509824, 4046.9595304046584, 4052.1576715824895, 4065.6340929316502, 4070.531888832763, 4638.657477973669, 4657.4876763555985, 4657.650676199299, 4664.55686709762, 4671.04243630055, 4032.9798351008058, 4038.374052021941, 4054.8378064877666, 4054.918901621951, 4070.185962807391, 2382.332946774906, 2479.776820086201, 2488.2783992642294, 2488.626705994079, 2490.8007359411204, 4356.194104090753, 4356.803943822536, 4721.748736584807, 4825.324454576362, 4881.243407271879, 5406.216098665672, 5407.756650950638, 5410.3507579090765, 5416.539594134542, 5423.322084739408, 4948.331975183304, 4951.702897826142, 4953.67801092935, 4958.628102892298, 4961.454240033666, 5057.533315338511, 5230.529252367305, 5270.604704647243, 5270.631055826056, 5303.814366497154, 5158.277841102174, 5180.792768289377, 5188.455212202664, 5189.922151167811, 5192.350956130484, 4920.950790492049, 4924.8768780780765, 4937.654364194472, 4943.431505376928, 4949.950500494949, 3587.4260118380935, 3685.207680348738, 3688.2992231475932, 3690.9446358305186, 3695.1870588470492, 5301.1783173608155, 5311.309529761261, 5311.973440132774, 5347.411784703757, 5349.545288650353, 5156.802782275014, 5171.844844654666, 5177.456367081402, 5184.714840683799, 5211.244369566468, 4878.902421951612, 5089.26205700164, 5117.385913690232, 5145.948540514697, 5149.588032957429, 5038.0, 5038.798448062036, 5049.671771334852, 5058.9494105058475, 5086.796528138833, 4997.425296090851, 5124.615653826053, 5136.460671629425, 5136.486351364833, 5203.973980130075, 5003.348894864759, 5004.197649316395, 5005.899882002267, 5023.648344615842, 5032.647714659939], "value": 3765.7621368404675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.9231346081739, 630.2877748144596, 657.7073202424923, 696.6621188723468, 741.3809469093309, 12161.27032378058, 12894.80657790134, 12995.155314904549, 13099.607011789638, 13122.278274694889, 12923.0, 12964.0, 12997.220166789999, 13059.869401305985, 13063.0, 608.6044071353612, 620.9782657606985, 735.5366119344832, 737.6827963975488, 758.4880205861049, 750.8348163404042, 768.3891306411416, 768.5849641193748, 768.8654485465021, 769.3921801776589, 806.6571707024491, 807.019471342319, 809.0130041349573, 812.7846120777998, 813.4712436915993, 642.5181114164377, 654.8166513376215, 757.9658915348823, 804.4087595617187, 808.3977436809556, 577.8006587727227, 578.129914478711, 582.7698059266565, 583.0496291045611, 583.5098517245534, 13334.733305333935, 13358.265295408748, 13384.996125290545, 13393.263370514618, 13393.933030334883, 12415.44130514129, 12530.81203781944, 12761.170523915916, 12999.0, 13429.798553021712, 10999.725006874813, 11046.226764126515, 11395.145364097725, 11471.827922581084, 11676.0, 3998.1803730235233, 4036.576159503239, 4120.876373708794, 4124.628783409477, 4147.937780933258, 59833.700831496, 59944.400555994755, 59950.10074848881, 60312.39687603112, 60340.0, 9814.607415703435, 9918.900810991798, 10257.538410771533, 10457.215708821717, 10568.947155264175, 18270.0, 18279.54301142482, 18364.63270734578, 18421.447356579323, 18441.53896152607, 5920.437558431942, 6196.628202307786, 6356.364363563699, 6456.225252969673, 6620.271770105381, 3512.877049303262, 3558.288342331544, 3582.5342705448124, 3593.3352329819068, 3595.460680897886, 2640.2343320436858, 2753.2153336299057, 2762.9915080995293, 2771.7366850149206, 2780.0, 472.6478773313834, 479.78409715628106, 487.86095962651183, 490.6663468841222, 495.86115887551546, 533.2614329154072, 562.1399259133451, 571.4913726783167, 577.2178697864417, 639.0701529274894, 8752.387332886765, 8809.42738721981, 8845.0, 9133.269338452908, 9486.0, 491.8549028036738, 529.75631209644, 550.6310771782915, 569.6126633888913, 581.6713556840372, 3749.043993781568, 3993.4209539617173, 4053.6554392876346, 4104.384342348671, 4247.957520424818, 88121.86598541122, 95280.0, 100349.0, 102657.0, 104018.47990759998, 48711.75644121828, 87504.56247718721, 92502.0749792507, 93126.0, 93318.53340733254, 57115.42884571101, 76962.0, 78488.0, 78955.0, 80230.19769802345, 7937.32532734724, 8043.652992656244, 8088.433809633269, 8524.27543658796, 8591.269742071743, 40276.194476109726, 41425.585744142176, 42358.78820605877, 43157.56842431535, 43573.346399804665, 56968.43031569797, 63897.0, 66358.66820665865, 68611.31388686049, 69858.30141698518, 10580.36517808934, 10616.0, 10756.408397537898, 10810.756782960416, 11486.0, 12434.316112613893, 12612.684682883002, 12785.36073196355, 12972.610821675366, 13181.736365272449, 12102.46157690866, 12288.385580721108, 12308.753824923631, 12656.493740250287, 13042.0, 11738.119641026786, 11792.469338879599, 12240.877591223974, 12679.366031698562, 12710.809337860124, 11627.302361858316, 11917.0, 12185.478073328668, 12498.625041248777, 12517.186382885084, 9838.950805245928, 10150.223710850423, 10292.897071029493, 10785.838212426663, 10828.24202305831, 9429.58556216573, 9928.652497162564, 10145.28982971185, 10715.410652414192, 10795.98887338023], "value": 6544.426137648033, "unit": "score"}], "name": "dromaeo_css", "value": 6308.777147913073, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 116.0, 115.0, 115.0, 116.0, 114.0, 116.0, 116.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 124.0, 169.0, 133.0, 126.0, 128.0, 129.0, 157.0, 131.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 160.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 103.0, 77.0, 79.0, 77.0, 77.0, 102.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 85.0, 83.0, 84.0, 105.0, 84.0, 83.0, 116.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 64.0, 63.0, 65.0, 66.0, 66.0, 64.0, 64.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 67.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 84.0, 83.0, 82.0, 82.0, 82.0, 89.0, 85.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 146.0, 144.0, 136.0, 135.0, 136.0, 140.0, 139.0, 178.0, 137.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 181.0, 181.0, 178.0, 174.0, 171.0, 179.0, 176.0, 172.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 78.0, 70.0, 71.0, 71.0, 69.0, 72.0, 71.0, 69.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1552.3999999999999, "alertThreshold": 2.0}]} 22:31:58 INFO - Return code: 0 22:31:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:31:58 INFO - # TBPL SUCCESS # 22:31:58 INFO - Running post-action listener: _resource_record_post_action 22:31:58 INFO - [mozharness: 2016-10-06 05:31:58.592654Z] Finished run-tests step (success) 22:31:58 INFO - Running post-run listener: _resource_record_post_run 22:31:58 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 204800; Write bytes: 393105408; Read time: 188; Write time: 309084 22:31:58 INFO - TinderboxPrint: CPU usage
13.1% 22:31:58 INFO - TinderboxPrint: I/O read bytes / time
204,800 / 188 22:31:58 INFO - TinderboxPrint: I/O write bytes / time
393,105,408 / 309,084 22:31:58 INFO - TinderboxPrint: CPU idle
8,337.1 (86.9%) 22:31:58 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 22:31:58 INFO - TinderboxPrint: Swap in / out
0 / 0 22:31:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99160064; Read time: 0; Write time: 69064 22:31:58 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 200704; Write bytes: 293945344; Read time: 176; Write time: 240020 22:31:59 INFO - Running post-run listener: _upload_blobber_files 22:31:59 INFO - Blob upload gear active. 22:31:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:31:59 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 22:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:31:59 INFO - (blobuploader) - INFO - Open directory for files ... 22:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:02 INFO - (blobuploader) - INFO - Done attempting. 22:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:03 INFO - (blobuploader) - INFO - Done attempting. 22:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:04 INFO - (blobuploader) - INFO - Done attempting. 22:32:04 INFO - (blobuploader) - INFO - Iteration through files over. 22:32:04 INFO - Return code: 0 22:32:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:32:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:32:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37978237dd8553dcee5375c57130e3cedd3887572418c5d2e0f91c02437bff8c7a4d04d5a8f35eeb8a38d9824cbd7be7baa6532fe8025c20905635f2adf2c472", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c65950e48cc0c0fd1253677837166d4c9ba03b642d3cf9379a6f61814b206014b564c0bbed0e187d526a2814f718b71b8265d472088785e43800247225821b29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3c0f66d34f91ad2d0583306ec1d6885803e1ddc631ce1784a781c88225fe780a1000c3581183648bdcb209940edb1fbac792e9f464d6ca5ff0d846910fbfd09"} 22:32:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:32:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:32:04 INFO - Contents: 22:32:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37978237dd8553dcee5375c57130e3cedd3887572418c5d2e0f91c02437bff8c7a4d04d5a8f35eeb8a38d9824cbd7be7baa6532fe8025c20905635f2adf2c472", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c65950e48cc0c0fd1253677837166d4c9ba03b642d3cf9379a6f61814b206014b564c0bbed0e187d526a2814f718b71b8265d472088785e43800247225821b29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3c0f66d34f91ad2d0583306ec1d6885803e1ddc631ce1784a781c88225fe780a1000c3581183648bdcb209940edb1fbac792e9f464d6ca5ff0d846910fbfd09"} 22:32:04 INFO - Running post-run listener: copy_logs_to_upload_dir 22:32:04 INFO - Copying logs to upload dir... 22:32:04 INFO - mkdir: /builds/slave/test/build/upload/logs 22:32:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.478150 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-05 22:32:04.276376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 22:32:04.280041) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37978237dd8553dcee5375c57130e3cedd3887572418c5d2e0f91c02437bff8c7a4d04d5a8f35eeb8a38d9824cbd7be7baa6532fe8025c20905635f2adf2c472", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c65950e48cc0c0fd1253677837166d4c9ba03b642d3cf9379a6f61814b206014b564c0bbed0e187d526a2814f718b71b8265d472088785e43800247225821b29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3c0f66d34f91ad2d0583306ec1d6885803e1ddc631ce1784a781c88225fe780a1000c3581183648bdcb209940edb1fbac792e9f464d6ca5ff0d846910fbfd09"} build_url:https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/Q--ufmiWQM2QEzMYDPRskQ/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/Firefox-Non-PGO/sha512/37978237dd8553dcee5375c57130e3cedd3887572418c5d2e0f91c02437bff8c7a4d04d5a8f35eeb8a38d9824cbd7be7baa6532fe8025c20905635f2adf2c472", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c65950e48cc0c0fd1253677837166d4c9ba03b642d3cf9379a6f61814b206014b564c0bbed0e187d526a2814f718b71b8265d472088785e43800247225821b29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3c0f66d34f91ad2d0583306ec1d6885803e1ddc631ce1784a781c88225fe780a1000c3581183648bdcb209940edb1fbac792e9f464d6ca5ff0d846910fbfd09"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 22:32:04.305188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:32:04.305486) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475708086.202291-1407178780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:32:04.390376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 22:32:04.390692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 22:32:04.390993) ========= ========= Total master_lag: 0.21 =========