builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1477433775.1 results: success (0) buildid: 20161025133924 builduid: 20c65cc1c7174e32992599da32a4b0d0 revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.100248) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.100676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.100980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.116598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.116862) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 15:16:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.6M=0s 2016-10-25 15:16:15 (38.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110471 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.240607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.240934) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:15.291245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 15:16:15.291622) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --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 b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --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=2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 15:16:15,759 truncating revision to first 12 chars 2016-10-25 15:16:15,759 Setting DEBUG logging. 2016-10-25 15:16:15,759 attempt 1/10 2016-10-25 15:16:15,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1b18f25c0ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 15:16:16,341 unpacking tar archive at: mozilla-central-b1b18f25c0ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.444097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 15:16:16.748864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:16.749196) ========= script_repo_revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:16.749632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:16.749904) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 15:16:16.763573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-25 15:16:16.763861) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:16:17 INFO - MultiFileLogger online at 20161025 15:16:17 in /builds/slave/test 15:16:17 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 15:16:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:17 INFO - {'append_to_log': False, 15:16:17 INFO - 'base_work_dir': '/builds/slave/test', 15:16:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:16:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:17 INFO - 'branch': 'Firefox-Non-PGO', 15:16:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:17 INFO - 'config_files': ('talos/linux_config.py',), 15:16:17 INFO - 'default_actions': ('clobber', 15:16:17 INFO - 'read-buildbot-config', 15:16:17 INFO - 'download-and-extract', 15:16:17 INFO - 'populate-webroot', 15:16:17 INFO - 'create-virtualenv', 15:16:17 INFO - 'install', 15:16:17 INFO - 'run-tests'), 15:16:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:17 INFO - 'download_minidump_stackwalk': True, 15:16:17 INFO - 'download_symbols': 'ondemand', 15:16:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:17 INFO - 'installer_path': 'installer.exe', 15:16:17 INFO - 'log_level': 'info', 15:16:17 INFO - 'log_name': 'talos', 15:16:17 INFO - 'log_to_console': True, 15:16:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:16:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:16:17 INFO - 'opt_config_files': (), 15:16:17 INFO - 'pip_index': False, 15:16:17 INFO - 'sps_profile': False, 15:16:17 INFO - 'sps_profile_interval': 0, 15:16:17 INFO - 'suite': 'dromaeojs', 15:16:17 INFO - 'system_bits': '32', 15:16:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:17 INFO - 'title': 'talos-linux64-ix-012', 15:16:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:17 INFO - 'use_talos_json': True, 15:16:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:17 INFO - 'work_dir': 'build'} 15:16:17 INFO - [mozharness: 2016-10-25 22:16:17.334532Z] Running clobber step. 15:16:17 INFO - Running pre-action listener: _resource_record_pre_action 15:16:17 INFO - Running main action method: clobber 15:16:17 INFO - rmtree: /builds/slave/test/build 15:16:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:17 INFO - Running post-action listener: _resource_record_post_action 15:16:17 INFO - [mozharness: 2016-10-25 22:16:17.794204Z] Finished clobber step (success) 15:16:17 INFO - [mozharness: 2016-10-25 22:16:17.794305Z] Running read-buildbot-config step. 15:16:17 INFO - Running pre-action listener: _resource_record_pre_action 15:16:17 INFO - Running main action method: read_buildbot_config 15:16:17 INFO - Using buildbot properties: 15:16:17 INFO - { 15:16:17 INFO - "project": "", 15:16:17 INFO - "product": "firefox", 15:16:17 INFO - "script_repo_revision": "production", 15:16:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:16:17 INFO - "repository": "", 15:16:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:16:17 INFO - "buildid": "20161025133924", 15:16:17 INFO - "pgo_build": "False", 15:16:17 INFO - "basedir": "/builds/slave/test", 15:16:17 INFO - "buildnumber": 694, 15:16:17 INFO - "slavename": "talos-linux64-ix-012", 15:16:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:16:17 INFO - "platform": "ubuntu64_hw", 15:16:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:16:17 INFO - "branch": "mozilla-central", 15:16:17 INFO - "repo_path": "mozilla-central", 15:16:17 INFO - "revision": "b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1", 15:16:17 INFO - "stage_platform": "linux64", 15:16:17 INFO - "builduid": "20c65cc1c7174e32992599da32a4b0d0", 15:16:17 INFO - "slavebuilddir": "test" 15:16:17 INFO - } 15:16:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:16:17 INFO - Running post-action listener: _resource_record_post_action 15:16:17 INFO - [mozharness: 2016-10-25 22:16:17.796834Z] Finished read-buildbot-config step (success) 15:16:17 INFO - [mozharness: 2016-10-25 22:16:17.796924Z] Running download-and-extract step. 15:16:17 INFO - Running pre-action listener: _resource_record_pre_action 15:16:17 INFO - Running main action method: download_and_extract 15:16:17 INFO - mkdir: /builds/slave/test/build/tests 15:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:17 INFO - trying https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:16:17 INFO - Downloading https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/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 15:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/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 15:16:18 INFO - Downloaded 1361 bytes. 15:16:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:16:18 INFO - Using the following test package requirements: 15:16:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:16:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:16:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:16:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'jsshell-linux-x86_64.zip'], 15:16:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:16:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:16:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:16:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:16:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:16:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:16:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:16:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:16:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:16:18 INFO - Fetch https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:16:18 INFO - Http code: 200 15:16:18 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 15:16:18 INFO - x-amz-cf-id: QG8bHmnTRFLrQDOSF-BGe4pjDlpRo_n-b056_LGKDACckBwkhLwEyw== 15:16:18 INFO - x-amz-version-id: qNY3L.ndCy65RYE_ZaTlYZXY7PMbYXo1 15:16:19 INFO - Expected file size: 20467761 15:16:19 INFO - Obtained file size: 20467761 15:16:23 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 15:16:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:16:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:16:23 INFO - Fetch https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:16:23 INFO - Http code: 200 15:16:23 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 15:16:23 INFO - x-amz-cf-id: hxmyIB9Q3w1TFSaDxLAc9nG91-0CbrIvKM0SwBiazPWJKbL-oyryqw== 15:16:23 INFO - x-amz-version-id: qNY3L.ndCy65RYE_ZaTlYZXY7PMbYXo1 15:16:24 INFO - Expected file size: 20467761 15:16:24 INFO - Obtained file size: 20467761 15:16:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:16:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:16:28 INFO - Fetch https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:16:29 INFO - Http code: 200 15:16:29 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 15:16:29 INFO - x-amz-cf-id: FXyarKvVFxxbyDHcIiswiKcamCDDmZIKO2mDO4UOjTItCWDg0LF25g== 15:16:29 INFO - x-amz-version-id: F6x0hYCmNHCmmZGTwQbZAFasttnb8N2M 15:16:29 INFO - Expected file size: 14409028 15:16:29 INFO - Obtained file size: 14409028 15:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:29 INFO - trying https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:29 INFO - Downloading https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/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 15:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/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 15:16:30 INFO - Downloaded 55563794 bytes. 15:16:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:30 INFO - mkdir: /builds/slave/test/properties 15:16:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:16:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:16:30 INFO - Contents: 15:16:30 INFO - build_url:https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:31 INFO - Running post-action listener: _resource_record_post_action 15:16:31 INFO - Running post-action listener: set_extra_try_arguments 15:16:31 INFO - [mozharness: 2016-10-25 22:16:31.413383Z] Finished download-and-extract step (success) 15:16:31 INFO - [mozharness: 2016-10-25 22:16:31.413611Z] Running populate-webroot step. 15:16:31 INFO - Running pre-action listener: _resource_record_pre_action 15:16:31 INFO - Running main action method: populate_webroot 15:16:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:16:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:16:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:16:31 INFO - '--tppagecycles', 15:16:31 INFO - '7'], 15:16:31 INFO - 'tests': ['tsvgm']}}, 15:16:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:16:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:16:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:16:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:16:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['damp', 'tps']}, 15:16:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'tests': ['damp', 'tps']}, 15:16:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['dromaeo_dom']}, 15:16:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:16:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['basic_compositor_video']}, 15:16:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:16:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['a11yr', 15:16:31 INFO - 'ts_paint', 15:16:31 INFO - 'tpaint', 15:16:31 INFO - 'sessionrestore', 15:16:31 INFO - 'sessionrestore_no_auto_restore', 15:16:31 INFO - 'tabpaint']}, 15:16:31 INFO - 'other-e10s': {'tests': ['a11yr', 15:16:31 INFO - 'ts_paint', 15:16:31 INFO - 'tpaint', 15:16:31 INFO - 'sessionrestore', 15:16:31 INFO - 'sessionrestore_no_auto_restore', 15:16:31 INFO - 'tabpaint']}, 15:16:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:16:31 INFO - 'ts_paint', 15:16:31 INFO - 'tpaint', 15:16:31 INFO - 'sessionrestore', 15:16:31 INFO - 'sessionrestore_no_auto_restore', 15:16:31 INFO - 'tabpaint']}, 15:16:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:16:31 INFO - 'ts_paint', 15:16:31 INFO - 'tpaint', 15:16:31 INFO - 'sessionrestore', 15:16:31 INFO - 'sessionrestore_no_auto_restore', 15:16:31 INFO - 'tabpaint']}, 15:16:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['a11yr', 15:16:31 INFO - 'ts_paint', 15:16:31 INFO - 'tpaint', 15:16:31 INFO - 'sessionrestore', 15:16:31 INFO - 'sessionrestore_no_auto_restore', 15:16:31 INFO - 'tabpaint']}, 15:16:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['a11yr', 15:16:31 INFO - 'ts_paint', 15:16:31 INFO - 'tpaint', 15:16:31 INFO - 'sessionrestore', 15:16:31 INFO - 'sessionrestore_no_auto_restore', 15:16:31 INFO - 'tabpaint']}, 15:16:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['tsvgx', 15:16:31 INFO - 'tsvgr_opacity', 15:16:31 INFO - 'tart', 15:16:31 INFO - 'tscrollx', 15:16:31 INFO - 'cart']}, 15:16:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:16:31 INFO - 'tsvgr_opacity', 15:16:31 INFO - 'tart', 15:16:31 INFO - 'tscrollx', 15:16:31 INFO - 'cart']}, 15:16:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'talos_options': ['--disable-e10s'], 15:16:31 INFO - 'tests': ['tp5o']}, 15:16:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'tests': ['tp5o']}, 15:16:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'talos_options': ['--disable-e10s', 15:16:31 INFO - '--xperf_path', 15:16:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:31 INFO - 'tests': ['tp5n']}, 15:16:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:31 INFO - 'talos_options': ['--xperf_path', 15:16:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:31 INFO - 'tests': ['tp5n']}}, 15:16:31 INFO - 'talos.zip': {'path': '', 15:16:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:16:31 INFO - Running post-action listener: _resource_record_post_action 15:16:31 INFO - [mozharness: 2016-10-25 22:16:31.430327Z] Finished populate-webroot step (success) 15:16:31 INFO - [mozharness: 2016-10-25 22:16:31.430416Z] Running create-virtualenv step. 15:16:31 INFO - Running pre-action listener: _resource_record_pre_action 15:16:31 INFO - Running main action method: create_virtualenv 15:16:31 INFO - Creating virtualenv /builds/slave/test/build/venv 15:16:31 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 15:16:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:16:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:16:31 INFO - Using real prefix '/usr' 15:16:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:16:32 INFO - Installing distribute.............................................................................................................................................................................................done. 15:16:33 INFO - Installing pip.................done. 15:16:34 INFO - Return code: 0 15:16:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:16:34 INFO - Reading from file tmpfile_stdout 15:16:34 INFO - Output received: 15:16:34 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) 15:16:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:16:34 INFO - Using env: {'DISPLAY': ':0', 15:16:34 INFO - 'HOME': '/home/cltbld', 15:16:34 INFO - 'LANG': 'en_US.UTF-8', 15:16:34 INFO - 'LANGUAGE': 'en_US:en', 15:16:34 INFO - 'LOGNAME': 'cltbld', 15:16:34 INFO - 'MAIL': '/var/mail/cltbld', 15:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:34 INFO - 'MOZ_NO_REMOTE': '1', 15:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:34 INFO - 'NO_EM_RESTART': '1', 15:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:34 INFO - 'PWD': '/builds/slave/test', 15:16:34 INFO - 'SHELL': '/bin/bash', 15:16:34 INFO - 'SHLVL': '1', 15:16:34 INFO - 'TERM': 'linux', 15:16:34 INFO - 'TMOUT': '86400', 15:16:34 INFO - 'USER': 'cltbld', 15:16:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:34 INFO - '_': '/tools/buildbot/bin/python'} 15:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:34 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 15:16:34 INFO - Cleaning up... 15:16:34 INFO - Return code: 0 15:16:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:16:34 INFO - Using env: {'DISPLAY': ':0', 15:16:34 INFO - 'HOME': '/home/cltbld', 15:16:34 INFO - 'LANG': 'en_US.UTF-8', 15:16:34 INFO - 'LANGUAGE': 'en_US:en', 15:16:34 INFO - 'LOGNAME': 'cltbld', 15:16:34 INFO - 'MAIL': '/var/mail/cltbld', 15:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:34 INFO - 'MOZ_NO_REMOTE': '1', 15:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:34 INFO - 'NO_EM_RESTART': '1', 15:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:34 INFO - 'PWD': '/builds/slave/test', 15:16:34 INFO - 'SHELL': '/bin/bash', 15:16:34 INFO - 'SHLVL': '1', 15:16:34 INFO - 'TERM': 'linux', 15:16:34 INFO - 'TMOUT': '86400', 15:16:34 INFO - 'USER': 'cltbld', 15:16:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:34 INFO - '_': '/tools/buildbot/bin/python'} 15:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:34 INFO - Downloading/unpacking psutil>=3.1.1 15:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:36 INFO - Installing collected packages: psutil 15:16:36 INFO - Running setup.py install for psutil 15:16:36 INFO - building 'psutil._psutil_linux' extension 15:16:36 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 15:16:36 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 15:16:36 INFO - building 'psutil._psutil_posix' extension 15:16:36 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 15:16:37 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 15:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:37 INFO - Successfully installed psutil 15:16:37 INFO - Cleaning up... 15:16:37 INFO - Return code: 0 15:16:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:37 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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:37 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 15:16:37 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 15:16:37 INFO - Using env: {'DISPLAY': ':0', 15:16:37 INFO - 'HOME': '/home/cltbld', 15:16:37 INFO - 'LANG': 'en_US.UTF-8', 15:16:37 INFO - 'LANGUAGE': 'en_US:en', 15:16:37 INFO - 'LOGNAME': 'cltbld', 15:16:37 INFO - 'MAIL': '/var/mail/cltbld', 15:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:37 INFO - 'MOZ_NO_REMOTE': '1', 15:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:37 INFO - 'NO_EM_RESTART': '1', 15:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:37 INFO - 'PWD': '/builds/slave/test', 15:16:37 INFO - 'SHELL': '/bin/bash', 15:16:37 INFO - 'SHLVL': '1', 15:16:37 INFO - 'TERM': 'linux', 15:16:37 INFO - 'TMOUT': '86400', 15:16:37 INFO - 'USER': 'cltbld', 15:16:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:37 INFO - '_': '/tools/buildbot/bin/python'} 15:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:16:37 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 15:16:37 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 15:16:37 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 15:16:37 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 15:16:37 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 15:16:37 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 15:16:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:16:39 INFO - Installing collected packages: mozsystemmonitor 15:16:39 INFO - Running setup.py install for mozsystemmonitor 15:16:39 INFO - Successfully installed mozsystemmonitor 15:16:39 INFO - Cleaning up... 15:16:39 INFO - Return code: 0 15:16:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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', '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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:16: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 jsonschema==2.5.1 15:16:39 INFO - Using env: {'DISPLAY': ':0', 15:16:39 INFO - 'HOME': '/home/cltbld', 15:16:39 INFO - 'LANG': 'en_US.UTF-8', 15:16:39 INFO - 'LANGUAGE': 'en_US:en', 15:16:39 INFO - 'LOGNAME': 'cltbld', 15:16:39 INFO - 'MAIL': '/var/mail/cltbld', 15:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:39 INFO - 'MOZ_NO_REMOTE': '1', 15:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:39 INFO - 'NO_EM_RESTART': '1', 15:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:39 INFO - 'PWD': '/builds/slave/test', 15:16:39 INFO - 'SHELL': '/bin/bash', 15:16:39 INFO - 'SHLVL': '1', 15:16:39 INFO - 'TERM': 'linux', 15:16:39 INFO - 'TMOUT': '86400', 15:16:39 INFO - 'USER': 'cltbld', 15:16:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:39 INFO - '_': '/tools/buildbot/bin/python'} 15:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:39 INFO - Downloading/unpacking jsonschema==2.5.1 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:42 INFO - warning: no files found matching '*.txt' 15:16:42 INFO - no previously-included directories found matching 'build' 15:16:42 INFO - no previously-included directories found matching 'dist' 15:16:42 INFO - no previously-included directories found matching '.git*' 15:16:42 INFO - Installing collected packages: jsonschema, functools32 15:16:42 INFO - Running setup.py install for functools32 15:16:42 INFO - warning: no files found matching '*.txt' 15:16:42 INFO - no previously-included directories found matching 'build' 15:16:42 INFO - no previously-included directories found matching 'dist' 15:16:42 INFO - no previously-included directories found matching '.git*' 15:16:42 INFO - Successfully installed jsonschema functools32 15:16:42 INFO - Cleaning up... 15:16:42 INFO - Return code: 0 15:16:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:42 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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:42 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 15:16:42 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 15:16:42 INFO - Using env: {'DISPLAY': ':0', 15:16:42 INFO - 'HOME': '/home/cltbld', 15:16:42 INFO - 'LANG': 'en_US.UTF-8', 15:16:42 INFO - 'LANGUAGE': 'en_US:en', 15:16:42 INFO - 'LOGNAME': 'cltbld', 15:16:42 INFO - 'MAIL': '/var/mail/cltbld', 15:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:42 INFO - 'MOZ_NO_REMOTE': '1', 15:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:42 INFO - 'NO_EM_RESTART': '1', 15:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:42 INFO - 'PWD': '/builds/slave/test', 15:16:42 INFO - 'SHELL': '/bin/bash', 15:16:42 INFO - 'SHLVL': '1', 15:16:42 INFO - 'TERM': 'linux', 15:16:42 INFO - 'TMOUT': '86400', 15:16:42 INFO - 'USER': 'cltbld', 15:16:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:42 INFO - '_': '/tools/buildbot/bin/python'} 15:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:16:42 INFO - Cleaning up... 15:16:42 INFO - Return code: 0 15:16:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:42 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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:42 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 15:16:42 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 15:16:42 INFO - Using env: {'DISPLAY': ':0', 15:16:42 INFO - 'HOME': '/home/cltbld', 15:16:42 INFO - 'LANG': 'en_US.UTF-8', 15:16:42 INFO - 'LANGUAGE': 'en_US:en', 15:16:42 INFO - 'LOGNAME': 'cltbld', 15:16:42 INFO - 'MAIL': '/var/mail/cltbld', 15:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:42 INFO - 'MOZ_NO_REMOTE': '1', 15:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:42 INFO - 'NO_EM_RESTART': '1', 15:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:42 INFO - 'PWD': '/builds/slave/test', 15:16:42 INFO - 'SHELL': '/bin/bash', 15:16:42 INFO - 'SHLVL': '1', 15:16:42 INFO - 'TERM': 'linux', 15:16:42 INFO - 'TMOUT': '86400', 15:16:42 INFO - 'USER': 'cltbld', 15:16:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:42 INFO - '_': '/tools/buildbot/bin/python'} 15:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16:45 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 15:16:45 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 15:16:45 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 15:16:45 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 15:16:45 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 15:16:45 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 15:16:45 INFO - Downloading docopt-0.6.1.tar.gz 15:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:45 INFO - Running setup.py install for blobuploader 15:16:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:45 INFO - Running setup.py install for requests 15:16:45 INFO - Running setup.py install for docopt 15:16:45 INFO - Successfully installed blobuploader requests docopt 15:16:45 INFO - Cleaning up... 15:16:46 INFO - Return code: 0 15:16:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:46 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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:46 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 15:16:46 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 15:16:46 INFO - Using env: {'DISPLAY': ':0', 15:16:46 INFO - 'HOME': '/home/cltbld', 15:16:46 INFO - 'LANG': 'en_US.UTF-8', 15:16:46 INFO - 'LANGUAGE': 'en_US:en', 15:16:46 INFO - 'LOGNAME': 'cltbld', 15:16:46 INFO - 'MAIL': '/var/mail/cltbld', 15:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:46 INFO - 'MOZ_NO_REMOTE': '1', 15:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:46 INFO - 'NO_EM_RESTART': '1', 15:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:46 INFO - 'PWD': '/builds/slave/test', 15:16:46 INFO - 'SHELL': '/bin/bash', 15:16:46 INFO - 'SHLVL': '1', 15:16:46 INFO - 'TERM': 'linux', 15:16:46 INFO - 'TMOUT': '86400', 15:16:46 INFO - 'USER': 'cltbld', 15:16:46 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:46 INFO - '_': '/tools/buildbot/bin/python'} 15:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:46 INFO - Running setup.py (path:/tmp/pip-QkLGOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:46 INFO - Running setup.py (path:/tmp/pip-5dDNn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:46 INFO - Running setup.py (path:/tmp/pip-H49ZA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:46 INFO - Running setup.py (path:/tmp/pip-fbefeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:46 INFO - Running setup.py (path:/tmp/pip-LP3xMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:46 INFO - Running setup.py (path:/tmp/pip-UQdYLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:46 INFO - Running setup.py (path:/tmp/pip-omvTDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:46 INFO - Running setup.py (path:/tmp/pip-Taqkhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:46 INFO - Running setup.py (path:/tmp/pip-LEFxLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:46 INFO - Running setup.py (path:/tmp/pip-4blzF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:46 INFO - Running setup.py (path:/tmp/pip-wpW5XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:47 INFO - Running setup.py (path:/tmp/pip-dw65M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:47 INFO - Running setup.py (path:/tmp/pip-jI5Gbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:47 INFO - Running setup.py (path:/tmp/pip-bU_l0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:47 INFO - Running setup.py (path:/tmp/pip-VufHx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:47 INFO - Running setup.py (path:/tmp/pip-JTHsdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:47 INFO - Running setup.py (path:/tmp/pip-oRdoDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:47 INFO - Running setup.py install for manifestparser 15:16:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:47 INFO - Running setup.py install for mozcrash 15:16:47 INFO - Running setup.py install for mozdebug 15:16:47 INFO - Running setup.py install for mozdevice 15:16:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:16:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:47 INFO - Running setup.py install for mozfile 15:16:47 INFO - Running setup.py install for mozhttpd 15:16:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Running setup.py install for mozinfo 15:16:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Running setup.py install for mozInstall 15:16:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Running setup.py install for mozleak 15:16:48 INFO - Running setup.py install for mozlog 15:16:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Running setup.py install for moznetwork 15:16:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Running setup.py install for mozprocess 15:16:48 INFO - Running setup.py install for mozprofile 15:16:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Running setup.py install for mozrunner 15:16:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:48 INFO - Running setup.py install for mozscreenshot 15:16:49 INFO - Running setup.py install for moztest 15:16:49 INFO - Running setup.py install for mozversion 15:16:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:49 INFO - Cleaning up... 15:16:49 INFO - Return code: 0 15:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:49 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')]} 15:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:49 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')]} 15:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:49 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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:49 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 15:16:49 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 15:16:49 INFO - Using env: {'DISPLAY': ':0', 15:16:49 INFO - 'HOME': '/home/cltbld', 15:16:49 INFO - 'LANG': 'en_US.UTF-8', 15:16:49 INFO - 'LANGUAGE': 'en_US:en', 15:16:49 INFO - 'LOGNAME': 'cltbld', 15:16:49 INFO - 'MAIL': '/var/mail/cltbld', 15:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:49 INFO - 'MOZ_NO_REMOTE': '1', 15:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:49 INFO - 'NO_EM_RESTART': '1', 15:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:49 INFO - 'PWD': '/builds/slave/test', 15:16:49 INFO - 'SHELL': '/bin/bash', 15:16:49 INFO - 'SHLVL': '1', 15:16:49 INFO - 'TERM': 'linux', 15:16:49 INFO - 'TMOUT': '86400', 15:16:49 INFO - 'USER': 'cltbld', 15:16:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:49 INFO - '_': '/tools/buildbot/bin/python'} 15:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:49 INFO - Running setup.py (path:/tmp/pip-XBR_cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:49 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)) 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:49 INFO - Running setup.py (path:/tmp/pip-k8uTlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:49 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)) 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:49 INFO - Running setup.py (path:/tmp/pip-PXFBKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:49 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)) 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:49 INFO - Running setup.py (path:/tmp/pip-phKfOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:49 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)) 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:49 INFO - Running setup.py (path:/tmp/pip-03mGuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:49 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)) 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:49 INFO - Running setup.py (path:/tmp/pip-fA5s2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:49 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)) 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:49 INFO - Running setup.py (path:/tmp/pip-tiUerN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:49 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)) 15:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:49 INFO - Running setup.py (path:/tmp/pip-m5Jb6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:50 INFO - Running setup.py (path:/tmp/pip-qLQAaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:50 INFO - Running setup.py (path:/tmp/pip-V7E3He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:50 INFO - Running setup.py (path:/tmp/pip-1bov_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:50 INFO - Running setup.py (path:/tmp/pip-8l59vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:50 INFO - Running setup.py (path:/tmp/pip-F0bs27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:50 INFO - Running setup.py (path:/tmp/pip-HCn5yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:50 INFO - Running setup.py (path:/tmp/pip-on1OOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:50 INFO - Running setup.py (path:/tmp/pip-OLinep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:50 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)) 15:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:50 INFO - Running setup.py (path:/tmp/pip-ek82qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:50 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)) 15:16:50 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)) 15:16:50 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)) 15:16:50 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)) 15:16:50 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)) 15:16:50 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)) 15:16:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16:50 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 15:16:50 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 15:16:50 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 15:16:50 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 15:16:50 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 15:16:50 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 15:16:52 INFO - Downloading blessings-1.6.tar.gz 15:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:52 INFO - Installing collected packages: blessings 15:16:52 INFO - Running setup.py install for blessings 15:16:52 INFO - Successfully installed blessings 15:16:52 INFO - Cleaning up... 15:16:52 INFO - Return code: 0 15:16:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:53 INFO - Reading from file tmpfile_stdout 15:16:53 INFO - Current package versions: 15:16:53 INFO - argparse == 1.2.1 15:16:53 INFO - blessings == 1.6 15:16:53 INFO - blobuploader == 1.2.4 15:16:53 INFO - docopt == 0.6.1 15:16:53 INFO - functools32 == 3.2.3-2 15:16:53 INFO - jsonschema == 2.5.1 15:16:53 INFO - manifestparser == 1.1 15:16:53 INFO - mozInstall == 1.12 15:16:53 INFO - mozcrash == 0.17 15:16:53 INFO - mozdebug == 0.1 15:16:53 INFO - mozdevice == 0.48 15:16:53 INFO - mozfile == 1.2 15:16:53 INFO - mozhttpd == 0.7 15:16:53 INFO - mozinfo == 0.9 15:16:53 INFO - mozleak == 0.1 15:16:53 INFO - mozlog == 3.4 15:16:53 INFO - moznetwork == 0.27 15:16:53 INFO - mozprocess == 0.23 15:16:53 INFO - mozprofile == 0.28 15:16:53 INFO - mozrunner == 6.12 15:16:53 INFO - mozscreenshot == 0.1 15:16:53 INFO - mozsystemmonitor == 0.3 15:16:53 INFO - moztest == 0.7 15:16:53 INFO - mozversion == 1.4 15:16:53 INFO - psutil == 3.1.1 15:16:53 INFO - requests == 1.2.3 15:16:53 INFO - wsgiref == 0.1.2 15:16:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:53 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')]} 15:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:53 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')]} 15:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:53 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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:53 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 15:16:53 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 15:16:53 INFO - Using env: {'DISPLAY': ':0', 15:16:53 INFO - 'HOME': '/home/cltbld', 15:16:53 INFO - 'LANG': 'en_US.UTF-8', 15:16:53 INFO - 'LANGUAGE': 'en_US:en', 15:16:53 INFO - 'LOGNAME': 'cltbld', 15:16:53 INFO - 'MAIL': '/var/mail/cltbld', 15:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:53 INFO - 'MOZ_NO_REMOTE': '1', 15:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:53 INFO - 'NO_EM_RESTART': '1', 15:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:53 INFO - 'PWD': '/builds/slave/test', 15:16:53 INFO - 'SHELL': '/bin/bash', 15:16:53 INFO - 'SHLVL': '1', 15:16:53 INFO - 'TERM': 'linux', 15:16:53 INFO - 'TMOUT': '86400', 15:16:53 INFO - 'USER': 'cltbld', 15:16:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:53 INFO - '_': '/tools/buildbot/bin/python'} 15:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 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)) 15:16:53 INFO - Cleaning up... 15:16:53 INFO - Return code: 0 15:16:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16:53 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')]} 15:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:53 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')]} 15:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:53 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 0x7f5eb6a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2321ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', '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 15:16:53 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 15:16:53 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 15:16:53 INFO - Using env: {'DISPLAY': ':0', 15:16:53 INFO - 'HOME': '/home/cltbld', 15:16:53 INFO - 'LANG': 'en_US.UTF-8', 15:16:53 INFO - 'LANGUAGE': 'en_US:en', 15:16:53 INFO - 'LOGNAME': 'cltbld', 15:16:53 INFO - 'MAIL': '/var/mail/cltbld', 15:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:53 INFO - 'MOZ_NO_REMOTE': '1', 15:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:53 INFO - 'NO_EM_RESTART': '1', 15:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:53 INFO - 'PWD': '/builds/slave/test', 15:16:53 INFO - 'SHELL': '/bin/bash', 15:16:53 INFO - 'SHLVL': '1', 15:16:53 INFO - 'TERM': 'linux', 15:16:53 INFO - 'TMOUT': '86400', 15:16:53 INFO - 'USER': 'cltbld', 15:16:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:53 INFO - '_': '/tools/buildbot/bin/python'} 15:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:16:53 INFO - Cleaning up... 15:16:53 INFO - Return code: 0 15:16:53 INFO - Running post-action listener: _resource_record_post_action 15:16:53 INFO - Running post-action listener: _start_resource_monitoring 15:16:53 INFO - Starting resource monitoring. 15:16:53 INFO - [mozharness: 2016-10-25 22:16:53.610568Z] Finished create-virtualenv step (success) 15:16:53 INFO - [mozharness: 2016-10-25 22:16:53.611164Z] Running install step. 15:16:53 INFO - Running pre-action listener: _resource_record_pre_action 15:16:53 INFO - Running main action method: install 15:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:53 INFO - Reading from file tmpfile_stdout 15:16:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:53 INFO - Reading from file tmpfile_stdout 15:16:53 INFO - Output received: 15:16:53 INFO - Usage: mozinstall [options] installer 15:16:53 INFO - Options: 15:16:53 INFO - -h, --help show this help message and exit 15:16:53 INFO - -d DEST, --destination=DEST 15:16:53 INFO - Directory to install application into. [default: 15:16:53 INFO - "/builds/slave/test"] 15:16:53 INFO - --app=APP Application being installed. [default: firefox] 15:16:53 INFO - mkdir: /builds/slave/test/build/application 15:16:53 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'] 15:16:53 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 15:17:09 INFO - Reading from file tmpfile_stdout 15:17:09 INFO - Output received: 15:17:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:17:09 INFO - Running post-action listener: _resource_record_post_action 15:17:09 INFO - [mozharness: 2016-10-25 22:17:09.924579Z] Finished install step (success) 15:17:09 INFO - [mozharness: 2016-10-25 22:17:09.924828Z] Running run-tests step. 15:17:09 INFO - Running pre-action listener: _resource_record_pre_action 15:17:09 INFO - Running main action method: run_tests 15:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:17:09 INFO - Python 2.7.3 15:17:09 INFO - Return code: 0 15:17:09 INFO - grabbing minidump binary from tooltool 15:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:09 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 0x231ef60>, '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 0x231fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23201d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:17:09 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 15:17:09 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 15:17:09 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 15:17:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:17:10 INFO - Return code: 0 15:17:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:17:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:17:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:17:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:17:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:17:10 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/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:17:10 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/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 15:17:10 INFO - Using env: {'DISPLAY': ':0', 15:17:10 INFO - 'HOME': '/home/cltbld', 15:17:10 INFO - 'LANG': 'en_US.UTF-8', 15:17:10 INFO - 'LANGUAGE': 'en_US:en', 15:17:10 INFO - 'LOGNAME': 'cltbld', 15:17:10 INFO - 'MAIL': '/var/mail/cltbld', 15:17:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:17:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:10 INFO - 'MOZ_NO_REMOTE': '1', 15:17:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:10 INFO - 'NO_EM_RESTART': '1', 15:17:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:10 INFO - 'PWD': '/builds/slave/test', 15:17:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:17:10 INFO - 'SHELL': '/bin/bash', 15:17:10 INFO - 'SHLVL': '1', 15:17:10 INFO - 'TERM': 'linux', 15:17:10 INFO - 'TMOUT': '86400', 15:17:10 INFO - 'USER': 'cltbld', 15:17:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224', 15:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:10 INFO - '_': '/tools/buildbot/bin/python'} 15:17:10 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/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:17:10 INFO - mozversion application_buildid: 20161025133924 15:17:10 INFO - mozversion application_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 15:17:10 INFO - mozversion application_display_name: Nightly 15:17:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:17:10 INFO - mozversion application_name: Firefox 15:17:10 INFO - mozversion application_remotingname: firefox 15:17:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:17:10 INFO - mozversion application_vendor: Mozilla 15:17:10 INFO - mozversion application_version: 52.0a1 15:17:10 INFO - mozversion platform_buildid: 20161025133924 15:17:10 INFO - mozversion platform_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 15:17:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:17:10 INFO - mozversion platform_version: 52.0a1 15:17:10 INFO - using testdate: 1477433830 15:17:10 INFO - actual date: 1477433830 15:17:10 INFO - starting webserver on 'localhost:50295' 15:17:10 INFO - SUITE-START | Running 2 tests 15:17:10 INFO - TEST-START | dromaeo_css 15:17:10 INFO - operating with platform_type : linux_ 15:17:10 INFO - Initialising browser for dromaeo_css test... 15:17:10 INFO - TEST-INFO | started process 21869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjfalO5/profile http://localhost:50295/getInfo.html) 15:17:14 INFO - PROCESS | 21869 | __metrics Screen width/height:1600/1200 15:17:14 INFO - PROCESS | 21869 | colorDepth:24 15:17:14 INFO - PROCESS | 21869 | Browser inner width/height: 1024/697 15:17:14 INFO - PROCESS | 21869 | __metrics 15:17:14 INFO - PROCESS | 21869 | 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" 15:17:14 INFO - PROCESS | 21869 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:17:15 INFO - PROCESS | 21869 | console.error: PushService: 15:17:15 INFO - PROCESS | 21869 | stateChangeProcessEnqueue: Error transitioning state 15:17:15 INFO - PROCESS | 21869 | UnknownError 15:17:15 INFO - TEST-INFO | 21869: exit 0 15:17:15 INFO - Browser initialized. 15:17:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:17:15 INFO - TEST-INFO | started process 21950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjfalO5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:28 INFO - PROCESS | 21950 | RSS: Main: 172953600 15:17:28 INFO - PROCESS | 21950 | 15:18:19 INFO - PROCESS | 21950 | 1477433899099 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] 15:20:32 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:50295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50295/tests/dromaeo/cssquery-ext.html) 15:20:35 INFO - PROCESS | 21950 | RSS: Main: 387100672 15:20:35 INFO - PROCESS | 21950 | 15:23:38 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:50295/tests/dromaeo/cssquery-ext.html (next: http://localhost:50295/tests/dromaeo/cssquery-jquery.html) 15:23:38 INFO - PROCESS | 21950 | RSS: Main: 278577152 15:23:38 INFO - PROCESS | 21950 | 15:26:41 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:50295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50295/tests/dromaeo/cssquery-mootools.html) 15:26:41 INFO - PROCESS | 21950 | RSS: Main: 238411776 15:26:41 INFO - PROCESS | 21950 | 15:29:44 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:50295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50295/tests/dromaeo/cssquery-prototype.html) 15:29:44 INFO - PROCESS | 21950 | RSS: Main: 218148864 15:29:44 INFO - PROCESS | 21950 | 15:32:47 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:50295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50295/tests/dromaeo/cssquery-yui.html) 15:32:48 INFO - PROCESS | 21950 | RSS: Main: 218132480 15:32:48 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:50295/tests/dromaeo/cssquery-yui.html (next: http://localhost:50295/tests/dromaeo/cssquery-dojo.html) 15:35:51 INFO - PROCESS | 21950 | RSS: Main: 314892288 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | __start_tp_report 15:35:51 INFO - PROCESS | 21950 | _x_x_mozilla_page_load 15:35:51 INFO - PROCESS | 21950 | _x_x_mozilla_page_load_details 15:35:51 INFO - PROCESS | 21950 | |i|pagename|runs| 15:35:51 INFO - PROCESS | 21950 | |0;dojo.html;2567.627693984372;2596.324955511569;2619.5415802234606;2621.2529429112706;2635.9604605930913;4515.322701594762;4581.496035436099;4721.669483136182;4735.810567577297;4743.193657078301;4614.238650622651;4630.583247507724;4665.323528088434;4680.906381872361;4750.928736068961;4324.97837510812;4346.78266086696;4346.826126954934;4366.56334366564;4387.890302742425;4294.141171765644;4317.525072242051;4408.338749187616;4430.7784610769495;4499.6400287976885;4377.080813029268;4397.560243975593;4412.24991751403;4438.400815889862;4467.977660111695;4191.476065491814;4219.303814870543;4228.577142285778;4277.615014648665;4358.782060896942;4218.957810421887;4238.554951730055;4261;4265.360195970598;4272;4523.5024147343765;4557.908841823145;4647.53524647536;4666;4707.31743897133;4835.734034628094;4850.199717046683;4931.926021109686;4941.678790878582;4991.850244492671;4808.903821923542;4877.853664390074;4941.579965702919;4947.975260123676;5013.0725815723845;4635.119327327797;4654.86035418938;4691.929621055687;4700.177468942921;4713.6936099153445;5099.5410413063;5128.3076784633595;5140.768665410065;5145.922811157836;5169.353830771153;4742.73914934675;4873.26900964851;4904.4605093439695;4908.950910490921;4960.330355402047;4851.223804191312;4876.926846097241;4914.877128071756;4920.188168952154;4931.580815630711;4878.195097808893;4880.511948805091;4893.314935908976;4936.654434189572;4952.20764677657;4882.438519570295;4890.95109048912;4915.243306528052;4918.385201849769;4979.825706100269;4220.366944958281;4241.681873859473;4249.213895429355;4289.871303860889;4297.656187504992;3757.098296408842;3759.793211373346;3807.9238415232094;3821.636944490269;3841.2701586698436;4326.307790753464;4329.242382583098;4330.437043184366;4330.501992270866;4377.737335759864;4805.951940480551;4853.878653033702;5014.047331007097;5017.197248440232;5078.1874900016555;4202.537720850704;4293.97853010733;4307.763073031013;4320.179165958458;4378.036831896978;4559.886002849889;4572.839950601713;4573.908521829611;4577.977110114494;4631.583157515773;4666.533346665374;4680.695754775928;4680.812767489262;4684.976575117239;4734.26618874075;4824.324594556835;4863.586595139453;4872.244802055687;4925.113479573711;4931.728754918514;4561.657875659405;4574.519675434165;4605.078984203105;4607;4613.284940834176;4826.6621336506105;4842.854714358575;4853.781579828846;4858.95141048585;4865.659403841697;4892.510748925221;4895.681780684244;4901.215805471107;4905.117078925685;4909.1654418748185;4724.71651700899;4775.689580177277;4789.880252993703;4792.329073929583;4806.951930480651;4687.648426367968;4687.648426368104;4690.460597031249;4702.200625893538;4704.741239231738;4652.744099074584;4741.217699079613;4749.810007599657;4771.71369717818;4827.831025914076;4876.512348765237;4878.975605121952;4880.487548807324;4881.414230292387;4925.335079764329;4656.7671616418365;4711.199096153594;4756.6908150970075;4822.855314340575;4867.513248675245 15:35:51 INFO - PROCESS | 21950 | |1;ext.html;554.1604469229118;571.9084946408575;579.996605871842;586.3696526234299;592.1443514122093;37691.246175076514;39292.214155716865;39619.80190099049;44339.55660443394;44371.11257774843;41183.58816411835;41672.374914376305;41697.58302416975;41729.791351043204;41756.37365439513;7585.355244804198;7765.301122898938;7769.0677118745825;7770.766876993699;7773.844523109535;7812.453128281023;7903.36773058154;7904.525728456282;7905.01187351581;7907.130215676271;7905.051393832719;7922.80192995174;7942.523448593074;7946;7948.642311096015;7856.567888766115;7890.289873911318;7891.763247102596;7893.723719669784;7901.841963160705;7769.300762931307;7835.725749598793;7837.020372453443;7839.8432031359625;7842.254985776342;38058.42912356317;38411.23177536461;38420.23159536822;38428.42357364642;38446.42330365047;2559.795216382685;2683.6645419322585;2786.651668541432;3466.5493485846932;3556.9110772230642;27909.441811163662;28501;28737.28156796076;29593.26016849596;30024.249393765112;3485.35520928629;3528.947065794015;3544.397452433067;3556.3598552260582;3594.442861356468;168794;170345;170457;170577;170965.99999999875;27617.309567260978;51889.48110518847;52221.21668174981;52239.73880130575;52295.47704522982;30030.549541756893;32028.839855800572;32232;32232.19419514484;32247;12044;12307.815382769266;12313.938430307791;12325.288436543946;12327.198732082386;9488.193503552136;9695.418274903528;9699.6120155193;9704.223662107015;9713.125818676353;7728.6522106505345;7748.22517748232;7757.1079325878245;7868.449208555347;7869.331106855867;3064.739497142768;3068.8772449102235;3079.969200308013;3087.07387783664;3098.3648352087766;740.6148802622606;786.4062632712265;887.3832686282972;897.8024834536392;963.027342384183;26099.478010439685;27270.5909411359;27845.164645060682;27883;27914.16257512278;894.8255090257468;927.0729270729271;930.2883294279882;935.9017303183203;1012.3318609717551;13983;14549.709005819825;14566.927165364104;14810.851891481163;14949.17779522115;356561;359712;360832;360986;360997;48802.267965980536;49363.50636493589;49411.258831117564;49537;49553.75223123861;1019.6635110413694;1061.1616822710128;1105.4362275239685;1136.596508239563;1153.2792004996877;27640.447191055664;28758;29135.85432072826;29210.7078929208;29690.703092968793;41271.58728412678;41887.790561047;42122.157556849306;42158.57841421669;42228.36657450079;278804;279122;279948;280453;281356;21887.45281367915;22611.851874071937;37599.43600845935;37650.246995059395;37689.28883889514;37810.243795124494;41900.790496047324;41994;42017.57982420137;42060;35599.82200088983;36359;36372.81813591021;36586.26827463489;36629.63370366262;35592.644073558935;35752.106197344234;35833.59580839816;35928.64071359357;36038.45942310815;34605;34856;34864.65135348614;35108.12229694278;35470.46794298036;30199.698003020567;32753.34493310073;33112;33259.667403326624;33542.32915341728;24286.878565607058;25181.87409063016;25354.746452535237;25419.87290063538;25687 15:35:51 INFO - PROCESS | 21950 | |2;jquery.html;348.25473486738366;358.56255368450496;362.25737238660747;371.28898160023556;384.5904112120591;15327.157006364645;16740.246688899;17305.91347043266;17394.13029348531;17405.91297043516;14089.788653170212;15709;16229.594260143473;16379.09914954677;16398.590035249126;5010.874728131789;5202.193659982709;5240.79036838526;5244.318238628973;5280.630355875091;3736.364817980936;3940.586238444965;5118.795248190068;5941.28704555454;6274.403931626488;6254.312025677172;6257;6257.091587065943;6259.687015649222;6261.749530018794;5995.280566332046;6172.043333283348;6190.0405437157315;6190.721417536177;6198.845028874269;5227.581793456515;5384.542313903323;5430.809921652763;5435.0488664483555;5440.591955603306;20102.09540570678;20251.797482025286;20275.695864562043;21105;21937.341879743475;1829.9908500457414;2057.0640358636933;2182.301663467691;2218.4232099654046;2610.738926107393;13554.576769439165;13720.65698357539;14027.1583704977;14240.715185696332;15292.923535382251;1772.3885259585422;1854.3417086934214;1881.2757088520882;1896.6491199128068;1937.7190307405347;69780;74569.6271518639;75099.62450187714;76686;77454.61272693657;15192.848071519364;15520.223988800515;16260.455256750589;16350.264238109314;16364.972480090983;27771.44457110887;27788.722112778614;27851.721482785317;27920.720792791813;27951.58072628912;7793;7847;7892.210778922176;8026;8305.543195124204;6562.015697645392;6585.078089067534;6859.691313890787;6879.5184337096925;7056.682449289794;8168;8175.550344731097;8297.294729947902;8365.288950439159;8369.874451883226;2688.6639170103736;3196.280836811699;3213.4376484115655;3226.935461290761;3303.8766819281077;703.7958991892294;795.8726603743489;811.8782182672646;821.1501096365233;877.1666916429417;16334.83665163357;16501.422450214184;16514.33942642305;16576.419825306057;17295.481135565955;807.608309969676;816.7835523586255;827.2513375395276;835.1189495082746;845.809692819123;8253.380996425172;9094.48172597174;9512.28657850664;9647.758806029766;9735.858111215663;278772;283958.58020709764;362896;364491;365790;74835.62582187055;76880;77608;78375.2162478368;78436.60781696055;900.3922352412227;901.8511945528915;903.1104362203224;913.9040400757958;939.7885475767897;14944.850551494346;15395.461158859385;15505.534833955;15508.224588770741;16240.18799060066;32775.836120819244;35399;35771;35843.662534985175;37512.99999999891;49163;49283.26075108805;49360.50639493559;49641;49751;6503.154589903283;6662.467002639874;6742.393184613408;7378.667959941708;7755.108162561378;7263.2335616301925;10847.67456976292;10872.945635271773;11112.611058612909;12202.328871911775;6662.900621397415;9976.700698979042;10211.132053775513;10251.7437064074;10328.845067323846;10141.29010969225;10237.84643230367;10374;10379.169666426818;10825.783484330426;10104.89895101069;10461.476926153815;10530.210234232616;10747.829390329714;10808.621698240524;6971.65141742921;7125;7394.7781566553085;7402;7561.848763024819;8919.866202006846;9020.548972551478;9064.320175986959;10367.637132700622;10433.843492347469 15:35:51 INFO - PROCESS | 21950 | |3;mootools.html;1317.5125203674638;1374.2853716067646;1428.9714205715886;1634.713925063115;1674.1963857348474;5774.105013722869;5991.041433370661;6380.330065343136;6813.931860681391;6829.556078854871;6429.742810287595;6647.4017338439535;6658.467322614191;6772.72909083636;6774.491913106512;1974.5754662747506;1995.5011247188204;2003.3188715836613;2009.3469622372713;2014.244658253155;1594.1710310638462;1641.491137747296;1961.460598335462;1971.3100414854757;1977.5945931084166;1930;2001.8898960557165;2003.7695664998566;2005.3883565512513;2012.0342235726787;1941.2914286285545;1965.1746266568075;1968.252064215596;1969.7045443183565;1991.1736629298969;1984.8908310042941;1990.5421752996892;1992.163291417608;1994.0328940463864;1994.3717728915344;6827.897581536281;6885.070515480446;6894.345037221506;6898.034275201426;6914.792556223271;3847.384418493056;3940.1134744682217;3953.2884080865433;3957.2679054374744;3961.1285517186175;2396.484755777499;2668.452967141751;2668.866556672159;2674.304680782991;2679.263202619276;797.6769408389612;801.9157988411249;808.6765293882436;850.808568072185;856.1181982557976;8705.260052895512;8722.34582406322;8722.781930451789;8731.825363492695;8796.824063518758;3312.9834350828573;3501.8074005929407;3528.2061536154674;3554.360215161296;3575.910602234965;7670.194629563927;7674.57789821554;7683.923160768432;7685.5772932488135;7690.346320562703;3982.064214909494;3987.3620220764537;3987.7407968481957;3994.940075898864;3995.9400608990886;3598.2803439312243;3609.2781443711365;3610.1696609779897;3613.403788374941;3614.1145419371896;2943.67619561848;3056.709612586845;3066.386722655478;3082.3681145365144;3214.8714051438146;854.2994744309607;866.0776273268948;970.1026550440955;982.7641366072235;983.6901376066517;631.9652419116993;709.5175280808996;753.7022875964074;756.1512102908337;772.212343409719;4338.089001309697;4379.299312110047;4400.779961001937;4417.690761646718;4467.955320446754;734.6693987705554;766.9884951725617;796.5380079553845;800.519688187083;800.5909599105499;2829.900953466619;2850.9002184923843;3083.953740693891;3092.5515800208846;3103.4258662147577;8168;8227.300679442315;8351.498910065295;8365.414420990472;8369.874451883226;8267.255946964802;8270.751877443687;8275;8276.793080173044;8290.8341833163;6291.1192433059405;6471.385218404244;6493.22081350241;6505.316941721146;6507.609543427409;4310.094880075219;4423.977880110579;4439.4228750262255;4446.377507149066;4617.12274667812;7381.963090184515;7383.556986580822;7545.207753185837;7603.9619801900635;7610.086789585285;7585.317321441097;7661.923380766121;7693.307602315818;7735.381169506313;7761.7671469855995;5938.4358485945495;5974.074018527135;6055.091736239599;6065.211522502046;6072.696365181635;6398.744050237939;6482.254540727877;6523.021546768023;6530.9020364693615;6532.477401807749;4737;5703.372629010722;5717.5425965921795;5909.497692696169;5937.643741375531;5511.724413779375;5525.143602741581;5528.944710552843;5631.915521267266;5649.152627105967;5284.392294886137;5287.334489635752;5325.840224793263;5326.813561525328;5368.033753924331;3795.5635101963626;3868.0909986153792;3891.3190191716903;3971.245463361952;3999.3800960851113;3878.4764056851964;3886.5336159661024;3919.7648141111627;3976.562578116347;4001.55982841893 15:35:51 INFO - PROCESS | 21950 | |4;prototype.html;261.3805281482885;261.50444906901424;263.3613487293314;270.7847261427165;271.5695622438435;4694.6244300455965;4783.473817880034;4790.928136077961;4804.90390192196;4811.326414301996;4674.228752255874;4717.4574923883765;4718.811247550102;4740.573348398643;4764.475907650156;3462.5325581046613;3575.535180426541;3698.4466524059894;3711.6845068169105;3711.7772933623933;3516.82415879205;3655.3603119454124;3671.210689701714;3680.263947210555;3702.61122582129;3647.288778688157;3651.872184473544;3653.324135035027;3655.6709896109346;3661.4690869823858;3465.9653403465895;3660.1215708230097;3677.8300802526637;3683.134463401112;3709.3879509880835;3082.5838511800844;3101;3163.825989570573;3166.5408515765316;3171.730402915755;4584.885377865547;4589.2198326284615;4594.150082234797;4596.5863072323655;4615;4132.421460995463;4145.91708165835;4150;4151.14901445203;4155.293600087962;4804.846836759188;4880.242213495624;4893.75531223441;4906.656534042619;4956.306117143603;3439.2777516721517;3445.104272889042;3445.7415693822813;3452.4648679454726;3465.636108208627;5171.4311425743135;5188.299579556787;5188.558972487305;5199.272101905736;5212.139996900545;3457.7233821294235;3515.0473602173784;3548.929021419557;3552.289542091592;3559.1458050068313;3545.2732189901008;3549;3549.1836877518317;3552.7690700104927;3562.1628917204953;4092.6112019358116;4100.774457404871;4112.403701463271;4126.338511659963;4142.2751018572235;4928.334674818925;4931.5315045070665;4937.703737775745;4939.925901111486;4946.579540739005;1198.1313547677864;1235.8630060344506;1250.3248245947268;1261.5710658376197;1263.91784534005;769.4075561817369;795.9323457506061;796.5380079553845;797.3182928595967;801.7033697531834;3896.921432068634;3919;3919.8040097994985;4182.2890108681595;4337.566243375701;4957.157283261854;5084.847454576368;5108.489151084936;5123.974380128076;5127.820526281637;4426.291793313055;4431.800568974404;4433.844815431445;4434.982083152158;4446.155230506193;2593.2511537770024;2686.033028109879;2707.9593806092926;2709.173702020863;2717.885666876571;4789.161896668139;4804.183288840905;4805.111054454937;4812.927806082912;4826.034793041335;5256.6320357574605;5258.97370513145;5266.3943646480375;5273.367195936512;5293.417724050351;4647.233206520887;4783.378160839069;4811.927821082757;4863.537963893425;4872.244802055687;5094.847154585368;5098.617603679813;5123.615728820428;5129.794498292973;5153;5029.245613158056;5036.748162591929;5040.344755181803;5082.745862706924;5095.490450955023;4694.671373003857;4781.187198176249;4818.349522814516;4821.7348045856415;4851.611871050378;3435.896923092311;3447.9482807758404;3448.827558622109;3463;3464.151282935697;5073.847784566469;5097.362829646294;5159.613029022913;5163.845084647466;5167.250748641502;4781.952180478151;4953.975230123826;5005.524475174998;5030.547250747451;5043.100217375098;4923.187674033744;4941.9243917553995;4955.35580374549;4956.529129732669;4987.975060124676;4870.905510630463;4871.610271178368;4911.705297682151;4915.738760170361;4929.359183306147;4783.425988881357;4967.7019378837385;4985.950140498694;4999.225120106389;5027.396712394536;4689;4742.956549559091;4808.975955120202;4894.314795928502;4912.6561140719805 15:35:51 INFO - PROCESS | 21950 | |5;yui.html;594.7739858853635;617.6386813713978;625.7903602293231;700.8750954717678;756.2626439221758;11340;11984.640460786179;12034.458449369777;12098.213616114946;12788.3605819709;11173.888261117387;11266.211365204439;11322.60370887019;11326.093912487002;11361.091112710985;787.6534324897041;810.4245985350408;816.0289255785626;816.1512027491432;816.2001238785994;622.3838399984006;645.132297060453;775.1899265267808;808.7775861638038;814.3322475570035;844.9028361738386;846.2637505370336;847.2501835875264;847.4491580472711;848.3043903998723;836.4228682209256;836.4270474724802;836.5608055770708;836.5984327522763;837.4472847920374;477.00782372664776;490.23523303646425;587.8442212813608;607.177274792654;612.3845535237058;11565.363904985223;11584.884151158549;11608.76782464346;11613.070954323633;11613.30320180792;11509.251898626646;12029.51881924722;12242.143049986504;12656.303903285316;12680.112392132554;9433.151016408488;9524.666636667684;9541.188998935098;9632.373895696757;10359.119474844647;4078.80476470908;4080.18396320737;4119.526254480743;4161.83352665893;4167.374893765959;49066.50933490655;49781;50018.74990625024;50344;50434;9600.231981441608;9724;9800.460974646463;9807.411555306704;9912.504374781376;16792.748108778378;16882.240299186567;16907.40824071176;16937;17065.317387304618;6322.146510221061;6326.536692919672;6416.7754128605275;6531.510136739764;6586.110875031809;3573.2317551726505;3650.7261955353456;3656.835442405098;3661.8901432957055;3712.480252764615;2522.2685421228007;2646.3251870773215;2651.0323731838125;2651.3239124023253;2988.6712461629204;526.5024551798514;527.2223470381234;536.1742915909533;537.9246905433242;548.2872266054113;562.3224015061841;574.1817909478975;596.3053043204704;597.3429227849331;603.809799913026;6934.16789985205;6937.826554336182;7048.964755176191;7173.856522869513;7230.6384680766805;511.7748190796038;556.5909056843217;558.2268558047053;559.1975515135712;563.6364544868537;3357.1103657530775;3385.0874256045254;3394.13449570358;3441.6558344165883;3470.0457374221787;68282.65858670774;71313.6434317825;72147;72208.63895680488;75266.62366688241;36681.63318366782;45200;53600;65732.34267657262;65984;58586.7070664644;59225.11162332568;59404;60590;61302;6309.828771740516;6485;6626.536142470173;6816.284290149463;6924.58452492852;39401.60598393979;39919;39933.60066399415;40114.79942600268;41196.588034119275;44344.33483497686;44488;45903.31145032894;46149.769251154874;46499.30251046304;10524.789504209719;10630.73423164427;10789.56841726322;10806.837897431702;11065.114790816877;11648.475818588353;11656.30062196271;11707.88292117102;12090.45592948337;12278.14053016316;10436.843447348449;10617.362958222531;10783.784324313312;11002.724931876766;11137.77004668637;10823.242373034127;11035.172362072715;11109.777804443704;11237.55049797999;11351.318920864775;10435.16518678519;10465.9476702616;10529;10533.631322903662;10551.103156231806;8953.448267243804;9136.588853501742;9778.608855645694;9906.25703072258;9970.601175952881;9740.415575065519;9752.463614500986;9816.950915245377;9820.361676491006;9871.605135794774 15:35:51 INFO - PROCESS | 21950 | __end_tp_report 15:35:51 INFO - PROCESS | 21950 | __start_cc_report 15:35:51 INFO - PROCESS | 21950 | _x_x_mozilla_cycle_collect,2553 15:35:51 INFO - PROCESS | 21950 | __end_cc_report 15:35:51 INFO - PROCESS | 21950 | __startTimestamp1477434951464__endTimestamp 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | ------- Summary: start ------- 15:35:51 INFO - PROCESS | 21950 | Number of tests: 6 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | [#0] dojo.html Cycles:165 Average:4590.75 Median:4700.18 stddev:453.22 (9.6%) stddev-sans-first:425.91 15:35:51 INFO - PROCESS | 21950 | Values: 2567.6 2596.3 2619.5 2621.3 2636.0 4515.3 4581.5 4721.7 4735.8 4743.2 4614.2 4630.6 4665.3 4680.9 4750.9 4325.0 4346.8 4346.8 4366.6 4387.9 4294.1 4317.5 4408.3 4430.8 4499.6 4377.1 4397.6 4412.2 4438.4 4468.0 4191.5 4219.3 4228.6 4277.6 4358.8 4219.0 4238.6 4261.0 4265.4 4272.0 4523.5 4557.9 4647.5 4666.0 4707.3 4835.7 4850.2 4931.9 4941.7 4991.9 4808.9 4877.9 4941.6 4948.0 5013.1 4635.1 4654.9 4691.9 4700.2 4713.7 5099.5 5128.3 5140.8 5145.9 5169.4 4742.7 4873.3 4904.5 4909.0 4960.3 4851.2 4876.9 4914.9 4920.2 4931.6 4878.2 4880.5 4893.3 4936.7 4952.2 4882.4 4891.0 4915.2 4918.4 4979.8 4220.4 4241.7 4249.2 4289.9 4297.7 3757.1 3759.8 3807.9 3821.6 3841.3 4326.3 4329.2 4330.4 4330.5 4377.7 4806.0 4853.9 5014.0 5017.2 5078.2 4202.5 4294.0 4307.8 4320.2 4378.0 4559.9 4572.8 4573.9 4578.0 4631.6 4666.5 4680.7 4680.8 4685.0 4734.3 4824.3 4863.6 4872.2 4925.1 4931.7 4561.7 4574.5 4605.1 4607.0 4613.3 4826.7 4842.9 4853.8 4859.0 4865.7 4892.5 4895.7 4901.2 4905.1 4909.2 4724.7 4775.7 4789.9 4792.3 4807.0 4687.6 4687.6 4690.5 4702.2 4704.7 4652.7 4741.2 4749.8 4771.7 4827.8 4876.5 4879.0 4880.5 4881.4 4925.3 4656.8 4711.2 4756.7 4822.9 4867.5 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | [#1] ext.html Cycles:180 Average:42241.65 Median:36365.91 stddev:74097.55 (203.8%) stddev-sans-first:74239.30 15:35:51 INFO - PROCESS | 21950 | Values: 554.2 571.9 580.0 586.4 592.1 37691.2 39292.2 39619.8 44339.6 44371.1 41183.6 41672.4 41697.6 41729.8 41756.4 7585.4 7765.3 7769.1 7770.8 7773.8 7812.5 7903.4 7904.5 7905.0 7907.1 7905.1 7922.8 7942.5 7946.0 7948.6 7856.6 7890.3 7891.8 7893.7 7901.8 7769.3 7835.7 7837.0 7839.8 7842.3 38058.4 38411.2 38420.2 38428.4 38446.4 2559.8 2683.7 2786.7 3466.5 3556.9 27909.4 28501.0 28737.3 29593.3 30024.2 3485.4 3528.9 3544.4 3556.4 3594.4 168794.0 170345.0 170457.0 170577.0 170966.0 27617.3 51889.5 52221.2 52239.7 52295.5 30030.5 32028.8 32232.0 32232.2 32247.0 12044.0 12307.8 12313.9 12325.3 12327.2 9488.2 9695.4 9699.6 9704.2 9713.1 7728.7 7748.2 7757.1 7868.4 7869.3 3064.7 3068.9 3080.0 3087.1 3098.4 740.6 786.4 887.4 897.8 963.0 26099.5 27270.6 27845.2 27883.0 27914.2 894.8 927.1 930.3 935.9 1012.3 13983.0 14549.7 14566.9 14810.9 14949.2 356561.0 359712.0 360832.0 360986.0 360997.0 48802.3 49363.5 49411.3 49537.0 49553.8 1019.7 1061.2 1105.4 1136.6 1153.3 27640.4 28758.0 29135.9 29210.7 29690.7 41271.6 41887.8 42122.2 42158.6 42228.4 278804.0 279122.0 279948.0 280453.0 281356.0 21887.5 22611.9 37599.4 37650.2 37689.3 37810.2 41900.8 41994.0 42017.6 42060.0 35599.8 36359.0 36372.8 36586.3 36629.6 35592.6 35752.1 35833.6 35928.6 36038.5 34605.0 34856.0 34864.7 35108.1 35470.5 30199.7 32753.3 33112.0 33259.7 33542.3 24286.9 25181.9 25354.7 25419.9 25687.0 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | [#2] jquery.html Cycles:180 Average:23515.69 Median:26551.79 stddev:55548.49 (209.2%) stddev-sans-first:55677.08 15:35:51 INFO - PROCESS | 21950 | Values: 348.3 358.6 362.3 371.3 384.6 15327.2 16740.2 17305.9 17394.1 17405.9 14089.8 15709.0 16229.6 16379.1 16398.6 5010.9 5202.2 5240.8 5244.3 5280.6 3736.4 3940.6 5118.8 5941.3 6274.4 6254.3 6257.0 6257.1 6259.7 6261.7 5995.3 6172.0 6190.0 6190.7 6198.8 5227.6 5384.5 5430.8 5435.0 5440.6 20102.1 20251.8 20275.7 21105.0 21937.3 1830.0 2057.1 2182.3 2218.4 2610.7 13554.6 13720.7 14027.2 14240.7 15292.9 1772.4 1854.3 1881.3 1896.6 1937.7 69780.0 74569.6 75099.6 76686.0 77454.6 15192.8 15520.2 16260.5 16350.3 16365.0 27771.4 27788.7 27851.7 27920.7 27951.6 7793.0 7847.0 7892.2 8026.0 8305.5 6562.0 6585.1 6859.7 6879.5 7056.7 8168.0 8175.6 8297.3 8365.3 8369.9 2688.7 3196.3 3213.4 3226.9 3303.9 703.8 795.9 811.9 821.2 877.2 16334.8 16501.4 16514.3 16576.4 17295.5 807.6 816.8 827.3 835.1 845.8 8253.4 9094.5 9512.3 9647.8 9735.9 278772.0 283958.6 362896.0 364491.0 365790.0 74835.6 76880.0 77608.0 78375.2 78436.6 900.4 901.9 903.1 913.9 939.8 14944.9 15395.5 15505.5 15508.2 16240.2 32775.8 35399.0 35771.0 35843.7 37513.0 49163.0 49283.3 49360.5 49641.0 49751.0 6503.2 6662.5 6742.4 7378.7 7755.1 7263.2 10847.7 10872.9 11112.6 12202.3 6662.9 9976.7 10211.1 10251.7 10328.8 10141.3 10237.8 10374.0 10379.2 10825.8 10104.9 10461.5 10530.2 10747.8 10808.6 6971.7 7125.0 7394.8 7402.0 7561.8 8919.9 9020.5 9064.3 10367.6 10433.8 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | [#3] mootools.html Cycles:180 Average:4401.48 Median:5439.88 stddev:2420.82 (44.5%) stddev-sans-first:2416.52 15:35:51 INFO - PROCESS | 21950 | Values: 1317.5 1374.3 1429.0 1634.7 1674.2 5774.1 5991.0 6380.3 6813.9 6829.6 6429.7 6647.4 6658.5 6772.7 6774.5 1974.6 1995.5 2003.3 2009.3 2014.2 1594.2 1641.5 1961.5 1971.3 1977.6 1930.0 2001.9 2003.8 2005.4 2012.0 1941.3 1965.2 1968.3 1969.7 1991.2 1984.9 1990.5 1992.2 1994.0 1994.4 6827.9 6885.1 6894.3 6898.0 6914.8 3847.4 3940.1 3953.3 3957.3 3961.1 2396.5 2668.5 2668.9 2674.3 2679.3 797.7 801.9 808.7 850.8 856.1 8705.3 8722.3 8722.8 8731.8 8796.8 3313.0 3501.8 3528.2 3554.4 3575.9 7670.2 7674.6 7683.9 7685.6 7690.3 3982.1 3987.4 3987.7 3994.9 3995.9 3598.3 3609.3 3610.2 3613.4 3614.1 2943.7 3056.7 3066.4 3082.4 3214.9 854.3 866.1 970.1 982.8 983.7 632.0 709.5 753.7 756.2 772.2 4338.1 4379.3 4400.8 4417.7 4468.0 734.7 767.0 796.5 800.5 800.6 2829.9 2850.9 3084.0 3092.6 3103.4 8168.0 8227.3 8351.5 8365.4 8369.9 8267.3 8270.8 8275.0 8276.8 8290.8 6291.1 6471.4 6493.2 6505.3 6507.6 4310.1 4424.0 4439.4 4446.4 4617.1 7382.0 7383.6 7545.2 7604.0 7610.1 7585.3 7661.9 7693.3 7735.4 7761.8 5938.4 5974.1 6055.1 6065.2 6072.7 6398.7 6482.3 6523.0 6530.9 6532.5 4737.0 5703.4 5717.5 5909.5 5937.6 5511.7 5525.1 5528.9 5631.9 5649.2 5284.4 5287.3 5325.8 5326.8 5368.0 3795.6 3868.1 3891.3 3971.2 3999.4 3878.5 3886.5 3919.8 3976.6 4001.6 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | [#4] prototype.html Cycles:180 Average:4087.93 Median:4718.13 stddev:1217.21 (25.8%) stddev-sans-first:1186.26 15:35:51 INFO - PROCESS | 21950 | Values: 261.4 261.5 263.4 270.8 271.6 4694.6 4783.5 4790.9 4804.9 4811.3 4674.2 4717.5 4718.8 4740.6 4764.5 3462.5 3575.5 3698.4 3711.7 3711.8 3516.8 3655.4 3671.2 3680.3 3702.6 3647.3 3651.9 3653.3 3655.7 3661.5 3466.0 3660.1 3677.8 3683.1 3709.4 3082.6 3101.0 3163.8 3166.5 3171.7 4584.9 4589.2 4594.2 4596.6 4615.0 4132.4 4145.9 4150.0 4151.1 4155.3 4804.8 4880.2 4893.8 4906.7 4956.3 3439.3 3445.1 3445.7 3452.5 3465.6 5171.4 5188.3 5188.6 5199.3 5212.1 3457.7 3515.0 3548.9 3552.3 3559.1 3545.3 3549.0 3549.2 3552.8 3562.2 4092.6 4100.8 4112.4 4126.3 4142.3 4928.3 4931.5 4937.7 4939.9 4946.6 1198.1 1235.9 1250.3 1261.6 1263.9 769.4 795.9 796.5 797.3 801.7 3896.9 3919.0 3919.8 4182.3 4337.6 4957.2 5084.8 5108.5 5124.0 5127.8 4426.3 4431.8 4433.8 4435.0 4446.2 2593.3 2686.0 2708.0 2709.2 2717.9 4789.2 4804.2 4805.1 4812.9 4826.0 5256.6 5259.0 5266.4 5273.4 5293.4 4647.2 4783.4 4811.9 4863.5 4872.2 5094.8 5098.6 5123.6 5129.8 5153.0 5029.2 5036.7 5040.3 5082.7 5095.5 4694.7 4781.2 4818.3 4821.7 4851.6 3435.9 3447.9 3448.8 3463.0 3464.2 5073.8 5097.4 5159.6 5163.8 5167.3 4782.0 4954.0 5005.5 5030.5 5043.1 4923.2 4941.9 4955.4 4956.5 4988.0 4870.9 4871.6 4911.7 4915.7 4929.4 4783.4 4967.7 4986.0 4999.2 5027.4 4689.0 4743.0 4809.0 4894.3 4912.7 15:35:51 INFO - PROCESS | 21950 | 15:35:51 INFO - PROCESS | 21950 | [#5] yui.html Cycles:180 Average:14407.97 Median:519.14 stddev:18647.04 (3591.9%) stddev-sans-first:18670.50 15:35:51 INFO - PROCESS | 21950 | Values: 594.8 617.6 625.8 700.9 756.3 11340.0 11984.6 12034.5 12098.2 12788.4 11173.9 11266.2 11322.6 11326.1 11361.1 787.7 810.4 816.0 816.2 816.2 622.4 645.1 775.2 808.8 814.3 844.9 846.3 847.3 847.4 848.3 836.4 836.4 836.6 836.6 837.4 477.0 490.2 587.8 607.2 612.4 11565.4 11584.9 11608.8 11613.1 11613.3 11509.3 12029.5 12242.1 12656.3 12680.1 9433.2 9524.7 9541.2 9632.4 10359.1 4078.8 4080.2 4119.5 4161.8 4167.4 49066.5 49781.0 50018.7 50344.0 50434.0 9600.2 9724.0 9800.5 9807.4 9912.5 16792.7 16882.2 16907.4 16937.0 17065.3 6322.1 6326.5 6416.8 6531.5 6586.1 3573.2 3650.7 3656.8 3661.9 3712.5 2522.3 2646.3 2651.0 2651.3 2988.7 526.5 527.2 536.2 537.9 548.3 562.3 574.2 596.3 597.3 603.8 6934.2 6937.8 7049.0 7173.9 7230.6 511.8 556.6 558.2 559.2 563.6 3357.1 3385.1 3394.1 3441.7 3470.0 68282.7 71313.6 72147.0 72208.6 75266.6 36681.6 45200.0 53600.0 65732.3 65984.0 58586.7 59225.1 59404.0 60590.0 61302.0 6309.8 6485.0 6626.5 6816.3 6924.6 39401.6 39919.0 39933.6 40114.8 41196.6 44344.3 44488.0 45903.3 46149.8 46499.3 10524.8 10630.7 10789.6 10806.8 11065.1 11648.5 11656.3 11707.9 12090.5 12278.1 10436.8 10617.4 10783.8 11002.7 11137.8 10823.2 11035.2 11109.8 11237.6 11351.3 10435.2 10465.9 10529.0 10533.6 10551.1 8953.4 9136.6 9778.6 9906.3 9970.6 9740.4 9752.5 9817.0 9820.4 9871.6 15:35:51 INFO - PROCESS | 21950 | -------- Summary: end -------- 15:35:51 INFO - PROCESS | 21950 | 15:35:52 INFO - TEST-INFO | 21950: exit 0 15:35:52 INFO - TEST-OK | dromaeo_css | took 1122179ms 15:35:52 INFO - TEST-START | kraken 15:35:52 INFO - operating with platform_type : linux_ 15:35:52 INFO - Initialising browser for kraken test... 15:35:52 INFO - TEST-INFO | started process 22264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNj25hJ/profile http://localhost:50295/getInfo.html) 15:35:56 INFO - PROCESS | 22264 | __metrics Screen width/height:1600/1200 15:35:56 INFO - PROCESS | 22264 | colorDepth:24 15:35:56 INFO - PROCESS | 22264 | Browser inner width/height: 1024/697 15:35:56 INFO - PROCESS | 22264 | __metrics 15:35:56 INFO - PROCESS | 22264 | 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" 15:35:56 INFO - PROCESS | 22264 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:57 INFO - TEST-INFO | 22264: exit 0 15:35:57 INFO - Browser initialized. 15:35:57 INFO - Running cycle 1/1 for kraken test... 15:35:57 INFO - TEST-INFO | started process 22349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNj25hJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:10 INFO - PROCESS | 22349 | RSS: Main: 173801472 15:36:10 INFO - PROCESS | 22349 | 15:36:13 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50295/tests/kraken/driver.html?testName=audio-beat-detection) 15:36:13 INFO - PROCESS | 22349 | RSS: Main: 229810176 15:36:13 INFO - PROCESS | 22349 | 15:36:16 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50295/tests/kraken/driver.html?testName=audio-dft) 15:36:17 INFO - PROCESS | 22349 | RSS: Main: 217280512 15:36:17 INFO - PROCESS | 22349 | 15:36:20 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50295/tests/kraken/driver.html?testName=audio-fft) 15:36:21 INFO - PROCESS | 22349 | RSS: Main: 299290624 15:36:21 INFO - PROCESS | 22349 | 15:36:23 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50295/tests/kraken/driver.html?testName=audio-oscillator) 15:36:24 INFO - PROCESS | 22349 | RSS: Main: 209801216 15:36:24 INFO - PROCESS | 22349 | 15:36:26 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:36:26 INFO - PROCESS | 22349 | RSS: Main: 212979712 15:36:26 INFO - PROCESS | 22349 | 15:36:29 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50295/tests/kraken/driver.html?testName=imaging-darkroom) 15:36:30 INFO - PROCESS | 22349 | RSS: Main: 248860672 15:36:30 INFO - PROCESS | 22349 | 15:36:34 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50295/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:34 INFO - PROCESS | 22349 | RSS: Main: 247914496 15:36:34 INFO - PROCESS | 22349 | 15:36:37 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50295/tests/kraken/driver.html?testName=json-parse-financial) 15:36:37 INFO - PROCESS | 22349 | RSS: Main: 247140352 15:36:37 INFO - PROCESS | 22349 | 15:36:39 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:40 INFO - PROCESS | 22349 | RSS: Main: 210284544 15:36:40 INFO - PROCESS | 22349 | 15:36:42 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:42 INFO - PROCESS | 22349 | RSS: Main: 217030656 15:36:42 INFO - PROCESS | 22349 | 15:36:44 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:45 INFO - PROCESS | 22349 | RSS: Main: 226689024 15:36:45 INFO - PROCESS | 22349 | 15:36:48 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:49 INFO - PROCESS | 22349 | RSS: Main: 235470848 15:36:49 INFO - PROCESS | 22349 | 15:36:52 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:52 INFO - PROCESS | 22349 | RSS: Main: 232169472 15:36:52 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | Cycle 1(1): loaded http://localhost:50295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50295/tests/kraken/driver.html?testName=ai-astar) 15:36:54 INFO - PROCESS | 22349 | RSS: Main: 282726400 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | __start_tp_report 15:36:54 INFO - PROCESS | 22349 | _x_x_mozilla_page_load 15:36:54 INFO - PROCESS | 22349 | _x_x_mozilla_page_load_details 15:36:54 INFO - PROCESS | 22349 | |i|pagename|runs| 15:36:54 INFO - PROCESS | 22349 | |0;ai-astar;107;115;118;114;116;116;115;116;116;115 15:36:54 INFO - PROCESS | 22349 | |1;audio-beat-detection;163;129;129;166;135;127;132;127;157;128 15:36:54 INFO - PROCESS | 22349 | |2;audio-dft;162;163;162;170;161;161;161;160;160;160 15:36:54 INFO - PROCESS | 22349 | |3;audio-fft;76;76;77;111;76;76;76;75;102;76 15:36:54 INFO - PROCESS | 22349 | |4;audio-oscillator;84;84;114;84;84;84;108;83;82;120 15:36:54 INFO - PROCESS | 22349 | |5;imaging-gaussian-blur;116;117;116;116;116;118;117;117;117;117 15:36:54 INFO - PROCESS | 22349 | |6;imaging-darkroom;147;146;146;145;146;147;146;145;146;146 15:36:54 INFO - PROCESS | 22349 | |7;imaging-desaturate;84;84;84;85;84;84;85;84;85;85 15:36:54 INFO - PROCESS | 22349 | |8;json-parse-financial;60;61;61;61;61;62;61;61;63;61 15:36:54 INFO - PROCESS | 22349 | |9;json-stringify-tinderbox;65;66;65;66;65;65;65;66;66;66 15:36:54 INFO - PROCESS | 22349 | |10;stanford-crypto-aes;91;84;93;84;84;83;91;90;89;84 15:36:54 INFO - PROCESS | 22349 | |11;stanford-crypto-ccm;150;142;140;141;142;141;142;157;182;146 15:36:54 INFO - PROCESS | 22349 | |12;stanford-crypto-pbkdf2;187;181;188;180;183;180;180;193;188;183 15:36:54 INFO - PROCESS | 22349 | |13;stanford-crypto-sha256-iterative;73;74;71;74;71;71;70;70;72;69 15:36:54 INFO - PROCESS | 22349 | __end_tp_report 15:36:54 INFO - PROCESS | 22349 | __start_cc_report 15:36:54 INFO - PROCESS | 22349 | _x_x_mozilla_cycle_collect,1955 15:36:54 INFO - PROCESS | 22349 | __end_cc_report 15:36:54 INFO - PROCESS | 22349 | __startTimestamp1477435014961__endTimestamp 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | ------- Summary: start ------- 15:36:54 INFO - PROCESS | 22349 | Number of tests: 14 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:2.94 (2.5%) stddev-sans-first:1.12 15:36:54 INFO - PROCESS | 22349 | Values: 107.0 115.0 118.0 114.0 116.0 116.0 115.0 116.0 116.0 115.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:133.50 stddev:15.99 (12.0%) stddev-sans-first:14.48 15:36:54 INFO - PROCESS | 22349 | Values: 163.0 129.0 129.0 166.0 135.0 127.0 132.0 127.0 157.0 128.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:2.98 (1.8%) stddev-sans-first:3.16 15:36:54 INFO - PROCESS | 22349 | Values: 162.0 163.0 162.0 170.0 161.0 161.0 161.0 160.0 160.0 160.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.04 (17.2%) stddev-sans-first:13.65 15:36:54 INFO - PROCESS | 22349 | Values: 76.0 76.0 77.0 111.0 76.0 76.0 76.0 75.0 102.0 76.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:84.00 stddev:14.98 (17.8%) stddev-sans-first:15.56 15:36:54 INFO - PROCESS | 22349 | Values: 84.0 84.0 114.0 84.0 84.0 84.0 108.0 83.0 82.0 120.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 15:36:54 INFO - PROCESS | 22349 | Values: 116.0 117.0 116.0 116.0 116.0 118.0 117.0 117.0 117.0 117.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 15:36:54 INFO - PROCESS | 22349 | Values: 147.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 146.0 146.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 15:36:54 INFO - PROCESS | 22349 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 85.0 84.0 85.0 85.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 15:36:54 INFO - PROCESS | 22349 | Values: 60.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 63.0 61.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:36:54 INFO - PROCESS | 22349 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 66.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:89.50 stddev:3.83 (4.3%) stddev-sans-first:3.82 15:36:54 INFO - PROCESS | 22349 | Values: 91.0 84.0 93.0 84.0 84.0 83.0 91.0 90.0 89.0 84.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:144.00 stddev:12.97 (9.0%) stddev-sans-first:13.74 15:36:54 INFO - PROCESS | 22349 | Values: 150.0 142.0 140.0 141.0 142.0 141.0 142.0 157.0 182.0 146.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:185.00 stddev:4.47 (2.4%) stddev-sans-first:4.64 15:36:54 INFO - PROCESS | 22349 | Values: 187.0 181.0 188.0 180.0 183.0 180.0 180.0 193.0 188.0 183.0 15:36:54 INFO - PROCESS | 22349 | 15:36:54 INFO - PROCESS | 22349 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.72 (2.4%) stddev-sans-first:1.73 15:36:54 INFO - PROCESS | 22349 | Values: 73.0 74.0 71.0 74.0 71.0 71.0 70.0 70.0 72.0 69.0 15:36:54 INFO - PROCESS | 22349 | -------- Summary: end -------- 15:36:54 INFO - PROCESS | 22349 | 15:36:56 INFO - TEST-INFO | 22349: exit 0 15:36:56 INFO - TEST-OK | kraken | took 63937ms 15:36:56 INFO - SUITE-END | took 1186s 15:36:56 INFO - Completed test suite (00:19:46) 15:36:56 INFO - javascript benchmark 15:36:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.627693984372, 2596.324955511569, 2619.5415802234606, 2621.2529429112706, 2635.9604605930913, 4515.322701594762, 4581.496035436099, 4721.669483136182, 4735.810567577297, 4743.193657078301, 4614.238650622651, 4630.583247507724, 4665.323528088434, 4680.906381872361, 4750.928736068961, 4324.97837510812, 4346.78266086696, 4346.826126954934, 4366.56334366564, 4387.890302742425, 4294.141171765644, 4317.525072242051, 4408.338749187616, 4430.7784610769495, 4499.6400287976885, 4377.080813029268, 4397.560243975593, 4412.24991751403, 4438.400815889862, 4467.977660111695, 4191.476065491814, 4219.303814870543, 4228.577142285778, 4277.615014648665, 4358.782060896942, 4218.957810421887, 4238.554951730055, 4261.0, 4265.360195970598, 4272.0, 4523.5024147343765, 4557.908841823145, 4647.53524647536, 4666.0, 4707.31743897133, 4835.734034628094, 4850.199717046683, 4931.926021109686, 4941.678790878582, 4991.850244492671, 4808.903821923542, 4877.853664390074, 4941.579965702919, 4947.975260123676, 5013.0725815723845, 4635.119327327797, 4654.86035418938, 4691.929621055687, 4700.177468942921, 4713.6936099153445, 5099.5410413063, 5128.3076784633595, 5140.768665410065, 5145.922811157836, 5169.353830771153, 4742.73914934675, 4873.26900964851, 4904.4605093439695, 4908.950910490921, 4960.330355402047, 4851.223804191312, 4876.926846097241, 4914.877128071756, 4920.188168952154, 4931.580815630711, 4878.195097808893, 4880.511948805091, 4893.314935908976, 4936.654434189572, 4952.20764677657, 4882.438519570295, 4890.95109048912, 4915.243306528052, 4918.385201849769, 4979.825706100269, 4220.366944958281, 4241.681873859473, 4249.213895429355, 4289.871303860889, 4297.656187504992, 3757.098296408842, 3759.793211373346, 3807.9238415232094, 3821.636944490269, 3841.2701586698436, 4326.307790753464, 4329.242382583098, 4330.437043184366, 4330.501992270866, 4377.737335759864, 4805.951940480551, 4853.878653033702, 5014.047331007097, 5017.197248440232, 5078.1874900016555, 4202.537720850704, 4293.97853010733, 4307.763073031013, 4320.179165958458, 4378.036831896978, 4559.886002849889, 4572.839950601713, 4573.908521829611, 4577.977110114494, 4631.583157515773, 4666.533346665374, 4680.695754775928, 4680.812767489262, 4684.976575117239, 4734.26618874075, 4824.324594556835, 4863.586595139453, 4872.244802055687, 4925.113479573711, 4931.728754918514, 4561.657875659405, 4574.519675434165, 4605.078984203105, 4607.0, 4613.284940834176, 4826.6621336506105, 4842.854714358575, 4853.781579828846, 4858.95141048585, 4865.659403841697, 4892.510748925221, 4895.681780684244, 4901.215805471107, 4905.117078925685, 4909.1654418748185, 4724.71651700899, 4775.689580177277, 4789.880252993703, 4792.329073929583, 4806.951930480651, 4687.648426367968, 4687.648426368104, 4690.460597031249, 4702.200625893538, 4704.741239231738, 4652.744099074584, 4741.217699079613, 4749.810007599657, 4771.71369717818, 4827.831025914076, 4876.512348765237, 4878.975605121952, 4880.487548807324, 4881.414230292387, 4925.335079764329, 4656.7671616418365, 4711.199096153594, 4756.6908150970075, 4822.855314340575, 4867.513248675245], "value": 4563.113140708894, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1604469229118, 571.9084946408575, 579.996605871842, 586.3696526234299, 592.1443514122093, 37691.246175076514, 39292.214155716865, 39619.80190099049, 44339.55660443394, 44371.11257774843, 41183.58816411835, 41672.374914376305, 41697.58302416975, 41729.791351043204, 41756.37365439513, 7585.355244804198, 7765.301122898938, 7769.0677118745825, 7770.766876993699, 7773.844523109535, 7812.453128281023, 7903.36773058154, 7904.525728456282, 7905.01187351581, 7907.130215676271, 7905.051393832719, 7922.80192995174, 7942.523448593074, 7946.0, 7948.642311096015, 7856.567888766115, 7890.289873911318, 7891.763247102596, 7893.723719669784, 7901.841963160705, 7769.300762931307, 7835.725749598793, 7837.020372453443, 7839.8432031359625, 7842.254985776342, 38058.42912356317, 38411.23177536461, 38420.23159536822, 38428.42357364642, 38446.42330365047, 2559.795216382685, 2683.6645419322585, 2786.651668541432, 3466.5493485846932, 3556.9110772230642, 27909.441811163662, 28501.0, 28737.28156796076, 29593.26016849596, 30024.249393765112, 3485.35520928629, 3528.947065794015, 3544.397452433067, 3556.3598552260582, 3594.442861356468, 168794.0, 170345.0, 170457.0, 170577.0, 170965.99999999875, 27617.309567260978, 51889.48110518847, 52221.21668174981, 52239.73880130575, 52295.47704522982, 30030.549541756893, 32028.839855800572, 32232.0, 32232.19419514484, 32247.0, 12044.0, 12307.815382769266, 12313.938430307791, 12325.288436543946, 12327.198732082386, 9488.193503552136, 9695.418274903528, 9699.6120155193, 9704.223662107015, 9713.125818676353, 7728.6522106505345, 7748.22517748232, 7757.1079325878245, 7868.449208555347, 7869.331106855867, 3064.739497142768, 3068.8772449102235, 3079.969200308013, 3087.07387783664, 3098.3648352087766, 740.6148802622606, 786.4062632712265, 887.3832686282972, 897.8024834536392, 963.027342384183, 26099.478010439685, 27270.5909411359, 27845.164645060682, 27883.0, 27914.16257512278, 894.8255090257468, 927.0729270729271, 930.2883294279882, 935.9017303183203, 1012.3318609717551, 13983.0, 14549.709005819825, 14566.927165364104, 14810.851891481163, 14949.17779522115, 356561.0, 359712.0, 360832.0, 360986.0, 360997.0, 48802.267965980536, 49363.50636493589, 49411.258831117564, 49537.0, 49553.75223123861, 1019.6635110413694, 1061.1616822710128, 1105.4362275239685, 1136.596508239563, 1153.2792004996877, 27640.447191055664, 28758.0, 29135.85432072826, 29210.7078929208, 29690.703092968793, 41271.58728412678, 41887.790561047, 42122.157556849306, 42158.57841421669, 42228.36657450079, 278804.0, 279122.0, 279948.0, 280453.0, 281356.0, 21887.45281367915, 22611.851874071937, 37599.43600845935, 37650.246995059395, 37689.28883889514, 37810.243795124494, 41900.790496047324, 41994.0, 42017.57982420137, 42060.0, 35599.82200088983, 36359.0, 36372.81813591021, 36586.26827463489, 36629.63370366262, 35592.644073558935, 35752.106197344234, 35833.59580839816, 35928.64071359357, 36038.45942310815, 34605.0, 34856.0, 34864.65135348614, 35108.12229694278, 35470.46794298036, 30199.698003020567, 32753.34493310073, 33112.0, 33259.667403326624, 33542.32915341728, 24286.878565607058, 25181.87409063016, 25354.746452535237, 25419.87290063538, 25687.0], "value": 16069.165423216247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.25473486738366, 358.56255368450496, 362.25737238660747, 371.28898160023556, 384.5904112120591, 15327.157006364645, 16740.246688899, 17305.91347043266, 17394.13029348531, 17405.91297043516, 14089.788653170212, 15709.0, 16229.594260143473, 16379.09914954677, 16398.590035249126, 5010.874728131789, 5202.193659982709, 5240.79036838526, 5244.318238628973, 5280.630355875091, 3736.364817980936, 3940.586238444965, 5118.795248190068, 5941.28704555454, 6274.403931626488, 6254.312025677172, 6257.0, 6257.091587065943, 6259.687015649222, 6261.749530018794, 5995.280566332046, 6172.043333283348, 6190.0405437157315, 6190.721417536177, 6198.845028874269, 5227.581793456515, 5384.542313903323, 5430.809921652763, 5435.0488664483555, 5440.591955603306, 20102.09540570678, 20251.797482025286, 20275.695864562043, 21105.0, 21937.341879743475, 1829.9908500457414, 2057.0640358636933, 2182.301663467691, 2218.4232099654046, 2610.738926107393, 13554.576769439165, 13720.65698357539, 14027.1583704977, 14240.715185696332, 15292.923535382251, 1772.3885259585422, 1854.3417086934214, 1881.2757088520882, 1896.6491199128068, 1937.7190307405347, 69780.0, 74569.6271518639, 75099.62450187714, 76686.0, 77454.61272693657, 15192.848071519364, 15520.223988800515, 16260.455256750589, 16350.264238109314, 16364.972480090983, 27771.44457110887, 27788.722112778614, 27851.721482785317, 27920.720792791813, 27951.58072628912, 7793.0, 7847.0, 7892.210778922176, 8026.0, 8305.543195124204, 6562.015697645392, 6585.078089067534, 6859.691313890787, 6879.5184337096925, 7056.682449289794, 8168.0, 8175.550344731097, 8297.294729947902, 8365.288950439159, 8369.874451883226, 2688.6639170103736, 3196.280836811699, 3213.4376484115655, 3226.935461290761, 3303.8766819281077, 703.7958991892294, 795.8726603743489, 811.8782182672646, 821.1501096365233, 877.1666916429417, 16334.83665163357, 16501.422450214184, 16514.33942642305, 16576.419825306057, 17295.481135565955, 807.608309969676, 816.7835523586255, 827.2513375395276, 835.1189495082746, 845.809692819123, 8253.380996425172, 9094.48172597174, 9512.28657850664, 9647.758806029766, 9735.858111215663, 278772.0, 283958.58020709764, 362896.0, 364491.0, 365790.0, 74835.62582187055, 76880.0, 77608.0, 78375.2162478368, 78436.60781696055, 900.3922352412227, 901.8511945528915, 903.1104362203224, 913.9040400757958, 939.7885475767897, 14944.850551494346, 15395.461158859385, 15505.534833955, 15508.224588770741, 16240.18799060066, 32775.836120819244, 35399.0, 35771.0, 35843.662534985175, 37512.99999999891, 49163.0, 49283.26075108805, 49360.50639493559, 49641.0, 49751.0, 6503.154589903283, 6662.467002639874, 6742.393184613408, 7378.667959941708, 7755.108162561378, 7263.2335616301925, 10847.67456976292, 10872.945635271773, 11112.611058612909, 12202.328871911775, 6662.900621397415, 9976.700698979042, 10211.132053775513, 10251.7437064074, 10328.845067323846, 10141.29010969225, 10237.84643230367, 10374.0, 10379.169666426818, 10825.783484330426, 10104.89895101069, 10461.476926153815, 10530.210234232616, 10747.829390329714, 10808.621698240524, 6971.65141742921, 7125.0, 7394.7781566553085, 7402.0, 7561.848763024819, 8919.866202006846, 9020.548972551478, 9064.320175986959, 10367.637132700622, 10433.843492347469], "value": 8799.554180071624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.5125203674638, 1374.2853716067646, 1428.9714205715886, 1634.713925063115, 1674.1963857348474, 5774.105013722869, 5991.041433370661, 6380.330065343136, 6813.931860681391, 6829.556078854871, 6429.742810287595, 6647.4017338439535, 6658.467322614191, 6772.72909083636, 6774.491913106512, 1974.5754662747506, 1995.5011247188204, 2003.3188715836613, 2009.3469622372713, 2014.244658253155, 1594.1710310638462, 1641.491137747296, 1961.460598335462, 1971.3100414854757, 1977.5945931084166, 1930.0, 2001.8898960557165, 2003.7695664998566, 2005.3883565512513, 2012.0342235726787, 1941.2914286285545, 1965.1746266568075, 1968.252064215596, 1969.7045443183565, 1991.1736629298969, 1984.8908310042941, 1990.5421752996892, 1992.163291417608, 1994.0328940463864, 1994.3717728915344, 6827.897581536281, 6885.070515480446, 6894.345037221506, 6898.034275201426, 6914.792556223271, 3847.384418493056, 3940.1134744682217, 3953.2884080865433, 3957.2679054374744, 3961.1285517186175, 2396.484755777499, 2668.452967141751, 2668.866556672159, 2674.304680782991, 2679.263202619276, 797.6769408389612, 801.9157988411249, 808.6765293882436, 850.808568072185, 856.1181982557976, 8705.260052895512, 8722.34582406322, 8722.781930451789, 8731.825363492695, 8796.824063518758, 3312.9834350828573, 3501.8074005929407, 3528.2061536154674, 3554.360215161296, 3575.910602234965, 7670.194629563927, 7674.57789821554, 7683.923160768432, 7685.5772932488135, 7690.346320562703, 3982.064214909494, 3987.3620220764537, 3987.7407968481957, 3994.940075898864, 3995.9400608990886, 3598.2803439312243, 3609.2781443711365, 3610.1696609779897, 3613.403788374941, 3614.1145419371896, 2943.67619561848, 3056.709612586845, 3066.386722655478, 3082.3681145365144, 3214.8714051438146, 854.2994744309607, 866.0776273268948, 970.1026550440955, 982.7641366072235, 983.6901376066517, 631.9652419116993, 709.5175280808996, 753.7022875964074, 756.1512102908337, 772.212343409719, 4338.089001309697, 4379.299312110047, 4400.779961001937, 4417.690761646718, 4467.955320446754, 734.6693987705554, 766.9884951725617, 796.5380079553845, 800.519688187083, 800.5909599105499, 2829.900953466619, 2850.9002184923843, 3083.953740693891, 3092.5515800208846, 3103.4258662147577, 8168.0, 8227.300679442315, 8351.498910065295, 8365.414420990472, 8369.874451883226, 8267.255946964802, 8270.751877443687, 8275.0, 8276.793080173044, 8290.8341833163, 6291.1192433059405, 6471.385218404244, 6493.22081350241, 6505.316941721146, 6507.609543427409, 4310.094880075219, 4423.977880110579, 4439.4228750262255, 4446.377507149066, 4617.12274667812, 7381.963090184515, 7383.556986580822, 7545.207753185837, 7603.9619801900635, 7610.086789585285, 7585.317321441097, 7661.923380766121, 7693.307602315818, 7735.381169506313, 7761.7671469855995, 5938.4358485945495, 5974.074018527135, 6055.091736239599, 6065.211522502046, 6072.696365181635, 6398.744050237939, 6482.254540727877, 6523.021546768023, 6530.9020364693615, 6532.477401807749, 4737.0, 5703.372629010722, 5717.5425965921795, 5909.497692696169, 5937.643741375531, 5511.724413779375, 5525.143602741581, 5528.944710552843, 5631.915521267266, 5649.152627105967, 5284.392294886137, 5287.334489635752, 5325.840224793263, 5326.813561525328, 5368.033753924331, 3795.5635101963626, 3868.0909986153792, 3891.3190191716903, 3971.245463361952, 3999.3800960851113, 3878.4764056851964, 3886.5336159661024, 3919.7648141111627, 3976.562578116347, 4001.55982841893], "value": 3578.164940634276, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.3805281482885, 261.50444906901424, 263.3613487293314, 270.7847261427165, 271.5695622438435, 4694.6244300455965, 4783.473817880034, 4790.928136077961, 4804.90390192196, 4811.326414301996, 4674.228752255874, 4717.4574923883765, 4718.811247550102, 4740.573348398643, 4764.475907650156, 3462.5325581046613, 3575.535180426541, 3698.4466524059894, 3711.6845068169105, 3711.7772933623933, 3516.82415879205, 3655.3603119454124, 3671.210689701714, 3680.263947210555, 3702.61122582129, 3647.288778688157, 3651.872184473544, 3653.324135035027, 3655.6709896109346, 3661.4690869823858, 3465.9653403465895, 3660.1215708230097, 3677.8300802526637, 3683.134463401112, 3709.3879509880835, 3082.5838511800844, 3101.0, 3163.825989570573, 3166.5408515765316, 3171.730402915755, 4584.885377865547, 4589.2198326284615, 4594.150082234797, 4596.5863072323655, 4615.0, 4132.421460995463, 4145.91708165835, 4150.0, 4151.14901445203, 4155.293600087962, 4804.846836759188, 4880.242213495624, 4893.75531223441, 4906.656534042619, 4956.306117143603, 3439.2777516721517, 3445.104272889042, 3445.7415693822813, 3452.4648679454726, 3465.636108208627, 5171.4311425743135, 5188.299579556787, 5188.558972487305, 5199.272101905736, 5212.139996900545, 3457.7233821294235, 3515.0473602173784, 3548.929021419557, 3552.289542091592, 3559.1458050068313, 3545.2732189901008, 3549.0, 3549.1836877518317, 3552.7690700104927, 3562.1628917204953, 4092.6112019358116, 4100.774457404871, 4112.403701463271, 4126.338511659963, 4142.2751018572235, 4928.334674818925, 4931.5315045070665, 4937.703737775745, 4939.925901111486, 4946.579540739005, 1198.1313547677864, 1235.8630060344506, 1250.3248245947268, 1261.5710658376197, 1263.91784534005, 769.4075561817369, 795.9323457506061, 796.5380079553845, 797.3182928595967, 801.7033697531834, 3896.921432068634, 3919.0, 3919.8040097994985, 4182.2890108681595, 4337.566243375701, 4957.157283261854, 5084.847454576368, 5108.489151084936, 5123.974380128076, 5127.820526281637, 4426.291793313055, 4431.800568974404, 4433.844815431445, 4434.982083152158, 4446.155230506193, 2593.2511537770024, 2686.033028109879, 2707.9593806092926, 2709.173702020863, 2717.885666876571, 4789.161896668139, 4804.183288840905, 4805.111054454937, 4812.927806082912, 4826.034793041335, 5256.6320357574605, 5258.97370513145, 5266.3943646480375, 5273.367195936512, 5293.417724050351, 4647.233206520887, 4783.378160839069, 4811.927821082757, 4863.537963893425, 4872.244802055687, 5094.847154585368, 5098.617603679813, 5123.615728820428, 5129.794498292973, 5153.0, 5029.245613158056, 5036.748162591929, 5040.344755181803, 5082.745862706924, 5095.490450955023, 4694.671373003857, 4781.187198176249, 4818.349522814516, 4821.7348045856415, 4851.611871050378, 3435.896923092311, 3447.9482807758404, 3448.827558622109, 3463.0, 3464.151282935697, 5073.847784566469, 5097.362829646294, 5159.613029022913, 5163.845084647466, 5167.250748641502, 4781.952180478151, 4953.975230123826, 5005.524475174998, 5030.547250747451, 5043.100217375098, 4923.187674033744, 4941.9243917553995, 4955.35580374549, 4956.529129732669, 4987.975060124676, 4870.905510630463, 4871.610271178368, 4911.705297682151, 4915.738760170361, 4929.359183306147, 4783.425988881357, 4967.7019378837385, 4985.950140498694, 4999.225120106389, 5027.396712394536, 4689.0, 4742.956549559091, 4808.975955120202, 4894.314795928502, 4912.6561140719805], "value": 3690.716995289572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.7739858853635, 617.6386813713978, 625.7903602293231, 700.8750954717678, 756.2626439221758, 11340.0, 11984.640460786179, 12034.458449369777, 12098.213616114946, 12788.3605819709, 11173.888261117387, 11266.211365204439, 11322.60370887019, 11326.093912487002, 11361.091112710985, 787.6534324897041, 810.4245985350408, 816.0289255785626, 816.1512027491432, 816.2001238785994, 622.3838399984006, 645.132297060453, 775.1899265267808, 808.7775861638038, 814.3322475570035, 844.9028361738386, 846.2637505370336, 847.2501835875264, 847.4491580472711, 848.3043903998723, 836.4228682209256, 836.4270474724802, 836.5608055770708, 836.5984327522763, 837.4472847920374, 477.00782372664776, 490.23523303646425, 587.8442212813608, 607.177274792654, 612.3845535237058, 11565.363904985223, 11584.884151158549, 11608.76782464346, 11613.070954323633, 11613.30320180792, 11509.251898626646, 12029.51881924722, 12242.143049986504, 12656.303903285316, 12680.112392132554, 9433.151016408488, 9524.666636667684, 9541.188998935098, 9632.373895696757, 10359.119474844647, 4078.80476470908, 4080.18396320737, 4119.526254480743, 4161.83352665893, 4167.374893765959, 49066.50933490655, 49781.0, 50018.74990625024, 50344.0, 50434.0, 9600.231981441608, 9724.0, 9800.460974646463, 9807.411555306704, 9912.504374781376, 16792.748108778378, 16882.240299186567, 16907.40824071176, 16937.0, 17065.317387304618, 6322.146510221061, 6326.536692919672, 6416.7754128605275, 6531.510136739764, 6586.110875031809, 3573.2317551726505, 3650.7261955353456, 3656.835442405098, 3661.8901432957055, 3712.480252764615, 2522.2685421228007, 2646.3251870773215, 2651.0323731838125, 2651.3239124023253, 2988.6712461629204, 526.5024551798514, 527.2223470381234, 536.1742915909533, 537.9246905433242, 548.2872266054113, 562.3224015061841, 574.1817909478975, 596.3053043204704, 597.3429227849331, 603.809799913026, 6934.16789985205, 6937.826554336182, 7048.964755176191, 7173.856522869513, 7230.6384680766805, 511.7748190796038, 556.5909056843217, 558.2268558047053, 559.1975515135712, 563.6364544868537, 3357.1103657530775, 3385.0874256045254, 3394.13449570358, 3441.6558344165883, 3470.0457374221787, 68282.65858670774, 71313.6434317825, 72147.0, 72208.63895680488, 75266.62366688241, 36681.63318366782, 45200.0, 53600.0, 65732.34267657262, 65984.0, 58586.7070664644, 59225.11162332568, 59404.0, 60590.0, 61302.0, 6309.828771740516, 6485.0, 6626.536142470173, 6816.284290149463, 6924.58452492852, 39401.60598393979, 39919.0, 39933.60066399415, 40114.79942600268, 41196.588034119275, 44344.33483497686, 44488.0, 45903.31145032894, 46149.769251154874, 46499.30251046304, 10524.789504209719, 10630.73423164427, 10789.56841726322, 10806.837897431702, 11065.114790816877, 11648.475818588353, 11656.30062196271, 11707.88292117102, 12090.45592948337, 12278.14053016316, 10436.843447348449, 10617.362958222531, 10783.784324313312, 11002.724931876766, 11137.77004668637, 10823.242373034127, 11035.172362072715, 11109.777804443704, 11237.55049797999, 11351.318920864775, 10435.16518678519, 10465.9476702616, 10529.0, 10533.631322903662, 10551.103156231806, 8953.448267243804, 9136.588853501742, 9778.608855645694, 9906.25703072258, 9970.601175952881, 9740.415575065519, 9752.463614500986, 9816.950915245377, 9820.361676491006, 9871.605135794774], "value": 6009.129915946411, "unit": "score"}], "name": "dromaeo_css", "value": 6093.85611253822, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 118.0, 114.0, 116.0, 116.0, 115.0, 116.0, 116.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 129.0, 166.0, 135.0, 127.0, 132.0, 127.0, 157.0, 128.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 170.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 111.0, 76.0, 76.0, 76.0, 75.0, 102.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 84.0, 84.0, 108.0, 83.0, 82.0, 120.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 63.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 93.0, 84.0, 84.0, 83.0, 91.0, 90.0, 89.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 142.0, 140.0, 141.0, 142.0, 141.0, 142.0, 157.0, 182.0, 146.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 181.0, 188.0, 180.0, 183.0, 180.0, 180.0, 193.0, 188.0, 183.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 71.0, 74.0, 71.0, 71.0, 70.0, 70.0, 72.0, 69.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1556.1000000000001, "alertThreshold": 2.0}]} 15:36:56 INFO - Return code: 0 15:36:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:36:56 INFO - # TBPL SUCCESS # 15:36:56 INFO - Running post-action listener: _resource_record_post_action 15:36:56 INFO - [mozharness: 2016-10-25 22:36:56.769303Z] Finished run-tests step (success) 15:36:56 INFO - Running post-run listener: _resource_record_post_run 15:36:56 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405819392; Read time: 20; Write time: 246884 15:36:56 INFO - TinderboxPrint: CPU usage
13.0% 15:36:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 15:36:56 INFO - TinderboxPrint: I/O write bytes / time
405,819,392 / 246,884 15:36:56 INFO - TinderboxPrint: CPU idle
8,346.1 (86.9%) 15:36:56 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 15:36:56 INFO - TinderboxPrint: Swap in / out
0 / 0 15:36:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110223360; Read time: 0; Write time: 55568 15:36:56 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294424576; Read time: 0; Write time: 191280 15:36:57 INFO - Running post-run listener: _upload_blobber_files 15:36:57 INFO - Blob upload gear active. 15:36:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:57 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 15:36:57 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'] 15:36:57 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 15:36:57 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:36:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:36:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:58 INFO - (blobuploader) - INFO - Done attempting. 15:36:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:36:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:37:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:01 INFO - (blobuploader) - INFO - Done attempting. 15:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:37:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:02 INFO - (blobuploader) - INFO - Done attempting. 15:37:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:02 INFO - Return code: 0 15:37:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e137cc572c31004d29333a6474e9bef3e8f0d75788853cd369352bc47a8efb8ec785212e28f30f81dff7795482712f1e71ce9ca661993b312744cc829dc15031", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/453fb2d99a1479130034290696062ec0e8404369f2ce31765e612140609e0b38afc5b6c32473bc6eb63bfdc979eca76e6eb5975d3972ad0ffb987e1196d9af5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b467383703f6ab9862871fbe02254e62b583b33380ed2526682ce275474652f4e1b50da7267ac49b8172ea7eb89f49372f73c9a1afd6b935fc6a7e6079b9784c"} 15:37:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:02 INFO - Contents: 15:37:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e137cc572c31004d29333a6474e9bef3e8f0d75788853cd369352bc47a8efb8ec785212e28f30f81dff7795482712f1e71ce9ca661993b312744cc829dc15031", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/453fb2d99a1479130034290696062ec0e8404369f2ce31765e612140609e0b38afc5b6c32473bc6eb63bfdc979eca76e6eb5975d3972ad0ffb987e1196d9af5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b467383703f6ab9862871fbe02254e62b583b33380ed2526682ce275474652f4e1b50da7267ac49b8172ea7eb89f49372f73c9a1afd6b935fc6a7e6079b9784c"} 15:37:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:02 INFO - Copying logs to upload dir... 15:37:02 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.454057 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-25 15:37:02.231801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 15:37:02.234871) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224 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/e137cc572c31004d29333a6474e9bef3e8f0d75788853cd369352bc47a8efb8ec785212e28f30f81dff7795482712f1e71ce9ca661993b312744cc829dc15031", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/453fb2d99a1479130034290696062ec0e8404369f2ce31765e612140609e0b38afc5b6c32473bc6eb63bfdc979eca76e6eb5975d3972ad0ffb987e1196d9af5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b467383703f6ab9862871fbe02254e62b583b33380ed2526682ce275474652f4e1b50da7267ac49b8172ea7eb89f49372f73c9a1afd6b935fc6a7e6079b9784c"} build_url:https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/RGbGNrgiSsmO765332Y3Tw/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/e137cc572c31004d29333a6474e9bef3e8f0d75788853cd369352bc47a8efb8ec785212e28f30f81dff7795482712f1e71ce9ca661993b312744cc829dc15031", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/453fb2d99a1479130034290696062ec0e8404369f2ce31765e612140609e0b38afc5b6c32473bc6eb63bfdc979eca76e6eb5975d3972ad0ffb987e1196d9af5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b467383703f6ab9862871fbe02254e62b583b33380ed2526682ce275474652f4e1b50da7267ac49b8172ea7eb89f49372f73c9a1afd6b935fc6a7e6079b9784c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 15:37:02.260256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:37:02.260598) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477433576.379128-560636224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:37:02.345352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 15:37:02.345670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 15:37:02.345971) ========= ========= Total master_lag: 0.17 =========