builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1480180657.69 results: success (0) buildid: 20161126062719 builduid: 30124f9638c94b50b6f27fa53bf20f66 revision: fe8d7e54713a87a4a356a77ff35b0830a8567e76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.693879) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.694442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.694749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.714745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.715151) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 09:17:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.5K=0.3s 2016-11-26 09:17:38 (45.5 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.335315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.064514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.064849) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016951 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.114798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.115428) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fe8d7e54713a87a4a356a77ff35b0830a8567e76 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fe8d7e54713a87a4a356a77ff35b0830a8567e76 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 09:17:38,768 truncating revision to first 12 chars 2016-11-26 09:17:38,768 Setting DEBUG logging. 2016-11-26 09:17:38,768 attempt 1/10 2016-11-26 09:17:38,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fe8d7e54713a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 09:17:39,057 unpacking tar archive at: mozilla-aurora-fe8d7e54713a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626142 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.755917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.756255) ========= script_repo_revision: fe8d7e54713a87a4a356a77ff35b0830a8567e76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.756705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.757029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.766435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-26 09:17:38.766869) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:17:39 INFO - MultiFileLogger online at 20161126 09:17:39 in /builds/slave/test 09:17:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:17:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:39 INFO - {'append_to_log': False, 09:17:39 INFO - 'base_work_dir': '/builds/slave/test', 09:17:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:17:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:39 INFO - 'branch': 'Mozilla-Aurora', 09:17:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:39 INFO - 'config_files': ('talos/linux_config.py',), 09:17:39 INFO - 'default_actions': ('clobber', 09:17:39 INFO - 'read-buildbot-config', 09:17:39 INFO - 'download-and-extract', 09:17:39 INFO - 'populate-webroot', 09:17:39 INFO - 'create-virtualenv', 09:17:39 INFO - 'install', 09:17:39 INFO - 'run-tests'), 09:17:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:39 INFO - 'download_minidump_stackwalk': True, 09:17:39 INFO - 'download_symbols': 'ondemand', 09:17:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:39 INFO - 'installer_path': 'installer.exe', 09:17:39 INFO - 'log_level': 'info', 09:17:39 INFO - 'log_name': 'talos', 09:17:39 INFO - 'log_to_console': True, 09:17:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:17:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:17:39 INFO - 'opt_config_files': (), 09:17:39 INFO - 'pip_index': False, 09:17:39 INFO - 'sps_profile': False, 09:17:39 INFO - 'sps_profile_interval': 0, 09:17:39 INFO - 'suite': 'dromaeojs-e10s', 09:17:39 INFO - 'system_bits': '32', 09:17:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:39 INFO - 'title': 'talos-linux64-ix-048', 09:17:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:39 INFO - 'use_talos_json': True, 09:17:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:39 INFO - 'work_dir': 'build'} 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.520425Z] Running clobber step. 09:17:39 INFO - Running pre-action listener: _resource_record_pre_action 09:17:39 INFO - Running main action method: clobber 09:17:39 INFO - rmtree: /builds/slave/test/build 09:17:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:39 INFO - Running post-action listener: _resource_record_post_action 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.977270Z] Finished clobber step (success) 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.977369Z] Running read-buildbot-config step. 09:17:39 INFO - Running pre-action listener: _resource_record_pre_action 09:17:39 INFO - Running main action method: read_buildbot_config 09:17:39 INFO - Using buildbot properties: 09:17:39 INFO - { 09:17:39 INFO - "project": "", 09:17:39 INFO - "product": "firefox", 09:17:39 INFO - "script_repo_revision": "production", 09:17:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:17:39 INFO - "repository": "", 09:17:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:17:39 INFO - "buildid": "20161126062719", 09:17:39 INFO - "pgo_build": "True", 09:17:39 INFO - "basedir": "/builds/slave/test", 09:17:39 INFO - "buildnumber": 670, 09:17:39 INFO - "slavename": "talos-linux64-ix-048", 09:17:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:17:39 INFO - "platform": "ubuntu64_hw", 09:17:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:17:39 INFO - "branch": "mozilla-aurora", 09:17:39 INFO - "repo_path": "releases/mozilla-aurora", 09:17:39 INFO - "revision": "fe8d7e54713a87a4a356a77ff35b0830a8567e76", 09:17:39 INFO - "stage_platform": "linux64-pgo", 09:17:39 INFO - "builduid": "30124f9638c94b50b6f27fa53bf20f66", 09:17:39 INFO - "slavebuilddir": "test" 09:17:39 INFO - } 09:17:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:17:39 INFO - Running post-action listener: _resource_record_post_action 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.979816Z] Finished read-buildbot-config step (success) 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.979905Z] Running download-and-extract step. 09:17:39 INFO - Running pre-action listener: _resource_record_pre_action 09:17:39 INFO - Running main action method: download_and_extract 09:17:39 INFO - mkdir: /builds/slave/test/build/tests 09:17: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')]} 09:17:39 INFO - trying https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:17:39 INFO - Downloading https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:17:40 INFO - Downloaded 1361 bytes. 09:17:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:17:40 INFO - Using the following test package requirements: 09:17:40 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:17:40 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:17:40 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:17:40 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'jsshell-linux-x86_64.zip'], 09:17:40 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:17:40 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:17:40 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:17:40 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:17:40 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:17:40 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:17:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:17:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:17:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:40 INFO - Fetch https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:17:41 INFO - Http code: 200 09:17:41 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 09:17:41 INFO - x-amz-cf-id: O_KmtoLxPo56rC_fiMI7b8KQy8nC6SFWjn2Gblp8CGoEviXHZ723Yg== 09:17:41 INFO - x-amz-version-id: 7OKOiiZTqMXrNDIvyZbzeEY_Zy2l3fYA 09:17:41 INFO - Expected file size: 21951407 09:17:41 INFO - Obtained file size: 21951407 09:17:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:17:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:17:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:17:46 INFO - Http code: 200 09:17:46 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 09:17:46 INFO - x-amz-cf-id: 51GC5nh4Q4vqdUbXLLKze9TQMV0_kvjwJ2wbpXCQ9ddgujmgd4u3cg== 09:17:46 INFO - x-amz-version-id: 7OKOiiZTqMXrNDIvyZbzeEY_Zy2l3fYA 09:17:46 INFO - Expected file size: 21951407 09:17:46 INFO - Obtained file size: 21951407 09:17:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:17:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:17:50 INFO - Fetch https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:17:51 INFO - Http code: 200 09:17:51 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:17:51 INFO - x-amz-cf-id: -KK1rEJCDVH4FWWpQgmLdQizCHp4ZfnzRgNzpZ1vMy-KcOp2a6b2lw== 09:17:51 INFO - x-amz-version-id: HQBp6Mo546IVZ4t91ANO1QAFy4x3WkWe 09:17:51 INFO - Expected file size: 14409038 09:17:51 INFO - Obtained file size: 14409038 09:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:51 INFO - trying https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:51 INFO - Downloading https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:17:53 INFO - Downloaded 63966616 bytes. 09:17:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:53 INFO - mkdir: /builds/slave/test/properties 09:17:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:17:53 INFO - Writing to file /builds/slave/test/properties/build_url 09:17:53 INFO - Contents: 09:17:53 INFO - build_url:https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - Running post-action listener: set_extra_try_arguments 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.719051Z] Finished download-and-extract step (success) 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.719369Z] Running populate-webroot step. 09:17:53 INFO - Running pre-action listener: _resource_record_pre_action 09:17:53 INFO - Running main action method: populate_webroot 09:17:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:53 INFO - '--tppagecycles', 09:17:53 INFO - '7'], 09:17:53 INFO - 'tests': ['tsvgm']}}, 09:17:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:17:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:17:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:17:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['damp', 'tps']}, 09:17:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['damp', 'tps']}, 09:17:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['dromaeo_dom']}, 09:17:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['basic_compositor_video']}, 09:17:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:17:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tsvgx', 09:17:53 INFO - 'tsvgr_opacity', 09:17:53 INFO - 'tart', 09:17:53 INFO - 'tscrollx', 09:17:53 INFO - 'cart']}, 09:17:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:17:53 INFO - 'tsvgr_opacity', 09:17:53 INFO - 'tart', 09:17:53 INFO - 'tscrollx', 09:17:53 INFO - 'cart']}, 09:17:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tp5o']}, 09:17:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['tp5o']}, 09:17:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s', 09:17:53 INFO - '--xperf_path', 09:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:53 INFO - 'tests': ['tp5n']}, 09:17:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--xperf_path', 09:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:53 INFO - 'tests': ['tp5n']}}, 09:17:53 INFO - 'talos.zip': {'path': '', 09:17:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.736874Z] Finished populate-webroot step (success) 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.736962Z] Running create-virtualenv step. 09:17:53 INFO - Running pre-action listener: _resource_record_pre_action 09:17:53 INFO - Running main action method: create_virtualenv 09:17:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:17:53 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 09:17:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:17:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:53 INFO - Using real prefix '/usr' 09:17:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:17:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:56 INFO - Installing pip.................done. 09:17:56 INFO - Return code: 0 09:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:17:56 INFO - Reading from file tmpfile_stdout 09:17:56 INFO - Output received: 09:17:56 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) 09:17:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:56 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')]} 09:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 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')]} 09:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:17:56 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 09:17:56 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 09:17:56 INFO - Using env: {'DISPLAY': ':0', 09:17:56 INFO - 'HOME': '/home/cltbld', 09:17:56 INFO - 'LANG': 'en_US.UTF-8', 09:17:56 INFO - 'LANGUAGE': 'en_US:en', 09:17:56 INFO - 'LOGNAME': 'cltbld', 09:17:56 INFO - 'MAIL': '/var/mail/cltbld', 09:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:56 INFO - 'MOZ_NO_REMOTE': '1', 09:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:56 INFO - 'NO_EM_RESTART': '1', 09:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:56 INFO - 'PWD': '/builds/slave/test', 09:17:56 INFO - 'SHELL': '/bin/bash', 09:17:56 INFO - 'SHLVL': '1', 09:17:56 INFO - 'TERM': 'linux', 09:17:56 INFO - 'TMOUT': '86400', 09:17:56 INFO - 'USER': 'cltbld', 09:17:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:56 INFO - '_': '/tools/buildbot/bin/python'} 09:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:56 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 09:17:56 INFO - Cleaning up... 09:17:56 INFO - Return code: 0 09:17:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:17:56 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')]} 09:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 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')]} 09:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:17:56 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 09:17:56 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 09:17:56 INFO - Using env: {'DISPLAY': ':0', 09:17:56 INFO - 'HOME': '/home/cltbld', 09:17:56 INFO - 'LANG': 'en_US.UTF-8', 09:17:56 INFO - 'LANGUAGE': 'en_US:en', 09:17:56 INFO - 'LOGNAME': 'cltbld', 09:17:56 INFO - 'MAIL': '/var/mail/cltbld', 09:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:56 INFO - 'MOZ_NO_REMOTE': '1', 09:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:56 INFO - 'NO_EM_RESTART': '1', 09:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:56 INFO - 'PWD': '/builds/slave/test', 09:17:56 INFO - 'SHELL': '/bin/bash', 09:17:56 INFO - 'SHLVL': '1', 09:17:56 INFO - 'TERM': 'linux', 09:17:56 INFO - 'TMOUT': '86400', 09:17:56 INFO - 'USER': 'cltbld', 09:17:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:56 INFO - '_': '/tools/buildbot/bin/python'} 09:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:56 INFO - Downloading/unpacking psutil>=3.1.1 09:17:56 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 09:17:56 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 09:17:56 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 09:17:56 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 09:17:56 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 09:17:56 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 09:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:59 INFO - Installing collected packages: psutil 09:17:59 INFO - Running setup.py install for psutil 09:17:59 INFO - building 'psutil._psutil_linux' extension 09:17:59 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 09:17:59 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 09:17:59 INFO - building 'psutil._psutil_posix' extension 09:17:59 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 09:17:59 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 09:17:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:59 INFO - Successfully installed psutil 09:17:59 INFO - Cleaning up... 09:17:59 INFO - Return code: 0 09:17:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:17:59 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')]} 09:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 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')]} 09:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:17:59 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 09:17:59 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 09:17:59 INFO - Using env: {'DISPLAY': ':0', 09:17:59 INFO - 'HOME': '/home/cltbld', 09:17:59 INFO - 'LANG': 'en_US.UTF-8', 09:17:59 INFO - 'LANGUAGE': 'en_US:en', 09:17:59 INFO - 'LOGNAME': 'cltbld', 09:17:59 INFO - 'MAIL': '/var/mail/cltbld', 09:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:59 INFO - 'MOZ_NO_REMOTE': '1', 09:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:59 INFO - 'NO_EM_RESTART': '1', 09:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:59 INFO - 'PWD': '/builds/slave/test', 09:17:59 INFO - 'SHELL': '/bin/bash', 09:17:59 INFO - 'SHLVL': '1', 09:17:59 INFO - 'TERM': 'linux', 09:17:59 INFO - 'TMOUT': '86400', 09:17:59 INFO - 'USER': 'cltbld', 09:17:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:59 INFO - '_': '/tools/buildbot/bin/python'} 09:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:17:59 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 09:17:59 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 09:17:59 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 09:17:59 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 09:17:59 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 09:17:59 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 09:18:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:01 INFO - Installing collected packages: mozsystemmonitor 09:18:01 INFO - Running setup.py install for mozsystemmonitor 09:18:01 INFO - Successfully installed mozsystemmonitor 09:18:01 INFO - Cleaning up... 09:18:01 INFO - Return code: 0 09:18:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:01 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')]} 09:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:01 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')]} 09:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:01 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:18:01 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 09:18:01 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 09:18:01 INFO - Using env: {'DISPLAY': ':0', 09:18:01 INFO - 'HOME': '/home/cltbld', 09:18:01 INFO - 'LANG': 'en_US.UTF-8', 09:18:01 INFO - 'LANGUAGE': 'en_US:en', 09:18:01 INFO - 'LOGNAME': 'cltbld', 09:18:01 INFO - 'MAIL': '/var/mail/cltbld', 09:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:01 INFO - 'MOZ_NO_REMOTE': '1', 09:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:01 INFO - 'NO_EM_RESTART': '1', 09:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:01 INFO - 'PWD': '/builds/slave/test', 09:18:01 INFO - 'SHELL': '/bin/bash', 09:18:01 INFO - 'SHLVL': '1', 09:18:01 INFO - 'TERM': 'linux', 09:18:01 INFO - 'TMOUT': '86400', 09:18:01 INFO - 'USER': 'cltbld', 09:18:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:01 INFO - '_': '/tools/buildbot/bin/python'} 09:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:02 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:02 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 09:18:02 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 09:18:02 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 09:18:02 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 09:18:02 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 09:18:02 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 09:18:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:04 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 09:18:04 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 09:18:04 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 09:18:04 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 09:18:04 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 09:18:04 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 09:18:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:04 INFO - warning: no files found matching '*.txt' 09:18:04 INFO - no previously-included directories found matching 'build' 09:18:04 INFO - no previously-included directories found matching 'dist' 09:18:04 INFO - no previously-included directories found matching '.git*' 09:18:04 INFO - Installing collected packages: jsonschema, functools32 09:18:04 INFO - Running setup.py install for functools32 09:18:04 INFO - warning: no files found matching '*.txt' 09:18:04 INFO - no previously-included directories found matching 'build' 09:18:04 INFO - no previously-included directories found matching 'dist' 09:18:04 INFO - no previously-included directories found matching '.git*' 09:18:04 INFO - Successfully installed jsonschema functools32 09:18:04 INFO - Cleaning up... 09:18:04 INFO - Return code: 0 09:18:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:04 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')]} 09:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 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')]} 09:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:18:04 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 09:18:04 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 09:18:04 INFO - Using env: {'DISPLAY': ':0', 09:18:04 INFO - 'HOME': '/home/cltbld', 09:18:04 INFO - 'LANG': 'en_US.UTF-8', 09:18:04 INFO - 'LANGUAGE': 'en_US:en', 09:18:04 INFO - 'LOGNAME': 'cltbld', 09:18:04 INFO - 'MAIL': '/var/mail/cltbld', 09:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:04 INFO - 'MOZ_NO_REMOTE': '1', 09:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:04 INFO - 'NO_EM_RESTART': '1', 09:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:04 INFO - 'PWD': '/builds/slave/test', 09:18:04 INFO - 'SHELL': '/bin/bash', 09:18:04 INFO - 'SHLVL': '1', 09:18:04 INFO - 'TERM': 'linux', 09:18:04 INFO - 'TMOUT': '86400', 09:18:04 INFO - 'USER': 'cltbld', 09:18:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:04 INFO - '_': '/tools/buildbot/bin/python'} 09:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:04 INFO - Cleaning up... 09:18:04 INFO - Return code: 0 09:18:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:04 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')]} 09:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 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')]} 09:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:18:04 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 09:18:04 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 09:18:04 INFO - Using env: {'DISPLAY': ':0', 09:18:04 INFO - 'HOME': '/home/cltbld', 09:18:04 INFO - 'LANG': 'en_US.UTF-8', 09:18:04 INFO - 'LANGUAGE': 'en_US:en', 09:18:04 INFO - 'LOGNAME': 'cltbld', 09:18:04 INFO - 'MAIL': '/var/mail/cltbld', 09:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:04 INFO - 'MOZ_NO_REMOTE': '1', 09:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:04 INFO - 'NO_EM_RESTART': '1', 09:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:04 INFO - 'PWD': '/builds/slave/test', 09:18:04 INFO - 'SHELL': '/bin/bash', 09:18:04 INFO - 'SHLVL': '1', 09:18:04 INFO - 'TERM': 'linux', 09:18:04 INFO - 'TMOUT': '86400', 09:18:04 INFO - 'USER': 'cltbld', 09:18:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:04 INFO - '_': '/tools/buildbot/bin/python'} 09:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:18:05 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 09:18:05 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 09:18:05 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 09:18:05 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 09:18:05 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 09:18:05 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 09:18:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 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 09:18:07 INFO - Downloading docopt-0.6.1.tar.gz 09:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:07 INFO - Running setup.py install for blobuploader 09:18:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:07 INFO - Running setup.py install for requests 09:18:08 INFO - Running setup.py install for docopt 09:18:08 INFO - Successfully installed blobuploader requests docopt 09:18:08 INFO - Cleaning up... 09:18:08 INFO - Return code: 0 09:18:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:08 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:18:08 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 09:18:08 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 09:18:08 INFO - Using env: {'DISPLAY': ':0', 09:18:08 INFO - 'HOME': '/home/cltbld', 09:18:08 INFO - 'LANG': 'en_US.UTF-8', 09:18:08 INFO - 'LANGUAGE': 'en_US:en', 09:18:08 INFO - 'LOGNAME': 'cltbld', 09:18:08 INFO - 'MAIL': '/var/mail/cltbld', 09:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:08 INFO - 'MOZ_NO_REMOTE': '1', 09:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:08 INFO - 'NO_EM_RESTART': '1', 09:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:08 INFO - 'PWD': '/builds/slave/test', 09:18:08 INFO - 'SHELL': '/bin/bash', 09:18:08 INFO - 'SHLVL': '1', 09:18:08 INFO - 'TERM': 'linux', 09:18:08 INFO - 'TMOUT': '86400', 09:18:08 INFO - 'USER': 'cltbld', 09:18:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:08 INFO - '_': '/tools/buildbot/bin/python'} 09:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:08 INFO - Running setup.py (path:/tmp/pip-d_4xMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:08 INFO - Running setup.py (path:/tmp/pip-344yDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:08 INFO - Running setup.py (path:/tmp/pip-GFzOrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:08 INFO - Running setup.py (path:/tmp/pip-UKBdOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:08 INFO - Running setup.py (path:/tmp/pip-sdpzk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:08 INFO - Running setup.py (path:/tmp/pip-EDMGzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:09 INFO - Running setup.py (path:/tmp/pip-4r8O_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:09 INFO - Running setup.py (path:/tmp/pip-MddR3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:09 INFO - Running setup.py (path:/tmp/pip-m0MUnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:09 INFO - Running setup.py (path:/tmp/pip-TiK4_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:09 INFO - Running setup.py (path:/tmp/pip-snZzVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:09 INFO - Running setup.py (path:/tmp/pip-jP4E7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:09 INFO - Running setup.py (path:/tmp/pip-SEBvGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:09 INFO - Running setup.py (path:/tmp/pip-N6F3Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:09 INFO - Running setup.py (path:/tmp/pip-KDQnuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:09 INFO - Running setup.py (path:/tmp/pip-N1m85Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:09 INFO - Running setup.py (path:/tmp/pip-sCD2BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:09 INFO - Running setup.py install for manifestparser 09:18:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:09 INFO - Running setup.py install for mozcrash 09:18:10 INFO - Running setup.py install for mozdebug 09:18:10 INFO - Running setup.py install for mozdevice 09:18:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozfile 09:18:10 INFO - Running setup.py install for mozhttpd 09:18:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozinfo 09:18:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozInstall 09:18:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozleak 09:18:10 INFO - Running setup.py install for mozlog 09:18:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for moznetwork 09:18:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozprocess 09:18:11 INFO - Running setup.py install for mozprofile 09:18:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:11 INFO - Running setup.py install for mozrunner 09:18:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:11 INFO - Running setup.py install for mozscreenshot 09:18:11 INFO - Running setup.py install for moztest 09:18:11 INFO - Running setup.py install for mozversion 09:18:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:11 INFO - Cleaning up... 09:18:11 INFO - Return code: 0 09:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:11 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:18:11 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 09:18:11 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 09:18:11 INFO - Using env: {'DISPLAY': ':0', 09:18:11 INFO - 'HOME': '/home/cltbld', 09:18:11 INFO - 'LANG': 'en_US.UTF-8', 09:18:11 INFO - 'LANGUAGE': 'en_US:en', 09:18:11 INFO - 'LOGNAME': 'cltbld', 09:18:11 INFO - 'MAIL': '/var/mail/cltbld', 09:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:11 INFO - 'MOZ_NO_REMOTE': '1', 09:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:11 INFO - 'NO_EM_RESTART': '1', 09:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:11 INFO - 'PWD': '/builds/slave/test', 09:18:11 INFO - 'SHELL': '/bin/bash', 09:18:11 INFO - 'SHLVL': '1', 09:18:11 INFO - 'TERM': 'linux', 09:18:11 INFO - 'TMOUT': '86400', 09:18:11 INFO - 'USER': 'cltbld', 09:18:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:11 INFO - '_': '/tools/buildbot/bin/python'} 09:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:11 INFO - Running setup.py (path:/tmp/pip-u1ilAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:11 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)) 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:11 INFO - Running setup.py (path:/tmp/pip-Z0p4QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:12 INFO - Running setup.py (path:/tmp/pip-xU7ggg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:12 INFO - Running setup.py (path:/tmp/pip-jgvxIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:12 INFO - Running setup.py (path:/tmp/pip-C7wiz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:12 INFO - Running setup.py (path:/tmp/pip-zBxWmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:12 INFO - Running setup.py (path:/tmp/pip-MRHnkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:12 INFO - Running setup.py (path:/tmp/pip-QajVLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:12 INFO - Running setup.py (path:/tmp/pip-2SzVpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:12 INFO - Running setup.py (path:/tmp/pip-d6l8QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:12 INFO - Running setup.py (path:/tmp/pip-MyVRIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:12 INFO - Running setup.py (path:/tmp/pip-74fIxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:12 INFO - Running setup.py (path:/tmp/pip-k2iZUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:12 INFO - Running setup.py (path:/tmp/pip-7PF0nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:12 INFO - Running setup.py (path:/tmp/pip-dQWEyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:12 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)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:12 INFO - Running setup.py (path:/tmp/pip-6akMBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:13 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)) 09:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:13 INFO - Running setup.py (path:/tmp/pip-uALgdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:13 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)) 09:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:13 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)) 09:18:13 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)) 09:18:13 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)) 09:18:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:15 INFO - Downloading blessings-1.6.tar.gz 09:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:15 INFO - Installing collected packages: blessings 09:18:15 INFO - Running setup.py install for blessings 09:18:15 INFO - Successfully installed blessings 09:18:15 INFO - Cleaning up... 09:18:15 INFO - Return code: 0 09:18:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:15 INFO - Reading from file tmpfile_stdout 09:18:15 INFO - Current package versions: 09:18:15 INFO - argparse == 1.2.1 09:18:15 INFO - blessings == 1.6 09:18:15 INFO - blobuploader == 1.2.4 09:18:15 INFO - docopt == 0.6.1 09:18:15 INFO - functools32 == 3.2.3-2 09:18:15 INFO - jsonschema == 2.5.1 09:18:15 INFO - manifestparser == 1.1 09:18:15 INFO - mozInstall == 1.12 09:18:15 INFO - mozcrash == 1.0 09:18:15 INFO - mozdebug == 0.1 09:18:15 INFO - mozdevice == 0.48 09:18:15 INFO - mozfile == 1.2 09:18:15 INFO - mozhttpd == 0.7 09:18:15 INFO - mozinfo == 0.9 09:18:15 INFO - mozleak == 0.1 09:18:15 INFO - mozlog == 3.4 09:18:15 INFO - moznetwork == 0.27 09:18:15 INFO - mozprocess == 0.23 09:18:15 INFO - mozprofile == 0.28 09:18:15 INFO - mozrunner == 6.13 09:18:15 INFO - mozscreenshot == 0.1 09:18:15 INFO - mozsystemmonitor == 0.3 09:18:15 INFO - moztest == 0.7 09:18:15 INFO - mozversion == 1.4 09:18:15 INFO - psutil == 3.1.1 09:18:15 INFO - requests == 1.2.3 09:18:15 INFO - wsgiref == 0.1.2 09:18:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:15 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')]} 09:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 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')]} 09:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:18:15 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 09:18:15 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 09:18:15 INFO - Using env: {'DISPLAY': ':0', 09:18:15 INFO - 'HOME': '/home/cltbld', 09:18:15 INFO - 'LANG': 'en_US.UTF-8', 09:18:15 INFO - 'LANGUAGE': 'en_US:en', 09:18:15 INFO - 'LOGNAME': 'cltbld', 09:18:15 INFO - 'MAIL': '/var/mail/cltbld', 09:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:15 INFO - 'MOZ_NO_REMOTE': '1', 09:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:15 INFO - 'NO_EM_RESTART': '1', 09:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:15 INFO - 'PWD': '/builds/slave/test', 09:18:15 INFO - 'SHELL': '/bin/bash', 09:18:15 INFO - 'SHLVL': '1', 09:18:15 INFO - 'TERM': 'linux', 09:18:15 INFO - 'TMOUT': '86400', 09:18:15 INFO - 'USER': 'cltbld', 09:18:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:15 INFO - '_': '/tools/buildbot/bin/python'} 09:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 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)) 09:18:15 INFO - Cleaning up... 09:18:15 INFO - Return code: 0 09:18:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:15 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')]} 09:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 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')]} 09:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 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 0x7f9e01b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', '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 09:18:15 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 09:18:15 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 09:18:15 INFO - Using env: {'DISPLAY': ':0', 09:18:15 INFO - 'HOME': '/home/cltbld', 09:18:15 INFO - 'LANG': 'en_US.UTF-8', 09:18:15 INFO - 'LANGUAGE': 'en_US:en', 09:18:15 INFO - 'LOGNAME': 'cltbld', 09:18:15 INFO - 'MAIL': '/var/mail/cltbld', 09:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:15 INFO - 'MOZ_NO_REMOTE': '1', 09:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:15 INFO - 'NO_EM_RESTART': '1', 09:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:15 INFO - 'PWD': '/builds/slave/test', 09:18:15 INFO - 'SHELL': '/bin/bash', 09:18:15 INFO - 'SHLVL': '1', 09:18:15 INFO - 'TERM': 'linux', 09:18:15 INFO - 'TMOUT': '86400', 09:18:15 INFO - 'USER': 'cltbld', 09:18:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:15 INFO - '_': '/tools/buildbot/bin/python'} 09:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:15 INFO - Cleaning up... 09:18:15 INFO - Return code: 0 09:18:15 INFO - Running post-action listener: _resource_record_post_action 09:18:15 INFO - Running post-action listener: _start_resource_monitoring 09:18:16 INFO - Starting resource monitoring. 09:18:16 INFO - [mozharness: 2016-11-26 17:18:16.027624Z] Finished create-virtualenv step (success) 09:18:16 INFO - [mozharness: 2016-11-26 17:18:16.028125Z] Running install step. 09:18:16 INFO - Running pre-action listener: _resource_record_pre_action 09:18:16 INFO - Running main action method: install 09:18:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:16 INFO - Reading from file tmpfile_stdout 09:18:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:16 INFO - Reading from file tmpfile_stdout 09:18:16 INFO - Output received: 09:18:16 INFO - Usage: mozinstall [options] installer 09:18:16 INFO - Options: 09:18:16 INFO - -h, --help show this help message and exit 09:18:16 INFO - -d DEST, --destination=DEST 09:18:16 INFO - Directory to install application into. [default: 09:18:16 INFO - "/builds/slave/test"] 09:18:16 INFO - --app=APP Application being installed. [default: firefox] 09:18:16 INFO - mkdir: /builds/slave/test/build/application 09:18:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:18:32 INFO - Reading from file tmpfile_stdout 09:18:32 INFO - Output received: 09:18:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:18:32 INFO - Running post-action listener: _resource_record_post_action 09:18:32 INFO - [mozharness: 2016-11-26 17:18:32.231711Z] Finished install step (success) 09:18:32 INFO - [mozharness: 2016-11-26 17:18:32.231955Z] Running run-tests step. 09:18:32 INFO - Running pre-action listener: _resource_record_pre_action 09:18:32 INFO - Running main action method: run_tests 09:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:32 INFO - Python 2.7.3 09:18:32 INFO - Return code: 0 09:18:32 INFO - grabbing minidump binary from tooltool 09:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:32 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 0x25cef60>, '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 0x25cfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:32 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 09:18:32 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 09:18:32 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 09:18:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:32 INFO - Return code: 0 09:18:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:18:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:18:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:18:32 INFO - Using env: {'DISPLAY': ':0', 09:18:32 INFO - 'HOME': '/home/cltbld', 09:18:32 INFO - 'LANG': 'en_US.UTF-8', 09:18:32 INFO - 'LANGUAGE': 'en_US:en', 09:18:32 INFO - 'LOGNAME': 'cltbld', 09:18:32 INFO - 'MAIL': '/var/mail/cltbld', 09:18:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:32 INFO - 'MOZ_NO_REMOTE': '1', 09:18:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:32 INFO - 'NO_EM_RESTART': '1', 09:18:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:32 INFO - 'PWD': '/builds/slave/test', 09:18:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:32 INFO - 'SHELL': '/bin/bash', 09:18:32 INFO - 'SHLVL': '1', 09:18:32 INFO - 'TERM': 'linux', 09:18:32 INFO - 'TMOUT': '86400', 09:18:32 INFO - 'USER': 'cltbld', 09:18:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620', 09:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:32 INFO - '_': '/tools/buildbot/bin/python'} 09:18:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:18:32 INFO - mozversion application_buildid: 20161126062719 09:18:32 INFO - mozversion application_changeset: fe8d7e54713a87a4a356a77ff35b0830a8567e76 09:18:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:18:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:32 INFO - mozversion application_name: Firefox 09:18:32 INFO - mozversion application_remotingname: firefox-dev 09:18:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:18:32 INFO - mozversion application_vendor: Mozilla 09:18:32 INFO - mozversion application_version: 52.0a2 09:18:32 INFO - mozversion platform_buildid: 20161126062719 09:18:32 INFO - mozversion platform_changeset: fe8d7e54713a87a4a356a77ff35b0830a8567e76 09:18:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:18:32 INFO - mozversion platform_version: 52.0a2 09:18:32 INFO - using testdate: 1480180712 09:18:32 INFO - actual date: 1480180712 09:18:32 INFO - starting webserver on 'localhost:33763' 09:18:32 INFO - SUITE-START | Running 2 tests 09:18:32 INFO - TEST-START | dromaeo_css 09:18:32 INFO - operating with platform_type : linux_ 09:18:32 INFO - Initialising browser for dromaeo_css test... 09:18:32 INFO - TEST-INFO | started process 4034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgaJS67/profile http://localhost:33763/getInfo.html) 09:18:37 INFO - PROCESS | 4034 | __metrics Screen width/height:1600/1200 09:18:37 INFO - PROCESS | 4034 | colorDepth:24 09:18:37 INFO - PROCESS | 4034 | Browser inner width/height: 1024/697 09:18:37 INFO - PROCESS | 4034 | __metrics 09:18:37 ERROR - PROCESS | 4034 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:18:38 INFO - TEST-INFO | 4034: exit 0 09:18:38 INFO - Browser initialized. 09:18:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:18:38 INFO - TEST-INFO | started process 4166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgaJS67/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:50 INFO - PROCESS | 4166 | RSS: Main: 152403968 09:18:50 INFO - PROCESS | 4166 | 09:19:40 INFO - PROCESS | 4166 | 1480180780227 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] 09:21:51 INFO - PROCESS | 4166 | Cycle 1(1): loaded http://localhost:33763/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33763/tests/dromaeo/cssquery-ext.html) 09:21:52 INFO - PROCESS | 4166 | RSS: Main: 156983296 09:21:52 INFO - PROCESS | 4166 | 09:24:54 INFO - PROCESS | 4166 | Cycle 1(1): loaded http://localhost:33763/tests/dromaeo/cssquery-ext.html (next: http://localhost:33763/tests/dromaeo/cssquery-jquery.html) 09:24:54 INFO - PROCESS | 4166 | RSS: Main: 152895488 09:24:54 INFO - PROCESS | 4166 | 09:27:56 INFO - PROCESS | 4166 | Cycle 1(1): loaded http://localhost:33763/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33763/tests/dromaeo/cssquery-mootools.html) 09:27:57 INFO - PROCESS | 4166 | RSS: Main: 153460736 09:27:57 INFO - PROCESS | 4166 | 09:30:58 INFO - PROCESS | 4166 | Cycle 1(1): loaded http://localhost:33763/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33763/tests/dromaeo/cssquery-prototype.html) 09:30:59 INFO - PROCESS | 4166 | RSS: Main: 152563712 09:30:59 INFO - PROCESS | 4166 | 09:34:02 INFO - PROCESS | 4166 | Cycle 1(1): loaded http://localhost:33763/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33763/tests/dromaeo/cssquery-yui.html) 09:34:02 INFO - PROCESS | 4166 | RSS: Main: 154673152 09:34:02 INFO - PROCESS | 4166 | 09:37:04 INFO - PROCESS | 4166 | Cycle 1(1): loaded http://localhost:33763/tests/dromaeo/cssquery-yui.html (next: http://localhost:33763/tests/dromaeo/cssquery-dojo.html) 09:37:05 INFO - PROCESS | 4166 | RSS: Main: 156078080 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | __start_tp_report 09:37:05 INFO - PROCESS | 4166 | _x_x_mozilla_page_load 09:37:05 INFO - PROCESS | 4166 | _x_x_mozilla_page_load_details 09:37:05 INFO - PROCESS | 4166 | |i|pagename|runs| 09:37:05 INFO - PROCESS | 4166 | |0;dojo.html;3232.4343239933014;3256.267339848533;3256.690614391632;3279.3769183855075;3279.770416070876;5634.40838711935;5680.091185410335;5680.943190568093;5693.715314234292;5708.257926469559;5524.723763811803;5643.746031428585;5650.26546548948;5653.067243904751;5664.122061080539;5026.070177017245;5081.898362032757;5109.744512774365;5116.20698791686;5132.4610915853855;5148.0476111919415;5151.072806894757;5152.046871328816;5162.690238585678;5172.456892026339;5019.749012549376;5059.139946209153;5161.071007218718;5167.844964651048;5191.558717509016;5085.008423357447;5104.515071068261;5107.284980102789;5139.486051394868;5156;5090.618203634705;5110.744462776846;5118.667286626394;5155.0978578748945;5161.793528258865;5400.459954004607;5625.409332020161;5645.407232240637;5662.433756624346;5701.287339082614;5871.178035075093;5908.734106965197;5959.195508606326;5968.940310596882;5969.970150149265;5975.223220981245;6035.185249991239;6042.0030694935285;6050.546209034296;6052.576319657625;5457.045017121988;5485.533729633026;5629.071203251458;5634.408387119375;5640.210370548086;5959.612625179349;5985.730642121115;6018.247719035121;6030.728617212236;6042.123892035718;5735.713214339266;5790.392008839095;5798.536117110621;5800.071988481823;5806.274215723035;5848.152017957373;5926.733297001559;5960.910586341121;5966.85082872923;5995.820125396245;5987.43119403656;5993.280806303184;5994.130851026664;5995.850103747354;6000.249968753906;5989.970050149721;5999.340072592011;6011.368806275365;6017.308009578955;6018.307894592178;4528.682992190581;4598.88502787433;4618.515055919147;4647.047355292157;4657.301404789308;4162.292410290258;4173.1862286853775;4176.749395036308;4196.223698615766;4211.052513184571;5766.509846662997;5780.653160810365;5797.594168408255;5798.043322851767;5809.796657116981;5894.351621321651;5944.375840536768;5963.701814909237;6041.486473649789;6087.208662873798;5786;5789.45000224978;5796.681182535001;5804.535637149018;5805.042168042311;5215.269862219292;5216.347956505437;5231.921521177185;5241.318628578337;5261.237120617566;6112.8777424452155;6131.448169664752;6143.327652471189;6173.96913015441;6293.217852902129;5971.044632858721;5988.4909782668965;6018.789342372996;6019.668918209541;6046.032634778414;6119.112728654409;6200.875982480235;6205.968970155121;6252.249730032243;6259.1550140730415;5770.451807078321;5817.156512305776;5830.53355731549;5861.912071318849;5909.645421274738;6003.789867354796;6062.696865156637;6118.223266370805;6124.14262003311;6129.509639228761;5917.171595976481;5918.644881307136;5944.821655350346;5956.493698035542;5963.373845746134;5616.634918730269;5765.596408251382;5954.880902381841;5958.404159584007;5974.2830860297045;5795.8551036224435;5804.158397032322;5821.039528477754;5830.183774271521;5854.297484301911;5937.109433584997;5938.970305148447;5972.044472884318;5972.910406343995;5975.641461512323;5707.6290041147195;5755.8561035974435;5759.136129580596;5832.591718579659;5847.093700476433 09:37:05 INFO - PROCESS | 4166 | |1;ext.html;576.9480746732793;626.5707990026832;642.9324920883307;671.0638659070594;676.9120014398128;45334.77332613336;46205.30692039622;46439.303410448825;48036.75981620096;48874.75562622182;46754.53245467544;47325.29012064822;47402.76298618502;47417;47495;8895.955520222406;9077.773055673628;9086.091390860895;9110.407823491485;9114.13415725505;8905;8927.55362231889;8978.102189781002;8997.280217582611;9002.954985225097;8894.24398926092;8950.641974321019;9005.774855628597;9018.819623607524;9034.32242581809;8929.910700892973;8939;8950.552472376356;8965.193132618031;8997.460152390877;8885.911140888573;8968.192862642329;8995.5052472114;8995.730128096167;9038.909610903938;43694;44061;44236.11527769427;44283.33574996378;44332.55667443349;3551.733619978512;3569.8750543731103;3661.5423072115987;3822.7132965027454;4059.7564146151326;33428.83285583581;33728.156796080046;33793.15517112092;33800.83099584511;34183.658163418295;4100.938485922714;4163.687723420756;4170.603792639695;4218.0720241546815;4261.829526818955;357013;358196;358209;358381.2080939605;358989;62405.687971559855;62727.37272627215;62800.37199627945;62881.37118628755;62984.37015629785;67666;68135.65932170307;68264.3173568268;68362.31637683559;68630.31369686239;16526.752098718527;16597;16775.077370744726;16796.664066718597;16861.831381686272;12118.636440906786;12124.211926224767;12144.939275303566;12162.391880405945;12205.267683938815;18546.44360669155;19322.903385482983;19354.806451935583;19498.512537186685;19536.31622893192;6220.191375121205;6325.5255855811;6419.486441084702;6478.125453063776;6543.509236807258;997.665781963036;1041.250299784154;1098.4068602954476;1120.708615759892;1159.3044173495834;33062.50406243908;33161.3367732644;33359.83320083384;33392.66607333944;33479;1151.3034614058543;1169.818678104895;1170.6605084525393;1197.2277880766856;1281.653953432568;17498.56253593645;17520.824791752173;17588.912055439898;17657.646847062988;18107.366242181724;495322;495733;496442;497822;499718;62576.374236257056;62610.68694656497;62681;62780.686096569225;63122.68438657777;1386.6048176269715;1416.5325442603917;1420.488624095325;1436.432609119392;1450.4995776457106;31468.685313146576;32822.67177328196;33157.17107072342;33223.501647474826;33481.33037339191;55687.16469252884;55772;55809;56103.71948140233;56146.1578076321;417503;419570;421243;421404;422116;44643.330350044125;44654.776726116164;45505.77247113743;45876.31185532153;46118.30822537598;50574.494255056976;51195;51510.48489515057;54250.72874635601;54619.453805463025;43289;44366.556334436245;45044.54955450403;45759.54240457553;46517.3022404671;43719.78140109279;44647.330290046324;44747.32879006882;45527.54472455233;45673.77163114163;43142;43567.56432435635;43746.34380484232;43924;44439.77780111208;35506.28987420185;38165.4275185878;38659;39199.41200882046;39471.802640986614;29478;29548.852255738584;30119.698803011688;30140.24649383783;30382.84808575943 09:37:05 INFO - PROCESS | 4166 | |2;jquery.html;416.2078516786564;426.39877772341003;438.10189112319756;438.66223008283623;441.5253602377444;18662;19100.140493677784;20440.591188176226;20593.176272949066;20623.690644640305;17812.842165259248;18921.526961825926;19507.707384389247;19526.511837204078;19922.80077199231;5161.277421161031;5381.48875856793;5393.217983392406;5408.486193811601;5431.809886653968;5263.131583288753;5304.92042619361;5360.65155764876;5403.378611459673;5445.945540544583;5353;5379.784808607651;5387.946120538783;5391.78432862685;5408.621396502246;5407;5408.810691625794;5410.675359478424;5457.317835270591;5759.539236861041;5267.867408507151;5287.206918962186;5294.549963253128;5297.046531624306;5298.390685071227;14527.418903243857;14960.625984350478;15034.323455444423;15035.699286014218;23193.49242299245;2303.573838839803;2465.3220364399936;2786.8327900326044;2797.4544963732083;2889.2632378743497;10851.565937362497;11036.28264162835;11164.218504704673;15044.323005464781;15338.309776060105;1942.796006419334;2021.9494512637154;2035.2469586253033;2108.399106254725;2127.5319429725437;87670.561647192;91674;92146.5392673039;92297.53851230768;93862.5306873468;11793.705157371134;12017.339046352534;12023.879761202452;12181.634550963485;12355;17116.74324885128;17339.47981560555;17387.304507819546;17482.300707971794;17529;6590.340965903371;6660.800175994728;6680.732770689216;7636.465447418627;8134.105248422668;7370;7522.5862577558755;7757.650905709256;8014.278714915686;8083.676652933935;5062.291279220912;5175.741212939338;5188;5232.110541208004;5247.763850626731;2073.212179371829;2141.1328411993168;2141.4111119442277;2150.559135377244;2209.237812954528;990.2721499697716;1010.1666125446536;1045.5399624165343;1052.5158427123456;1070.5075665194097;20309.796902031085;20562.588748224953;20767;20978.79021209799;21049.05279262437;1022.7443139215196;1023.8310678738073;1028.6348346337093;1086.896744809242;1087.1140020882956;10781.838272425763;11432.88567114335;11454.770904581861;11539.307641541534;11612.88387116118;381364;383033;385562;520663;544160;103616;104456;106836;107425.46287268514;110588;1045.3205416479198;1076.7092884921185;1088.6298658456162;1122.405125283601;1130.5816847766214;18653.81346186575;18832.62334753325;19041.619167616846;19103.617927641648;19169.520761980504;45146.322805158605;45385.773071134434;45993.54006459893;46362;46604.7669761649;63704.68147659232;63747.362526376;64004.359956401706;64495.677521612095;65202.347976519624;8681.782955426164;9023.278137749096;9062.275017998676;9117.133872282122;9240.491772952551;12159;13947.651308716957;14027.929860350632;14198.219097949712;14307;5737.225474560881;11255.549778009115;12169.452374643339;12339.62981110568;12407.193532420364;11958.820617690915;12067.155299129328;12142.635720928387;12157.08821838348;12286.938565307117;11716.355600442057;11837.112216583962;11876.881231187923;11920.821187682019;12111.212771169845;8624.482531048157;9074.546272686208;9224;9301.977157068895;9545.809083818423;11206.215564910379;11959.282443053444;12069;12075.939620301842;12128.211666241667 09:37:05 INFO - PROCESS | 4166 | |3;mootools.html;1505.6762795998861;1520.9011414258073;1663.708850951084;1750.194910341243;1772.7429522719206;7792.961035194816;8044.3966702497255;8218.096009438965;8766.912330876688;8781.868271975925;7949.324307433861;8225.300849427806;8239.299659528931;8471.957640211791;8485.745427637181;2406.9398265043337;2441.2676197140877;2442.291735396742;2442.3894026493376;2443.364725171459;2398.1726304425033;2441.7192022917416;2472.344828620417;2474.492728990562;2474.826762126652;2417.516496700658;2424.9030038798514;2425.8059355251626;2428.4171798768257;2451.4851881104987;2383.940401489959;2390.1156572068357;2393.9760602393926;2404.5070760494145;2422.7213870404953;2394.688690470245;2396.880155992211;2397.137030668958;2417.54066727323;2420.8668523231217;8603.913960860375;8820.117988201193;8852.822943541094;8855.114488551093;8862.955685221597;5296.814611488618;5457.345118585756;5463.9180412293845;5470.8085217017615;5480.314960629921;3467.2025434150037;3472.4270495368232;3530.4351303791527;3586.910327241814;3622.673959343672;1137.584781554735;1147.8679951805482;1186.649938268213;1191.9463624136936;1193.1528614683584;11726.589569365116;11780.410979451079;11806.586769463114;11844.763104737944;11878.109141814399;4726.361941137902;4783.230204824237;4835.564799168092;4896.681715688469;4984.601231901439;9972;9980.001999799963;9990.150837178775;9995.050470205319;10025.649102281532;5409.594280428983;5412.242286079952;5424;5434.130539113723;5444.6188766785945;4445.933311000337;4549.727016379028;4920.3603531541385;4921.138800709861;4966.056449274626;3917.941230881539;3963.6630886374405;4002.3396139637216;4021.9195616087513;4085.3054980652764;1373.5329987804193;1378.3315092180285;1385.7852032934911;1387.7640801063844;1407.838098618672;899.321012635456;1044.5038606661774;1059.4120263253967;1061.2889364126054;1068.503146037081;5902.380250073767;6086.726097325631;6115.877682446415;6157.0456579230295;6265;515.6416290677943;518.7354449230919;527.9102552566073;528.577138289367;531.8510816971254;3971.6425521703186;4184.476940382452;4189.4344263524645;4195.559466256061;4278.935815962763;10229;10589.4705264738;10613.628523001658;10637.361758294372;10661.147108231324;10399.636012739518;10482.633107841342;10533.420661863518;10562.471876406302;10564.207684423545;7782.883256751154;7979.760607181794;8155.632996515171;8283.875741863756;8293.087760346358;6005.579609427298;6152.78465253714;6198;6206.534509911684;6246.625202487865;9229.723108306762;9646.517674116407;9652.420854748738;9716.611335546499;9741.707748767549;9841.458719770195;9924.1068303853;9967.551460184164;10030.799384012425;10099.646512372032;7001.054857594159;7128.964355178191;7671.117821450604;7701.1913749057785;7861.1352751198465;8316.750497485085;8456.746297611082;8458.238758511763;8466.830663386821;8477.872831907403;7437.293457121565;7473.364763995121;7604.885926711215;7652.196519365609;7848.489848159851;7189.173245076883;7203.063601731741;7280.96359518199;7305.890411643936;7340.632968351668;6963;7096;7105.431565474646;7124.323189297009;7148.928510714826;5040.092783299041;5048.268001139888;5052.444231134498;5135.3324067870935;5297.5232229099565;5094.388673359221;5133.255677926754;5147.6654017488745;5213.947860521346;5308.46915308466 09:37:05 INFO - PROCESS | 4166 | |4;prototype.html;348.37640623284324;356.9500269962205;363.2353895050918;363.3895056305406;363.623649522744;5537.861553461155;5588.6646801191955;5749.878773639137;5829.941700582993;5833.56248281379;5455.1544510600925;5572.665640061599;5626.299376299368;5632;5633.324001119861;4437.801793515749;4446.244138496447;4447.110577884428;4448.466184057901;4474.709143905652;4259;4403.889902752425;4470.56941778631;4480.148771733377;4501.954980450187;4379.211741886459;4381.868543943687;4382.189294980423;4383.019546708237;4413.889652758675;4387.3199654053515;4390.978045109754;4405.229084910144;4421.557844215553;4439.689221754478;3823.0824602095295;3874.3219936511277;3906.121122747359;3917.6082391760883;3924.1164241164115;5496.917546236809;5504.311961004874;5509.842932984078;5531.529819965308;5533.557315414757;5003.17447621142;5025.195968644999;5048;5053.317802096743;5064.11378008847;5697.344805347397;5870.3836097209605;5938.7624495020145;5967.283925928873;6007.669578173199;4256.893207766003;4262.147570485884;4265;4272.2950713132295;4293.141371725636;6127.969360153215;6148.631082135086;6150.7232174552255;6198.876022479525;6204.906926396107;4147.129102888427;4236.173946080547;4257.829686812493;4267.591694740728;4312.482502099768;4331.826726930887;4333.414988976511;4342.82628694855;4343.782810859444;4367.978160109179;4986.875328116754;5001.674891132137;5023;5084.923726144111;5092.821751238763;5675.77296908119;5791.247137872049;5984;5989.251343582052;6056.152138700585;1462.0423622527262;1476.7120411519866;1486.7362741669494;1487.412472073525;1487.4422091715608;970.427447805798;1004.7638804880847;1008.1732978957185;1008.9949550252348;1023.4473384372355;5547.004617506582;5571.526420254324;5574.442555744393;5587.832365029056;5609.775608975677;5980;6005.369436209223;6006.939930600725;6022.69886505673;6032.215811944419;5432.246784063944;5541.806036788693;5543.722813859291;5552.83390487994;5625.887482250332;3142.3872344892984;3145;3146.4179126861604;3152.653208147102;3152.984235078856;5981.700914954322;6127.754889804447;6171.105189747462;6180.196574445384;6194;5947.286325640951;5977.9402205977385;6029.78895738647;6038.580933480628;6066.302375226817;6166.040300655711;6170.624309640731;6197.81406557804;6235.719392627343;6237.220347456568;5752.71236438168;5876.529877609695;5911.467967882912;5928.67392293428;5961.7615295387695;5815.5929084963645;5834.737436815439;5840;5848.590598658053;5858.150568167677;6053.727582258897;6147.907781383372;6207.751689932352;6211.27323605851;6240.188775459162;4160.43834082395;4164.416981622636;4187.120704652058;4203.600657937491;4222.606539841783;5811.4479124483105;5931.9110213345975;5940.316863560746;6006.519478441627;6144.4777193937225;5960.377433929058;5971.596674781336;5992.98119319708;6009.609375390585;6044.818655440344;5944.227250457413;6009.338972712911;6054.517647764395;6054.969725151346;6070.848228794315;5771.9134212986;5965.9105113422465;5980.8803823924145;5986.2517185351835;5999.160117583455;6047.274327080779;6063.363346848518;6076.54425918049;6106.572539922163;6109.633421994695;5622.662640241599;5855.619384739978;5895.793647222326;5920.141579470866;5921.733521991607 09:37:05 INFO - PROCESS | 4166 | |5;yui.html;726.7129483853874;763.2901401696423;845.6744153500903;877.2105105405135;880.9515476648781;15129.621759456018;16036.839631603694;16049.91975040126;16056.518304450885;16070.67858642828;14304.35630396632;14358;14415.279236038208;14429.278536073207;14444.783328250085;841.6507149532952;851.8040850604365;851.8722191671237;853.8548446764034;855.1234984141242;834.5410024486539;834.9165083491663;836.9121242269565;840.1472505407016;844.7043534762845;885.4996926736405;885.7254251182154;886.2821114896922;887.7469921072495;890.3233542507709;878.547548012774;879.6129702930722;886.4326830828275;886.4415418286503;888.6401007591903;647.2588885725864;649.4771708774434;652.1294072413334;652.5693042591914;657.5660064357501;13243.072984891061;13249.801252981213;13342.06605537603;13347;13362.265075420848;11513;11696.298222106701;11773.117016223818;11820.527178912833;12010.819837702442;10825.033076212601;11198.328100313925;11241.15691323154;11309.11617537531;11496.482658280314;3664.395374763161;3828.9042773930596;3884.7863367514774;3943.507061617298;3970.4441378207075;64429;66059.3394066058;66153.66923165401;67056;69039.65480172617;9759.902400976041;9994.10053095225;10101.343412678152;10174.440405777605;10395.480225988671;19250.133743981554;19312.32406865753;19397.61204775925;19418.320358787376;19479.415617531497;7966.482178658369;8483.618237179342;8691.435056721293;8792.42849214799;8861.291096712248;4738.8341408050555;4781.6891902026255;4812.157872372391;4872.4153101628035;4879.219324908068;3530.805805680712;3639.5814481334455;3651.6165802590876;3657.707383409374;3659.0486473517076;615.3630991923338;615.8645098078416;623.429561950819;639.0861068671844;648.4293821437105;594.881023795234;741.6588369350052;745.8396444764293;769.3071272582931;773.9264769846856;8896.59965301563;8998.64005439775;9082.36423450352;9478.099580539838;9615.90384096164;684.1619016704597;720.4704542161508;738.235925816777;744.114503740547;745.1356426545182;4329.307310830315;4465.7767111644935;4503.774811259489;4503.842365517191;4539.818407263739;81691.5915420419;91117.54441227751;91637;92948;95153;49517.257241141415;51227.23159152616;51884.48115518797;63189.36810631835;80974.59512702399;49059.50940490621;66820.33179668238;68104.6594767023;69047.3095269041;69847.3015269851;9547.236221102434;9607.711768646952;9716;9874.111329980049;10018.499075046364;45496.54503455055;45668.314975276066;45984.31023534583;46116.30825537687;47368.52631473641;36441;44086;52784;54926;55628.16557751718;13177.341132943506;13308.667283317995;13700.109492882932;13750.312484375941;13969.092009019787;14395.28023598795;14664.706705866036;15377.76933346023;15601.609959751097;15610.687786243985;13766.793498097737;14242.928785356007;14283.071600345944;14304.427822886968;14340.713185736435;12688.6827829305;13045.412956416794;13063.542776002794;13195.736085278433;14118.43526258938;13615.25116118623;13913.791293130813;13917.443302267797;14056.648583785487;14143.222122783345;11522.82715759281;11716.774795171115;11919.404029798301;12276.570320039113;12510.437030333838;11124.388158651029;11203.327800332007;11467;11476.368799715761;11577.594784182513 09:37:05 INFO - PROCESS | 4166 | __end_tp_report 09:37:05 INFO - PROCESS | 4166 | __start_cc_report 09:37:05 INFO - PROCESS | 4166 | _x_x_mozilla_cycle_collect,312 09:37:05 INFO - PROCESS | 4166 | __end_cc_report 09:37:05 INFO - PROCESS | 4166 | __startTimestamp1480181825146__endTimestamp 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | ------- Summary: start ------- 09:37:05 INFO - PROCESS | 4166 | Number of tests: 6 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | [#0] dojo.html Cycles:165 Average:5585.74 Median:5800.07 stddev:617.75 (10.7%) stddev-sans-first:591.41 09:37:05 INFO - PROCESS | 4166 | Values: 3232.4 3256.3 3256.7 3279.4 3279.8 5634.4 5680.1 5680.9 5693.7 5708.3 5524.7 5643.7 5650.3 5653.1 5664.1 5026.1 5081.9 5109.7 5116.2 5132.5 5148.0 5151.1 5152.0 5162.7 5172.5 5019.7 5059.1 5161.1 5167.8 5191.6 5085.0 5104.5 5107.3 5139.5 5156.0 5090.6 5110.7 5118.7 5155.1 5161.8 5400.5 5625.4 5645.4 5662.4 5701.3 5871.2 5908.7 5959.2 5968.9 5970.0 5975.2 6035.2 6042.0 6050.5 6052.6 5457.0 5485.5 5629.1 5634.4 5640.2 5959.6 5985.7 6018.2 6030.7 6042.1 5735.7 5790.4 5798.5 5800.1 5806.3 5848.2 5926.7 5960.9 5966.9 5995.8 5987.4 5993.3 5994.1 5995.9 6000.2 5990.0 5999.3 6011.4 6017.3 6018.3 4528.7 4598.9 4618.5 4647.0 4657.3 4162.3 4173.2 4176.7 4196.2 4211.1 5766.5 5780.7 5797.6 5798.0 5809.8 5894.4 5944.4 5963.7 6041.5 6087.2 5786.0 5789.5 5796.7 5804.5 5805.0 5215.3 5216.3 5231.9 5241.3 5261.2 6112.9 6131.4 6143.3 6174.0 6293.2 5971.0 5988.5 6018.8 6019.7 6046.0 6119.1 6200.9 6206.0 6252.2 6259.2 5770.5 5817.2 5830.5 5861.9 5909.6 6003.8 6062.7 6118.2 6124.1 6129.5 5917.2 5918.6 5944.8 5956.5 5963.4 5616.6 5765.6 5954.9 5958.4 5974.3 5795.9 5804.2 5821.0 5830.2 5854.3 5937.1 5939.0 5972.0 5972.9 5975.6 5707.6 5755.9 5759.1 5832.6 5847.1 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | [#1] ext.html Cycles:180 Average:60899.16 Median:44403.17 stddev:113179.20 (254.9%) stddev-sans-first:113406.07 09:37:05 INFO - PROCESS | 4166 | Values: 576.9 626.6 642.9 671.1 676.9 45334.8 46205.3 46439.3 48036.8 48874.8 46754.5 47325.3 47402.8 47417.0 47495.0 8896.0 9077.8 9086.1 9110.4 9114.1 8905.0 8927.6 8978.1 8997.3 9003.0 8894.2 8950.6 9005.8 9018.8 9034.3 8929.9 8939.0 8950.6 8965.2 8997.5 8885.9 8968.2 8995.5 8995.7 9038.9 43694.0 44061.0 44236.1 44283.3 44332.6 3551.7 3569.9 3661.5 3822.7 4059.8 33428.8 33728.2 33793.2 33800.8 34183.7 4100.9 4163.7 4170.6 4218.1 4261.8 357013.0 358196.0 358209.0 358381.2 358989.0 62405.7 62727.4 62800.4 62881.4 62984.4 67666.0 68135.7 68264.3 68362.3 68630.3 16526.8 16597.0 16775.1 16796.7 16861.8 12118.6 12124.2 12144.9 12162.4 12205.3 18546.4 19322.9 19354.8 19498.5 19536.3 6220.2 6325.5 6419.5 6478.1 6543.5 997.7 1041.3 1098.4 1120.7 1159.3 33062.5 33161.3 33359.8 33392.7 33479.0 1151.3 1169.8 1170.7 1197.2 1281.7 17498.6 17520.8 17588.9 17657.6 18107.4 495322.0 495733.0 496442.0 497822.0 499718.0 62576.4 62610.7 62681.0 62780.7 63122.7 1386.6 1416.5 1420.5 1436.4 1450.5 31468.7 32822.7 33157.2 33223.5 33481.3 55687.2 55772.0 55809.0 56103.7 56146.2 417503.0 419570.0 421243.0 421404.0 422116.0 44643.3 44654.8 45505.8 45876.3 46118.3 50574.5 51195.0 51510.5 54250.7 54619.5 43289.0 44366.6 45044.5 45759.5 46517.3 43719.8 44647.3 44747.3 45527.5 45673.8 43142.0 43567.6 43746.3 43924.0 44439.8 35506.3 38165.4 38659.0 39199.4 39471.8 29478.0 29548.9 30119.7 30140.2 30382.8 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | [#2] jquery.html Cycles:180 Average:28776.28 Median:11578.73 stddev:75034.70 (648.0%) stddev-sans-first:75214.98 09:37:05 INFO - PROCESS | 4166 | Values: 416.2 426.4 438.1 438.7 441.5 18662.0 19100.1 20440.6 20593.2 20623.7 17812.8 18921.5 19507.7 19526.5 19922.8 5161.3 5381.5 5393.2 5408.5 5431.8 5263.1 5304.9 5360.7 5403.4 5445.9 5353.0 5379.8 5387.9 5391.8 5408.6 5407.0 5408.8 5410.7 5457.3 5759.5 5267.9 5287.2 5294.5 5297.0 5298.4 14527.4 14960.6 15034.3 15035.7 23193.5 2303.6 2465.3 2786.8 2797.5 2889.3 10851.6 11036.3 11164.2 15044.3 15338.3 1942.8 2021.9 2035.2 2108.4 2127.5 87670.6 91674.0 92146.5 92297.5 93862.5 11793.7 12017.3 12023.9 12181.6 12355.0 17116.7 17339.5 17387.3 17482.3 17529.0 6590.3 6660.8 6680.7 7636.5 8134.1 7370.0 7522.6 7757.7 8014.3 8083.7 5062.3 5175.7 5188.0 5232.1 5247.8 2073.2 2141.1 2141.4 2150.6 2209.2 990.3 1010.2 1045.5 1052.5 1070.5 20309.8 20562.6 20767.0 20978.8 21049.1 1022.7 1023.8 1028.6 1086.9 1087.1 10781.8 11432.9 11454.8 11539.3 11612.9 381364.0 383033.0 385562.0 520663.0 544160.0 103616.0 104456.0 106836.0 107425.5 110588.0 1045.3 1076.7 1088.6 1122.4 1130.6 18653.8 18832.6 19041.6 19103.6 19169.5 45146.3 45385.8 45993.5 46362.0 46604.8 63704.7 63747.4 64004.4 64495.7 65202.3 8681.8 9023.3 9062.3 9117.1 9240.5 12159.0 13947.7 14027.9 14198.2 14307.0 5737.2 11255.5 12169.5 12339.6 12407.2 11958.8 12067.2 12142.6 12157.1 12286.9 11716.4 11837.1 11876.9 11920.8 12111.2 8624.5 9074.5 9224.0 9302.0 9545.8 11206.2 11959.3 12069.0 12075.9 12128.2 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | [#3] mootools.html Cycles:180 Average:5732.74 Median:5113.82 stddev:3146.13 (61.5%) stddev-sans-first:3138.91 09:37:05 INFO - PROCESS | 4166 | Values: 1505.7 1520.9 1663.7 1750.2 1772.7 7793.0 8044.4 8218.1 8766.9 8781.9 7949.3 8225.3 8239.3 8472.0 8485.7 2406.9 2441.3 2442.3 2442.4 2443.4 2398.2 2441.7 2472.3 2474.5 2474.8 2417.5 2424.9 2425.8 2428.4 2451.5 2383.9 2390.1 2394.0 2404.5 2422.7 2394.7 2396.9 2397.1 2417.5 2420.9 8603.9 8820.1 8852.8 8855.1 8863.0 5296.8 5457.3 5463.9 5470.8 5480.3 3467.2 3472.4 3530.4 3586.9 3622.7 1137.6 1147.9 1186.6 1191.9 1193.2 11726.6 11780.4 11806.6 11844.8 11878.1 4726.4 4783.2 4835.6 4896.7 4984.6 9972.0 9980.0 9990.2 9995.1 10025.6 5409.6 5412.2 5424.0 5434.1 5444.6 4445.9 4549.7 4920.4 4921.1 4966.1 3917.9 3963.7 4002.3 4021.9 4085.3 1373.5 1378.3 1385.8 1387.8 1407.8 899.3 1044.5 1059.4 1061.3 1068.5 5902.4 6086.7 6115.9 6157.0 6265.0 515.6 518.7 527.9 528.6 531.9 3971.6 4184.5 4189.4 4195.6 4278.9 10229.0 10589.5 10613.6 10637.4 10661.1 10399.6 10482.6 10533.4 10562.5 10564.2 7782.9 7979.8 8155.6 8283.9 8293.1 6005.6 6152.8 6198.0 6206.5 6246.6 9229.7 9646.5 9652.4 9716.6 9741.7 9841.5 9924.1 9967.6 10030.8 10099.6 7001.1 7129.0 7671.1 7701.2 7861.1 8316.8 8456.7 8458.2 8466.8 8477.9 7437.3 7473.4 7604.9 7652.2 7848.5 7189.2 7203.1 7281.0 7305.9 7340.6 6963.0 7096.0 7105.4 7124.3 7148.9 5040.1 5048.3 5052.4 5135.3 5297.5 5094.4 5133.3 5147.7 5213.9 5308.5 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | [#4] prototype.html Cycles:180 Average:4962.91 Median:5599.22 stddev:1459.71 (26.1%) stddev-sans-first:1422.12 09:37:05 INFO - PROCESS | 4166 | Values: 348.4 357.0 363.2 363.4 363.6 5537.9 5588.7 5749.9 5829.9 5833.6 5455.2 5572.7 5626.3 5632.0 5633.3 4437.8 4446.2 4447.1 4448.5 4474.7 4259.0 4403.9 4470.6 4480.1 4502.0 4379.2 4381.9 4382.2 4383.0 4413.9 4387.3 4391.0 4405.2 4421.6 4439.7 3823.1 3874.3 3906.1 3917.6 3924.1 5496.9 5504.3 5509.8 5531.5 5533.6 5003.2 5025.2 5048.0 5053.3 5064.1 5697.3 5870.4 5938.8 5967.3 6007.7 4256.9 4262.1 4265.0 4272.3 4293.1 6128.0 6148.6 6150.7 6198.9 6204.9 4147.1 4236.2 4257.8 4267.6 4312.5 4331.8 4333.4 4342.8 4343.8 4368.0 4986.9 5001.7 5023.0 5084.9 5092.8 5675.8 5791.2 5984.0 5989.3 6056.2 1462.0 1476.7 1486.7 1487.4 1487.4 970.4 1004.8 1008.2 1009.0 1023.4 5547.0 5571.5 5574.4 5587.8 5609.8 5980.0 6005.4 6006.9 6022.7 6032.2 5432.2 5541.8 5543.7 5552.8 5625.9 3142.4 3145.0 3146.4 3152.7 3153.0 5981.7 6127.8 6171.1 6180.2 6194.0 5947.3 5977.9 6029.8 6038.6 6066.3 6166.0 6170.6 6197.8 6235.7 6237.2 5752.7 5876.5 5911.5 5928.7 5961.8 5815.6 5834.7 5840.0 5848.6 5858.2 6053.7 6147.9 6207.8 6211.3 6240.2 4160.4 4164.4 4187.1 4203.6 4222.6 5811.4 5931.9 5940.3 6006.5 6144.5 5960.4 5971.6 5993.0 6009.6 6044.8 5944.2 6009.3 6054.5 6055.0 6070.8 5771.9 5965.9 5980.9 5986.3 5999.2 6047.3 6063.4 6076.5 6106.6 6109.6 5622.7 5855.6 5895.8 5920.1 5921.7 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - PROCESS | 4166 | [#5] yui.html Cycles:180 Average:17128.06 Median:26053.68 stddev:22112.32 (84.9%) stddev-sans-first:22140.06 09:37:05 INFO - PROCESS | 4166 | Values: 726.7 763.3 845.7 877.2 881.0 15129.6 16036.8 16049.9 16056.5 16070.7 14304.4 14358.0 14415.3 14429.3 14444.8 841.7 851.8 851.9 853.9 855.1 834.5 834.9 836.9 840.1 844.7 885.5 885.7 886.3 887.7 890.3 878.5 879.6 886.4 886.4 888.6 647.3 649.5 652.1 652.6 657.6 13243.1 13249.8 13342.1 13347.0 13362.3 11513.0 11696.3 11773.1 11820.5 12010.8 10825.0 11198.3 11241.2 11309.1 11496.5 3664.4 3828.9 3884.8 3943.5 3970.4 64429.0 66059.3 66153.7 67056.0 69039.7 9759.9 9994.1 10101.3 10174.4 10395.5 19250.1 19312.3 19397.6 19418.3 19479.4 7966.5 8483.6 8691.4 8792.4 8861.3 4738.8 4781.7 4812.2 4872.4 4879.2 3530.8 3639.6 3651.6 3657.7 3659.0 615.4 615.9 623.4 639.1 648.4 594.9 741.7 745.8 769.3 773.9 8896.6 8998.6 9082.4 9478.1 9615.9 684.2 720.5 738.2 744.1 745.1 4329.3 4465.8 4503.8 4503.8 4539.8 81691.6 91117.5 91637.0 92948.0 95153.0 49517.3 51227.2 51884.5 63189.4 80974.6 49059.5 66820.3 68104.7 69047.3 69847.3 9547.2 9607.7 9716.0 9874.1 10018.5 45496.5 45668.3 45984.3 46116.3 47368.5 36441.0 44086.0 52784.0 54926.0 55628.2 13177.3 13308.7 13700.1 13750.3 13969.1 14395.3 14664.7 15377.8 15601.6 15610.7 13766.8 14242.9 14283.1 14304.4 14340.7 12688.7 13045.4 13063.5 13195.7 14118.4 13615.3 13913.8 13917.4 14056.6 14143.2 11522.8 11716.8 11919.4 12276.6 12510.4 11124.4 11203.3 11467.0 11476.4 11577.6 09:37:05 INFO - PROCESS | 4166 | -------- Summary: end -------- 09:37:05 INFO - PROCESS | 4166 | 09:37:05 INFO - TEST-INFO | 4166: exit 0 09:37:05 INFO - TEST-OK | dromaeo_css | took 1113457ms 09:37:05 INFO - TEST-START | kraken 09:37:05 INFO - operating with platform_type : linux_ 09:37:05 INFO - Initialising browser for kraken test... 09:37:05 INFO - TEST-INFO | started process 4540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk6psat/profile http://localhost:33763/getInfo.html) 09:37:10 INFO - PROCESS | 4540 | __metrics Screen width/height:1600/1200 09:37:10 INFO - PROCESS | 4540 | colorDepth:24 09:37:10 INFO - PROCESS | 4540 | Browser inner width/height: 1024/697 09:37:10 INFO - PROCESS | 4540 | __metrics 09:37:11 ERROR - PROCESS | 4540 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:37:11 INFO - TEST-INFO | 4540: exit 0 09:37:11 INFO - Browser initialized. 09:37:11 INFO - Running cycle 1/1 for kraken test... 09:37:11 INFO - TEST-INFO | started process 4671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk6psat/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:23 INFO - PROCESS | 4671 | RSS: Main: 152313856 09:37:23 INFO - PROCESS | 4671 | 09:37:26 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33763/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:27 INFO - PROCESS | 4671 | RSS: Main: 157466624 09:37:27 INFO - PROCESS | 4671 | 09:37:30 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33763/tests/kraken/driver.html?testName=audio-dft) 09:37:30 INFO - PROCESS | 4671 | RSS: Main: 154566656 09:37:30 INFO - PROCESS | 4671 | 09:37:33 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33763/tests/kraken/driver.html?testName=audio-fft) 09:37:34 INFO - PROCESS | 4671 | RSS: Main: 155668480 09:37:34 INFO - PROCESS | 4671 | 09:37:36 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33763/tests/kraken/driver.html?testName=audio-oscillator) 09:37:36 INFO - PROCESS | 4671 | RSS: Main: 154386432 09:37:36 INFO - PROCESS | 4671 | 09:37:38 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33763/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:37:39 INFO - PROCESS | 4671 | RSS: Main: 154714112 09:37:39 INFO - PROCESS | 4671 | 09:37:42 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33763/tests/kraken/driver.html?testName=imaging-darkroom) 09:37:43 INFO - PROCESS | 4671 | RSS: Main: 158564352 09:37:43 INFO - PROCESS | 4671 | 09:37:46 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33763/tests/kraken/driver.html?testName=imaging-desaturate) 09:37:47 INFO - PROCESS | 4671 | RSS: Main: 159236096 09:37:47 INFO - PROCESS | 4671 | 09:37:49 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33763/tests/kraken/driver.html?testName=json-parse-financial) 09:37:50 INFO - PROCESS | 4671 | RSS: Main: 157466624 09:37:50 INFO - PROCESS | 4671 | 09:37:51 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33763/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:52 INFO - PROCESS | 4671 | RSS: Main: 157474816 09:37:52 INFO - PROCESS | 4671 | 09:37:54 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:54 INFO - PROCESS | 4671 | RSS: Main: 156954624 09:37:54 INFO - PROCESS | 4671 | 09:37:56 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:57 INFO - PROCESS | 4671 | RSS: Main: 158142464 09:37:57 INFO - PROCESS | 4671 | 09:38:00 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:00 INFO - PROCESS | 4671 | RSS: Main: 157511680 09:38:00 INFO - PROCESS | 4671 | 09:38:03 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:04 INFO - PROCESS | 4671 | RSS: Main: 157827072 09:38:04 INFO - PROCESS | 4671 | 09:38:05 INFO - PROCESS | 4671 | Cycle 1(1): loaded http://localhost:33763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33763/tests/kraken/driver.html?testName=ai-astar) 09:38:06 INFO - PROCESS | 4671 | RSS: Main: 159678464 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | __start_tp_report 09:38:06 INFO - PROCESS | 4671 | _x_x_mozilla_page_load 09:38:06 INFO - PROCESS | 4671 | _x_x_mozilla_page_load_details 09:38:06 INFO - PROCESS | 4671 | |i|pagename|runs| 09:38:06 INFO - PROCESS | 4671 | |0;ai-astar;105;112;112;112;112;111;113;112;114;111 09:38:06 INFO - PROCESS | 4671 | |1;audio-beat-detection;155;122;124;164;124;125;131;129;156;128 09:38:06 INFO - PROCESS | 4671 | |2;audio-dft;164;163;163;163;164;160;162;161;163;163 09:38:06 INFO - PROCESS | 4671 | |3;audio-fft;75;77;76;112;79;78;76;77;97;79 09:38:06 INFO - PROCESS | 4671 | |4;audio-oscillator;83;82;118;84;83;82;104;82;82;109 09:38:06 INFO - PROCESS | 4671 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;117;117;121 09:38:06 INFO - PROCESS | 4671 | |6;imaging-darkroom;146;146;147;147;147;146;147;146;146;146 09:38:06 INFO - PROCESS | 4671 | |7;imaging-desaturate;86;85;84;85;85;85;86;85;86;85 09:38:06 INFO - PROCESS | 4671 | |8;json-parse-financial;58;52;52;51;51;59;53;56;52;52 09:38:06 INFO - PROCESS | 4671 | |9;json-stringify-tinderbox;59;59;58;59;59;59;59;59;59;59 09:38:06 INFO - PROCESS | 4671 | |10;stanford-crypto-aes;76;75;75;79;76;78;76;77;78;76 09:38:06 INFO - PROCESS | 4671 | |11;stanford-crypto-ccm;135;124;124;133;130;136;128;132;171;130 09:38:06 INFO - PROCESS | 4671 | |12;stanford-crypto-pbkdf2;155;154;158;156;160;155;163;153;153;158 09:38:06 INFO - PROCESS | 4671 | |13;stanford-crypto-sha256-iterative;63;62;71;62;61;61;66;61;64;61 09:38:06 INFO - PROCESS | 4671 | __end_tp_report 09:38:06 INFO - PROCESS | 4671 | __start_cc_report 09:38:06 INFO - PROCESS | 4671 | _x_x_mozilla_cycle_collect,810 09:38:06 INFO - PROCESS | 4671 | __end_cc_report 09:38:06 INFO - PROCESS | 4671 | __startTimestamp1480181886085__endTimestamp 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | ------- Summary: start ------- 09:38:06 INFO - PROCESS | 4671 | Number of tests: 14 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.41 (2.2%) stddev-sans-first:0.93 09:38:06 INFO - PROCESS | 4671 | Values: 105.0 112.0 112.0 112.0 112.0 111.0 113.0 112.0 114.0 111.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:130.00 stddev:15.94 (12.3%) stddev-sans-first:15.32 09:38:06 INFO - PROCESS | 4671 | Values: 155.0 122.0 124.0 164.0 124.0 125.0 131.0 129.0 156.0 128.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 09:38:06 INFO - PROCESS | 4671 | Values: 164.0 163.0 163.0 163.0 164.0 160.0 162.0 161.0 163.0 163.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.50 stddev:12.14 (15.7%) stddev-sans-first:12.56 09:38:06 INFO - PROCESS | 4671 | Values: 75.0 77.0 76.0 112.0 79.0 78.0 76.0 77.0 97.0 79.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:13.84 (16.9%) stddev-sans-first:14.38 09:38:06 INFO - PROCESS | 4671 | Values: 83.0 82.0 118.0 84.0 83.0 82.0 104.0 82.0 82.0 109.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.50 stddev:1.25 (1.1%) stddev-sans-first:1.32 09:38:06 INFO - PROCESS | 4671 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 121.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:38:06 INFO - PROCESS | 4671 | Values: 146.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 09:38:06 INFO - PROCESS | 4671 | Values: 86.0 85.0 84.0 85.0 85.0 85.0 86.0 85.0 86.0 85.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:52.50 stddev:2.95 (5.6%) stddev-sans-first:2.67 09:38:06 INFO - PROCESS | 4671 | Values: 58.0 52.0 52.0 51.0 51.0 59.0 53.0 56.0 52.0 52.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 09:38:06 INFO - PROCESS | 4671 | Values: 59.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.50 stddev:1.35 (1.8%) stddev-sans-first:1.41 09:38:06 INFO - PROCESS | 4671 | Values: 76.0 75.0 75.0 79.0 76.0 78.0 76.0 77.0 78.0 76.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:132.50 stddev:13.52 (10.2%) stddev-sans-first:14.34 09:38:06 INFO - PROCESS | 4671 | Values: 135.0 124.0 124.0 133.0 130.0 136.0 128.0 132.0 171.0 130.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.00 stddev:3.24 (2.1%) stddev-sans-first:3.39 09:38:06 INFO - PROCESS | 4671 | Values: 155.0 154.0 158.0 156.0 160.0 155.0 163.0 153.0 153.0 158.0 09:38:06 INFO - PROCESS | 4671 | 09:38:06 INFO - PROCESS | 4671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:62.50 stddev:3.19 (5.1%) stddev-sans-first:3.38 09:38:06 INFO - PROCESS | 4671 | Values: 63.0 62.0 71.0 62.0 61.0 61.0 66.0 61.0 64.0 61.0 09:38:06 INFO - PROCESS | 4671 | -------- Summary: end -------- 09:38:06 INFO - PROCESS | 4671 | 09:38:07 INFO - TEST-INFO | 4671: exit 0 09:38:07 INFO - TEST-OK | kraken | took 61150ms 09:38:07 INFO - SUITE-END | took 1174s 09:38:07 INFO - Completed test suite (00:19:34) 09:38:07 INFO - javascript benchmark 09:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7407.325950254141, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3232.4343239933014, 3256.267339848533, 3256.690614391632, 3279.3769183855075, 3279.770416070876, 5634.40838711935, 5680.091185410335, 5680.943190568093, 5693.715314234292, 5708.257926469559, 5524.723763811803, 5643.746031428585, 5650.26546548948, 5653.067243904751, 5664.122061080539, 5026.070177017245, 5081.898362032757, 5109.744512774365, 5116.20698791686, 5132.4610915853855, 5148.0476111919415, 5151.072806894757, 5152.046871328816, 5162.690238585678, 5172.456892026339, 5019.749012549376, 5059.139946209153, 5161.071007218718, 5167.844964651048, 5191.558717509016, 5085.008423357447, 5104.515071068261, 5107.284980102789, 5139.486051394868, 5156.0, 5090.618203634705, 5110.744462776846, 5118.667286626394, 5155.0978578748945, 5161.793528258865, 5400.459954004607, 5625.409332020161, 5645.407232240637, 5662.433756624346, 5701.287339082614, 5871.178035075093, 5908.734106965197, 5959.195508606326, 5968.940310596882, 5969.970150149265, 5975.223220981245, 6035.185249991239, 6042.0030694935285, 6050.546209034296, 6052.576319657625, 5457.045017121988, 5485.533729633026, 5629.071203251458, 5634.408387119375, 5640.210370548086, 5959.612625179349, 5985.730642121115, 6018.247719035121, 6030.728617212236, 6042.123892035718, 5735.713214339266, 5790.392008839095, 5798.536117110621, 5800.071988481823, 5806.274215723035, 5848.152017957373, 5926.733297001559, 5960.910586341121, 5966.85082872923, 5995.820125396245, 5987.43119403656, 5993.280806303184, 5994.130851026664, 5995.850103747354, 6000.249968753906, 5989.970050149721, 5999.340072592011, 6011.368806275365, 6017.308009578955, 6018.307894592178, 4528.682992190581, 4598.88502787433, 4618.515055919147, 4647.047355292157, 4657.301404789308, 4162.292410290258, 4173.1862286853775, 4176.749395036308, 4196.223698615766, 4211.052513184571, 5766.509846662997, 5780.653160810365, 5797.594168408255, 5798.043322851767, 5809.796657116981, 5894.351621321651, 5944.375840536768, 5963.701814909237, 6041.486473649789, 6087.208662873798, 5786.0, 5789.45000224978, 5796.681182535001, 5804.535637149018, 5805.042168042311, 5215.269862219292, 5216.347956505437, 5231.921521177185, 5241.318628578337, 5261.237120617566, 6112.8777424452155, 6131.448169664752, 6143.327652471189, 6173.96913015441, 6293.217852902129, 5971.044632858721, 5988.4909782668965, 6018.789342372996, 6019.668918209541, 6046.032634778414, 6119.112728654409, 6200.875982480235, 6205.968970155121, 6252.249730032243, 6259.1550140730415, 5770.451807078321, 5817.156512305776, 5830.53355731549, 5861.912071318849, 5909.645421274738, 6003.789867354796, 6062.696865156637, 6118.223266370805, 6124.14262003311, 6129.509639228761, 5917.171595976481, 5918.644881307136, 5944.821655350346, 5956.493698035542, 5963.373845746134, 5616.634918730269, 5765.596408251382, 5954.880902381841, 5958.404159584007, 5974.2830860297045, 5795.8551036224435, 5804.158397032322, 5821.039528477754, 5830.183774271521, 5854.297484301911, 5937.109433584997, 5938.970305148447, 5972.044472884318, 5972.910406343995, 5975.641461512323, 5707.6290041147195, 5755.8561035974435, 5759.136129580596, 5832.591718579659, 5847.093700476433], "value": 5544.928106392495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.9480746732793, 626.5707990026832, 642.9324920883307, 671.0638659070594, 676.9120014398128, 45334.77332613336, 46205.30692039622, 46439.303410448825, 48036.75981620096, 48874.75562622182, 46754.53245467544, 47325.29012064822, 47402.76298618502, 47417.0, 47495.0, 8895.955520222406, 9077.773055673628, 9086.091390860895, 9110.407823491485, 9114.13415725505, 8905.0, 8927.55362231889, 8978.102189781002, 8997.280217582611, 9002.954985225097, 8894.24398926092, 8950.641974321019, 9005.774855628597, 9018.819623607524, 9034.32242581809, 8929.910700892973, 8939.0, 8950.552472376356, 8965.193132618031, 8997.460152390877, 8885.911140888573, 8968.192862642329, 8995.5052472114, 8995.730128096167, 9038.909610903938, 43694.0, 44061.0, 44236.11527769427, 44283.33574996378, 44332.55667443349, 3551.733619978512, 3569.8750543731103, 3661.5423072115987, 3822.7132965027454, 4059.7564146151326, 33428.83285583581, 33728.156796080046, 33793.15517112092, 33800.83099584511, 34183.658163418295, 4100.938485922714, 4163.687723420756, 4170.603792639695, 4218.0720241546815, 4261.829526818955, 357013.0, 358196.0, 358209.0, 358381.2080939605, 358989.0, 62405.687971559855, 62727.37272627215, 62800.37199627945, 62881.37118628755, 62984.37015629785, 67666.0, 68135.65932170307, 68264.3173568268, 68362.31637683559, 68630.31369686239, 16526.752098718527, 16597.0, 16775.077370744726, 16796.664066718597, 16861.831381686272, 12118.636440906786, 12124.211926224767, 12144.939275303566, 12162.391880405945, 12205.267683938815, 18546.44360669155, 19322.903385482983, 19354.806451935583, 19498.512537186685, 19536.31622893192, 6220.191375121205, 6325.5255855811, 6419.486441084702, 6478.125453063776, 6543.509236807258, 997.665781963036, 1041.250299784154, 1098.4068602954476, 1120.708615759892, 1159.3044173495834, 33062.50406243908, 33161.3367732644, 33359.83320083384, 33392.66607333944, 33479.0, 1151.3034614058543, 1169.818678104895, 1170.6605084525393, 1197.2277880766856, 1281.653953432568, 17498.56253593645, 17520.824791752173, 17588.912055439898, 17657.646847062988, 18107.366242181724, 495322.0, 495733.0, 496442.0, 497822.0, 499718.0, 62576.374236257056, 62610.68694656497, 62681.0, 62780.686096569225, 63122.68438657777, 1386.6048176269715, 1416.5325442603917, 1420.488624095325, 1436.432609119392, 1450.4995776457106, 31468.685313146576, 32822.67177328196, 33157.17107072342, 33223.501647474826, 33481.33037339191, 55687.16469252884, 55772.0, 55809.0, 56103.71948140233, 56146.1578076321, 417503.0, 419570.0, 421243.0, 421404.0, 422116.0, 44643.330350044125, 44654.776726116164, 45505.77247113743, 45876.31185532153, 46118.30822537598, 50574.494255056976, 51195.0, 51510.48489515057, 54250.72874635601, 54619.453805463025, 43289.0, 44366.556334436245, 45044.54955450403, 45759.54240457553, 46517.3022404671, 43719.78140109279, 44647.330290046324, 44747.32879006882, 45527.54472455233, 45673.77163114163, 43142.0, 43567.56432435635, 43746.34380484232, 43924.0, 44439.77780111208, 35506.28987420185, 38165.4275185878, 38659.0, 39199.41200882046, 39471.802640986614, 29478.0, 29548.852255738584, 30119.698803011688, 30140.24649383783, 30382.84808575943], "value": 21092.941944048456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.2078516786564, 426.39877772341003, 438.10189112319756, 438.66223008283623, 441.5253602377444, 18662.0, 19100.140493677784, 20440.591188176226, 20593.176272949066, 20623.690644640305, 17812.842165259248, 18921.526961825926, 19507.707384389247, 19526.511837204078, 19922.80077199231, 5161.277421161031, 5381.48875856793, 5393.217983392406, 5408.486193811601, 5431.809886653968, 5263.131583288753, 5304.92042619361, 5360.65155764876, 5403.378611459673, 5445.945540544583, 5353.0, 5379.784808607651, 5387.946120538783, 5391.78432862685, 5408.621396502246, 5407.0, 5408.810691625794, 5410.675359478424, 5457.317835270591, 5759.539236861041, 5267.867408507151, 5287.206918962186, 5294.549963253128, 5297.046531624306, 5298.390685071227, 14527.418903243857, 14960.625984350478, 15034.323455444423, 15035.699286014218, 23193.49242299245, 2303.573838839803, 2465.3220364399936, 2786.8327900326044, 2797.4544963732083, 2889.2632378743497, 10851.565937362497, 11036.28264162835, 11164.218504704673, 15044.323005464781, 15338.309776060105, 1942.796006419334, 2021.9494512637154, 2035.2469586253033, 2108.399106254725, 2127.5319429725437, 87670.561647192, 91674.0, 92146.5392673039, 92297.53851230768, 93862.5306873468, 11793.705157371134, 12017.339046352534, 12023.879761202452, 12181.634550963485, 12355.0, 17116.74324885128, 17339.47981560555, 17387.304507819546, 17482.300707971794, 17529.0, 6590.340965903371, 6660.800175994728, 6680.732770689216, 7636.465447418627, 8134.105248422668, 7370.0, 7522.5862577558755, 7757.650905709256, 8014.278714915686, 8083.676652933935, 5062.291279220912, 5175.741212939338, 5188.0, 5232.110541208004, 5247.763850626731, 2073.212179371829, 2141.1328411993168, 2141.4111119442277, 2150.559135377244, 2209.237812954528, 990.2721499697716, 1010.1666125446536, 1045.5399624165343, 1052.5158427123456, 1070.5075665194097, 20309.796902031085, 20562.588748224953, 20767.0, 20978.79021209799, 21049.05279262437, 1022.7443139215196, 1023.8310678738073, 1028.6348346337093, 1086.896744809242, 1087.1140020882956, 10781.838272425763, 11432.88567114335, 11454.770904581861, 11539.307641541534, 11612.88387116118, 381364.0, 383033.0, 385562.0, 520663.0, 544160.0, 103616.0, 104456.0, 106836.0, 107425.46287268514, 110588.0, 1045.3205416479198, 1076.7092884921185, 1088.6298658456162, 1122.405125283601, 1130.5816847766214, 18653.81346186575, 18832.62334753325, 19041.619167616846, 19103.617927641648, 19169.520761980504, 45146.322805158605, 45385.773071134434, 45993.54006459893, 46362.0, 46604.7669761649, 63704.68147659232, 63747.362526376, 64004.359956401706, 64495.677521612095, 65202.347976519624, 8681.782955426164, 9023.278137749096, 9062.275017998676, 9117.133872282122, 9240.491772952551, 12159.0, 13947.651308716957, 14027.929860350632, 14198.219097949712, 14307.0, 5737.225474560881, 11255.549778009115, 12169.452374643339, 12339.62981110568, 12407.193532420364, 11958.820617690915, 12067.155299129328, 12142.635720928387, 12157.08821838348, 12286.938565307117, 11716.355600442057, 11837.112216583962, 11876.881231187923, 11920.821187682019, 12111.212771169845, 8624.482531048157, 9074.546272686208, 9224.0, 9301.977157068895, 9545.809083818423, 11206.215564910379, 11959.282443053444, 12069.0, 12075.939620301842, 12128.211666241667], "value": 9493.320649990035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.6762795998861, 1520.9011414258073, 1663.708850951084, 1750.194910341243, 1772.7429522719206, 7792.961035194816, 8044.3966702497255, 8218.096009438965, 8766.912330876688, 8781.868271975925, 7949.324307433861, 8225.300849427806, 8239.299659528931, 8471.957640211791, 8485.745427637181, 2406.9398265043337, 2441.2676197140877, 2442.291735396742, 2442.3894026493376, 2443.364725171459, 2398.1726304425033, 2441.7192022917416, 2472.344828620417, 2474.492728990562, 2474.826762126652, 2417.516496700658, 2424.9030038798514, 2425.8059355251626, 2428.4171798768257, 2451.4851881104987, 2383.940401489959, 2390.1156572068357, 2393.9760602393926, 2404.5070760494145, 2422.7213870404953, 2394.688690470245, 2396.880155992211, 2397.137030668958, 2417.54066727323, 2420.8668523231217, 8603.913960860375, 8820.117988201193, 8852.822943541094, 8855.114488551093, 8862.955685221597, 5296.814611488618, 5457.345118585756, 5463.9180412293845, 5470.8085217017615, 5480.314960629921, 3467.2025434150037, 3472.4270495368232, 3530.4351303791527, 3586.910327241814, 3622.673959343672, 1137.584781554735, 1147.8679951805482, 1186.649938268213, 1191.9463624136936, 1193.1528614683584, 11726.589569365116, 11780.410979451079, 11806.586769463114, 11844.763104737944, 11878.109141814399, 4726.361941137902, 4783.230204824237, 4835.564799168092, 4896.681715688469, 4984.601231901439, 9972.0, 9980.001999799963, 9990.150837178775, 9995.050470205319, 10025.649102281532, 5409.594280428983, 5412.242286079952, 5424.0, 5434.130539113723, 5444.6188766785945, 4445.933311000337, 4549.727016379028, 4920.3603531541385, 4921.138800709861, 4966.056449274626, 3917.941230881539, 3963.6630886374405, 4002.3396139637216, 4021.9195616087513, 4085.3054980652764, 1373.5329987804193, 1378.3315092180285, 1385.7852032934911, 1387.7640801063844, 1407.838098618672, 899.321012635456, 1044.5038606661774, 1059.4120263253967, 1061.2889364126054, 1068.503146037081, 5902.380250073767, 6086.726097325631, 6115.877682446415, 6157.0456579230295, 6265.0, 515.6416290677943, 518.7354449230919, 527.9102552566073, 528.577138289367, 531.8510816971254, 3971.6425521703186, 4184.476940382452, 4189.4344263524645, 4195.559466256061, 4278.935815962763, 10229.0, 10589.4705264738, 10613.628523001658, 10637.361758294372, 10661.147108231324, 10399.636012739518, 10482.633107841342, 10533.420661863518, 10562.471876406302, 10564.207684423545, 7782.883256751154, 7979.760607181794, 8155.632996515171, 8283.875741863756, 8293.087760346358, 6005.579609427298, 6152.78465253714, 6198.0, 6206.534509911684, 6246.625202487865, 9229.723108306762, 9646.517674116407, 9652.420854748738, 9716.611335546499, 9741.707748767549, 9841.458719770195, 9924.1068303853, 9967.551460184164, 10030.799384012425, 10099.646512372032, 7001.054857594159, 7128.964355178191, 7671.117821450604, 7701.1913749057785, 7861.1352751198465, 8316.750497485085, 8456.746297611082, 8458.238758511763, 8466.830663386821, 8477.872831907403, 7437.293457121565, 7473.364763995121, 7604.885926711215, 7652.196519365609, 7848.489848159851, 7189.173245076883, 7203.063601731741, 7280.96359518199, 7305.890411643936, 7340.632968351668, 6963.0, 7096.0, 7105.431565474646, 7124.323189297009, 7148.928510714826, 5040.092783299041, 5048.268001139888, 5052.444231134498, 5135.3324067870935, 5297.5232229099565, 5094.388673359221, 5133.255677926754, 5147.6654017488745, 5213.947860521346, 5308.46915308466], "value": 4601.119143914548, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.37640623284324, 356.9500269962205, 363.2353895050918, 363.3895056305406, 363.623649522744, 5537.861553461155, 5588.6646801191955, 5749.878773639137, 5829.941700582993, 5833.56248281379, 5455.1544510600925, 5572.665640061599, 5626.299376299368, 5632.0, 5633.324001119861, 4437.801793515749, 4446.244138496447, 4447.110577884428, 4448.466184057901, 4474.709143905652, 4259.0, 4403.889902752425, 4470.56941778631, 4480.148771733377, 4501.954980450187, 4379.211741886459, 4381.868543943687, 4382.189294980423, 4383.019546708237, 4413.889652758675, 4387.3199654053515, 4390.978045109754, 4405.229084910144, 4421.557844215553, 4439.689221754478, 3823.0824602095295, 3874.3219936511277, 3906.121122747359, 3917.6082391760883, 3924.1164241164115, 5496.917546236809, 5504.311961004874, 5509.842932984078, 5531.529819965308, 5533.557315414757, 5003.17447621142, 5025.195968644999, 5048.0, 5053.317802096743, 5064.11378008847, 5697.344805347397, 5870.3836097209605, 5938.7624495020145, 5967.283925928873, 6007.669578173199, 4256.893207766003, 4262.147570485884, 4265.0, 4272.2950713132295, 4293.141371725636, 6127.969360153215, 6148.631082135086, 6150.7232174552255, 6198.876022479525, 6204.906926396107, 4147.129102888427, 4236.173946080547, 4257.829686812493, 4267.591694740728, 4312.482502099768, 4331.826726930887, 4333.414988976511, 4342.82628694855, 4343.782810859444, 4367.978160109179, 4986.875328116754, 5001.674891132137, 5023.0, 5084.923726144111, 5092.821751238763, 5675.77296908119, 5791.247137872049, 5984.0, 5989.251343582052, 6056.152138700585, 1462.0423622527262, 1476.7120411519866, 1486.7362741669494, 1487.412472073525, 1487.4422091715608, 970.427447805798, 1004.7638804880847, 1008.1732978957185, 1008.9949550252348, 1023.4473384372355, 5547.004617506582, 5571.526420254324, 5574.442555744393, 5587.832365029056, 5609.775608975677, 5980.0, 6005.369436209223, 6006.939930600725, 6022.69886505673, 6032.215811944419, 5432.246784063944, 5541.806036788693, 5543.722813859291, 5552.83390487994, 5625.887482250332, 3142.3872344892984, 3145.0, 3146.4179126861604, 3152.653208147102, 3152.984235078856, 5981.700914954322, 6127.754889804447, 6171.105189747462, 6180.196574445384, 6194.0, 5947.286325640951, 5977.9402205977385, 6029.78895738647, 6038.580933480628, 6066.302375226817, 6166.040300655711, 6170.624309640731, 6197.81406557804, 6235.719392627343, 6237.220347456568, 5752.71236438168, 5876.529877609695, 5911.467967882912, 5928.67392293428, 5961.7615295387695, 5815.5929084963645, 5834.737436815439, 5840.0, 5848.590598658053, 5858.150568167677, 6053.727582258897, 6147.907781383372, 6207.751689932352, 6211.27323605851, 6240.188775459162, 4160.43834082395, 4164.416981622636, 4187.120704652058, 4203.600657937491, 4222.606539841783, 5811.4479124483105, 5931.9110213345975, 5940.316863560746, 6006.519478441627, 6144.4777193937225, 5960.377433929058, 5971.596674781336, 5992.98119319708, 6009.609375390585, 6044.818655440344, 5944.227250457413, 6009.338972712911, 6054.517647764395, 6054.969725151346, 6070.848228794315, 5771.9134212986, 5965.9105113422465, 5980.8803823924145, 5986.2517185351835, 5999.160117583455, 6047.274327080779, 6063.363346848518, 6076.54425918049, 6106.572539922163, 6109.633421994695, 5622.662640241599, 5855.619384739978, 5895.793647222326, 5920.141579470866, 5921.733521991607], "value": 4497.9072326152855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.7129483853874, 763.2901401696423, 845.6744153500903, 877.2105105405135, 880.9515476648781, 15129.621759456018, 16036.839631603694, 16049.91975040126, 16056.518304450885, 16070.67858642828, 14304.35630396632, 14358.0, 14415.279236038208, 14429.278536073207, 14444.783328250085, 841.6507149532952, 851.8040850604365, 851.8722191671237, 853.8548446764034, 855.1234984141242, 834.5410024486539, 834.9165083491663, 836.9121242269565, 840.1472505407016, 844.7043534762845, 885.4996926736405, 885.7254251182154, 886.2821114896922, 887.7469921072495, 890.3233542507709, 878.547548012774, 879.6129702930722, 886.4326830828275, 886.4415418286503, 888.6401007591903, 647.2588885725864, 649.4771708774434, 652.1294072413334, 652.5693042591914, 657.5660064357501, 13243.072984891061, 13249.801252981213, 13342.06605537603, 13347.0, 13362.265075420848, 11513.0, 11696.298222106701, 11773.117016223818, 11820.527178912833, 12010.819837702442, 10825.033076212601, 11198.328100313925, 11241.15691323154, 11309.11617537531, 11496.482658280314, 3664.395374763161, 3828.9042773930596, 3884.7863367514774, 3943.507061617298, 3970.4441378207075, 64429.0, 66059.3394066058, 66153.66923165401, 67056.0, 69039.65480172617, 9759.902400976041, 9994.10053095225, 10101.343412678152, 10174.440405777605, 10395.480225988671, 19250.133743981554, 19312.32406865753, 19397.61204775925, 19418.320358787376, 19479.415617531497, 7966.482178658369, 8483.618237179342, 8691.435056721293, 8792.42849214799, 8861.291096712248, 4738.8341408050555, 4781.6891902026255, 4812.157872372391, 4872.4153101628035, 4879.219324908068, 3530.805805680712, 3639.5814481334455, 3651.6165802590876, 3657.707383409374, 3659.0486473517076, 615.3630991923338, 615.8645098078416, 623.429561950819, 639.0861068671844, 648.4293821437105, 594.881023795234, 741.6588369350052, 745.8396444764293, 769.3071272582931, 773.9264769846856, 8896.59965301563, 8998.64005439775, 9082.36423450352, 9478.099580539838, 9615.90384096164, 684.1619016704597, 720.4704542161508, 738.235925816777, 744.114503740547, 745.1356426545182, 4329.307310830315, 4465.7767111644935, 4503.774811259489, 4503.842365517191, 4539.818407263739, 81691.5915420419, 91117.54441227751, 91637.0, 92948.0, 95153.0, 49517.257241141415, 51227.23159152616, 51884.48115518797, 63189.36810631835, 80974.59512702399, 49059.50940490621, 66820.33179668238, 68104.6594767023, 69047.3095269041, 69847.3015269851, 9547.236221102434, 9607.711768646952, 9716.0, 9874.111329980049, 10018.499075046364, 45496.54503455055, 45668.314975276066, 45984.31023534583, 46116.30825537687, 47368.52631473641, 36441.0, 44086.0, 52784.0, 54926.0, 55628.16557751718, 13177.341132943506, 13308.667283317995, 13700.109492882932, 13750.312484375941, 13969.092009019787, 14395.28023598795, 14664.706705866036, 15377.76933346023, 15601.609959751097, 15610.687786243985, 13766.793498097737, 14242.928785356007, 14283.071600345944, 14304.427822886968, 14340.713185736435, 12688.6827829305, 13045.412956416794, 13063.542776002794, 13195.736085278433, 14118.43526258938, 13615.25116118623, 13913.791293130813, 13917.443302267797, 14056.648583785487, 14143.222122783345, 11522.82715759281, 11716.774795171115, 11919.404029798301, 12276.570320039113, 12510.437030333838, 11124.388158651029, 11203.327800332007, 11467.0, 11476.368799715761, 11577.594784182513], "value": 7187.854933138407, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1475.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 112.0, 112.0, 111.0, 113.0, 112.0, 114.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 124.0, 164.0, 124.0, 125.0, 131.0, 129.0, 156.0, 128.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 164.0, 160.0, 162.0, 161.0, 163.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 112.0, 79.0, 78.0, 76.0, 77.0, 97.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 118.0, 84.0, 83.0, 82.0, 104.0, 82.0, 82.0, 109.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 121.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 52.0, 51.0, 51.0, 59.0, 53.0, 56.0, 52.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 79.0, 76.0, 78.0, 76.0, 77.0, 78.0, 76.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 124.0, 133.0, 130.0, 136.0, 128.0, 132.0, 171.0, 130.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 158.0, 156.0, 160.0, 155.0, 163.0, 153.0, 153.0, 158.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 71.0, 62.0, 61.0, 61.0, 66.0, 61.0, 64.0, 61.0], "value": 63.2, "unit": "score"}]}]} 09:38:07 INFO - Return code: 0 09:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:07 ERROR - # TBPL SUCCESS # 09:38:07 INFO - Running post-action listener: _resource_record_post_action 09:38:07 INFO - [mozharness: 2016-11-26 17:38:07.424926Z] Finished run-tests step (success) 09:38:07 INFO - Running post-run listener: _resource_record_post_run 09:38:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 696320; Write bytes: 365604864; Read time: 124; Write time: 255060 09:38:07 INFO - TinderboxPrint: CPU usage
13.3% 09:38:07 INFO - TinderboxPrint: I/O read bytes / time
696,320 / 124 09:38:07 INFO - TinderboxPrint: I/O write bytes / time
365,604,864 / 255,060 09:38:07 INFO - TinderboxPrint: CPU idle
8,234.3 (86.7%) 09:38:07 INFO - TinderboxPrint: CPU user
1,208.2 (12.7%) 09:38:07 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108064768; Read time: 16; Write time: 102264 09:38:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 688128; Write bytes: 245129216; Read time: 96; Write time: 150504 09:38:08 INFO - Running post-run listener: _upload_blobber_files 09:38:08 INFO - Blob upload gear active. 09:38:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:08 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 09:38:08 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:38:08 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:38:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:09 INFO - (blobuploader) - INFO - Done attempting. 09:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:10 INFO - (blobuploader) - INFO - Done attempting. 09:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:13 INFO - (blobuploader) - INFO - Done attempting. 09:38:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:13 INFO - Return code: 0 09:38:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08f1de4eecc3c68860c3e3cf946dd0395731611038cff3724527eaa294178d30b9c3624972252406ada68a9c29565f33276f2c1be9c3c16b3ded680f4fa78252", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/616d174463248856d5d1ce07d3e93e81bcdf446907e923c802b748c5e99ffd57244fd3e235ea459eb1b5706602b6f76e3d685c7b80d32bb6f1e6905fb88b6013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2651c693b3fa72b5393173ff2ad8f2c90a73d897aaeda0183b8d36c1482f3d1b75f6b48b4b3e050f4acaecf79badbb6a999b041553d8a95bb20f51157b62ffdc"} 09:38:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:13 INFO - Contents: 09:38:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08f1de4eecc3c68860c3e3cf946dd0395731611038cff3724527eaa294178d30b9c3624972252406ada68a9c29565f33276f2c1be9c3c16b3ded680f4fa78252", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/616d174463248856d5d1ce07d3e93e81bcdf446907e923c802b748c5e99ffd57244fd3e235ea459eb1b5706602b6f76e3d685c7b80d32bb6f1e6905fb88b6013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2651c693b3fa72b5393173ff2ad8f2c90a73d897aaeda0183b8d36c1482f3d1b75f6b48b4b3e050f4acaecf79badbb6a999b041553d8a95bb20f51157b62ffdc"} 09:38:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:13 INFO - Copying logs to upload dir... 09:38:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.021890 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-26 09:38:12.792616) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:12.795746) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08f1de4eecc3c68860c3e3cf946dd0395731611038cff3724527eaa294178d30b9c3624972252406ada68a9c29565f33276f2c1be9c3c16b3ded680f4fa78252", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/616d174463248856d5d1ce07d3e93e81bcdf446907e923c802b748c5e99ffd57244fd3e235ea459eb1b5706602b6f76e3d685c7b80d32bb6f1e6905fb88b6013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2651c693b3fa72b5393173ff2ad8f2c90a73d897aaeda0183b8d36c1482f3d1b75f6b48b4b3e050f4acaecf79badbb6a999b041553d8a95bb20f51157b62ffdc"} build_url:https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08f1de4eecc3c68860c3e3cf946dd0395731611038cff3724527eaa294178d30b9c3624972252406ada68a9c29565f33276f2c1be9c3c16b3ded680f4fa78252", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/616d174463248856d5d1ce07d3e93e81bcdf446907e923c802b748c5e99ffd57244fd3e235ea459eb1b5706602b6f76e3d685c7b80d32bb6f1e6905fb88b6013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2651c693b3fa72b5393173ff2ad8f2c90a73d897aaeda0183b8d36c1482f3d1b75f6b48b4b3e050f4acaecf79badbb6a999b041553d8a95bb20f51157b62ffdc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:12.820902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:12.821193) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1480160034.363848-1970799620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:12.902966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 09:38:12.903299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 09:38:12.903575) ========= ========= Total master_lag: 0.16 =========