builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1480722544.04 results: success (0) buildid: 20161202141144 builduid: 5379c59769e84e12858a96cd0b6f4310 revision: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.040929) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.041475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.041787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.060341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.060625) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-02 15:49:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-12-02 15:49:04 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.149079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.149673) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015102 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.202486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:04.202853) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 --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 bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-02 15:49:04,454 truncating revision to first 12 chars 2016-12-02 15:49:04,454 Setting DEBUG logging. 2016-12-02 15:49:04,455 attempt 1/10 2016-12-02 15:49:04,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb91b72c0d3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 15:49:05,064 unpacking tar archive at: mozilla-aurora-bb91b72c0d3b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949105 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:05.168103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:05.168477) ========= script_repo_revision: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:05.168958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:05.169293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:49:05.178649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-02 15:49:05.178977) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:49:05 INFO - MultiFileLogger online at 20161202 15:49:05 in /builds/slave/test 15:49:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:49:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:49:05 INFO - {'append_to_log': False, 15:49:05 INFO - 'base_work_dir': '/builds/slave/test', 15:49:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:49:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:49:05 INFO - 'branch': 'Mozilla-Aurora', 15:49:05 INFO - 'buildbot_json_path': 'buildprops.json', 15:49:05 INFO - 'config_files': ('talos/linux_config.py',), 15:49:05 INFO - 'default_actions': ('clobber', 15:49:05 INFO - 'read-buildbot-config', 15:49:05 INFO - 'download-and-extract', 15:49:05 INFO - 'populate-webroot', 15:49:05 INFO - 'create-virtualenv', 15:49:05 INFO - 'install', 15:49:05 INFO - 'run-tests'), 15:49:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:49:05 INFO - 'download_minidump_stackwalk': True, 15:49:05 INFO - 'download_symbols': 'ondemand', 15:49:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:49:05 INFO - 'tooltool.py': '/tools/tooltool.py', 15:49:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:49:05 INFO - '/tools/misc-python/virtualenv.py')}, 15:49:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:49:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:49:05 INFO - 'installer_path': 'installer.exe', 15:49:05 INFO - 'log_level': 'info', 15:49:05 INFO - 'log_name': 'talos', 15:49:05 INFO - 'log_to_console': True, 15:49:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:49:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:49:05 INFO - 'opt_config_files': (), 15:49:05 INFO - 'pip_index': False, 15:49:05 INFO - 'sps_profile': False, 15:49:05 INFO - 'sps_profile_interval': 0, 15:49:05 INFO - 'suite': 'dromaeojs', 15:49:05 INFO - 'system_bits': '32', 15:49:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:49:05 INFO - 'title': 'talos-linux64-ix-012', 15:49:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:49:05 INFO - 'use_talos_json': True, 15:49:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:49:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:49:05 INFO - 'work_dir': 'build'} 15:49:05 INFO - [mozharness: 2016-12-02 23:49:05.529727Z] Running clobber step. 15:49:05 INFO - Running pre-action listener: _resource_record_pre_action 15:49:05 INFO - Running main action method: clobber 15:49:05 INFO - rmtree: /builds/slave/test/build 15:49:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:49:06 INFO - Running post-action listener: _resource_record_post_action 15:49:06 INFO - [mozharness: 2016-12-02 23:49:06.522701Z] Finished clobber step (success) 15:49:06 INFO - [mozharness: 2016-12-02 23:49:06.522799Z] Running read-buildbot-config step. 15:49:06 INFO - Running pre-action listener: _resource_record_pre_action 15:49:06 INFO - Running main action method: read_buildbot_config 15:49:06 INFO - Using buildbot properties: 15:49:06 INFO - { 15:49:06 INFO - "project": "", 15:49:06 INFO - "product": "firefox", 15:49:06 INFO - "script_repo_revision": "production", 15:49:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:49:06 INFO - "repository": "", 15:49:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:49:06 INFO - "buildid": "20161202141144", 15:49:06 INFO - "pgo_build": "True", 15:49:06 INFO - "basedir": "/builds/slave/test", 15:49:06 INFO - "buildnumber": 949, 15:49:06 INFO - "slavename": "talos-linux64-ix-012", 15:49:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:49:06 INFO - "platform": "ubuntu64_hw", 15:49:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:49:06 INFO - "branch": "mozilla-aurora", 15:49:06 INFO - "repo_path": "releases/mozilla-aurora", 15:49:06 INFO - "revision": "bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1", 15:49:06 INFO - "stage_platform": "linux64-pgo", 15:49:06 INFO - "builduid": "5379c59769e84e12858a96cd0b6f4310", 15:49:06 INFO - "slavebuilddir": "test" 15:49:06 INFO - } 15:49:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 15:49:06 INFO - Running post-action listener: _resource_record_post_action 15:49:06 INFO - [mozharness: 2016-12-02 23:49:06.525206Z] Finished read-buildbot-config step (success) 15:49:06 INFO - [mozharness: 2016-12-02 23:49:06.525294Z] Running download-and-extract step. 15:49:06 INFO - Running pre-action listener: _resource_record_pre_action 15:49:06 INFO - Running main action method: download_and_extract 15:49:06 INFO - mkdir: /builds/slave/test/build/tests 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:06 INFO - trying https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:49:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/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 15:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/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 15:49:07 INFO - Downloaded 1361 bytes. 15:49:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:49:07 INFO - Using the following test package requirements: 15:49:07 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:49:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:49:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:49:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'jsshell-linux-x86_64.zip'], 15:49:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:49:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:49:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:49:07 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:49:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:49:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:49:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:49:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:49:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:49:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:49:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:49:07 INFO - Http code: 200 15:49:07 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 15:49:07 INFO - x-amz-cf-id: rjnPMHKA7o5fIIxvYJniV8rxwEctNZiPq538DKoUwqazWgGLcPnrFg== 15:49:07 INFO - x-amz-version-id: y9GuPwKeNgzW9zz9DeoAsCnALJzpgary 15:49:07 INFO - Expected file size: 21955360 15:49:07 INFO - Obtained file size: 21955360 15:49:11 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 15:49:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:49:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:49:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:49:12 INFO - Http code: 200 15:49:12 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 15:49:12 INFO - x-amz-cf-id: FyYRC8faZU-YN3yy3Fn8nulq3UIDcM2tyjqOkC_hn7mLV1vvMsTMYg== 15:49:12 INFO - x-amz-version-id: y9GuPwKeNgzW9zz9DeoAsCnALJzpgary 15:49:12 INFO - Expected file size: 21955360 15:49:12 INFO - Obtained file size: 21955360 15:49:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 15:49:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:49:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:49:17 INFO - Http code: 200 15:49:17 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 15:49:17 INFO - x-amz-cf-id: qYokdj8nS7kstm_r5bXFI6mZVONBGxTEWL1lAgHKx_lVL0_3kcuKog== 15:49:17 INFO - x-amz-version-id: hHJ1SfvtQqXUfFWxHYxzioUH8f5thues 15:49:17 INFO - Expected file size: 14409038 15:49:17 INFO - Obtained file size: 14409038 15:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:18 INFO - trying https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:49:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/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 15:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/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 15:49:19 INFO - Downloaded 63987849 bytes. 15:49:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:49:19 INFO - mkdir: /builds/slave/test/properties 15:49:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:19 INFO - Contents: 15:49:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:49:19 INFO - Running post-action listener: _resource_record_post_action 15:49:19 INFO - Running post-action listener: set_extra_try_arguments 15:49:19 INFO - [mozharness: 2016-12-02 23:49:19.975389Z] Finished download-and-extract step (success) 15:49:19 INFO - [mozharness: 2016-12-02 23:49:19.975616Z] Running populate-webroot step. 15:49:19 INFO - Running pre-action listener: _resource_record_pre_action 15:49:19 INFO - Running main action method: populate_webroot 15:49:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:19 INFO - '--tppagecycles', 15:49:19 INFO - '7'], 15:49:19 INFO - 'tests': ['tsvgm']}}, 15:49:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['damp', 'tps']}, 15:49:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'tests': ['damp', 'tps']}, 15:49:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['dromaeo_dom']}, 15:49:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['basic_compositor_video']}, 15:49:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['a11yr', 15:49:19 INFO - 'ts_paint', 15:49:19 INFO - 'tpaint', 15:49:19 INFO - 'sessionrestore', 15:49:19 INFO - 'sessionrestore_no_auto_restore', 15:49:19 INFO - 'tabpaint']}, 15:49:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:19 INFO - 'ts_paint', 15:49:19 INFO - 'tpaint', 15:49:19 INFO - 'sessionrestore', 15:49:19 INFO - 'sessionrestore_no_auto_restore', 15:49:19 INFO - 'tabpaint']}, 15:49:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:19 INFO - 'ts_paint', 15:49:19 INFO - 'tpaint', 15:49:19 INFO - 'sessionrestore', 15:49:19 INFO - 'sessionrestore_no_auto_restore', 15:49:19 INFO - 'tabpaint']}, 15:49:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:19 INFO - 'ts_paint', 15:49:19 INFO - 'tpaint', 15:49:19 INFO - 'sessionrestore', 15:49:19 INFO - 'sessionrestore_no_auto_restore', 15:49:19 INFO - 'tabpaint']}, 15:49:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['a11yr', 15:49:19 INFO - 'ts_paint', 15:49:19 INFO - 'tpaint', 15:49:19 INFO - 'sessionrestore', 15:49:19 INFO - 'sessionrestore_no_auto_restore', 15:49:19 INFO - 'tabpaint']}, 15:49:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['a11yr', 15:49:19 INFO - 'ts_paint', 15:49:19 INFO - 'tpaint', 15:49:19 INFO - 'sessionrestore', 15:49:19 INFO - 'sessionrestore_no_auto_restore', 15:49:19 INFO - 'tabpaint']}, 15:49:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['tsvgx', 15:49:19 INFO - 'tsvgr_opacity', 15:49:19 INFO - 'tart', 15:49:19 INFO - 'tscrollx', 15:49:19 INFO - 'cart']}, 15:49:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:19 INFO - 'tsvgr_opacity', 15:49:19 INFO - 'tart', 15:49:19 INFO - 'tscrollx', 15:49:19 INFO - 'cart']}, 15:49:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'talos_options': ['--disable-e10s'], 15:49:19 INFO - 'tests': ['tp5o']}, 15:49:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'tests': ['tp5o']}, 15:49:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'talos_options': ['--disable-e10s', 15:49:19 INFO - '--xperf_path', 15:49:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:19 INFO - 'tests': ['tp5n']}, 15:49:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:19 INFO - 'talos_options': ['--xperf_path', 15:49:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:19 INFO - 'tests': ['tp5n']}}, 15:49:19 INFO - 'talos.zip': {'path': '', 15:49:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:19 INFO - Running post-action listener: _resource_record_post_action 15:49:19 INFO - [mozharness: 2016-12-02 23:49:19.995056Z] Finished populate-webroot step (success) 15:49:19 INFO - [mozharness: 2016-12-02 23:49:19.995145Z] Running create-virtualenv step. 15:49:19 INFO - Running pre-action listener: _resource_record_pre_action 15:49:19 INFO - Running main action method: create_virtualenv 15:49:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:49:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:20 INFO - Using real prefix '/usr' 15:49:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:20 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:22 INFO - Installing pip.................done. 15:49:22 INFO - Return code: 0 15:49:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:22 INFO - Reading from file tmpfile_stdout 15:49:22 INFO - Output received: 15:49:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:49:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:22 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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:49:22 INFO - Using env: {'DISPLAY': ':0', 15:49:22 INFO - 'HOME': '/home/cltbld', 15:49:22 INFO - 'LANG': 'en_US.UTF-8', 15:49:22 INFO - 'LANGUAGE': 'en_US:en', 15:49:22 INFO - 'LOGNAME': 'cltbld', 15:49:22 INFO - 'MAIL': '/var/mail/cltbld', 15:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:22 INFO - 'MOZ_NO_REMOTE': '1', 15:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:22 INFO - 'NO_EM_RESTART': '1', 15:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:22 INFO - 'PWD': '/builds/slave/test', 15:49:22 INFO - 'SHELL': '/bin/bash', 15:49:22 INFO - 'SHLVL': '1', 15:49:22 INFO - 'TERM': 'linux', 15:49:22 INFO - 'TMOUT': '86400', 15:49:22 INFO - 'USER': 'cltbld', 15:49:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:22 INFO - '_': '/tools/buildbot/bin/python'} 15:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:49:22 INFO - Cleaning up... 15:49:22 INFO - Return code: 0 15:49:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:23 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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:49:23 INFO - Using env: {'DISPLAY': ':0', 15:49:23 INFO - 'HOME': '/home/cltbld', 15:49:23 INFO - 'LANG': 'en_US.UTF-8', 15:49:23 INFO - 'LANGUAGE': 'en_US:en', 15:49:23 INFO - 'LOGNAME': 'cltbld', 15:49:23 INFO - 'MAIL': '/var/mail/cltbld', 15:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:23 INFO - 'MOZ_NO_REMOTE': '1', 15:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:23 INFO - 'NO_EM_RESTART': '1', 15:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:23 INFO - 'PWD': '/builds/slave/test', 15:49:23 INFO - 'SHELL': '/bin/bash', 15:49:23 INFO - 'SHLVL': '1', 15:49:23 INFO - 'TERM': 'linux', 15:49:23 INFO - 'TMOUT': '86400', 15:49:23 INFO - 'USER': 'cltbld', 15:49:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:23 INFO - '_': '/tools/buildbot/bin/python'} 15:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:23 INFO - Downloading/unpacking psutil>=3.1.1 15:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:25 INFO - Installing collected packages: psutil 15:49:25 INFO - Running setup.py install for psutil 15:49:25 INFO - building 'psutil._psutil_linux' extension 15:49:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:49:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:49:25 INFO - building 'psutil._psutil_posix' extension 15:49:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:49:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:49:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:25 INFO - Successfully installed psutil 15:49:25 INFO - Cleaning up... 15:49:25 INFO - Return code: 0 15:49:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:49:25 INFO - Using env: {'DISPLAY': ':0', 15:49:25 INFO - 'HOME': '/home/cltbld', 15:49:25 INFO - 'LANG': 'en_US.UTF-8', 15:49:25 INFO - 'LANGUAGE': 'en_US:en', 15:49:25 INFO - 'LOGNAME': 'cltbld', 15:49:25 INFO - 'MAIL': '/var/mail/cltbld', 15:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:25 INFO - 'MOZ_NO_REMOTE': '1', 15:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:25 INFO - 'NO_EM_RESTART': '1', 15:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:25 INFO - 'PWD': '/builds/slave/test', 15:49:25 INFO - 'SHELL': '/bin/bash', 15:49:25 INFO - 'SHLVL': '1', 15:49:25 INFO - 'TERM': 'linux', 15:49:25 INFO - 'TMOUT': '86400', 15:49:25 INFO - 'USER': 'cltbld', 15:49:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:25 INFO - '_': '/tools/buildbot/bin/python'} 15:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:28 INFO - Installing collected packages: mozsystemmonitor 15:49:28 INFO - Running setup.py install for mozsystemmonitor 15:49:28 INFO - Successfully installed mozsystemmonitor 15:49:28 INFO - Cleaning up... 15:49:28 INFO - Return code: 0 15:49:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:28 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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:49:28 INFO - Using env: {'DISPLAY': ':0', 15:49:28 INFO - 'HOME': '/home/cltbld', 15:49:28 INFO - 'LANG': 'en_US.UTF-8', 15:49:28 INFO - 'LANGUAGE': 'en_US:en', 15:49:28 INFO - 'LOGNAME': 'cltbld', 15:49:28 INFO - 'MAIL': '/var/mail/cltbld', 15:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:28 INFO - 'MOZ_NO_REMOTE': '1', 15:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:28 INFO - 'NO_EM_RESTART': '1', 15:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:28 INFO - 'PWD': '/builds/slave/test', 15:49:28 INFO - 'SHELL': '/bin/bash', 15:49:28 INFO - 'SHLVL': '1', 15:49:28 INFO - 'TERM': 'linux', 15:49:28 INFO - 'TMOUT': '86400', 15:49:28 INFO - 'USER': 'cltbld', 15:49:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:28 INFO - '_': '/tools/buildbot/bin/python'} 15:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:28 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:30 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:30 INFO - warning: no files found matching '*.txt' 15:49:30 INFO - no previously-included directories found matching 'build' 15:49:30 INFO - no previously-included directories found matching 'dist' 15:49:30 INFO - no previously-included directories found matching '.git*' 15:49:30 INFO - Installing collected packages: jsonschema, functools32 15:49:30 INFO - Running setup.py install for functools32 15:49:30 INFO - warning: no files found matching '*.txt' 15:49:30 INFO - no previously-included directories found matching 'build' 15:49:30 INFO - no previously-included directories found matching 'dist' 15:49:30 INFO - no previously-included directories found matching '.git*' 15:49:30 INFO - Successfully installed jsonschema functools32 15:49:30 INFO - Cleaning up... 15:49:30 INFO - Return code: 0 15:49:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:30 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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:49:30 INFO - Using env: {'DISPLAY': ':0', 15:49:30 INFO - 'HOME': '/home/cltbld', 15:49:30 INFO - 'LANG': 'en_US.UTF-8', 15:49:30 INFO - 'LANGUAGE': 'en_US:en', 15:49:30 INFO - 'LOGNAME': 'cltbld', 15:49:30 INFO - 'MAIL': '/var/mail/cltbld', 15:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:30 INFO - 'MOZ_NO_REMOTE': '1', 15:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:30 INFO - 'NO_EM_RESTART': '1', 15:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:30 INFO - 'PWD': '/builds/slave/test', 15:49:30 INFO - 'SHELL': '/bin/bash', 15:49:30 INFO - 'SHLVL': '1', 15:49:30 INFO - 'TERM': 'linux', 15:49:30 INFO - 'TMOUT': '86400', 15:49:30 INFO - 'USER': 'cltbld', 15:49:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:30 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:31 INFO - Cleaning up... 15:49:31 INFO - Return code: 0 15:49:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:33 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:34 INFO - Downloading docopt-0.6.1.tar.gz 15:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:34 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:34 INFO - Running setup.py install for blobuploader 15:49:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:34 INFO - Running setup.py install for requests 15:49:34 INFO - Running setup.py install for docopt 15:49:34 INFO - Successfully installed blobuploader requests docopt 15:49:34 INFO - Cleaning up... 15:49:34 INFO - Return code: 0 15:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:49:34 INFO - Using env: {'DISPLAY': ':0', 15:49:34 INFO - 'HOME': '/home/cltbld', 15:49:34 INFO - 'LANG': 'en_US.UTF-8', 15:49:34 INFO - 'LANGUAGE': 'en_US:en', 15:49:34 INFO - 'LOGNAME': 'cltbld', 15:49:34 INFO - 'MAIL': '/var/mail/cltbld', 15:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:34 INFO - 'MOZ_NO_REMOTE': '1', 15:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:34 INFO - 'NO_EM_RESTART': '1', 15:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:34 INFO - 'PWD': '/builds/slave/test', 15:49:34 INFO - 'SHELL': '/bin/bash', 15:49:34 INFO - 'SHLVL': '1', 15:49:34 INFO - 'TERM': 'linux', 15:49:34 INFO - 'TMOUT': '86400', 15:49:34 INFO - 'USER': 'cltbld', 15:49:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:34 INFO - '_': '/tools/buildbot/bin/python'} 15:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:34 INFO - Running setup.py (path:/tmp/pip-1CQygM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:35 INFO - Running setup.py (path:/tmp/pip-9MBa_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:35 INFO - Running setup.py (path:/tmp/pip-Gg1tjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:35 INFO - Running setup.py (path:/tmp/pip-rcmnue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:35 INFO - Running setup.py (path:/tmp/pip-J2e5tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:35 INFO - Running setup.py (path:/tmp/pip-zIpAHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:35 INFO - Running setup.py (path:/tmp/pip-5Y0ZPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:35 INFO - Running setup.py (path:/tmp/pip-1Uyezo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:35 INFO - Running setup.py (path:/tmp/pip-poEeFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:35 INFO - Running setup.py (path:/tmp/pip-42b2cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 INFO - Running setup.py (path:/tmp/pip-JS3sgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:35 INFO - Running setup.py (path:/tmp/pip-ues5WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:35 INFO - Running setup.py (path:/tmp/pip-ia7uWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:35 INFO - Running setup.py (path:/tmp/pip-dGRAJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:36 INFO - Running setup.py (path:/tmp/pip-1xtedR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:36 INFO - Running setup.py (path:/tmp/pip-cvaV1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:36 INFO - Running setup.py (path:/tmp/pip-Fh_Rkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:36 INFO - Running setup.py install for manifestparser 15:49:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozcrash 15:49:36 INFO - Running setup.py install for mozdebug 15:49:36 INFO - Running setup.py install for mozdevice 15:49:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozfile 15:49:36 INFO - Running setup.py install for mozhttpd 15:49:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozinfo 15:49:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozInstall 15:49:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozleak 15:49:37 INFO - Running setup.py install for mozlog 15:49:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for moznetwork 15:49:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozprocess 15:49:37 INFO - Running setup.py install for mozprofile 15:49:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozrunner 15:49:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozscreenshot 15:49:37 INFO - Running setup.py install for moztest 15:49:37 INFO - Running setup.py install for mozversion 15:49:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:38 INFO - Cleaning up... 15:49:38 INFO - Return code: 0 15:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:38 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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:49:38 INFO - Using env: {'DISPLAY': ':0', 15:49:38 INFO - 'HOME': '/home/cltbld', 15:49:38 INFO - 'LANG': 'en_US.UTF-8', 15:49:38 INFO - 'LANGUAGE': 'en_US:en', 15:49:38 INFO - 'LOGNAME': 'cltbld', 15:49:38 INFO - 'MAIL': '/var/mail/cltbld', 15:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:38 INFO - 'MOZ_NO_REMOTE': '1', 15:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:38 INFO - 'NO_EM_RESTART': '1', 15:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:38 INFO - 'PWD': '/builds/slave/test', 15:49:38 INFO - 'SHELL': '/bin/bash', 15:49:38 INFO - 'SHLVL': '1', 15:49:38 INFO - 'TERM': 'linux', 15:49:38 INFO - 'TMOUT': '86400', 15:49:38 INFO - 'USER': 'cltbld', 15:49:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:38 INFO - '_': '/tools/buildbot/bin/python'} 15:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:38 INFO - Running setup.py (path:/tmp/pip-n7KACV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:38 INFO - Running setup.py (path:/tmp/pip-KB4ZuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:38 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)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:38 INFO - Running setup.py (path:/tmp/pip-xdjAEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:38 INFO - Running setup.py (path:/tmp/pip-D5pciV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:38 INFO - Running setup.py (path:/tmp/pip-9cFjXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:38 INFO - Running setup.py (path:/tmp/pip-h4MPbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:38 INFO - Running setup.py (path:/tmp/pip-BQQ059-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:38 INFO - Running setup.py (path:/tmp/pip-DP8OP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:38 INFO - Running setup.py (path:/tmp/pip-0dxzlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:38 INFO - Running setup.py (path:/tmp/pip-4dzJxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:39 INFO - Running setup.py (path:/tmp/pip-VdSFDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:39 INFO - Running setup.py (path:/tmp/pip-8ZHgt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:39 INFO - Running setup.py (path:/tmp/pip-EtDxqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:39 INFO - Running setup.py (path:/tmp/pip-50lSAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:39 INFO - Running setup.py (path:/tmp/pip-Hxc_k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:39 INFO - Running setup.py (path:/tmp/pip-sMwKZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:39 INFO - Running setup.py (path:/tmp/pip-qvgouQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:49:39 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)) 15:49:39 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)) 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:41 INFO - Downloading blessings-1.6.tar.gz 15:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:41 INFO - Installing collected packages: blessings 15:49:41 INFO - Running setup.py install for blessings 15:49:41 INFO - Successfully installed blessings 15:49:41 INFO - Cleaning up... 15:49:41 INFO - Return code: 0 15:49:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:41 INFO - Reading from file tmpfile_stdout 15:49:41 INFO - Current package versions: 15:49:41 INFO - argparse == 1.2.1 15:49:41 INFO - blessings == 1.6 15:49:41 INFO - blobuploader == 1.2.4 15:49:41 INFO - docopt == 0.6.1 15:49:41 INFO - functools32 == 3.2.3-2 15:49:41 INFO - jsonschema == 2.5.1 15:49:41 INFO - manifestparser == 1.1 15:49:41 INFO - mozInstall == 1.12 15:49:41 INFO - mozcrash == 1.0 15:49:41 INFO - mozdebug == 0.1 15:49:41 INFO - mozdevice == 0.48 15:49:41 INFO - mozfile == 1.2 15:49:41 INFO - mozhttpd == 0.7 15:49:41 INFO - mozinfo == 0.9 15:49:41 INFO - mozleak == 0.1 15:49:41 INFO - mozlog == 3.4 15:49:41 INFO - moznetwork == 0.27 15:49:41 INFO - mozprocess == 0.23 15:49:41 INFO - mozprofile == 0.28 15:49:41 INFO - mozrunner == 6.13 15:49:41 INFO - mozscreenshot == 0.1 15:49:41 INFO - mozsystemmonitor == 0.3 15:49:41 INFO - moztest == 0.7 15:49:41 INFO - mozversion == 1.4 15:49:41 INFO - psutil == 3.1.1 15:49:41 INFO - requests == 1.2.3 15:49:41 INFO - wsgiref == 0.1.2 15:49:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 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 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:49:42 INFO - Using env: {'DISPLAY': ':0', 15:49:42 INFO - 'HOME': '/home/cltbld', 15:49:42 INFO - 'LANG': 'en_US.UTF-8', 15:49:42 INFO - 'LANGUAGE': 'en_US:en', 15:49:42 INFO - 'LOGNAME': 'cltbld', 15:49:42 INFO - 'MAIL': '/var/mail/cltbld', 15:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:42 INFO - 'MOZ_NO_REMOTE': '1', 15:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:42 INFO - 'NO_EM_RESTART': '1', 15:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:42 INFO - 'PWD': '/builds/slave/test', 15:49:42 INFO - 'SHELL': '/bin/bash', 15:49:42 INFO - 'SHLVL': '1', 15:49:42 INFO - 'TERM': 'linux', 15:49:42 INFO - 'TMOUT': '86400', 15:49:42 INFO - 'USER': 'cltbld', 15:49:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:42 INFO - '_': '/tools/buildbot/bin/python'} 15:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:49:42 INFO - Cleaning up... 15:49:42 INFO - Return code: 0 15:49:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc07cc97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:49:42 INFO - Using env: {'DISPLAY': ':0', 15:49:42 INFO - 'HOME': '/home/cltbld', 15:49:42 INFO - 'LANG': 'en_US.UTF-8', 15:49:42 INFO - 'LANGUAGE': 'en_US:en', 15:49:42 INFO - 'LOGNAME': 'cltbld', 15:49:42 INFO - 'MAIL': '/var/mail/cltbld', 15:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:42 INFO - 'MOZ_NO_REMOTE': '1', 15:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:42 INFO - 'NO_EM_RESTART': '1', 15:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:42 INFO - 'PWD': '/builds/slave/test', 15:49:42 INFO - 'SHELL': '/bin/bash', 15:49:42 INFO - 'SHLVL': '1', 15:49:42 INFO - 'TERM': 'linux', 15:49:42 INFO - 'TMOUT': '86400', 15:49:42 INFO - 'USER': 'cltbld', 15:49:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:42 INFO - '_': '/tools/buildbot/bin/python'} 15:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:42 INFO - Cleaning up... 15:49:42 INFO - Return code: 0 15:49:42 INFO - Running post-action listener: _resource_record_post_action 15:49:42 INFO - Running post-action listener: _start_resource_monitoring 15:49:42 INFO - Starting resource monitoring. 15:49:42 INFO - [mozharness: 2016-12-02 23:49:42.488372Z] Finished create-virtualenv step (success) 15:49:42 INFO - [mozharness: 2016-12-02 23:49:42.488879Z] Running install step. 15:49:42 INFO - Running pre-action listener: _resource_record_pre_action 15:49:42 INFO - Running main action method: install 15:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:42 INFO - Reading from file tmpfile_stdout 15:49:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:42 INFO - Reading from file tmpfile_stdout 15:49:42 INFO - Output received: 15:49:42 INFO - Usage: mozinstall [options] installer 15:49:42 INFO - Options: 15:49:42 INFO - -h, --help show this help message and exit 15:49:42 INFO - -d DEST, --destination=DEST 15:49:42 INFO - Directory to install application into. [default: 15:49:42 INFO - "/builds/slave/test"] 15:49:42 INFO - --app=APP Application being installed. [default: firefox] 15:49:42 INFO - mkdir: /builds/slave/test/build/application 15:49:42 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'] 15:49:42 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 15:49:58 INFO - Reading from file tmpfile_stdout 15:49:58 INFO - Output received: 15:49:58 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:58 INFO - Running post-action listener: _resource_record_post_action 15:49:58 INFO - [mozharness: 2016-12-02 23:49:58.705035Z] Finished install step (success) 15:49:58 INFO - [mozharness: 2016-12-02 23:49:58.705278Z] Running run-tests step. 15:49:58 INFO - Running pre-action listener: _resource_record_pre_action 15:49:58 INFO - Running main action method: run_tests 15:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:58 INFO - Python 2.7.3 15:49:58 INFO - Return code: 0 15:49:58 INFO - grabbing minidump binary from tooltool 15:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:58 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 0xda6f60>, '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 0xda7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:49:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:49:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:49:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:58 INFO - Return code: 0 15:49:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:58 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:49:58 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:49:58 INFO - Using env: {'DISPLAY': ':0', 15:49:58 INFO - 'HOME': '/home/cltbld', 15:49:58 INFO - 'LANG': 'en_US.UTF-8', 15:49:58 INFO - 'LANGUAGE': 'en_US:en', 15:49:58 INFO - 'LOGNAME': 'cltbld', 15:49:58 INFO - 'MAIL': '/var/mail/cltbld', 15:49:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:58 INFO - 'MOZ_NO_REMOTE': '1', 15:49:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:58 INFO - 'NO_EM_RESTART': '1', 15:49:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:58 INFO - 'PWD': '/builds/slave/test', 15:49:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:58 INFO - 'SHELL': '/bin/bash', 15:49:58 INFO - 'SHLVL': '1', 15:49:58 INFO - 'TERM': 'linux', 15:49:58 INFO - 'TMOUT': '86400', 15:49:58 INFO - 'USER': 'cltbld', 15:49:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256', 15:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:58 INFO - '_': '/tools/buildbot/bin/python'} 15:49:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:49:58 INFO - mozversion application_buildid: 20161202141144 15:49:58 INFO - mozversion application_changeset: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 15:49:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:49:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:58 INFO - mozversion application_name: Firefox 15:49:58 INFO - mozversion application_remotingname: firefox-dev 15:49:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:49:58 INFO - mozversion application_vendor: Mozilla 15:49:58 INFO - mozversion application_version: 52.0a2 15:49:58 INFO - mozversion platform_buildid: 20161202141144 15:49:58 INFO - mozversion platform_changeset: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 15:49:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:49:58 INFO - mozversion platform_version: 52.0a2 15:49:58 INFO - using testdate: 1480722598 15:49:58 INFO - actual date: 1480722598 15:49:58 INFO - starting webserver on 'localhost:60471' 15:49:58 INFO - SUITE-START | Running 2 tests 15:49:58 INFO - TEST-START | dromaeo_css 15:49:58 INFO - operating with platform_type : linux_ 15:49:58 INFO - Initialising browser for dromaeo_css test... 15:49:58 INFO - TEST-INFO | started process 16732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpimNPKJ/profile http://localhost:60471/getInfo.html) 15:50:02 INFO - PROCESS | 16732 | __metrics Screen width/height:1600/1200 15:50:02 INFO - PROCESS | 16732 | colorDepth:24 15:50:02 INFO - PROCESS | 16732 | Browser inner width/height: 1024/697 15:50:02 INFO - PROCESS | 16732 | __metrics 15:50:03 INFO - PROCESS | 16732 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:50:03 INFO - PROCESS | 16732 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:03 INFO - PROCESS | 16732 | console.error: PushService: 15:50:03 INFO - PROCESS | 16732 | stateChangeProcessEnqueue: Error transitioning state 15:50:03 INFO - PROCESS | 16732 | UnknownError 15:50:04 INFO - TEST-INFO | 16732: exit 0 15:50:04 INFO - Browser initialized. 15:50:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:04 INFO - TEST-INFO | started process 16828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpimNPKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:15 INFO - PROCESS | 16828 | RSS: Main: 144986112 15:50:15 INFO - PROCESS | 16828 | 15:51:07 INFO - PROCESS | 16828 | 1480722667217 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:53:17 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60471/tests/dromaeo/cssquery-ext.html) 15:53:18 INFO - PROCESS | 16828 | RSS: Main: 246595584 15:53:18 INFO - PROCESS | 16828 | 15:56:20 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-ext.html (next: http://localhost:60471/tests/dromaeo/cssquery-jquery.html) 15:56:21 INFO - PROCESS | 16828 | RSS: Main: 225734656 15:56:21 INFO - PROCESS | 16828 | 15:59:23 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60471/tests/dromaeo/cssquery-mootools.html) 15:59:23 INFO - PROCESS | 16828 | RSS: Main: 206921728 15:59:23 INFO - PROCESS | 16828 | 16:02:25 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60471/tests/dromaeo/cssquery-prototype.html) 16:02:26 INFO - PROCESS | 16828 | RSS: Main: 174481408 16:02:26 INFO - PROCESS | 16828 | 16:05:29 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60471/tests/dromaeo/cssquery-yui.html) 16:05:29 INFO - PROCESS | 16828 | RSS: Main: 175083520 16:05:29 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-yui.html (next: http://localhost:60471/tests/dromaeo/cssquery-dojo.html) 16:08:32 INFO - PROCESS | 16828 | RSS: Main: 257347584 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | __start_tp_report 16:08:32 INFO - PROCESS | 16828 | _x_x_mozilla_page_load 16:08:32 INFO - PROCESS | 16828 | _x_x_mozilla_page_load_details 16:08:32 INFO - PROCESS | 16828 | |i|pagename|runs| 16:08:32 INFO - PROCESS | 16828 | |0;dojo.html;3132.498800191969;3167.9841600791992;3176.158318045717;3183.474726670098;3187.1235410262175;5316.494932981365;5337.066013447646;5384.446703745788;5398.217258497515;5423.105187644034;5414.83755487336;5449.727513624312;5464.9180262295995;5478.643888147268;5494.5054945054935;4969.900601987958;5013.799448022075;5017.172166592508;5026.5727413169925;5071.543561079502;4952.331435256248;4962.776675049613;5055.646104772667;5088.54203121719;5131.769070391822;4898.41219053714;4898.53463920927;4907.263910413449;4943.357363542752;4952.678075925053;4972.950270497285;5043.747812609392;5049.823256186034;5053.393592768854;5076.543111120017;4827.58965487934;4857.101436234273;4953.43035550909;4981.277714731344;5009.173486374744;5321.095413779667;5376.596755243333;5403.945960540384;5406.297181366436;5422.53908417781;5795.623284486495;5857.707114644293;5877.9118313225335;5890.322612899486;5895.498882594985;5679.318481782171;5838.445347692005;5852.76588936442;5881.323647780518;5883.411658834125;5319.308489896327;5341.278927344836;5367.060764366221;5399.325084364455;5444.945550544523;5867.677277749679;5883.382244864228;5885.911711324334;5886.087656413263;5887.558433117533;5613.803516876889;5658.066419040894;5675.801346952837;5685.943140568624;5687.687177205294;5718.628289161191;5772.7690892363835;5780.971095144498;5810.7966221182905;5881.911771323434;5781.364049954502;5816.738246778905;5826.1552074948895;5831.008728516078;5838.824835254949;5808.244928159397;5843.883122337615;5846.210761547137;5847.181394604759;5852.239208902815;4466.441694788152;4485.506594274627;4511.661625378044;4547.7498737569085;4568.565986231302;4087.1212689271947;4090.959090409058;4097.959020409818;4122.773247471418;4126.133511962522;5606.103023516218;5622.184783206412;5625.184348269478;5633.479190393437;5660.943390566124;5728.283964504437;5783.219265399117;5790.218320526759;5846.269216347957;5930.28836539618;5589.105743081088;5591.8881622368135;5592.7762889483965;5594.720263986785;5616.5787565931905;5100.979804039207;5125.154349532286;5134.383873935077;5144.30551875492;5166.889118839393;5833.241678581842;5929.436703513073;6011.6693581853415;6114.663693496811;6132.877342453126;5889.823305300848;5945.910811337747;5953.28560572734;5990.161377407079;5993.190919225849;6136.355682653436;6138.386161383826;6144.41628045335;6145.631262124287;6147.354527774698;5550.639208451437;5606.327240731139;5819.854503637443;5829.59192856513;5835.824925252249;5720.799772008127;5724.313082430135;5735.9139612905;5744.167095771007;5822.592418530662;5602.803901863415;5612.85967850807;5644.604877658525;5652.660840349592;5652.886942261214;5568.053430916835;5651.180578815966;5651.858703532444;5652.463016013472;5661.377248502579;5585.944140558705;5604.579656525695;5627.127795191752;5629;5717.742701578356;5716.28546431696;5724.084146536534;5724.856878578069;5729.856753581027;5731.5128214100605;5457.781688732565;5511.53151982086;5522.337319521683;5574.554035677217;5599.608027438203 16:08:32 INFO - PROCESS | 16828 | |1;ext.html;584.1733946465748;640.6764583885138;642.1267076775584;657.9769708060219;663.3068443476567;34577.82711086444;43707;44692.10615787682;44783.552164478344;44792.552074479245;46224.3066354005;46292.53707462925;46546.534534654726;46601.53398466014;46604.76697616507;8135.186481351847;8877.86683199751;9009.459432434074;9017;9024.278057755397;8414.326853851708;8517.403781735282;8526.658933642648;10588.04707576318;10829.512671929742;10923.563057477691;10983.835242471328;10990.120790336794;10995.175361847854;10997.780044399107;10766.084882784973;10811.513481893333;10821.13430925528;10823.729406764814;10827.621033263877;10738.08726258269;10782.514786834612;10796.67609971702;10802.51388687511;10812.567497300099;43685.56314436878;43977.34033989493;44123;44136.55863441389;44174.33738493925;3604.1710406606626;3650.7444478886487;3671.8714844980564;3807.5430948286107;4263.509696384925;30046.96700394194;30481.847590761903;30643;30751.69248307533;30754.846225768953;4246.384274280212;4477.462704475483;4485.327200919855;4525.705829121097;4636.605888499482;368344;368671.9999999973;369931.9999999973;370092;370448;55601.721991390594;55802.72098639481;55828;55878;55889;38690.6130938687;39428.605713942496;39800.80099599483;42024.159516810105;42044.159116818104;18723.625527489374;18962.14670339838;18967.43097707071;18974.81025189758;18976;13339.399727012307;14550.854491455162;14729.116253024853;14734.189619570812;14738.926305368404;17897.46307610774;19092.427227183205;19559.804401956084;19582.31461898827;20056.197752089753;7148.749793757298;7221.169565499929;7271.63641817907;7315.341619254293;7318.268173182639;914.92680585553;974.8732664753678;1051.5898799468214;1068.4657671164418;1109.6892869996414;32347.666222042335;32984.34031319408;33290;33505.66494335074;33653.495197572054;1136.8294755786533;1137.9943100284445;1148.2364227788428;1166.2652528906735;1174.929504229749;14843;18194.727079093824;18510.537236569195;18539.35112271064;19400.2239910402;523576;527891;528251;528491;529722;61054;61367.38632613706;61419.38580614136;61448;61520;1268.4482250221183;1327.4889167670324;1347.8786909178025;1391.0957877379583;1398.7062716829375;30565.23586910345;33783.4932476018;33784.3243135131;34225.31549369048;34633.65366346304;53271;53783.193252100464;53982.19026714524;53994.460055400516;54033.72983135059;381319;381571;383716;383896;386670;30114.84942575273;30414.391712166074;30746;31184.688153119085;32335;48782.75608621934;48908.75545622249;49185.75407123085;49864.75067624639;49904;41419.792901035304;41861.79069104635;41916.371254430596;41929;43439.78280108706;41081.38377924393;41554;41866.58133418749;42413.36379954365;42613.786931065144;41958.58041419669;42066.57933420627;42103.15793684171;42175.57824421716;42326.576734233495;35283.64716352804;37075.81462092672;37564;38115;38358.424623631225;28201;28485.715142848305;28490.287742806595;28631.713682862905;28645.28386790347 16:08:32 INFO - PROCESS | 16828 | |2;jquery.html;391.6313522654783;428.76861178819996;431.37881450710984;438.0953331370719;451.43345101897137;16177.676446471078;18773.873567585953;20720;20790.480237994037;20885.895570522163;19773.209071637153;19883.20467181311;20156.294529691462;20542;20689.482762930933;5726.1697053927055;5979.880402391949;5981.342052374235;5982.162497250389;5986.132010858423;5545.639533430334;5823.767049318043;5847.210626565423;5847.619904706202;5849.883002339972;5574.247476590649;5798.2172406725185;5813.476787089161;5813.505852002585;5823.039198532237;5751.10857817037;5819.9418005819825;5856.385079566627;5866.73599688015;5869.735861886225;5110.718910459923;5286.471352864722;5289.709066001368;5289.973550132263;5293.073712100406;24102;24120.63819042716;24149.275521734377;24349.14777982762;24384.878075609686;2481.416867036245;2516.735742747022;2536.340551456635;2711.227300219448;2826.477101736165;14857.257137143208;14859.8855085869;15044;15170.696586068327;15490.225488725519;1944.931927382535;1955.2179128348773;1961.9607607847763;2003.5792483578466;2034.2879992002681;81366.59316703437;81857;83406.18115880496;83606;87002;9988.450635214987;11223.943880280709;11384.203105782515;11956.760864782656;12437.191582547106;14657.853421465863;15535.145566993924;15536.300866461037;15668.138252396227;16350.264238109314;8649.524276164746;8823.647054117764;9028.18746312835;9060.81878362429;9113.908860911439;8537.573121344032;8648.78378040554;8792.47245165292;8835.911640883638;9021.548922553846;6622.5695329804375;6845.212800527904;6923.6884340204815;6978.162620485473;7114.359707626339;2065.173930427841;2084.8644838085474;2085.520330324034;2094.664853623413;2103.9368818935454;953.4422362917771;983.2772911909741;1037.6420135053395;1062.5059347403494;1113.3264375053138;19686.803131968783;20632.174713011613;20757.688634670492;20765.79234207669;21062.368128956157;1028.747956750601;1046.6179844356755;1072.4155335342257;1101.1576144249655;1135.744457497073;10765.892341076646;11689.240199387013;11706.356150411639;11717.238379505305;11744.236624619372;486682;497888;501953;507642;509211.53942302737;80003;80145.59927200327;84105.57947210225;84447.5777621108;86051.56974215215;1027.5170669785189;1044.3472829481575;1051.8001579699833;1073.313079629038;1073.5115522437272;16466.83533164701;17210.397636083177;17695.64608707793;18013.549661258574;18163;40123.39814902837;44295;44652.33021504745;44827;45613.77193114146;51674.224886625976;58531.70734146302;60757.39242607694;60942.39057609367;61440.38559614526;8823.911760882309;9264.583093760662;9275.489848058422;9346.579403926975;9458.385204961656;13286.269255191057;13987.090839095426;13993.790093148407;14052.227127508086;14471.204083775494;11830.526778928746;12284.201526900722;12377.62867113988;12388;12649.367531623566;11982.64052078439;12019.399030048287;12163.026957843529;12196.817047744113;12349.814752778895;12202.75594488123;12263.202891812003;12365.134440589072;12543.247405155354;12585.93707031459;8767.736967890973;9016.278697704036;9196.632134714804;9308.255339572954;9400.482973436527;9059.870930331499;11425.257358271685;11903.226290291102;11924.76150477003;12200.572979945659 16:08:32 INFO - PROCESS | 16828 | |3;mootools.html;1336.9799453008213;1499.302824186753;1501.06183635228;1650.6616143690537;1774.7781527309087;7718.459707820455;8417.200365965231;8726.825463490726;8756.781080472983;8958.059403762592;8725.95637021814;8783;8796.69211577595;8799.560021998906;8807.07525709801;2437.5612389769835;2470.28361775085;2473.171487551663;2476.4675594747127;2477.9008839646394;2415.698037745282;2522;2523.3060908250286;2523.8611876346795;2530.342111051131;2407.5305315463493;2420.0198919437657;2421.079989603948;2430.3802530354733;2434.8904299306573;2367.1951536477595;2375.45364566149;2401.2436082633913;2406.8074554035634;2412.2522018174245;2374.4301367671806;2412.276317104879;2427.7329493755674;2436.0621160853198;2437.756224377566;8631.43895646781;8695.130486951317;8712.695055673084;8792.780180495538;8796.296296296281;5200.349956255468;5365.222042803811;5366.785328586851;5374.381946076212;5378.97310513445;3241.8865339713234;3317.4526203176447;3341.9331613367594;3404.591449026108;3408.403529382373;1043.82776841821;1059.0944742245347;2018.2128969701828;2039.6022775558772;2095.3190213180624;11526.711832204179;12015.879841201651;12107.45516451753;12117;12121.69695757613;4483.932741008823;4693.413323334583;4699.295105734099;4785.282207668877;4809.134355815987;10413.47932603382;10428.165746740242;10440.73898152537;10440.738981525523;10449.111825494918;5374.785008599612;5376.6505177164145;5378.166384210375;5398.568114550826;5403.243545903577;4273.465816772903;4495.2582823834355;4663.696859704109;4947.282644016597;5034.597232221414;4060.878173654736;4133.198468891937;4159.176132543867;4221.873343799691;4250.256205164084;1286.2796833773118;1307.3267267357128;1343.9664008399868;1348.986510134886;1357.3169270105195;957.6887511558771;979.1725991537139;987.59015008772;1000.3047881722133;1001.0590045357341;5616.9157462638095;5636.436356364331;5767.365589785204;5791.913121303184;5946.910796338058;478.4163320748681;485.6406259368042;492.5443964332978;506.55170174395187;507.14039702703565;3969.106950936074;3978.124812541236;3982.980085099614;3994.4807175067635;4012.197560487914;10333.896661033445;10812.783744325227;10815.78368432627;10820.242583019113;10891.782164356668;10759.139268858473;10760;10763.677089687322;10771.299865508718;10793.730156746144;7999.280064794197;8225.876611850827;8316.958415208006;8327.20891515305;8347.916520834835;6040.788572399945;6140.416660417253;6149.569530132848;6161.4146656067605;6225.62646241227;9615.182709469773;9635.13283804461;9638.132568068908;9646.421214726857;9698.46658433793;9113;9324.067593240621;9657.565409556728;9811.362261452983;9814.65648702292;7560.924390756022;7627.771166865003;7655.617219139132;7669.309762121436;7683.692652293846;8512.489250644981;8547.230749232598;8629.22336989674;8630.568471576522;8633.870491942751;7282.526635768658;7365.447591430771;7445.851082978418;7455.440841936768;7487.550746954982;7395.778126656209;7527.8118047049265;7602.847943040998;7745.7676269712;7751.496152750279;7193.172785129777;7206.243344448757;7279.1265048194555;7284.562926224444;7294.2341054190665;5075.3402057732255;5124.846254612367;5216.765245564035;5244.187150991603;5337.306150200449;5082.263071854634;5225.817096401608;5332.493413125747;5395.919061214006;5444.8366549003595 16:08:32 INFO - PROCESS | 16828 | |4;prototype.html;359.5685177786656;359.7517712778183;361.3243235150268;369.26331967724394;372.77819697280125;5303.708296043721;5347.7058761768085;5350.197470379445;5352.277442545255;5356.973215133924;5261.421243663203;5262.500062494057;5288.524032837044;5294.867628309295;5344.701778235357;4084.734492258001;4227.302495088322;4233.513145988205;4242.809073591696;4266.914661706764;4228.217779710763;4236.703430759848;4240.618344349008;4264.87205383839;4297.914041719179;3970.2456533258733;4062.5937406259286;4199.832006719727;4202.642775364083;4206.927233555439;4130.256553820311;4215.367694845751;4229.111886503838;4233.5554766749665;4250.978745106286;3794.0704527390967;3818.1409182933894;3824;3833.5591406988274;3834.060655139481;4903.239997800347;4953.331300274453;5117.181250999822;5133.25567792668;5233.848553318264;4501.167284052461;4759.595434388081;4768.356271903283;4825.782839772219;4830.806767729287;5521.641093328961;5523.8066667666435;5527.198556209327;5536.474034966672;5539.695316757577;4078.388241763759;4192.643625291823;4199.9790001050105;4202.915941681149;4206.116715489751;5632;5689.231953686241;5698.715064246812;5699.743511541949;5708.828735137911;4244.87265382039;4270.679699022586;4282.571742825692;4302;4319.935200971988;4214.199302132585;4246.723962942398;4251.617354438115;4357.716748411343;4361.847335343311;4713.74074425903;4767.141914455362;4774.331593576902;4782.426108866958;4821.5178482151505;5491.505764481136;5514.365847927459;5539.501444869981;5554.666719996813;5587.608867379245;1379.8891892027016;1443.7473442147582;1447.2763618190904;1451.4121780678843;1455.919924404168;1019.9235057370727;1023.4524529376896;1023.5496381592076;1034.4827586206898;1035.5598870480167;5127.000469816774;5149.871253218625;5168.3539557555305;5176.275321454999;5201.2198170274005;5439.564834813205;5441.421987623624;5456.890862182734;5472.644278121909;5473.2063850741415;5014.423341315795;5064.949350506521;5169.896602067937;5183.900520289289;5203.557697595671;2886;2910.428368680931;2913.431880783227;2921.35730139369;2922;5694.743736531866;5695.7152142392715;5705.286839145107;5712.2288491054005;5722.513586345124;5461.344638643388;5647.576431767634;5712.857678370611;5782.132680097935;5794.971025144847;5837.387074357216;5859.451138754655;5864.266966629171;5881.176635271066;5884.588078834612;5603.523700485504;5699.487046165865;5710.743016564182;5728.656280623176;5733.365990692632;5586.888262234651;5630.071038278638;5641.351244606923;5658.236138121301;5661.207430959586;5860.267466566679;5881.353051164283;5894.941050589611;5929.288485381781;5930.881382372415;4040.454538637364;4146.958530414658;4161;4185.853495127656;4186.455760751083;5701.802621449377;5705;5720.11338242573;5723.227364305932;5732.799352022826;5606.803761868315;5607.495325420732;5620.1288800236025;5669.744861481326;5670.710987627249;5328.413874473727;5505.256790333254;5523.861903452445;5535.972320138373;5546.251256080377;5524.281843360337;5533.391326954113;5544.7227638617105;5554.777808887599;5560.499555040065;5300.3639563252655;5561.915426491795;5585.944140558542;5593.972030139823;5610.326760788568;5442.292501974718;5457.154141108134;5459.918101228405;5465.863353416196;5472.835814925558 16:08:32 INFO - PROCESS | 16828 | |5;yui.html;781.6482582837724;805.2672068417739;809.1140201479378;813.9186081391862;814.5927036481759;14066.578002659911;14795;15131;16017.279222434989;16238.83761162388;13814.861851381484;14783.113013219214;14931;14945.701085978273;14965.102093874375;811.3347055414563;848.173031294486;849.2696281198196;849.6261644876265;850.0394554153797;842.3513894301384;844.0335815491259;844.4890841041174;845.222395396237;845.4208866926175;886.2024178239571;886.441541828647;888.0143041224236;888.4003297774009;889.2663552569124;877.666486735043;878.6968495868915;882.9646814127459;883.659790980474;886.6320477002037;646.763931165126;647.7279542592123;648.1315037849257;648.2868844271311;648.4423395879539;14816.407343706238;14835.48075817352;14856.62858428537;15574;15792;14552.708945821025;14715.190664513448;15030.248487575687;15313.387464501406;15323.31045102973;11953.46209420578;12071;12167.817482737766;12232.449539770732;12313.630591082281;3776.848926042955;3877.670398016172;3976.065624578222;4013.8394464221396;4016.779077150785;43680.56319436828;53221.2016819748;64684.35315646831;65000.3499964999;65025;11304.547818087349;11548.364839933716;11673;11808.88191118095;12175.939120304341;21532.677009844865;21570.46073848135;21610.35168944934;21666;21940.780592194194;8602.225799678059;8703;8737.995130560066;8912.910870891337;8966.327525435618;4356.063446359048;4409.911801763947;4456.509783923766;4479.820807167742;4580.587747102777;3593.2274560969518;3650.361186792301;3714.7213958953184;3722.516072910504;3724.981375093107;619.2445216835454;624.1293395712955;631.2488139114439;637.4963778614842;641.172886975796;657.4970147836908;662.483263054818;672.5695554844806;763.9847203056019;775.352580595198;9621.27840411972;9672.226221902372;9784.755381115387;9789.559469823875;9902;639.6098379988204;669.0633113640845;669.2136739331266;695.7495301691387;705.108038331511;4822.662413631082;4972.925406118911;4977.576905962961;5043.747812609355;5075.695458272516;88503.55748221217;90909;91705.54147229355;93699;94551.52724236473;52209.47790522046;73775;74687;78995;79316;66159;69058.3094169062;69265.96101058488;69377.65311173513;71304.99999999897;9587.712368628952;9766.36518626287;9908.851367229641;9912.5074072415;9923.900760992587;44835.55164448314;45708.64256643476;46127;46269.53730462652;46299.53700462952;61654.38345616486;64830.30248916131;65004.34995649983;66719.33280667325;67147;12973.805392919303;13040.934795326342;13153.802692959805;13312.267825269315;13509.797353039516;12673.746525069631;13216.735665286833;13479.123856949267;14007.229602371968;14218;12892.742145156857;13389;13737.862621374059;13878.583642490741;14045.508407205698;13847.238401887993;13910.791338129733;13968.231747253592;13976.790348144583;14087;12453.875461245272;12634.494620215457;12729.490820367082;13066.738665226832;13173.27546984925;11012.284201526874;11284.830727539258;11367.204295699552;11432.314061156358;11930.284182949052;10505.422201778976;10658.14734821228;10694.19793515505;10721.839172412576;10892.183086268404 16:08:32 INFO - PROCESS | 16828 | __end_tp_report 16:08:32 INFO - PROCESS | 16828 | __start_cc_report 16:08:32 INFO - PROCESS | 16828 | _x_x_mozilla_cycle_collect,1017 16:08:32 INFO - PROCESS | 16828 | __end_cc_report 16:08:32 INFO - PROCESS | 16828 | __startTimestamp1480723712341__endTimestamp 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | ------- Summary: start ------- 16:08:32 INFO - PROCESS | 16828 | Number of tests: 6 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | [#0] dojo.html Cycles:165 Average:5422.18 Median:5613.80 stddev:596.17 (10.6%) stddev-sans-first:570.30 16:08:32 INFO - PROCESS | 16828 | Values: 3132.5 3168.0 3176.2 3183.5 3187.1 5316.5 5337.1 5384.4 5398.2 5423.1 5414.8 5449.7 5464.9 5478.6 5494.5 4969.9 5013.8 5017.2 5026.6 5071.5 4952.3 4962.8 5055.6 5088.5 5131.8 4898.4 4898.5 4907.3 4943.4 4952.7 4973.0 5043.7 5049.8 5053.4 5076.5 4827.6 4857.1 4953.4 4981.3 5009.2 5321.1 5376.6 5403.9 5406.3 5422.5 5795.6 5857.7 5877.9 5890.3 5895.5 5679.3 5838.4 5852.8 5881.3 5883.4 5319.3 5341.3 5367.1 5399.3 5444.9 5867.7 5883.4 5885.9 5886.1 5887.6 5613.8 5658.1 5675.8 5685.9 5687.7 5718.6 5772.8 5781.0 5810.8 5881.9 5781.4 5816.7 5826.2 5831.0 5838.8 5808.2 5843.9 5846.2 5847.2 5852.2 4466.4 4485.5 4511.7 4547.7 4568.6 4087.1 4091.0 4098.0 4122.8 4126.1 5606.1 5622.2 5625.2 5633.5 5660.9 5728.3 5783.2 5790.2 5846.3 5930.3 5589.1 5591.9 5592.8 5594.7 5616.6 5101.0 5125.2 5134.4 5144.3 5166.9 5833.2 5929.4 6011.7 6114.7 6132.9 5889.8 5945.9 5953.3 5990.2 5993.2 6136.4 6138.4 6144.4 6145.6 6147.4 5550.6 5606.3 5819.9 5829.6 5835.8 5720.8 5724.3 5735.9 5744.2 5822.6 5602.8 5612.9 5644.6 5652.7 5652.9 5568.1 5651.2 5651.9 5652.5 5661.4 5585.9 5604.6 5627.1 5629.0 5717.7 5716.3 5724.1 5724.9 5729.9 5731.5 5457.8 5511.5 5522.3 5574.6 5599.6 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | [#1] ext.html Cycles:180 Average:59308.20 Median:209964.71 stddev:114399.98 (54.5%) stddev-sans-first:114635.93 16:08:32 INFO - PROCESS | 16828 | Values: 584.2 640.7 642.1 658.0 663.3 34577.8 43707.0 44692.1 44783.6 44792.6 46224.3 46292.5 46546.5 46601.5 46604.8 8135.2 8877.9 9009.5 9017.0 9024.3 8414.3 8517.4 8526.7 10588.0 10829.5 10923.6 10983.8 10990.1 10995.2 10997.8 10766.1 10811.5 10821.1 10823.7 10827.6 10738.1 10782.5 10796.7 10802.5 10812.6 43685.6 43977.3 44123.0 44136.6 44174.3 3604.2 3650.7 3671.9 3807.5 4263.5 30047.0 30481.8 30643.0 30751.7 30754.8 4246.4 4477.5 4485.3 4525.7 4636.6 368344.0 368672.0 369932.0 370092.0 370448.0 55601.7 55802.7 55828.0 55878.0 55889.0 38690.6 39428.6 39800.8 42024.2 42044.2 18723.6 18962.1 18967.4 18974.8 18976.0 13339.4 14550.9 14729.1 14734.2 14738.9 17897.5 19092.4 19559.8 19582.3 20056.2 7148.7 7221.2 7271.6 7315.3 7318.3 914.9 974.9 1051.6 1068.5 1109.7 32347.7 32984.3 33290.0 33505.7 33653.5 1136.8 1138.0 1148.2 1166.3 1174.9 14843.0 18194.7 18510.5 18539.4 19400.2 523576.0 527891.0 528251.0 528491.0 529722.0 61054.0 61367.4 61419.4 61448.0 61520.0 1268.4 1327.5 1347.9 1391.1 1398.7 30565.2 33783.5 33784.3 34225.3 34633.7 53271.0 53783.2 53982.2 53994.5 54033.7 381319.0 381571.0 383716.0 383896.0 386670.0 30114.8 30414.4 30746.0 31184.7 32335.0 48782.8 48908.8 49185.8 49864.8 49904.0 41419.8 41861.8 41916.4 41929.0 43439.8 41081.4 41554.0 41866.6 42413.4 42613.8 41958.6 42066.6 42103.2 42175.6 42326.6 35283.6 37075.8 37564.0 38115.0 38358.4 28201.0 28485.7 28490.3 28631.7 28645.3 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | [#2] jquery.html Cycles:180 Average:29697.23 Median:13433.15 stddev:82286.80 (612.6%) stddev-sans-first:82488.21 16:08:32 INFO - PROCESS | 16828 | Values: 391.6 428.8 431.4 438.1 451.4 16177.7 18773.9 20720.0 20790.5 20885.9 19773.2 19883.2 20156.3 20542.0 20689.5 5726.2 5979.9 5981.3 5982.2 5986.1 5545.6 5823.8 5847.2 5847.6 5849.9 5574.2 5798.2 5813.5 5813.5 5823.0 5751.1 5819.9 5856.4 5866.7 5869.7 5110.7 5286.5 5289.7 5290.0 5293.1 24102.0 24120.6 24149.3 24349.1 24384.9 2481.4 2516.7 2536.3 2711.2 2826.5 14857.3 14859.9 15044.0 15170.7 15490.2 1944.9 1955.2 1962.0 2003.6 2034.3 81366.6 81857.0 83406.2 83606.0 87002.0 9988.5 11223.9 11384.2 11956.8 12437.2 14657.9 15535.1 15536.3 15668.1 16350.3 8649.5 8823.6 9028.2 9060.8 9113.9 8537.6 8648.8 8792.5 8835.9 9021.5 6622.6 6845.2 6923.7 6978.2 7114.4 2065.2 2084.9 2085.5 2094.7 2103.9 953.4 983.3 1037.6 1062.5 1113.3 19686.8 20632.2 20757.7 20765.8 21062.4 1028.7 1046.6 1072.4 1101.2 1135.7 10765.9 11689.2 11706.4 11717.2 11744.2 486682.0 497888.0 501953.0 507642.0 509211.5 80003.0 80145.6 84105.6 84447.6 86051.6 1027.5 1044.3 1051.8 1073.3 1073.5 16466.8 17210.4 17695.6 18013.5 18163.0 40123.4 44295.0 44652.3 44827.0 45613.8 51674.2 58531.7 60757.4 60942.4 61440.4 8823.9 9264.6 9275.5 9346.6 9458.4 13286.3 13987.1 13993.8 14052.2 14471.2 11830.5 12284.2 12377.6 12388.0 12649.4 11982.6 12019.4 12163.0 12196.8 12349.8 12202.8 12263.2 12365.1 12543.2 12585.9 8767.7 9016.3 9196.6 9308.3 9400.5 9059.9 11425.3 11903.2 11924.8 12200.6 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | [#3] mootools.html Cycles:180 Average:5779.73 Median:506.85 stddev:3201.09 (631.6%) stddev-sans-first:3192.65 16:08:32 INFO - PROCESS | 16828 | Values: 1337.0 1499.3 1501.1 1650.7 1774.8 7718.5 8417.2 8726.8 8756.8 8958.1 8726.0 8783.0 8796.7 8799.6 8807.1 2437.6 2470.3 2473.2 2476.5 2477.9 2415.7 2522.0 2523.3 2523.9 2530.3 2407.5 2420.0 2421.1 2430.4 2434.9 2367.2 2375.5 2401.2 2406.8 2412.3 2374.4 2412.3 2427.7 2436.1 2437.8 8631.4 8695.1 8712.7 8792.8 8796.3 5200.3 5365.2 5366.8 5374.4 5379.0 3241.9 3317.5 3341.9 3404.6 3408.4 1043.8 1059.1 2018.2 2039.6 2095.3 11526.7 12015.9 12107.5 12117.0 12121.7 4483.9 4693.4 4699.3 4785.3 4809.1 10413.5 10428.2 10440.7 10440.7 10449.1 5374.8 5376.7 5378.2 5398.6 5403.2 4273.5 4495.3 4663.7 4947.3 5034.6 4060.9 4133.2 4159.2 4221.9 4250.3 1286.3 1307.3 1344.0 1349.0 1357.3 957.7 979.2 987.6 1000.3 1001.1 5616.9 5636.4 5767.4 5791.9 5946.9 478.4 485.6 492.5 506.6 507.1 3969.1 3978.1 3983.0 3994.5 4012.2 10333.9 10812.8 10815.8 10820.2 10891.8 10759.1 10760.0 10763.7 10771.3 10793.7 7999.3 8225.9 8317.0 8327.2 8347.9 6040.8 6140.4 6149.6 6161.4 6225.6 9615.2 9635.1 9638.1 9646.4 9698.5 9113.0 9324.1 9657.6 9811.4 9814.7 7560.9 7627.8 7655.6 7669.3 7683.7 8512.5 8547.2 8629.2 8630.6 8633.9 7282.5 7365.4 7445.9 7455.4 7487.6 7395.8 7527.8 7602.8 7745.8 7751.5 7193.2 7206.2 7279.1 7284.6 7294.2 5075.3 5124.8 5216.8 5244.2 5337.3 5082.3 5225.8 5332.5 5395.9 5444.8 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | [#4] prototype.html Cycles:180 Average:4689.46 Median:5261.96 stddev:1340.46 (25.5%) stddev-sans-first:1304.22 16:08:32 INFO - PROCESS | 16828 | Values: 359.6 359.8 361.3 369.3 372.8 5303.7 5347.7 5350.2 5352.3 5357.0 5261.4 5262.5 5288.5 5294.9 5344.7 4084.7 4227.3 4233.5 4242.8 4266.9 4228.2 4236.7 4240.6 4264.9 4297.9 3970.2 4062.6 4199.8 4202.6 4206.9 4130.3 4215.4 4229.1 4233.6 4251.0 3794.1 3818.1 3824.0 3833.6 3834.1 4903.2 4953.3 5117.2 5133.3 5233.8 4501.2 4759.6 4768.4 4825.8 4830.8 5521.6 5523.8 5527.2 5536.5 5539.7 4078.4 4192.6 4200.0 4202.9 4206.1 5632.0 5689.2 5698.7 5699.7 5708.8 4244.9 4270.7 4282.6 4302.0 4319.9 4214.2 4246.7 4251.6 4357.7 4361.8 4713.7 4767.1 4774.3 4782.4 4821.5 5491.5 5514.4 5539.5 5554.7 5587.6 1379.9 1443.7 1447.3 1451.4 1455.9 1019.9 1023.5 1023.5 1034.5 1035.6 5127.0 5149.9 5168.4 5176.3 5201.2 5439.6 5441.4 5456.9 5472.6 5473.2 5014.4 5064.9 5169.9 5183.9 5203.6 2886.0 2910.4 2913.4 2921.4 2922.0 5694.7 5695.7 5705.3 5712.2 5722.5 5461.3 5647.6 5712.9 5782.1 5795.0 5837.4 5859.5 5864.3 5881.2 5884.6 5603.5 5699.5 5710.7 5728.7 5733.4 5586.9 5630.1 5641.4 5658.2 5661.2 5860.3 5881.4 5894.9 5929.3 5930.9 4040.5 4147.0 4161.0 4185.9 4186.5 5701.8 5705.0 5720.1 5723.2 5732.8 5606.8 5607.5 5620.1 5669.7 5670.7 5328.4 5505.3 5523.9 5536.0 5546.3 5524.3 5533.4 5544.7 5554.8 5560.5 5300.4 5561.9 5585.9 5594.0 5610.3 5442.3 5457.2 5459.9 5465.9 5472.8 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - PROCESS | 16828 | [#5] yui.html Cycles:180 Average:18029.48 Median:25561.10 stddev:23478.71 (91.9%) stddev-sans-first:23508.85 16:08:32 INFO - PROCESS | 16828 | Values: 781.6 805.3 809.1 813.9 814.6 14066.6 14795.0 15131.0 16017.3 16238.8 13814.9 14783.1 14931.0 14945.7 14965.1 811.3 848.2 849.3 849.6 850.0 842.4 844.0 844.5 845.2 845.4 886.2 886.4 888.0 888.4 889.3 877.7 878.7 883.0 883.7 886.6 646.8 647.7 648.1 648.3 648.4 14816.4 14835.5 14856.6 15574.0 15792.0 14552.7 14715.2 15030.2 15313.4 15323.3 11953.5 12071.0 12167.8 12232.4 12313.6 3776.8 3877.7 3976.1 4013.8 4016.8 43680.6 53221.2 64684.4 65000.3 65025.0 11304.5 11548.4 11673.0 11808.9 12175.9 21532.7 21570.5 21610.4 21666.0 21940.8 8602.2 8703.0 8738.0 8912.9 8966.3 4356.1 4409.9 4456.5 4479.8 4580.6 3593.2 3650.4 3714.7 3722.5 3725.0 619.2 624.1 631.2 637.5 641.2 657.5 662.5 672.6 764.0 775.4 9621.3 9672.2 9784.8 9789.6 9902.0 639.6 669.1 669.2 695.7 705.1 4822.7 4972.9 4977.6 5043.7 5075.7 88503.6 90909.0 91705.5 93699.0 94551.5 52209.5 73775.0 74687.0 78995.0 79316.0 66159.0 69058.3 69266.0 69377.7 71305.0 9587.7 9766.4 9908.9 9912.5 9923.9 44835.6 45708.6 46127.0 46269.5 46299.5 61654.4 64830.3 65004.3 66719.3 67147.0 12973.8 13040.9 13153.8 13312.3 13509.8 12673.7 13216.7 13479.1 14007.2 14218.0 12892.7 13389.0 13737.9 13878.6 14045.5 13847.2 13910.8 13968.2 13976.8 14087.0 12453.9 12634.5 12729.5 13066.7 13173.3 11012.3 11284.8 11367.2 11432.3 11930.3 10505.4 10658.1 10694.2 10721.8 10892.2 16:08:32 INFO - PROCESS | 16828 | -------- Summary: end -------- 16:08:32 INFO - PROCESS | 16828 | 16:08:32 INFO - TEST-INFO | 16828: exit 0 16:08:32 INFO - TEST-OK | dromaeo_css | took 1113975ms 16:08:32 INFO - TEST-START | kraken 16:08:32 INFO - operating with platform_type : linux_ 16:08:32 INFO - Initialising browser for kraken test... 16:08:32 INFO - TEST-INFO | started process 17147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0XD1Yd/profile http://localhost:60471/getInfo.html) 16:08:36 INFO - PROCESS | 17147 | __metrics Screen width/height:1600/1200 16:08:36 INFO - PROCESS | 17147 | colorDepth:24 16:08:36 INFO - PROCESS | 17147 | Browser inner width/height: 1024/697 16:08:36 INFO - PROCESS | 17147 | __metrics 16:08:37 INFO - PROCESS | 17147 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:08:37 INFO - PROCESS | 17147 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:37 INFO - PROCESS | 17147 | console.error: PushService: 16:08:37 INFO - PROCESS | 17147 | stateChangeProcessEnqueue: Error transitioning state 16:08:37 INFO - PROCESS | 17147 | UnknownError 16:08:38 INFO - TEST-INFO | 17147: exit 0 16:08:38 INFO - Browser initialized. 16:08:38 INFO - Running cycle 1/1 for kraken test... 16:08:38 INFO - TEST-INFO | started process 17242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0XD1Yd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:50 INFO - PROCESS | 17242 | RSS: Main: 144748544 16:08:50 INFO - PROCESS | 17242 | 16:08:52 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:53 INFO - PROCESS | 17242 | RSS: Main: 185962496 16:08:53 INFO - PROCESS | 17242 | 16:08:56 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-dft) 16:08:56 INFO - PROCESS | 17242 | RSS: Main: 175251456 16:08:56 INFO - PROCESS | 17242 | 16:08:59 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-fft) 16:09:00 INFO - PROCESS | 17242 | RSS: Main: 266854400 16:09:00 INFO - PROCESS | 17242 | 16:09:02 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-oscillator) 16:09:02 INFO - PROCESS | 17242 | RSS: Main: 172531712 16:09:02 INFO - PROCESS | 17242 | 16:09:04 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:05 INFO - PROCESS | 17242 | RSS: Main: 175378432 16:09:05 INFO - PROCESS | 17242 | 16:09:08 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60471/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:08 INFO - PROCESS | 17242 | RSS: Main: 214577152 16:09:08 INFO - PROCESS | 17242 | 16:09:12 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60471/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:12 INFO - PROCESS | 17242 | RSS: Main: 213057536 16:09:12 INFO - PROCESS | 17242 | 16:09:15 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60471/tests/kraken/driver.html?testName=json-parse-financial) 16:09:16 INFO - PROCESS | 17242 | RSS: Main: 211251200 16:09:16 INFO - PROCESS | 17242 | 16:09:17 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:18 INFO - PROCESS | 17242 | RSS: Main: 174399488 16:09:18 INFO - PROCESS | 17242 | 16:09:19 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:20 INFO - PROCESS | 17242 | RSS: Main: 180862976 16:09:20 INFO - PROCESS | 17242 | 16:09:22 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:23 INFO - PROCESS | 17242 | RSS: Main: 190054400 16:09:23 INFO - PROCESS | 17242 | 16:09:25 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:26 INFO - PROCESS | 17242 | RSS: Main: 198074368 16:09:26 INFO - PROCESS | 17242 | 16:09:29 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:29 INFO - PROCESS | 17242 | RSS: Main: 195489792 16:09:29 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60471/tests/kraken/driver.html?testName=ai-astar) 16:09:31 INFO - PROCESS | 17242 | RSS: Main: 246784000 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | __start_tp_report 16:09:31 INFO - PROCESS | 17242 | _x_x_mozilla_page_load 16:09:31 INFO - PROCESS | 17242 | _x_x_mozilla_page_load_details 16:09:31 INFO - PROCESS | 17242 | |i|pagename|runs| 16:09:31 INFO - PROCESS | 17242 | |0;ai-astar;104;110;110;110;110;111;112;111;111;111 16:09:31 INFO - PROCESS | 17242 | |1;audio-beat-detection;161;124;123;161;124;125;122;125;164;126 16:09:31 INFO - PROCESS | 17242 | |2;audio-dft;160;161;161;160;160;160;163;161;160;160 16:09:31 INFO - PROCESS | 17242 | |3;audio-fft;75;76;74;104;76;77;75;76;98;75 16:09:31 INFO - PROCESS | 17242 | |4;audio-oscillator;83;82;114;84;82;83;99;83;83;122 16:09:31 INFO - PROCESS | 17242 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;117;117 16:09:31 INFO - PROCESS | 17242 | |6;imaging-darkroom;146;146;147;183;146;147;146;145;146;146 16:09:31 INFO - PROCESS | 17242 | |7;imaging-desaturate;85;85;84;84;85;85;85;85;85;85 16:09:31 INFO - PROCESS | 17242 | |8;json-parse-financial;52;50;51;51;49;51;51;49;50;51 16:09:31 INFO - PROCESS | 17242 | |9;json-stringify-tinderbox;59;59;59;59;63;59;59;59;60;59 16:09:31 INFO - PROCESS | 17242 | |10;stanford-crypto-aes;76;79;82;76;75;75;75;75;74;84 16:09:31 INFO - PROCESS | 17242 | |11;stanford-crypto-ccm;133;127;126;127;130;138;136;125;168;128 16:09:31 INFO - PROCESS | 17242 | |12;stanford-crypto-pbkdf2;160;163;161;162;161;165;162;162;162;164 16:09:31 INFO - PROCESS | 17242 | |13;stanford-crypto-sha256-iterative;64;64;65;64;69;65;64;67;64;62 16:09:31 INFO - PROCESS | 17242 | __end_tp_report 16:09:31 INFO - PROCESS | 17242 | __start_cc_report 16:09:31 INFO - PROCESS | 17242 | _x_x_mozilla_cycle_collect,1596 16:09:31 INFO - PROCESS | 17242 | __end_cc_report 16:09:31 INFO - PROCESS | 17242 | __startTimestamp1480723771646__endTimestamp 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | ------- Summary: start ------- 16:09:31 INFO - PROCESS | 17242 | Number of tests: 14 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.21 (2.0%) stddev-sans-first:0.71 16:09:31 INFO - PROCESS | 17242 | Values: 104.0 110.0 110.0 110.0 110.0 111.0 112.0 111.0 111.0 111.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:125.50 stddev:18.34 (14.6%) stddev-sans-first:16.97 16:09:31 INFO - PROCESS | 17242 | Values: 161.0 124.0 123.0 161.0 124.0 125.0 122.0 125.0 164.0 126.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.00 16:09:31 INFO - PROCESS | 17242 | Values: 160.0 161.0 161.0 160.0 160.0 160.0 163.0 161.0 160.0 160.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:10.88 (14.3%) stddev-sans-first:11.34 16:09:31 INFO - PROCESS | 17242 | Values: 75.0 76.0 74.0 104.0 76.0 77.0 75.0 76.0 98.0 75.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:14.98 (18.0%) stddev-sans-first:15.57 16:09:31 INFO - PROCESS | 17242 | Values: 83.0 82.0 114.0 84.0 82.0 83.0 99.0 83.0 83.0 122.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:09:31 INFO - PROCESS | 17242 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:146.00 stddev:11.68 (8.0%) stddev-sans-first:12.31 16:09:31 INFO - PROCESS | 17242 | Values: 146.0 146.0 147.0 183.0 146.0 147.0 146.0 145.0 146.0 146.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 16:09:31 INFO - PROCESS | 17242 | Values: 85.0 85.0 84.0 84.0 85.0 85.0 85.0 85.0 85.0 85.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:0.87 16:09:31 INFO - PROCESS | 17242 | Values: 52.0 50.0 51.0 51.0 49.0 51.0 51.0 49.0 50.0 51.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.00 stddev:1.27 (2.2%) stddev-sans-first:1.33 16:09:31 INFO - PROCESS | 17242 | Values: 59.0 59.0 59.0 59.0 63.0 59.0 59.0 59.0 60.0 59.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:3.41 (4.5%) stddev-sans-first:3.60 16:09:31 INFO - PROCESS | 17242 | Values: 76.0 79.0 82.0 76.0 75.0 75.0 75.0 75.0 74.0 84.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:131.50 stddev:12.79 (9.7%) stddev-sans-first:13.56 16:09:31 INFO - PROCESS | 17242 | Values: 133.0 127.0 126.0 127.0 130.0 138.0 136.0 125.0 168.0 128.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.33 16:09:31 INFO - PROCESS | 17242 | Values: 160.0 163.0 161.0 162.0 161.0 165.0 162.0 162.0 162.0 164.0 16:09:31 INFO - PROCESS | 17242 | 16:09:31 INFO - PROCESS | 17242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:1.93 (3.0%) stddev-sans-first:2.03 16:09:31 INFO - PROCESS | 17242 | Values: 64.0 64.0 65.0 64.0 69.0 65.0 64.0 67.0 64.0 62.0 16:09:31 INFO - PROCESS | 17242 | -------- Summary: end -------- 16:09:31 INFO - PROCESS | 17242 | 16:09:32 INFO - TEST-INFO | 17242: exit 0 16:09:32 INFO - TEST-OK | kraken | took 59723ms 16:09:32 INFO - SUITE-END | took 1173s 16:09:32 INFO - Completed test suite (00:19:33) 16:09:32 INFO - javascript benchmark 16:09:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.498800191969, 3167.9841600791992, 3176.158318045717, 3183.474726670098, 3187.1235410262175, 5316.494932981365, 5337.066013447646, 5384.446703745788, 5398.217258497515, 5423.105187644034, 5414.83755487336, 5449.727513624312, 5464.9180262295995, 5478.643888147268, 5494.5054945054935, 4969.900601987958, 5013.799448022075, 5017.172166592508, 5026.5727413169925, 5071.543561079502, 4952.331435256248, 4962.776675049613, 5055.646104772667, 5088.54203121719, 5131.769070391822, 4898.41219053714, 4898.53463920927, 4907.263910413449, 4943.357363542752, 4952.678075925053, 4972.950270497285, 5043.747812609392, 5049.823256186034, 5053.393592768854, 5076.543111120017, 4827.58965487934, 4857.101436234273, 4953.43035550909, 4981.277714731344, 5009.173486374744, 5321.095413779667, 5376.596755243333, 5403.945960540384, 5406.297181366436, 5422.53908417781, 5795.623284486495, 5857.707114644293, 5877.9118313225335, 5890.322612899486, 5895.498882594985, 5679.318481782171, 5838.445347692005, 5852.76588936442, 5881.323647780518, 5883.411658834125, 5319.308489896327, 5341.278927344836, 5367.060764366221, 5399.325084364455, 5444.945550544523, 5867.677277749679, 5883.382244864228, 5885.911711324334, 5886.087656413263, 5887.558433117533, 5613.803516876889, 5658.066419040894, 5675.801346952837, 5685.943140568624, 5687.687177205294, 5718.628289161191, 5772.7690892363835, 5780.971095144498, 5810.7966221182905, 5881.911771323434, 5781.364049954502, 5816.738246778905, 5826.1552074948895, 5831.008728516078, 5838.824835254949, 5808.244928159397, 5843.883122337615, 5846.210761547137, 5847.181394604759, 5852.239208902815, 4466.441694788152, 4485.506594274627, 4511.661625378044, 4547.7498737569085, 4568.565986231302, 4087.1212689271947, 4090.959090409058, 4097.959020409818, 4122.773247471418, 4126.133511962522, 5606.103023516218, 5622.184783206412, 5625.184348269478, 5633.479190393437, 5660.943390566124, 5728.283964504437, 5783.219265399117, 5790.218320526759, 5846.269216347957, 5930.28836539618, 5589.105743081088, 5591.8881622368135, 5592.7762889483965, 5594.720263986785, 5616.5787565931905, 5100.979804039207, 5125.154349532286, 5134.383873935077, 5144.30551875492, 5166.889118839393, 5833.241678581842, 5929.436703513073, 6011.6693581853415, 6114.663693496811, 6132.877342453126, 5889.823305300848, 5945.910811337747, 5953.28560572734, 5990.161377407079, 5993.190919225849, 6136.355682653436, 6138.386161383826, 6144.41628045335, 6145.631262124287, 6147.354527774698, 5550.639208451437, 5606.327240731139, 5819.854503637443, 5829.59192856513, 5835.824925252249, 5720.799772008127, 5724.313082430135, 5735.9139612905, 5744.167095771007, 5822.592418530662, 5602.803901863415, 5612.85967850807, 5644.604877658525, 5652.660840349592, 5652.886942261214, 5568.053430916835, 5651.180578815966, 5651.858703532444, 5652.463016013472, 5661.377248502579, 5585.944140558705, 5604.579656525695, 5627.127795191752, 5629.0, 5717.742701578356, 5716.28546431696, 5724.084146536534, 5724.856878578069, 5729.856753581027, 5731.5128214100605, 5457.781688732565, 5511.53151982086, 5522.337319521683, 5574.554035677217, 5599.608027438203], "value": 5383.20212069978, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1733946465748, 640.6764583885138, 642.1267076775584, 657.9769708060219, 663.3068443476567, 34577.82711086444, 43707.0, 44692.10615787682, 44783.552164478344, 44792.552074479245, 46224.3066354005, 46292.53707462925, 46546.534534654726, 46601.53398466014, 46604.76697616507, 8135.186481351847, 8877.86683199751, 9009.459432434074, 9017.0, 9024.278057755397, 8414.326853851708, 8517.403781735282, 8526.658933642648, 10588.04707576318, 10829.512671929742, 10923.563057477691, 10983.835242471328, 10990.120790336794, 10995.175361847854, 10997.780044399107, 10766.084882784973, 10811.513481893333, 10821.13430925528, 10823.729406764814, 10827.621033263877, 10738.08726258269, 10782.514786834612, 10796.67609971702, 10802.51388687511, 10812.567497300099, 43685.56314436878, 43977.34033989493, 44123.0, 44136.55863441389, 44174.33738493925, 3604.1710406606626, 3650.7444478886487, 3671.8714844980564, 3807.5430948286107, 4263.509696384925, 30046.96700394194, 30481.847590761903, 30643.0, 30751.69248307533, 30754.846225768953, 4246.384274280212, 4477.462704475483, 4485.327200919855, 4525.705829121097, 4636.605888499482, 368344.0, 368671.9999999973, 369931.9999999973, 370092.0, 370448.0, 55601.721991390594, 55802.72098639481, 55828.0, 55878.0, 55889.0, 38690.6130938687, 39428.605713942496, 39800.80099599483, 42024.159516810105, 42044.159116818104, 18723.625527489374, 18962.14670339838, 18967.43097707071, 18974.81025189758, 18976.0, 13339.399727012307, 14550.854491455162, 14729.116253024853, 14734.189619570812, 14738.926305368404, 17897.46307610774, 19092.427227183205, 19559.804401956084, 19582.31461898827, 20056.197752089753, 7148.749793757298, 7221.169565499929, 7271.63641817907, 7315.341619254293, 7318.268173182639, 914.92680585553, 974.8732664753678, 1051.5898799468214, 1068.4657671164418, 1109.6892869996414, 32347.666222042335, 32984.34031319408, 33290.0, 33505.66494335074, 33653.495197572054, 1136.8294755786533, 1137.9943100284445, 1148.2364227788428, 1166.2652528906735, 1174.929504229749, 14843.0, 18194.727079093824, 18510.537236569195, 18539.35112271064, 19400.2239910402, 523576.0, 527891.0, 528251.0, 528491.0, 529722.0, 61054.0, 61367.38632613706, 61419.38580614136, 61448.0, 61520.0, 1268.4482250221183, 1327.4889167670324, 1347.8786909178025, 1391.0957877379583, 1398.7062716829375, 30565.23586910345, 33783.4932476018, 33784.3243135131, 34225.31549369048, 34633.65366346304, 53271.0, 53783.193252100464, 53982.19026714524, 53994.460055400516, 54033.72983135059, 381319.0, 381571.0, 383716.0, 383896.0, 386670.0, 30114.84942575273, 30414.391712166074, 30746.0, 31184.688153119085, 32335.0, 48782.75608621934, 48908.75545622249, 49185.75407123085, 49864.75067624639, 49904.0, 41419.792901035304, 41861.79069104635, 41916.371254430596, 41929.0, 43439.78280108706, 41081.38377924393, 41554.0, 41866.58133418749, 42413.36379954365, 42613.786931065144, 41958.58041419669, 42066.57933420627, 42103.15793684171, 42175.57824421716, 42326.576734233495, 35283.64716352804, 37075.81462092672, 37564.0, 38115.0, 38358.424623631225, 28201.0, 28485.715142848305, 28490.287742806595, 28631.713682862905, 28645.28386790347], "value": 20721.137847126945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.6313522654783, 428.76861178819996, 431.37881450710984, 438.0953331370719, 451.43345101897137, 16177.676446471078, 18773.873567585953, 20720.0, 20790.480237994037, 20885.895570522163, 19773.209071637153, 19883.20467181311, 20156.294529691462, 20542.0, 20689.482762930933, 5726.1697053927055, 5979.880402391949, 5981.342052374235, 5982.162497250389, 5986.132010858423, 5545.639533430334, 5823.767049318043, 5847.210626565423, 5847.619904706202, 5849.883002339972, 5574.247476590649, 5798.2172406725185, 5813.476787089161, 5813.505852002585, 5823.039198532237, 5751.10857817037, 5819.9418005819825, 5856.385079566627, 5866.73599688015, 5869.735861886225, 5110.718910459923, 5286.471352864722, 5289.709066001368, 5289.973550132263, 5293.073712100406, 24102.0, 24120.63819042716, 24149.275521734377, 24349.14777982762, 24384.878075609686, 2481.416867036245, 2516.735742747022, 2536.340551456635, 2711.227300219448, 2826.477101736165, 14857.257137143208, 14859.8855085869, 15044.0, 15170.696586068327, 15490.225488725519, 1944.931927382535, 1955.2179128348773, 1961.9607607847763, 2003.5792483578466, 2034.2879992002681, 81366.59316703437, 81857.0, 83406.18115880496, 83606.0, 87002.0, 9988.450635214987, 11223.943880280709, 11384.203105782515, 11956.760864782656, 12437.191582547106, 14657.853421465863, 15535.145566993924, 15536.300866461037, 15668.138252396227, 16350.264238109314, 8649.524276164746, 8823.647054117764, 9028.18746312835, 9060.81878362429, 9113.908860911439, 8537.573121344032, 8648.78378040554, 8792.47245165292, 8835.911640883638, 9021.548922553846, 6622.5695329804375, 6845.212800527904, 6923.6884340204815, 6978.162620485473, 7114.359707626339, 2065.173930427841, 2084.8644838085474, 2085.520330324034, 2094.664853623413, 2103.9368818935454, 953.4422362917771, 983.2772911909741, 1037.6420135053395, 1062.5059347403494, 1113.3264375053138, 19686.803131968783, 20632.174713011613, 20757.688634670492, 20765.79234207669, 21062.368128956157, 1028.747956750601, 1046.6179844356755, 1072.4155335342257, 1101.1576144249655, 1135.744457497073, 10765.892341076646, 11689.240199387013, 11706.356150411639, 11717.238379505305, 11744.236624619372, 486682.0, 497888.0, 501953.0, 507642.0, 509211.53942302737, 80003.0, 80145.59927200327, 84105.57947210225, 84447.5777621108, 86051.56974215215, 1027.5170669785189, 1044.3472829481575, 1051.8001579699833, 1073.313079629038, 1073.5115522437272, 16466.83533164701, 17210.397636083177, 17695.64608707793, 18013.549661258574, 18163.0, 40123.39814902837, 44295.0, 44652.33021504745, 44827.0, 45613.77193114146, 51674.224886625976, 58531.70734146302, 60757.39242607694, 60942.39057609367, 61440.38559614526, 8823.911760882309, 9264.583093760662, 9275.489848058422, 9346.579403926975, 9458.385204961656, 13286.269255191057, 13987.090839095426, 13993.790093148407, 14052.227127508086, 14471.204083775494, 11830.526778928746, 12284.201526900722, 12377.62867113988, 12388.0, 12649.367531623566, 11982.64052078439, 12019.399030048287, 12163.026957843529, 12196.817047744113, 12349.814752778895, 12202.75594488123, 12263.202891812003, 12365.134440589072, 12543.247405155354, 12585.93707031459, 8767.736967890973, 9016.278697704036, 9196.632134714804, 9308.255339572954, 9400.482973436527, 9059.870930331499, 11425.257358271685, 11903.226290291102, 11924.76150477003, 12200.572979945659], "value": 9758.341701171434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.9799453008213, 1499.302824186753, 1501.06183635228, 1650.6616143690537, 1774.7781527309087, 7718.459707820455, 8417.200365965231, 8726.825463490726, 8756.781080472983, 8958.059403762592, 8725.95637021814, 8783.0, 8796.69211577595, 8799.560021998906, 8807.07525709801, 2437.5612389769835, 2470.28361775085, 2473.171487551663, 2476.4675594747127, 2477.9008839646394, 2415.698037745282, 2522.0, 2523.3060908250286, 2523.8611876346795, 2530.342111051131, 2407.5305315463493, 2420.0198919437657, 2421.079989603948, 2430.3802530354733, 2434.8904299306573, 2367.1951536477595, 2375.45364566149, 2401.2436082633913, 2406.8074554035634, 2412.2522018174245, 2374.4301367671806, 2412.276317104879, 2427.7329493755674, 2436.0621160853198, 2437.756224377566, 8631.43895646781, 8695.130486951317, 8712.695055673084, 8792.780180495538, 8796.296296296281, 5200.349956255468, 5365.222042803811, 5366.785328586851, 5374.381946076212, 5378.97310513445, 3241.8865339713234, 3317.4526203176447, 3341.9331613367594, 3404.591449026108, 3408.403529382373, 1043.82776841821, 1059.0944742245347, 2018.2128969701828, 2039.6022775558772, 2095.3190213180624, 11526.711832204179, 12015.879841201651, 12107.45516451753, 12117.0, 12121.69695757613, 4483.932741008823, 4693.413323334583, 4699.295105734099, 4785.282207668877, 4809.134355815987, 10413.47932603382, 10428.165746740242, 10440.73898152537, 10440.738981525523, 10449.111825494918, 5374.785008599612, 5376.6505177164145, 5378.166384210375, 5398.568114550826, 5403.243545903577, 4273.465816772903, 4495.2582823834355, 4663.696859704109, 4947.282644016597, 5034.597232221414, 4060.878173654736, 4133.198468891937, 4159.176132543867, 4221.873343799691, 4250.256205164084, 1286.2796833773118, 1307.3267267357128, 1343.9664008399868, 1348.986510134886, 1357.3169270105195, 957.6887511558771, 979.1725991537139, 987.59015008772, 1000.3047881722133, 1001.0590045357341, 5616.9157462638095, 5636.436356364331, 5767.365589785204, 5791.913121303184, 5946.910796338058, 478.4163320748681, 485.6406259368042, 492.5443964332978, 506.55170174395187, 507.14039702703565, 3969.106950936074, 3978.124812541236, 3982.980085099614, 3994.4807175067635, 4012.197560487914, 10333.896661033445, 10812.783744325227, 10815.78368432627, 10820.242583019113, 10891.782164356668, 10759.139268858473, 10760.0, 10763.677089687322, 10771.299865508718, 10793.730156746144, 7999.280064794197, 8225.876611850827, 8316.958415208006, 8327.20891515305, 8347.916520834835, 6040.788572399945, 6140.416660417253, 6149.569530132848, 6161.4146656067605, 6225.62646241227, 9615.182709469773, 9635.13283804461, 9638.132568068908, 9646.421214726857, 9698.46658433793, 9113.0, 9324.067593240621, 9657.565409556728, 9811.362261452983, 9814.65648702292, 7560.924390756022, 7627.771166865003, 7655.617219139132, 7669.309762121436, 7683.692652293846, 8512.489250644981, 8547.230749232598, 8629.22336989674, 8630.568471576522, 8633.870491942751, 7282.526635768658, 7365.447591430771, 7445.851082978418, 7455.440841936768, 7487.550746954982, 7395.778126656209, 7527.8118047049265, 7602.847943040998, 7745.7676269712, 7751.496152750279, 7193.172785129777, 7206.243344448757, 7279.1265048194555, 7284.562926224444, 7294.2341054190665, 5075.3402057732255, 5124.846254612367, 5216.765245564035, 5244.187150991603, 5337.306150200449, 5082.263071854634, 5225.817096401608, 5332.493413125747, 5395.919061214006, 5444.8366549003595], "value": 4634.020494336285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5685177786656, 359.7517712778183, 361.3243235150268, 369.26331967724394, 372.77819697280125, 5303.708296043721, 5347.7058761768085, 5350.197470379445, 5352.277442545255, 5356.973215133924, 5261.421243663203, 5262.500062494057, 5288.524032837044, 5294.867628309295, 5344.701778235357, 4084.734492258001, 4227.302495088322, 4233.513145988205, 4242.809073591696, 4266.914661706764, 4228.217779710763, 4236.703430759848, 4240.618344349008, 4264.87205383839, 4297.914041719179, 3970.2456533258733, 4062.5937406259286, 4199.832006719727, 4202.642775364083, 4206.927233555439, 4130.256553820311, 4215.367694845751, 4229.111886503838, 4233.5554766749665, 4250.978745106286, 3794.0704527390967, 3818.1409182933894, 3824.0, 3833.5591406988274, 3834.060655139481, 4903.239997800347, 4953.331300274453, 5117.181250999822, 5133.25567792668, 5233.848553318264, 4501.167284052461, 4759.595434388081, 4768.356271903283, 4825.782839772219, 4830.806767729287, 5521.641093328961, 5523.8066667666435, 5527.198556209327, 5536.474034966672, 5539.695316757577, 4078.388241763759, 4192.643625291823, 4199.9790001050105, 4202.915941681149, 4206.116715489751, 5632.0, 5689.231953686241, 5698.715064246812, 5699.743511541949, 5708.828735137911, 4244.87265382039, 4270.679699022586, 4282.571742825692, 4302.0, 4319.935200971988, 4214.199302132585, 4246.723962942398, 4251.617354438115, 4357.716748411343, 4361.847335343311, 4713.74074425903, 4767.141914455362, 4774.331593576902, 4782.426108866958, 4821.5178482151505, 5491.505764481136, 5514.365847927459, 5539.501444869981, 5554.666719996813, 5587.608867379245, 1379.8891892027016, 1443.7473442147582, 1447.2763618190904, 1451.4121780678843, 1455.919924404168, 1019.9235057370727, 1023.4524529376896, 1023.5496381592076, 1034.4827586206898, 1035.5598870480167, 5127.000469816774, 5149.871253218625, 5168.3539557555305, 5176.275321454999, 5201.2198170274005, 5439.564834813205, 5441.421987623624, 5456.890862182734, 5472.644278121909, 5473.2063850741415, 5014.423341315795, 5064.949350506521, 5169.896602067937, 5183.900520289289, 5203.557697595671, 2886.0, 2910.428368680931, 2913.431880783227, 2921.35730139369, 2922.0, 5694.743736531866, 5695.7152142392715, 5705.286839145107, 5712.2288491054005, 5722.513586345124, 5461.344638643388, 5647.576431767634, 5712.857678370611, 5782.132680097935, 5794.971025144847, 5837.387074357216, 5859.451138754655, 5864.266966629171, 5881.176635271066, 5884.588078834612, 5603.523700485504, 5699.487046165865, 5710.743016564182, 5728.656280623176, 5733.365990692632, 5586.888262234651, 5630.071038278638, 5641.351244606923, 5658.236138121301, 5661.207430959586, 5860.267466566679, 5881.353051164283, 5894.941050589611, 5929.288485381781, 5930.881382372415, 4040.454538637364, 4146.958530414658, 4161.0, 4185.853495127656, 4186.455760751083, 5701.802621449377, 5705.0, 5720.11338242573, 5723.227364305932, 5732.799352022826, 5606.803761868315, 5607.495325420732, 5620.1288800236025, 5669.744861481326, 5670.710987627249, 5328.413874473727, 5505.256790333254, 5523.861903452445, 5535.972320138373, 5546.251256080377, 5524.281843360337, 5533.391326954113, 5544.7227638617105, 5554.777808887599, 5560.499555040065, 5300.3639563252655, 5561.915426491795, 5585.944140558542, 5593.972030139823, 5610.326760788568, 5442.292501974718, 5457.154141108134, 5459.918101228405, 5465.863353416196, 5472.835814925558], "value": 4274.451031495793, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.6482582837724, 805.2672068417739, 809.1140201479378, 813.9186081391862, 814.5927036481759, 14066.578002659911, 14795.0, 15131.0, 16017.279222434989, 16238.83761162388, 13814.861851381484, 14783.113013219214, 14931.0, 14945.701085978273, 14965.102093874375, 811.3347055414563, 848.173031294486, 849.2696281198196, 849.6261644876265, 850.0394554153797, 842.3513894301384, 844.0335815491259, 844.4890841041174, 845.222395396237, 845.4208866926175, 886.2024178239571, 886.441541828647, 888.0143041224236, 888.4003297774009, 889.2663552569124, 877.666486735043, 878.6968495868915, 882.9646814127459, 883.659790980474, 886.6320477002037, 646.763931165126, 647.7279542592123, 648.1315037849257, 648.2868844271311, 648.4423395879539, 14816.407343706238, 14835.48075817352, 14856.62858428537, 15574.0, 15792.0, 14552.708945821025, 14715.190664513448, 15030.248487575687, 15313.387464501406, 15323.31045102973, 11953.46209420578, 12071.0, 12167.817482737766, 12232.449539770732, 12313.630591082281, 3776.848926042955, 3877.670398016172, 3976.065624578222, 4013.8394464221396, 4016.779077150785, 43680.56319436828, 53221.2016819748, 64684.35315646831, 65000.3499964999, 65025.0, 11304.547818087349, 11548.364839933716, 11673.0, 11808.88191118095, 12175.939120304341, 21532.677009844865, 21570.46073848135, 21610.35168944934, 21666.0, 21940.780592194194, 8602.225799678059, 8703.0, 8737.995130560066, 8912.910870891337, 8966.327525435618, 4356.063446359048, 4409.911801763947, 4456.509783923766, 4479.820807167742, 4580.587747102777, 3593.2274560969518, 3650.361186792301, 3714.7213958953184, 3722.516072910504, 3724.981375093107, 619.2445216835454, 624.1293395712955, 631.2488139114439, 637.4963778614842, 641.172886975796, 657.4970147836908, 662.483263054818, 672.5695554844806, 763.9847203056019, 775.352580595198, 9621.27840411972, 9672.226221902372, 9784.755381115387, 9789.559469823875, 9902.0, 639.6098379988204, 669.0633113640845, 669.2136739331266, 695.7495301691387, 705.108038331511, 4822.662413631082, 4972.925406118911, 4977.576905962961, 5043.747812609355, 5075.695458272516, 88503.55748221217, 90909.0, 91705.54147229355, 93699.0, 94551.52724236473, 52209.47790522046, 73775.0, 74687.0, 78995.0, 79316.0, 66159.0, 69058.3094169062, 69265.96101058488, 69377.65311173513, 71304.99999999897, 9587.712368628952, 9766.36518626287, 9908.851367229641, 9912.5074072415, 9923.900760992587, 44835.55164448314, 45708.64256643476, 46127.0, 46269.53730462652, 46299.53700462952, 61654.38345616486, 64830.30248916131, 65004.34995649983, 66719.33280667325, 67147.0, 12973.805392919303, 13040.934795326342, 13153.802692959805, 13312.267825269315, 13509.797353039516, 12673.746525069631, 13216.735665286833, 13479.123856949267, 14007.229602371968, 14218.0, 12892.742145156857, 13389.0, 13737.862621374059, 13878.583642490741, 14045.508407205698, 13847.238401887993, 13910.791338129733, 13968.231747253592, 13976.790348144583, 14087.0, 12453.875461245272, 12634.494620215457, 12729.490820367082, 13066.738665226832, 13173.27546984925, 11012.284201526874, 11284.830727539258, 11367.204295699552, 11432.314061156358, 11930.284182949052, 10505.422201778976, 10658.14734821228, 10694.19793515505, 10721.839172412576, 10892.183086268404], "value": 7353.964296680196, "unit": "score"}], "name": "dromaeo_css", "value": 7357.090079302407, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 110.0, 110.0, 110.0, 111.0, 112.0, 111.0, 111.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 123.0, 161.0, 124.0, 125.0, 122.0, 125.0, 164.0, 126.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 163.0, 161.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 104.0, 76.0, 77.0, 75.0, 76.0, 98.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 84.0, 82.0, 83.0, 99.0, 83.0, 83.0, 122.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 183.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 51.0, 49.0, 51.0, 51.0, 49.0, 50.0, 51.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 63.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 82.0, 76.0, 75.0, 75.0, 75.0, 75.0, 74.0, 84.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 126.0, 127.0, 130.0, 138.0, 136.0, 125.0, 168.0, 128.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 162.0, 161.0, 165.0, 162.0, 162.0, 162.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 69.0, 65.0, 64.0, 67.0, 64.0, 62.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1477.3999999999999, "alertThreshold": 2.0}]} 16:09:32 INFO - Return code: 0 16:09:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:32 INFO - # TBPL SUCCESS # 16:09:32 INFO - Running post-action listener: _resource_record_post_action 16:09:32 INFO - [mozharness: 2016-12-03 00:09:32.949191Z] Finished run-tests step (success) 16:09:32 INFO - Running post-run listener: _resource_record_post_run 16:09:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 374378496; Read time: 28; Write time: 201048 16:09:33 INFO - TinderboxPrint: CPU usage
12.9% 16:09:33 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 16:09:33 INFO - TinderboxPrint: I/O write bytes / time
374,378,496 / 201,048 16:09:33 INFO - TinderboxPrint: CPU idle
8,266.7 (87.0%) 16:09:33 INFO - TinderboxPrint: CPU user
1,188.4 (12.5%) 16:09:33 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 123805696; Read time: 0; Write time: 73584 16:09:33 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249282560; Read time: 20; Write time: 127328 16:09:33 INFO - Running post-run listener: _upload_blobber_files 16:09:33 INFO - Blob upload gear active. 16:09:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:33 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 16:09:33 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'] 16:09:33 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 16:09:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:34 INFO - (blobuploader) - INFO - Done attempting. 16:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:38 INFO - (blobuploader) - INFO - Done attempting. 16:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:39 INFO - (blobuploader) - INFO - Done attempting. 16:09:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:39 INFO - Return code: 0 16:09:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb554cdc578d68d3d4fed7fa0cd99af67fc9ec4c5f06ad3de4f7098dfcbe7916bfa69d7292bcbc247f1eb2c80bb8933a2766ca7480ad03d681982cb8a99dea1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05fcee1f54c3ce30aee45b3195e853686395f351df26a365f7aa91a367fe8f5cba20e0a301f24f47bbde8039d159835c986afe8895e63e8ffeb708040f68baa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47500962d50d342ea4babdf949973d86b05493c4c267e6a135cb2a1141b986610351a5254c365f95ea738c4abd6e9547bb35da94818a92c763942b5b944d03cb"} 16:09:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:39 INFO - Contents: 16:09:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb554cdc578d68d3d4fed7fa0cd99af67fc9ec4c5f06ad3de4f7098dfcbe7916bfa69d7292bcbc247f1eb2c80bb8933a2766ca7480ad03d681982cb8a99dea1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05fcee1f54c3ce30aee45b3195e853686395f351df26a365f7aa91a367fe8f5cba20e0a301f24f47bbde8039d159835c986afe8895e63e8ffeb708040f68baa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47500962d50d342ea4babdf949973d86b05493c4c267e6a135cb2a1141b986610351a5254c365f95ea738c4abd6e9547bb35da94818a92c763942b5b944d03cb"} 16:09:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:39 INFO - Copying logs to upload dir... 16:09:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.659457 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-02 16:09:38.863910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:38.867663) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb554cdc578d68d3d4fed7fa0cd99af67fc9ec4c5f06ad3de4f7098dfcbe7916bfa69d7292bcbc247f1eb2c80bb8933a2766ca7480ad03d681982cb8a99dea1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05fcee1f54c3ce30aee45b3195e853686395f351df26a365f7aa91a367fe8f5cba20e0a301f24f47bbde8039d159835c986afe8895e63e8ffeb708040f68baa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47500962d50d342ea4babdf949973d86b05493c4c267e6a135cb2a1141b986610351a5254c365f95ea738c4abd6e9547bb35da94818a92c763942b5b944d03cb"} build_url:https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011839 build_url: 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb554cdc578d68d3d4fed7fa0cd99af67fc9ec4c5f06ad3de4f7098dfcbe7916bfa69d7292bcbc247f1eb2c80bb8933a2766ca7480ad03d681982cb8a99dea1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05fcee1f54c3ce30aee45b3195e853686395f351df26a365f7aa91a367fe8f5cba20e0a301f24f47bbde8039d159835c986afe8895e63e8ffeb708040f68baa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47500962d50d342ea4babdf949973d86b05493c4c267e6a135cb2a1141b986610351a5254c365f95ea738c4abd6e9547bb35da94818a92c763942b5b944d03cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:38.897163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:38.897928) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480721359.695727-1007493256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:38.978423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 16:09:38.978808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 16:09:38.979163) ========= ========= Total master_lag: 0.19 =========