builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1479837446.3 results: success (0) buildid: 20161122081651 builduid: ed2dce2cc78f4bed9cbad254fd692484 revision: c538edad135a485319c98da4ff86c1debaa93062 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.303351) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.303785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.304052) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.318475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.318728) ========= 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-1479837445.764641-904716275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-22 09:57:26-- 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% 223M=0s 2016-11-22 09:57:26 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096329 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.428358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.428666) ========= 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-1479837445.764641-904716275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015776 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:26.477665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 09:57:26.477987) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c538edad135a485319c98da4ff86c1debaa93062 --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 c538edad135a485319c98da4ff86c1debaa93062 --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-1479837445.764641-904716275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-22 09:57:26,685 truncating revision to first 12 chars 2016-11-22 09:57:26,685 Setting DEBUG logging. 2016-11-22 09:57:26,685 attempt 1/10 2016-11-22 09:57:26,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c538edad135a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 09:57:27,756 unpacking tar archive at: mozilla-aurora-c538edad135a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.420783 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 09:57:27.912987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:27.913315) ========= script_repo_revision: c538edad135a485319c98da4ff86c1debaa93062 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:27.913700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:27.913958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 09:57:27.923272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-22 09:57:27.923530) ========= /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-1479837445.764641-904716275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:28 INFO - MultiFileLogger online at 20161122 09:57:28 in /builds/slave/test 09:57:28 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 09:57:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:28 INFO - {'append_to_log': False, 09:57:28 INFO - 'base_work_dir': '/builds/slave/test', 09:57:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:28 INFO - 'branch': 'Mozilla-Aurora', 09:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:28 INFO - 'config_files': ('talos/linux_config.py',), 09:57:28 INFO - 'default_actions': ('clobber', 09:57:28 INFO - 'read-buildbot-config', 09:57:28 INFO - 'download-and-extract', 09:57:28 INFO - 'populate-webroot', 09:57:28 INFO - 'create-virtualenv', 09:57:28 INFO - 'install', 09:57:28 INFO - 'run-tests'), 09:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:28 INFO - 'download_minidump_stackwalk': True, 09:57:28 INFO - 'download_symbols': 'ondemand', 09:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:28 INFO - 'installer_path': 'installer.exe', 09:57:28 INFO - 'log_level': 'info', 09:57:28 INFO - 'log_name': 'talos', 09:57:28 INFO - 'log_to_console': True, 09:57:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:28 INFO - 'opt_config_files': (), 09:57:28 INFO - 'pip_index': False, 09:57:28 INFO - 'sps_profile': False, 09:57:28 INFO - 'sps_profile_interval': 0, 09:57:28 INFO - 'suite': 'dromaeojs', 09:57:28 INFO - 'system_bits': '32', 09:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:28 INFO - 'title': 'talos-linux64-ix-012', 09:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:28 INFO - 'use_talos_json': True, 09:57:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:28 INFO - 'work_dir': 'build'} 09:57:28 INFO - [mozharness: 2016-11-22 17:57:28.227434Z] Running clobber step. 09:57:28 INFO - Running pre-action listener: _resource_record_pre_action 09:57:28 INFO - Running main action method: clobber 09:57:28 INFO - rmtree: /builds/slave/test/build 09:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:29 INFO - Running post-action listener: _resource_record_post_action 09:57:29 INFO - [mozharness: 2016-11-22 17:57:29.187019Z] Finished clobber step (success) 09:57:29 INFO - [mozharness: 2016-11-22 17:57:29.187117Z] Running read-buildbot-config step. 09:57:29 INFO - Running pre-action listener: _resource_record_pre_action 09:57:29 INFO - Running main action method: read_buildbot_config 09:57:29 INFO - Using buildbot properties: 09:57:29 INFO - { 09:57:29 INFO - "project": "", 09:57:29 INFO - "product": "firefox", 09:57:29 INFO - "script_repo_revision": "production", 09:57:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:57:29 INFO - "repository": "", 09:57:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:57:29 INFO - "buildid": "20161122081651", 09:57:29 INFO - "pgo_build": "True", 09:57:29 INFO - "basedir": "/builds/slave/test", 09:57:29 INFO - "buildnumber": 614, 09:57:29 INFO - "slavename": "talos-linux64-ix-012", 09:57:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:57:29 INFO - "platform": "ubuntu64_hw", 09:57:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:57:29 INFO - "branch": "mozilla-aurora", 09:57:29 INFO - "repo_path": "releases/mozilla-aurora", 09:57:29 INFO - "revision": "c538edad135a485319c98da4ff86c1debaa93062", 09:57:29 INFO - "stage_platform": "linux64-pgo", 09:57:29 INFO - "builduid": "ed2dce2cc78f4bed9cbad254fd692484", 09:57:29 INFO - "slavebuilddir": "test" 09:57:29 INFO - } 09:57:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:57:29 INFO - Running post-action listener: _resource_record_post_action 09:57:29 INFO - [mozharness: 2016-11-22 17:57:29.189881Z] Finished read-buildbot-config step (success) 09:57:29 INFO - [mozharness: 2016-11-22 17:57:29.189969Z] Running download-and-extract step. 09:57:29 INFO - Running pre-action listener: _resource_record_pre_action 09:57:29 INFO - Running main action method: download_and_extract 09:57:29 INFO - mkdir: /builds/slave/test/build/tests 09:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:29 INFO - trying https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:57:29 INFO - Downloading https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:57:29 INFO - Downloaded 1361 bytes. 09:57:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:57:29 INFO - Using the following test package requirements: 09:57:29 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:29 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:29 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:57:29 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'jsshell-linux-x86_64.zip'], 09:57:29 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:29 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:29 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:57:29 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:57:29 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:29 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:29 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:29 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:57:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:29 INFO - Fetch https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:57:30 INFO - Http code: 200 09:57:30 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 09:57:30 INFO - x-amz-cf-id: qHljBWRrGGBobRyWmKzWbMG1kO_fRth9M-q05F87AVRCmufonT-oQg== 09:57:30 INFO - x-amz-version-id: RA0EaZGCNdbHSCEpizgA8fsMBFazQhDW 09:57:30 INFO - Expected file size: 21949505 09:57:30 INFO - Obtained file size: 21949505 09:57:34 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:57:35 INFO - Http code: 200 09:57:35 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 09:57:35 INFO - x-amz-cf-id: _ymTj3qMZq06XxXJjuzb3ApSFswBbPt-1Prml4_nNdfCvzFquHCTAg== 09:57:35 INFO - x-amz-version-id: RA0EaZGCNdbHSCEpizgA8fsMBFazQhDW 09:57:35 INFO - Expected file size: 21949505 09:57:35 INFO - Obtained file size: 21949505 09:57:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:57:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:57:39 INFO - Fetch https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:57:40 INFO - Http code: 200 09:57:40 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 09:57:40 INFO - x-amz-cf-id: l6CWm0PamRhMx1TSZlz6Jq4s5uv_12MnDvBCkR_b-oyH6xK5FTvQ3Q== 09:57:40 INFO - x-amz-version-id: y5A_t5cPg9YCTw63Mirvb8gCIjltDENl 09:57:40 INFO - Expected file size: 14409038 09:57:40 INFO - Obtained file size: 14409038 09:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:40 INFO - trying https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:57:40 INFO - Downloading https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:57:41 INFO - Downloaded 63963646 bytes. 09:57:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:57:41 INFO - mkdir: /builds/slave/test/properties 09:57:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:41 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:41 INFO - Contents: 09:57:41 INFO - build_url:https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:57:42 INFO - Running post-action listener: _resource_record_post_action 09:57:42 INFO - Running post-action listener: set_extra_try_arguments 09:57:42 INFO - [mozharness: 2016-11-22 17:57:42.470214Z] Finished download-and-extract step (success) 09:57:42 INFO - [mozharness: 2016-11-22 17:57:42.470441Z] Running populate-webroot step. 09:57:42 INFO - Running pre-action listener: _resource_record_pre_action 09:57:42 INFO - Running main action method: populate_webroot 09:57:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:42 INFO - '--tppagecycles', 09:57:42 INFO - '7'], 09:57:42 INFO - 'tests': ['tsvgm']}}, 09:57:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['damp', 'tps']}, 09:57:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'tests': ['damp', 'tps']}, 09:57:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['dromaeo_dom']}, 09:57:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['basic_compositor_video']}, 09:57:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['a11yr', 09:57:42 INFO - 'ts_paint', 09:57:42 INFO - 'tpaint', 09:57:42 INFO - 'sessionrestore', 09:57:42 INFO - 'sessionrestore_no_auto_restore', 09:57:42 INFO - 'tabpaint']}, 09:57:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tsvgx', 09:57:42 INFO - 'tsvgr_opacity', 09:57:42 INFO - 'tart', 09:57:42 INFO - 'tscrollx', 09:57:42 INFO - 'cart']}, 09:57:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:42 INFO - 'tsvgr_opacity', 09:57:42 INFO - 'tart', 09:57:42 INFO - 'tscrollx', 09:57:42 INFO - 'cart']}, 09:57:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s'], 09:57:42 INFO - 'tests': ['tp5o']}, 09:57:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'tests': ['tp5o']}, 09:57:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--disable-e10s', 09:57:42 INFO - '--xperf_path', 09:57:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:42 INFO - 'tests': ['tp5n']}, 09:57:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:42 INFO - 'talos_options': ['--xperf_path', 09:57:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:42 INFO - 'tests': ['tp5n']}}, 09:57:42 INFO - 'talos.zip': {'path': '', 09:57:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:42 INFO - Running post-action listener: _resource_record_post_action 09:57:42 INFO - [mozharness: 2016-11-22 17:57:42.489936Z] Finished populate-webroot step (success) 09:57:42 INFO - [mozharness: 2016-11-22 17:57:42.490023Z] Running create-virtualenv step. 09:57:42 INFO - Running pre-action listener: _resource_record_pre_action 09:57:42 INFO - Running main action method: create_virtualenv 09:57:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:57:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:42 INFO - Using real prefix '/usr' 09:57:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:45 INFO - Installing pip.................done. 09:57:45 INFO - Return code: 0 09:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:57:45 INFO - Reading from file tmpfile_stdout 09:57:45 INFO - Output received: 09:57:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:57:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:57:45 INFO - Using env: {'DISPLAY': ':0', 09:57:45 INFO - 'HOME': '/home/cltbld', 09:57:45 INFO - 'LANG': 'en_US.UTF-8', 09:57:45 INFO - 'LANGUAGE': 'en_US:en', 09:57:45 INFO - 'LOGNAME': 'cltbld', 09:57:45 INFO - 'MAIL': '/var/mail/cltbld', 09:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:45 INFO - 'MOZ_NO_REMOTE': '1', 09:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:45 INFO - 'NO_EM_RESTART': '1', 09:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:45 INFO - 'PWD': '/builds/slave/test', 09:57:45 INFO - 'SHELL': '/bin/bash', 09:57:45 INFO - 'SHLVL': '1', 09:57:45 INFO - 'TERM': 'linux', 09:57:45 INFO - 'TMOUT': '86400', 09:57:45 INFO - 'USER': 'cltbld', 09:57:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:45 INFO - '_': '/tools/buildbot/bin/python'} 09:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:45 INFO - Cleaning up... 09:57:45 INFO - Return code: 0 09:57:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:57:45 INFO - Using env: {'DISPLAY': ':0', 09:57:45 INFO - 'HOME': '/home/cltbld', 09:57:45 INFO - 'LANG': 'en_US.UTF-8', 09:57:45 INFO - 'LANGUAGE': 'en_US:en', 09:57:45 INFO - 'LOGNAME': 'cltbld', 09:57:45 INFO - 'MAIL': '/var/mail/cltbld', 09:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:45 INFO - 'MOZ_NO_REMOTE': '1', 09:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:45 INFO - 'NO_EM_RESTART': '1', 09:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:45 INFO - 'PWD': '/builds/slave/test', 09:57:45 INFO - 'SHELL': '/bin/bash', 09:57:45 INFO - 'SHLVL': '1', 09:57:45 INFO - 'TERM': 'linux', 09:57:45 INFO - 'TMOUT': '86400', 09:57:45 INFO - 'USER': 'cltbld', 09:57:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:45 INFO - '_': '/tools/buildbot/bin/python'} 09:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:45 INFO - Downloading/unpacking psutil>=3.1.1 09:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:47 INFO - Installing collected packages: psutil 09:57:47 INFO - Running setup.py install for psutil 09:57:47 INFO - building 'psutil._psutil_linux' extension 09:57:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:57:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:57:48 INFO - building 'psutil._psutil_posix' extension 09:57:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:57:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:57:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:48 INFO - Successfully installed psutil 09:57:48 INFO - Cleaning up... 09:57:48 INFO - Return code: 0 09:57:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:48 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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:57:48 INFO - Using env: {'DISPLAY': ':0', 09:57:48 INFO - 'HOME': '/home/cltbld', 09:57:48 INFO - 'LANG': 'en_US.UTF-8', 09:57:48 INFO - 'LANGUAGE': 'en_US:en', 09:57:48 INFO - 'LOGNAME': 'cltbld', 09:57:48 INFO - 'MAIL': '/var/mail/cltbld', 09:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:48 INFO - 'MOZ_NO_REMOTE': '1', 09:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:48 INFO - 'NO_EM_RESTART': '1', 09:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:48 INFO - 'PWD': '/builds/slave/test', 09:57:48 INFO - 'SHELL': '/bin/bash', 09:57:48 INFO - 'SHLVL': '1', 09:57:48 INFO - 'TERM': 'linux', 09:57:48 INFO - 'TMOUT': '86400', 09:57:48 INFO - 'USER': 'cltbld', 09:57:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:48 INFO - '_': '/tools/buildbot/bin/python'} 09:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:50 INFO - Installing collected packages: mozsystemmonitor 09:57:50 INFO - Running setup.py install for mozsystemmonitor 09:57:50 INFO - Successfully installed mozsystemmonitor 09:57:50 INFO - Cleaning up... 09:57:50 INFO - Return code: 0 09:57:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:50 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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:57:50 INFO - Using env: {'DISPLAY': ':0', 09:57:50 INFO - 'HOME': '/home/cltbld', 09:57:50 INFO - 'LANG': 'en_US.UTF-8', 09:57:50 INFO - 'LANGUAGE': 'en_US:en', 09:57:50 INFO - 'LOGNAME': 'cltbld', 09:57:50 INFO - 'MAIL': '/var/mail/cltbld', 09:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:50 INFO - 'MOZ_NO_REMOTE': '1', 09:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:50 INFO - 'NO_EM_RESTART': '1', 09:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:50 INFO - 'PWD': '/builds/slave/test', 09:57:50 INFO - 'SHELL': '/bin/bash', 09:57:50 INFO - 'SHLVL': '1', 09:57:50 INFO - 'TERM': 'linux', 09:57:50 INFO - 'TMOUT': '86400', 09:57:50 INFO - 'USER': 'cltbld', 09:57:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:50 INFO - '_': '/tools/buildbot/bin/python'} 09:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:50 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:53 INFO - warning: no files found matching '*.txt' 09:57:53 INFO - no previously-included directories found matching 'build' 09:57:53 INFO - no previously-included directories found matching 'dist' 09:57:53 INFO - no previously-included directories found matching '.git*' 09:57:53 INFO - Installing collected packages: jsonschema, functools32 09:57:53 INFO - Running setup.py install for functools32 09:57:53 INFO - warning: no files found matching '*.txt' 09:57:53 INFO - no previously-included directories found matching 'build' 09:57:53 INFO - no previously-included directories found matching 'dist' 09:57:53 INFO - no previously-included directories found matching '.git*' 09:57:53 INFO - Successfully installed jsonschema functools32 09:57:53 INFO - Cleaning up... 09:57:53 INFO - Return code: 0 09:57:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:57:53 INFO - Using env: {'DISPLAY': ':0', 09:57:53 INFO - 'HOME': '/home/cltbld', 09:57:53 INFO - 'LANG': 'en_US.UTF-8', 09:57:53 INFO - 'LANGUAGE': 'en_US:en', 09:57:53 INFO - 'LOGNAME': 'cltbld', 09:57:53 INFO - 'MAIL': '/var/mail/cltbld', 09:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:53 INFO - 'MOZ_NO_REMOTE': '1', 09:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:53 INFO - 'NO_EM_RESTART': '1', 09:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:53 INFO - 'PWD': '/builds/slave/test', 09:57:53 INFO - 'SHELL': '/bin/bash', 09:57:53 INFO - 'SHLVL': '1', 09:57:53 INFO - 'TERM': 'linux', 09:57:53 INFO - 'TMOUT': '86400', 09:57:53 INFO - 'USER': 'cltbld', 09:57:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:53 INFO - '_': '/tools/buildbot/bin/python'} 09:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:57:53 INFO - Cleaning up... 09:57:53 INFO - Return code: 0 09:57:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:53 INFO - Using env: {'DISPLAY': ':0', 09:57:53 INFO - 'HOME': '/home/cltbld', 09:57:53 INFO - 'LANG': 'en_US.UTF-8', 09:57:53 INFO - 'LANGUAGE': 'en_US:en', 09:57:53 INFO - 'LOGNAME': 'cltbld', 09:57:53 INFO - 'MAIL': '/var/mail/cltbld', 09:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:53 INFO - 'MOZ_NO_REMOTE': '1', 09:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:53 INFO - 'NO_EM_RESTART': '1', 09:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:53 INFO - 'PWD': '/builds/slave/test', 09:57:53 INFO - 'SHELL': '/bin/bash', 09:57:53 INFO - 'SHLVL': '1', 09:57:53 INFO - 'TERM': 'linux', 09:57:53 INFO - 'TMOUT': '86400', 09:57:53 INFO - 'USER': 'cltbld', 09:57:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:53 INFO - '_': '/tools/buildbot/bin/python'} 09:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:53 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - Downloading docopt-0.6.1.tar.gz 09:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:56 INFO - Running setup.py install for blobuploader 09:57:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:56 INFO - Running setup.py install for requests 09:57:57 INFO - Running setup.py install for docopt 09:57:57 INFO - Successfully installed blobuploader requests docopt 09:57:57 INFO - Cleaning up... 09:57:57 INFO - Return code: 0 09:57:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:57 INFO - Using env: {'DISPLAY': ':0', 09:57:57 INFO - 'HOME': '/home/cltbld', 09:57:57 INFO - 'LANG': 'en_US.UTF-8', 09:57:57 INFO - 'LANGUAGE': 'en_US:en', 09:57:57 INFO - 'LOGNAME': 'cltbld', 09:57:57 INFO - 'MAIL': '/var/mail/cltbld', 09:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:57 INFO - 'MOZ_NO_REMOTE': '1', 09:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:57 INFO - 'NO_EM_RESTART': '1', 09:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:57 INFO - 'PWD': '/builds/slave/test', 09:57:57 INFO - 'SHELL': '/bin/bash', 09:57:57 INFO - 'SHLVL': '1', 09:57:57 INFO - 'TERM': 'linux', 09:57:57 INFO - 'TMOUT': '86400', 09:57:57 INFO - 'USER': 'cltbld', 09:57:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:57 INFO - '_': '/tools/buildbot/bin/python'} 09:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:57 INFO - Running setup.py (path:/tmp/pip-qXuV3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:57 INFO - Running setup.py (path:/tmp/pip-0mUdG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:57 INFO - Running setup.py (path:/tmp/pip-o9zZE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:57 INFO - Running setup.py (path:/tmp/pip-Jr8GTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:57 INFO - Running setup.py (path:/tmp/pip-lI7uUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:57 INFO - Running setup.py (path:/tmp/pip-V9zQNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:57 INFO - Running setup.py (path:/tmp/pip-7YzEB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:57 INFO - Running setup.py (path:/tmp/pip-mN1lle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:57 INFO - Running setup.py (path:/tmp/pip-Os0str-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:58 INFO - Running setup.py (path:/tmp/pip-GGKmjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:58 INFO - Running setup.py (path:/tmp/pip-T2Bn2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:58 INFO - Running setup.py (path:/tmp/pip-xREh0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:58 INFO - Running setup.py (path:/tmp/pip-vrUcUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:58 INFO - Running setup.py (path:/tmp/pip-Y76Q0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:58 INFO - Running setup.py (path:/tmp/pip-BglVRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:58 INFO - Running setup.py (path:/tmp/pip-7S3ba3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:58 INFO - Running setup.py (path:/tmp/pip-WLUwFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:58 INFO - Running setup.py install for manifestparser 09:57:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:58 INFO - Running setup.py install for mozcrash 09:57:58 INFO - Running setup.py install for mozdebug 09:57:58 INFO - Running setup.py install for mozdevice 09:57:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozfile 09:57:59 INFO - Running setup.py install for mozhttpd 09:57:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozinfo 09:57:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozInstall 09:57:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozleak 09:57:59 INFO - Running setup.py install for mozlog 09:57:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for moznetwork 09:57:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozprocess 09:57:59 INFO - Running setup.py install for mozprofile 09:57:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozrunner 09:58:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Running setup.py install for mozscreenshot 09:58:00 INFO - Running setup.py install for moztest 09:58:00 INFO - Running setup.py install for mozversion 09:58:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:00 INFO - Cleaning up... 09:58:00 INFO - Return code: 0 09:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:00 INFO - Using env: {'DISPLAY': ':0', 09:58:00 INFO - 'HOME': '/home/cltbld', 09:58:00 INFO - 'LANG': 'en_US.UTF-8', 09:58:00 INFO - 'LANGUAGE': 'en_US:en', 09:58:00 INFO - 'LOGNAME': 'cltbld', 09:58:00 INFO - 'MAIL': '/var/mail/cltbld', 09:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:00 INFO - 'MOZ_NO_REMOTE': '1', 09:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:00 INFO - 'NO_EM_RESTART': '1', 09:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:00 INFO - 'PWD': '/builds/slave/test', 09:58:00 INFO - 'SHELL': '/bin/bash', 09:58:00 INFO - 'SHLVL': '1', 09:58:00 INFO - 'TERM': 'linux', 09:58:00 INFO - 'TMOUT': '86400', 09:58:00 INFO - 'USER': 'cltbld', 09:58:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:00 INFO - '_': '/tools/buildbot/bin/python'} 09:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:00 INFO - Running setup.py (path:/tmp/pip-aIJTdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:00 INFO - Running setup.py (path:/tmp/pip-7RFK2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:00 INFO - Running setup.py (path:/tmp/pip-1LD487-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:00 INFO - Running setup.py (path:/tmp/pip-El3nQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:00 INFO - Running setup.py (path:/tmp/pip-f9te2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:00 INFO - Running setup.py (path:/tmp/pip-rM1ybj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:01 INFO - Running setup.py (path:/tmp/pip-f2w1_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:01 INFO - Running setup.py (path:/tmp/pip-V4b6_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:01 INFO - Running setup.py (path:/tmp/pip-RmkbKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:01 INFO - Running setup.py (path:/tmp/pip-zK2XP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:01 INFO - Running setup.py (path:/tmp/pip-xRZC8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:01 INFO - Running setup.py (path:/tmp/pip-AGEq3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:01 INFO - Running setup.py (path:/tmp/pip-Q8_k2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:01 INFO - Running setup.py (path:/tmp/pip-9VVuIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:01 INFO - Running setup.py (path:/tmp/pip-BkS3HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:01 INFO - Running setup.py (path:/tmp/pip-FwasgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:01 INFO - Running setup.py (path:/tmp/pip-l_6Qth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:03 INFO - Downloading blessings-1.6.tar.gz 09:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:03 INFO - Installing collected packages: blessings 09:58:03 INFO - Running setup.py install for blessings 09:58:04 INFO - Successfully installed blessings 09:58:04 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:04 INFO - Reading from file tmpfile_stdout 09:58:04 INFO - Current package versions: 09:58:04 INFO - argparse == 1.2.1 09:58:04 INFO - blessings == 1.6 09:58:04 INFO - blobuploader == 1.2.4 09:58:04 INFO - docopt == 0.6.1 09:58:04 INFO - functools32 == 3.2.3-2 09:58:04 INFO - jsonschema == 2.5.1 09:58:04 INFO - manifestparser == 1.1 09:58:04 INFO - mozInstall == 1.12 09:58:04 INFO - mozcrash == 1.0 09:58:04 INFO - mozdebug == 0.1 09:58:04 INFO - mozdevice == 0.48 09:58:04 INFO - mozfile == 1.2 09:58:04 INFO - mozhttpd == 0.7 09:58:04 INFO - mozinfo == 0.9 09:58:04 INFO - mozleak == 0.1 09:58:04 INFO - mozlog == 3.4 09:58:04 INFO - moznetwork == 0.27 09:58:04 INFO - mozprocess == 0.23 09:58:04 INFO - mozprofile == 0.28 09:58:04 INFO - mozrunner == 6.13 09:58:04 INFO - mozscreenshot == 0.1 09:58:04 INFO - mozsystemmonitor == 0.3 09:58:04 INFO - moztest == 0.7 09:58:04 INFO - mozversion == 1.4 09:58:04 INFO - psutil == 3.1.1 09:58:04 INFO - requests == 1.2.3 09:58:04 INFO - wsgiref == 0.1.2 09:58:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:04 INFO - Using env: {'DISPLAY': ':0', 09:58:04 INFO - 'HOME': '/home/cltbld', 09:58:04 INFO - 'LANG': 'en_US.UTF-8', 09:58:04 INFO - 'LANGUAGE': 'en_US:en', 09:58:04 INFO - 'LOGNAME': 'cltbld', 09:58:04 INFO - 'MAIL': '/var/mail/cltbld', 09:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:04 INFO - 'MOZ_NO_REMOTE': '1', 09:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:04 INFO - 'NO_EM_RESTART': '1', 09:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:04 INFO - 'PWD': '/builds/slave/test', 09:58:04 INFO - 'SHELL': '/bin/bash', 09:58:04 INFO - 'SHLVL': '1', 09:58:04 INFO - 'TERM': 'linux', 09:58:04 INFO - 'TMOUT': '86400', 09:58:04 INFO - 'USER': 'cltbld', 09:58:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:04 INFO - '_': '/tools/buildbot/bin/python'} 09:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:04 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b606fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d15ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, '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-1479837445.764641-904716275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:58:04 INFO - Using env: {'DISPLAY': ':0', 09:58:04 INFO - 'HOME': '/home/cltbld', 09:58:04 INFO - 'LANG': 'en_US.UTF-8', 09:58:04 INFO - 'LANGUAGE': 'en_US:en', 09:58:04 INFO - 'LOGNAME': 'cltbld', 09:58:04 INFO - 'MAIL': '/var/mail/cltbld', 09:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:04 INFO - 'MOZ_NO_REMOTE': '1', 09:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:04 INFO - 'NO_EM_RESTART': '1', 09:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:04 INFO - 'PWD': '/builds/slave/test', 09:58:04 INFO - 'SHELL': '/bin/bash', 09:58:04 INFO - 'SHLVL': '1', 09:58:04 INFO - 'TERM': 'linux', 09:58:04 INFO - 'TMOUT': '86400', 09:58:04 INFO - 'USER': 'cltbld', 09:58:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:04 INFO - '_': '/tools/buildbot/bin/python'} 09:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:04 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Running post-action listener: _resource_record_post_action 09:58:04 INFO - Running post-action listener: _start_resource_monitoring 09:58:04 INFO - Starting resource monitoring. 09:58:04 INFO - [mozharness: 2016-11-22 17:58:04.803842Z] Finished create-virtualenv step (success) 09:58:04 INFO - [mozharness: 2016-11-22 17:58:04.804366Z] Running install step. 09:58:04 INFO - Running pre-action listener: _resource_record_pre_action 09:58:04 INFO - Running main action method: install 09:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:05 INFO - Reading from file tmpfile_stdout 09:58:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:05 INFO - Reading from file tmpfile_stdout 09:58:05 INFO - Output received: 09:58:05 INFO - Usage: mozinstall [options] installer 09:58:05 INFO - Options: 09:58:05 INFO - -h, --help show this help message and exit 09:58:05 INFO - -d DEST, --destination=DEST 09:58:05 INFO - Directory to install application into. [default: 09:58:05 INFO - "/builds/slave/test"] 09:58:05 INFO - --app=APP Application being installed. [default: firefox] 09:58:05 INFO - mkdir: /builds/slave/test/build/application 09:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:58:21 INFO - Reading from file tmpfile_stdout 09:58:21 INFO - Output received: 09:58:21 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:21 INFO - Running post-action listener: _resource_record_post_action 09:58:21 INFO - [mozharness: 2016-11-22 17:58:21.387947Z] Finished install step (success) 09:58:21 INFO - [mozharness: 2016-11-22 17:58:21.388188Z] Running run-tests step. 09:58:21 INFO - Running pre-action listener: _resource_record_pre_action 09:58:21 INFO - Running main action method: run_tests 09:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:21 INFO - Python 2.7.3 09:58:21 INFO - Return code: 0 09:58:21 INFO - grabbing minidump binary from tooltool 09:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:21 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 0x1d12f60>, '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 0x1d13d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d141d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:58:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:58:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:58:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:21 INFO - Return code: 0 09:58:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:21 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/BfcQNg0rSvmV0JXOvMD9YA/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 09:58:21 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/BfcQNg0rSvmV0JXOvMD9YA/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 09:58:21 INFO - Using env: {'DISPLAY': ':0', 09:58:21 INFO - 'HOME': '/home/cltbld', 09:58:21 INFO - 'LANG': 'en_US.UTF-8', 09:58:21 INFO - 'LANGUAGE': 'en_US:en', 09:58:21 INFO - 'LOGNAME': 'cltbld', 09:58:21 INFO - 'MAIL': '/var/mail/cltbld', 09:58:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:21 INFO - 'MOZ_NO_REMOTE': '1', 09:58:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:21 INFO - 'NO_EM_RESTART': '1', 09:58:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:21 INFO - 'PWD': '/builds/slave/test', 09:58:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:21 INFO - 'SHELL': '/bin/bash', 09:58:21 INFO - 'SHLVL': '1', 09:58:21 INFO - 'TERM': 'linux', 09:58:21 INFO - 'TMOUT': '86400', 09:58:21 INFO - 'USER': 'cltbld', 09:58:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479837445.764641-904716275', 09:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:21 INFO - '_': '/tools/buildbot/bin/python'} 09:58:21 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/BfcQNg0rSvmV0JXOvMD9YA/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 09:58:21 INFO - mozversion application_buildid: 20161122081651 09:58:21 INFO - mozversion application_changeset: c538edad135a485319c98da4ff86c1debaa93062 09:58:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:58:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:21 INFO - mozversion application_name: Firefox 09:58:21 INFO - mozversion application_remotingname: firefox-dev 09:58:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:58:21 INFO - mozversion application_vendor: Mozilla 09:58:21 INFO - mozversion application_version: 52.0a2 09:58:21 INFO - mozversion platform_buildid: 20161122081651 09:58:21 INFO - mozversion platform_changeset: c538edad135a485319c98da4ff86c1debaa93062 09:58:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:58:21 INFO - mozversion platform_version: 52.0a2 09:58:21 INFO - using testdate: 1479837501 09:58:21 INFO - actual date: 1479837501 09:58:21 INFO - starting webserver on 'localhost:58231' 09:58:21 INFO - SUITE-START | Running 2 tests 09:58:21 INFO - TEST-START | dromaeo_css 09:58:21 INFO - operating with platform_type : linux_ 09:58:21 INFO - Initialising browser for dromaeo_css test... 09:58:21 INFO - TEST-INFO | started process 12648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLxUBKQ/profile http://localhost:58231/getInfo.html) 09:58:24 ERROR - PROCESS | 12648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 09:58:25 INFO - PROCESS | 12648 | __metrics Screen width/height:1600/1200 09:58:25 INFO - PROCESS | 12648 | colorDepth:24 09:58:25 INFO - PROCESS | 12648 | Browser inner width/height: 1024/697 09:58:25 INFO - PROCESS | 12648 | __metrics 09:58:25 INFO - PROCESS | 12648 | 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" 09:58:25 INFO - PROCESS | 12648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:26 INFO - PROCESS | 12648 | console.error: PushService: 09:58:26 INFO - PROCESS | 12648 | stateChangeProcessEnqueue: Error transitioning state 09:58:26 INFO - PROCESS | 12648 | UnknownError 09:58:26 INFO - TEST-INFO | 12648: exit 0 09:58:26 INFO - Browser initialized. 09:58:26 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:26 INFO - TEST-INFO | started process 12739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLxUBKQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:38 INFO - PROCESS | 12739 | RSS: Main: 144576512 09:58:38 INFO - PROCESS | 12739 | 09:59:30 INFO - PROCESS | 12739 | 1479837570034 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] 10:01:39 INFO - PROCESS | 12739 | Cycle 1(1): loaded http://localhost:58231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58231/tests/dromaeo/cssquery-ext.html) 10:01:41 INFO - PROCESS | 12739 | RSS: Main: 297586688 10:01:41 INFO - PROCESS | 12739 | 10:04:43 INFO - PROCESS | 12739 | Cycle 1(1): loaded http://localhost:58231/tests/dromaeo/cssquery-ext.html (next: http://localhost:58231/tests/dromaeo/cssquery-jquery.html) 10:04:44 INFO - PROCESS | 12739 | RSS: Main: 231763968 10:04:44 INFO - PROCESS | 12739 | 10:07:46 INFO - PROCESS | 12739 | Cycle 1(1): loaded http://localhost:58231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58231/tests/dromaeo/cssquery-mootools.html) 10:07:46 INFO - PROCESS | 12739 | RSS: Main: 219422720 10:07:46 INFO - PROCESS | 12739 | 10:10:48 INFO - PROCESS | 12739 | Cycle 1(1): loaded http://localhost:58231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58231/tests/dromaeo/cssquery-prototype.html) 10:10:49 INFO - PROCESS | 12739 | RSS: Main: 217915392 10:10:49 INFO - PROCESS | 12739 | 10:13:51 INFO - PROCESS | 12739 | Cycle 1(1): loaded http://localhost:58231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58231/tests/dromaeo/cssquery-yui.html) 10:13:52 INFO - PROCESS | 12739 | RSS: Main: 179404800 10:13:52 INFO - PROCESS | 12739 | 10:16:54 INFO - PROCESS | 12739 | Cycle 1(1): loaded http://localhost:58231/tests/dromaeo/cssquery-yui.html (next: http://localhost:58231/tests/dromaeo/cssquery-dojo.html) 10:16:55 INFO - PROCESS | 12739 | RSS: Main: 270049280 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | __start_tp_report 10:16:55 INFO - PROCESS | 12739 | _x_x_mozilla_page_load 10:16:55 INFO - PROCESS | 12739 | _x_x_mozilla_page_load_details 10:16:55 INFO - PROCESS | 12739 | |i|pagename|runs| 10:16:55 INFO - PROCESS | 12739 | |0;dojo.html;3194.105650417883;3224.5002024686173;3232.143481977275;3263.689949454801;3272.263740658352;5571.997040532708;5642.463965923236;5644.915326270099;5655.462731040545;5680.9715951420185;5665.093585026397;5725.513331366828;5726.513246374053;5744.16709577111;5785.566082543805;5169.56058735007;5176.7929282828645;5190.636655434121;5226.7909283628605;5273.077211487994;4997.875053123683;5019.899602007958;5272.762725677354;5288.524032837044;5314.654547454423;5094.694318340911;5105.540501354877;5114.181730923053;5134.25553294772;5146.691198528081;5151.922721159186;5161.4322424533275;5230.555402790767;5233.712145831978;5261.342332208474;4958.776855041532;5067.923981140286;5139.434662187156;5182.300389447414;5206.271122042917;5455.536279416255;5466.508014278695;5506.724663766836;5538.75075621594;5545.500904918576;5973.223480947492;5975.163477113208;6069.817905462844;6079.422454866781;6087.847803804896;5921.615095018853;6128.896798576255;6134.386561343875;6144.539159563006;6148.938510614926;5528.44715528444;5566.888662226774;5589.273394458775;5600.187972744011;5601.215829783833;6105.755769769159;6148.78479253224;6159.3224745277985;6160.260768707783;6164.352742962014;5769.451902069297;5908.704564771744;5913.5564832636865;5922;5923.111533270044;5899.262592175978;5927.792527261525;5928.673922934194;5992.460678538865;5993.910091348634;5982.162497250389;6011.579189456784;6023.427774361517;6051.152838602599;6076.5442591805795;6011;6060.606060606046;6063.151158837766;6082.300535438481;6086.330503644595;4548.88627784308;4609.677322587387;4618.284165954283;4666.929996050062;4677.415323084614;4140.23405669952;4147.792610369469;4168.353905144708;4193.1404062167185;4229.9365509516765;5855.970720146457;5862.472377486047;5864.472197502245;5868.149118377812;5870.647761134345;5818.127280907897;6109.908351374733;6120.510359171256;6120.66336351496;6122.234720659918;5616.241807355955;5625.184348269478;5639.182318563785;5654.604177707521;5718.885622287531;5129.769160387791;5155.097857874857;5167.379914410295;5172.043172013189;5172.146595811724;6138.355472675394;6139.416755408229;6139.693015349126;6141.631502109888;6153.261608606996;5837.737301821343;5886.146508756121;6008.609440386361;6055.909161362495;6061;6236.937630623635;6237.376262373908;6240.875182496234;6247.250329960434;6250.0937364082865;5778.393268706894;5842.561807864342;5857.326407463026;5878.617889837147;5881.2942446906645;5871.1486834409625;5871.324797648325;5911.733971971357;5924.31870334917;5969.343372228965;5854.619449735754;5866.765329386777;5870.735816888336;5886.087656413263;5896.528277737856;5769.884602307847;5794.652320860593;5824.417558244142;5824.970875145597;5828.504577110993;5700.686462244616;5799.420057994167;5801.448862358069;5806.941930580809;5808.854778630568;5866.735996880236;5867.647941123546;5911.674857882857;6003.5797494174985;6038.094285857156;5820.796272130455;5829.446202610745;5835.766569337179;5839.503642190291;5841.591088623755 10:16:55 INFO - PROCESS | 12739 | |1;ext.html;543.6602123672704;608.6256951974536;626.5144513002423;645.8805121052609;660.1582981698338;45962;47043.764781176134;47190.292145617845;47207.52792472079;50268.74865625667;47768.761156194174;48152;48308.75845620776;48394.274085888654;48415;8454.78863028423;8639.740807775777;8755.3433492488;8889.111088891124;8898.555072246394;10324.89675103247;10611.151107911348;10611.946940265289;10886.61896833611;10906.454677266145;11101.333919964827;11166.497507612135;11187.384693841836;11193.49629266685;11195.27230730004;10822.13422926168;10839.83740243897;10867.565297388135;10867.619633312795;10875.891241087567;10888.510017049251;10948.069414099811;10960.671179864617;10968.451577421178;10975;44745.32882006773;45055.549444505465;45084.323735144;45171.774141129084;45181.54818451806;3875.786831724254;3881.3789793633164;3961.801909904493;3974.701897357681;4432.401625780542;33450.33099338;33475.665243347496;33589.49615755765;33823.15442113967;33840.83079584611;4494.5730155635165;4497;4550.726956382595;4565.840195593139;4586.770661466913;362250;364453;364631;364758;365904;64342.678286608265;64953.67523162448;65038.67480662566;65081.67459162674;65099.674501628135;40526.18947621031;41395.793021034704;41568;43456.130877382275;63380.36619633745;18754.906225469058;18796.624067518573;18863.90568047151;18881.622367552573;18938.810611893703;13931.582052538237;14098.224597647022;14679;14935;15186.164760938034;21020.894895525424;21193.046312915954;21259.68110478344;21279.255226067013;21292;7091.397231235403;7253.3834624057545;7349.669264883093;7420.888686669704;7425.591592462466;937.4750139921666;996.2478328861808;1025.7845852371086;1086.8206745886998;1120.8991190792867;32907.341853163285;34050.659493404746;34274.48588271178;34426.139346516036;34481.31037379238;1098.5166526728215;1099.9010089092021;1103.1836441033577;1132.5243397772956;1193.4927655746274;16912.408065717642;17544.649107017787;17754;18021.549461263574;18124.909375453037;609178;612796;616098;616643;618991;62831;63433.36566634367;63501.68249158725;63724;63757;1339.7990301454665;1380.1374141161773;1381.6338670252392;1421.5664222412263;1437.1018113678952;32948.341033179684;35097;35504.43693480787;35552.28895422129;35555.466667999484;53973;54453.18320225279;54463.72768136134;54545;54592;404948;405021;405194;405637;406065;29807;30909;31187.84406077955;32569.674303256663;32932.67067329392;50715.23927141022;51076.489235107176;51103;51222.48777512177;51991.480085198666;43126.78436607797;43165.568344316154;43417;44368.334474983545;44374.11251775011;43404.78297608492;43690.78154609207;43892.122157556034;44237.77881110574;44885.775571121936;42898;43345.34981975336;43615.781921090194;44374.55625443704;44471.11057778891;36703.449448257765;38753;39181.2163756729;39791.60208397879;39794;28217.569074464132;28599.28501787472;28882;28958.7104128956;29122.417551649272 10:16:55 INFO - PROCESS | 12739 | |2;jquery.html;405.4147590748631;417.3406018490785;430.1161113910913;433.8069559046225;439.1743522178304;14726.410943562258;18958.715619265706;18974.525636859067;18982.52543686405;19499;12838.293893835835;13336.866631333683;13406.798898016537;13426.328683565807;13453.260070696133;4184.8744537663915;4399.736015839044;5295.8146464873735;5480.6437581557275;5483.451654834525;5669.234653321811;5896.262967129109;5958.702064896759;6040.758369665208;6041.879162416749;5696.886062278772;5957.761689532414;5996.130561068642;6028.728707208164;6039.6980150992495;6000.279966404016;6025.096235564656;6036.245469316335;6037.667928263943;6037.698115094249;5329.760160792774;5574.191742197399;5613.747381367848;5644.8306550803545;5675.5743319250805;14456.49402270926;14758;14778.482753103697;14829.18439485828;14962.251887405586;2371.9525609487887;2427.381017840457;2489.751024897514;2542.987285063563;2595.8961641534315;10141.89858101417;10659;11092.778144437147;11316.660500185008;12891.87108128916;1926.730257763914;1971.4184315626924;1986.4239370582513;1992.9892853241734;2037.3582321568806;72881.63559182223;76778;83328;87069.56465217697;88682.99999999936;11571.76856462866;11745.88254117465;11808.398438476348;11865.584704535473;12003.51985920571;17107.48677539676;17110.657786844193;17124.571885702957;17128;17129.657406852042;8816.250618697482;8854.335924805537;9019.32355073359;9070.909290907006;9139.771505712277;8600.741977740678;8615.784605384915;8633.913660863436;8774.60514276859;8833.116688331116;4597.839075632403;5143.948560514422;5153.561947234452;5201.531862132426;5253.973730131402;1926.9325573605138;1967.331107423483;2152.171414005588;2163.880986545755;2174.4998650310517;982.5627595719836;1007.868977032981;1021.1779517488493;1027.1269420992096;1058.8200005999;19300.1314940828;19483.707744383846;19573.314933977526;19784.802151978296;19998.20007199696;1005.1054561440324;1031.9690409287734;1042.8644276244192;1045.7281106912258;1067.3489171605315;10299.433531155859;10759.4748575675;10887.292325998944;11168.609098681507;11381.829272560919;197493;197948;198129;199237;201069;98908.50545747225;99840.99999999854;100818.49590751999;101068.49465752771;103514.96485035204;1067.114295135036;1101.5043230546125;1108.3903852881044;1133.0652211925194;1134.2627292260097;17513.299468021647;17995.460136195936;18147.183376747813;18161.36435224761;18433.35483258133;41238.1752364945;43954.34068488911;46193.30710039285;46641.53358466508;47386.578402647974;58151.70924145352;59067.704661478136;59384.40615593789;60374;61398.386016139266;8365.163483651586;8890.644374225218;9144.908550914406;9203.953980230055;9258.675946341846;13104.082714210295;13465.865341346853;13687.178769273876;13690.794638080635;13745.931270343985;11740.58907938218;11786.823197651871;11979.760404791681;12002;12167.33079680626;11583.884161158618;11807.232529885874;11892.583759568373;12064.75870482568;12390.504379825066;11963.700907477383;12064.577739779066;12064.75870482603;12417.813732793835;12827.615171544869;8833.514156721441;8870.778230544289;9029.142231487998;9034.45793252407;9124.224440922597;9278.211352035152;11625.360605166798;11673.182877198515;11861.822072668745;11874.584389546324 10:16:55 INFO - PROCESS | 12739 | |3;mootools.html;1493.2459108150385;1493.5146077524803;1668.733002719565;1760.1111438723442;1808.222464340333;7955.92044079559;8198.139195384489;8498.235158835703;9108.54457277136;9142.085791420863;8487.108853570364;8808.11918808119;8815.691450799224;9077;9082.455052696827;2494.925152245431;2536.5941449368106;2537.581299085649;2540.9237722868343;2548.362909272682;2261.163369553259;2329.37106981115;2518.5214809186195;2596.6624338835927;2598.883050262743;2464.9753502465014;2533.0627667762956;2542.364408897776;2557.808164387669;2562.359410147463;2519.8740062996776;2537.53055684698;2540.720520742717;2541.440883005736;2543.4404431025146;2554.067765265683;2558.7313332100234;2587.974120258792;2597.8701064946868;2601.622764699127;8963;9016.729498115066;9066.138716821892;9087.818243635156;9089.454632722058;5313.0967735485065;5478.671279723189;5480.205370221335;5489.039418101816;5491.780328786844;3491.417799384855;3572.2498275362204;3604.4953706481115;3741.2330472253125;3757.3612485877466;1067.1196263082988;1120.910327173824;1133.880942501042;1136.5737848306885;1165.5745652836738;12480.625581232487;12526.498940042387;12545.811812822814;12598.622041338866;12613.486381634262;5106.285120083191;5260.079486089919;5289.47105289468;5305.4164041955355;5346.8395948121615;9740.318177727491;9742.976987416361;9787.510624468749;9797.80404391908;9839.55721992512;5583.748731307101;5606;5626.690532020778;5633.63381380209;5641.153826925994;5025.4974502550185;5256.92114618281;5304.443033481506;5317.494837990384;5326.866828329245;3664.2671465706967;3784.4512545681273;3814.3896976484184;3836.616338366141;3885.630865067814;1118.2898859224451;1159.3449700918954;1160.3675996581883;1204.7108693913397;1205.8794120588047;883.5626364949263;885.3359980014989;1034.0280136671504;1045.0491539960367;1054.920880933933;5818.418158184148;5861.0915308127305;6146.108814221912;6195.81412557624;6396;972.1590823937244;990.1435258501489;1005.3415013166388;1027.440045175381;1072.9946350268199;3947.5262968443394;3972.2651309507833;4081.591840815954;4258.212230737324;4298.946758044237;9988.200943924468;10539.63111291101;10630.30902991303;10636.574537018432;10641.5211315491;10403.791924161475;10530.262881598215;10544.947275263574;10556.208284378703;10572.577096916037;8390.874136887951;8578.78553036179;8592.613332400057;8594.5702714864;8601.78495537604;6103.931811932983;6107.9083813741945;6218.81343559694;6253.249610046823;6268.874622507433;10130.493475326057;10139.7465063374;10277.383356998604;10282.331648442827;10370.014848589371;10393.84409233847;10467.581296748045;10474.895251047697;10482.977512950532;10584.523696433525;7429.8142546436775;7513.737019204302;7596.088469383489;7597.772066838003;7602.1257555379625;8165.387595930448;8223.588820559067;8253.504789712397;8254.133316001733;8580.841586385757;6027.909581356195;7282.96358518204;7452.292032256927;7628.38972882157;7847.176046515034;6913.827154320981;6928.584284942919;6937.93062069393;6956.930430695831;7026.262242464468;6917;6946.930530694628;7004.509684322048;7055.682494287872;7143.714251430092;5272.604554658493;5325.387580428301;5337.919931200958;5367.114426119647;5392.5416339611575;4949.257611358325;5074.594032477319;5121.180611102355;5255.343082114736;5462.317210348707 10:16:55 INFO - PROCESS | 12739 | |4;prototype.html;362.3622424532823;371.5726914048844;374.96062913394087;382.66134470993165;383.0538569732759;5256.421793602701;5323.680579165253;5477.917831232529;5479.178123281505;5490.846922146349;5242.842714718565;5341.225522299264;5388.595855310858;5390.676559406428;5395.973020134894;4326.480822301328;4334.566543345672;4337.197618440583;4345.630621397185;4345.739255644671;4240.173166232586;4271.508776490712;4305.117450922553;4346.5436129206455;4353.521112677603;4259.10558782656;4266.850660226893;4273.487181538219;4285.400043993828;4293.270144075499;4267.103908179286;4267.317229243306;4269.914601707964;4284.843092365044;4311.396404503341;3764.4353346997896;3864.188520410717;3869.9032524186837;3877.7867217303037;3883.7475564088245;5254.238135470374;5270.6047046471285;5273.894522109575;5286.3127793387;5289.603279754034;4926.334944782444;4928.704277743311;4939.678920870132;4941.629377796679;4947.381577302837;5430.809921652763;5616.354119276254;5671.716414179275;5675;5679.375268720438;4222.451081359434;4226.387173859773;4231.534531201565;4232.280512312914;4249.3413520904305;5799.246098007232;5866;5867.037146241164;5878.913570375587;5883.588148829584;4146.979265103655;4329.5237523872975;4344.761038142932;4347.934780978225;4358.302671572596;4353.978230108829;4383.671224658164;4397.6042156206095;4398.252297109499;4401.92152922536;4902.362692849907;4902.901941961212;4920.778564964585;4921.975390123026;4934.309196712463;5517.834464966058;5644.923516683418;5654;5661.462161094772;5669.41256448187;1458.183417286323;1461.6053665510465;1463.7072585482733;1470.669099452636;1484;986.8815742110993;1037.273908264218;1037.7457522906784;1042.8122937871103;1052.347544522401;5351.224072509464;5361;5362.498500419811;5365.195220716846;5375.435579264199;5613.382527921925;5623.044082505984;5625.521830644359;5642.830715078554;5645.407232240637;5096.311997880312;5263.605229607795;5354.598405119632;5380;5380.354357477127;2977.211039074647;2978.8510574471625;2983.8060526065738;2986.6117404737247;2997.385535965122;5635.239242702265;5797.710114494343;5805.564582656318;5806.332271788714;5816.35355913067;5687;5702.6863522506665;5714.914276285859;5724.084146536534;5727.455891690282;5756.625819321731;5790.276215473066;5794.101914203306;5809.970950145223;5828.970855145697;5327;5531.612787104864;5564.805231816867;5628.409017053151;5634.464725851038;5502.669839809624;5522.2544956430365;5556.194351818883;5558.972205138948;5571.777128914798;5770.595348744261;5789.421057894177;5793.275840519935;5811.535077193899;5824.359320474659;3978.144698889753;4188.560201178954;4218.261804184194;4219.472565929259;4221.2190744712325;5769.8557536061935;5847.859667364823;5857.339163023111;5871.211174692158;5884.264466941632;5518.779248830002;5685.715714214355;5713.857153571194;5715.5713321500225;5719.685417301922;5718.828435146952;5734.856628584319;5743.913841292468;5766.855828604318;5773.278340207474;5679.488846003879;5705.800296989585;5706.457886500776;5712.971435142797;5745.339285982165;5644.915326270191;5742.913856292243;5775.33583637887;5794;5799.710014499174;5640.266765320482;5651.660900345993;5657.830265092054;5661.2923384576925;5662.320521537442 10:16:55 INFO - PROCESS | 12739 | |5;yui.html;803.8070862992884;816.8693009118542;857.352698712472;859.2867919626708;873.3755364914085;14833;15182.924085379585;15214.16322102284;15232.695346093085;15235.619109522253;13553.72892542151;14010.369533370997;14018.439262429516;14035.789463158035;14047.789283160735;716.0476566166985;732.3738203835724;734.8456824066952;734.8640501507211;736.105631657536;805.1948051948052;820.3396266005863;821.2813787935556;828.7638023163399;828.8176601147737;892.9330300227509;894.0969620683125;895.4895709445618;896.6547879066574;896.6906417286059;747.3535391885979;885.8671199320089;886.9379143459961;887.1837909123622;887.2768693514765;553.2945494494511;643.8165122939939;645.4255712415953;650.7592190889401;654.0614218596329;12175.391230438443;12199.024078073733;12214;12221.572244971383;12229.205101668453;14054.227017514033;14353.282335883268;14639.92680036593;14646;14679.486217982427;11698.064154867676;13008;13059.085863989525;13114.278714670689;13338.799918001238;4384.298512238027;4438.60052595268;4450.154470650598;4496.4829044659955;4558.361829343895;66281;67268.66365668189;67282;67287.99068013983;67297.32702672959;11503.309801411775;11542.07663386927;11542.653720388402;11557.537698491966;11701.180917335705;19902.701459478118;19942.60114797696;20711.378658640264;21266.149354025976;21438.464038399165;9005.14451127142;9264.675736349196;9283.210927071275;9332.44005359667;9361.812763744823;4816.831410900601;4891.706497610155;4913.901721965541;5079.974600126976;5171.250168725589;3845.4616353710503;3952.960470395317;3969.0871099647243;3969.980150099231;3974.0462289050997;666.7732970789955;678.389449495458;680.0479328939524;690.1304356510833;699.1959246866043;729.3946024799404;739.593223726948;742.38011260598;745.143085451724;759.3886921028625;9016.459012459274;9109.271258299452;9288.256939444827;9330.533473326306;9393.859092113624;671.4796033074407;684.4216636941776;701.2531653788699;701.5475018613068;705.4215543254585;4264.488261408589;4373.234683930299;4440.933385999213;4454.866354009385;4493.258612328995;89952.5502372497;95817;96349.51825240969;97843;98496.50751746338;69945.65027174831;81845.59077204695;84018.57990710008;84327.57836210902;84556.57721711475;70730.10984395805;70744.64627676932;71418.2858171422;71418.64290678513;73334;8639.568021598769;8847.911520884709;8870.911290887008;8890.288776897703;8892.777680558038;48532.51467485421;48855.75572122117;48927;49752.50247497624;49948.75025624849;61047.389526105944;67236.66381668061;67829.66085169543;68148.31851681619;70377;11530.135239857213;12507.749845002867;12580;12619.053570982029;12747.980161587237;11981.580644677395;12033;12080.939595301967;12517.24896506176;12761.170523916287;11276.210665253353;11399;11771.705707357385;11826.113041521749;12191.573294934635;11176.720581985515;11341.26281791681;11629.24409913353;11784.941075294568;12030.819537707117;11693.707657308636;11912.642620721392;11925.821112683143;12226.144169908377;12461.1900226485;9563.952180239054;9647.083527064917;9651.662191823252;9692.563834627317;10005.399676019462;8795.91204087951;9805.558749856416;9881.901180988098;10018.09837114634;10027.097561219525 10:16:55 INFO - PROCESS | 12739 | __end_tp_report 10:16:55 INFO - PROCESS | 12739 | __start_cc_report 10:16:55 INFO - PROCESS | 12739 | _x_x_mozilla_cycle_collect,1535 10:16:55 INFO - PROCESS | 12739 | __end_cc_report 10:16:55 INFO - PROCESS | 12739 | __startTimestamp1479838615215__endTimestamp 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | ------- Summary: start ------- 10:16:55 INFO - PROCESS | 12739 | Number of tests: 6 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | [#0] dojo.html Cycles:165 Average:5593.89 Median:5824.97 stddev:624.05 (10.7%) stddev-sans-first:596.89 10:16:55 INFO - PROCESS | 12739 | Values: 3194.1 3224.5 3232.1 3263.7 3272.3 5572.0 5642.5 5644.9 5655.5 5681.0 5665.1 5725.5 5726.5 5744.2 5785.6 5169.6 5176.8 5190.6 5226.8 5273.1 4997.9 5019.9 5272.8 5288.5 5314.7 5094.7 5105.5 5114.2 5134.3 5146.7 5151.9 5161.4 5230.6 5233.7 5261.3 4958.8 5067.9 5139.4 5182.3 5206.3 5455.5 5466.5 5506.7 5538.8 5545.5 5973.2 5975.2 6069.8 6079.4 6087.8 5921.6 6128.9 6134.4 6144.5 6148.9 5528.4 5566.9 5589.3 5600.2 5601.2 6105.8 6148.8 6159.3 6160.3 6164.4 5769.5 5908.7 5913.6 5922.0 5923.1 5899.3 5927.8 5928.7 5992.5 5993.9 5982.2 6011.6 6023.4 6051.2 6076.5 6011.0 6060.6 6063.2 6082.3 6086.3 4548.9 4609.7 4618.3 4666.9 4677.4 4140.2 4147.8 4168.4 4193.1 4229.9 5856.0 5862.5 5864.5 5868.1 5870.6 5818.1 6109.9 6120.5 6120.7 6122.2 5616.2 5625.2 5639.2 5654.6 5718.9 5129.8 5155.1 5167.4 5172.0 5172.1 6138.4 6139.4 6139.7 6141.6 6153.3 5837.7 5886.1 6008.6 6055.9 6061.0 6236.9 6237.4 6240.9 6247.3 6250.1 5778.4 5842.6 5857.3 5878.6 5881.3 5871.1 5871.3 5911.7 5924.3 5969.3 5854.6 5866.8 5870.7 5886.1 5896.5 5769.9 5794.7 5824.4 5825.0 5828.5 5700.7 5799.4 5801.4 5806.9 5808.9 5866.7 5867.6 5911.7 6003.6 6038.1 5820.8 5829.4 5835.8 5839.5 5841.6 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | [#1] ext.html Cycles:180 Average:63421.68 Median:39792.80 stddev:125898.43 (316.4%) stddev-sans-first:126163.09 10:16:55 INFO - PROCESS | 12739 | Values: 543.7 608.6 626.5 645.9 660.2 45962.0 47043.8 47190.3 47207.5 50268.7 47768.8 48152.0 48308.8 48394.3 48415.0 8454.8 8639.7 8755.3 8889.1 8898.6 10324.9 10611.2 10611.9 10886.6 10906.5 11101.3 11166.5 11187.4 11193.5 11195.3 10822.1 10839.8 10867.6 10867.6 10875.9 10888.5 10948.1 10960.7 10968.5 10975.0 44745.3 45055.5 45084.3 45171.8 45181.5 3875.8 3881.4 3961.8 3974.7 4432.4 33450.3 33475.7 33589.5 33823.2 33840.8 4494.6 4497.0 4550.7 4565.8 4586.8 362250.0 364453.0 364631.0 364758.0 365904.0 64342.7 64953.7 65038.7 65081.7 65099.7 40526.2 41395.8 41568.0 43456.1 63380.4 18754.9 18796.6 18863.9 18881.6 18938.8 13931.6 14098.2 14679.0 14935.0 15186.2 21020.9 21193.0 21259.7 21279.3 21292.0 7091.4 7253.4 7349.7 7420.9 7425.6 937.5 996.2 1025.8 1086.8 1120.9 32907.3 34050.7 34274.5 34426.1 34481.3 1098.5 1099.9 1103.2 1132.5 1193.5 16912.4 17544.6 17754.0 18021.5 18124.9 609178.0 612796.0 616098.0 616643.0 618991.0 62831.0 63433.4 63501.7 63724.0 63757.0 1339.8 1380.1 1381.6 1421.6 1437.1 32948.3 35097.0 35504.4 35552.3 35555.5 53973.0 54453.2 54463.7 54545.0 54592.0 404948.0 405021.0 405194.0 405637.0 406065.0 29807.0 30909.0 31187.8 32569.7 32932.7 50715.2 51076.5 51103.0 51222.5 51991.5 43126.8 43165.6 43417.0 44368.3 44374.1 43404.8 43690.8 43892.1 44237.8 44885.8 42898.0 43345.3 43615.8 44374.6 44471.1 36703.4 38753.0 39181.2 39791.6 39794.0 28217.6 28599.3 28882.0 28958.7 29122.4 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | [#2] jquery.html Cycles:180 Average:21147.72 Median:198038.50 stddev:37106.01 (18.7%) stddev-sans-first:37177.42 10:16:55 INFO - PROCESS | 12739 | Values: 405.4 417.3 430.1 433.8 439.2 14726.4 18958.7 18974.5 18982.5 19499.0 12838.3 13336.9 13406.8 13426.3 13453.3 4184.9 4399.7 5295.8 5480.6 5483.5 5669.2 5896.3 5958.7 6040.8 6041.9 5696.9 5957.8 5996.1 6028.7 6039.7 6000.3 6025.1 6036.2 6037.7 6037.7 5329.8 5574.2 5613.7 5644.8 5675.6 14456.5 14758.0 14778.5 14829.2 14962.3 2372.0 2427.4 2489.8 2543.0 2595.9 10141.9 10659.0 11092.8 11316.7 12891.9 1926.7 1971.4 1986.4 1993.0 2037.4 72881.6 76778.0 83328.0 87069.6 88683.0 11571.8 11745.9 11808.4 11865.6 12003.5 17107.5 17110.7 17124.6 17128.0 17129.7 8816.3 8854.3 9019.3 9070.9 9139.8 8600.7 8615.8 8633.9 8774.6 8833.1 4597.8 5143.9 5153.6 5201.5 5254.0 1926.9 1967.3 2152.2 2163.9 2174.5 982.6 1007.9 1021.2 1027.1 1058.8 19300.1 19483.7 19573.3 19784.8 19998.2 1005.1 1032.0 1042.9 1045.7 1067.3 10299.4 10759.5 10887.3 11168.6 11381.8 197493.0 197948.0 198129.0 199237.0 201069.0 98908.5 99841.0 100818.5 101068.5 103515.0 1067.1 1101.5 1108.4 1133.1 1134.3 17513.3 17995.5 18147.2 18161.4 18433.4 41238.2 43954.3 46193.3 46641.5 47386.6 58151.7 59067.7 59384.4 60374.0 61398.4 8365.2 8890.6 9144.9 9204.0 9258.7 13104.1 13465.9 13687.2 13690.8 13745.9 11740.6 11786.8 11979.8 12002.0 12167.3 11583.9 11807.2 11892.6 12064.8 12390.5 11963.7 12064.6 12064.8 12417.8 12827.6 8833.5 8870.8 9029.1 9034.5 9124.2 9278.2 11625.4 11673.2 11861.8 11874.6 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | [#3] mootools.html Cycles:180 Average:5850.89 Median:5256.13 stddev:3219.03 (61.2%) stddev-sans-first:3211.40 10:16:55 INFO - PROCESS | 12739 | Values: 1493.2 1493.5 1668.7 1760.1 1808.2 7955.9 8198.1 8498.2 9108.5 9142.1 8487.1 8808.1 8815.7 9077.0 9082.5 2494.9 2536.6 2537.6 2540.9 2548.4 2261.2 2329.4 2518.5 2596.7 2598.9 2465.0 2533.1 2542.4 2557.8 2562.4 2519.9 2537.5 2540.7 2541.4 2543.4 2554.1 2558.7 2588.0 2597.9 2601.6 8963.0 9016.7 9066.1 9087.8 9089.5 5313.1 5478.7 5480.2 5489.0 5491.8 3491.4 3572.2 3604.5 3741.2 3757.4 1067.1 1120.9 1133.9 1136.6 1165.6 12480.6 12526.5 12545.8 12598.6 12613.5 5106.3 5260.1 5289.5 5305.4 5346.8 9740.3 9743.0 9787.5 9797.8 9839.6 5583.7 5606.0 5626.7 5633.6 5641.2 5025.5 5256.9 5304.4 5317.5 5326.9 3664.3 3784.5 3814.4 3836.6 3885.6 1118.3 1159.3 1160.4 1204.7 1205.9 883.6 885.3 1034.0 1045.0 1054.9 5818.4 5861.1 6146.1 6195.8 6396.0 972.2 990.1 1005.3 1027.4 1073.0 3947.5 3972.3 4081.6 4258.2 4298.9 9988.2 10539.6 10630.3 10636.6 10641.5 10403.8 10530.3 10544.9 10556.2 10572.6 8390.9 8578.8 8592.6 8594.6 8601.8 6103.9 6107.9 6218.8 6253.2 6268.9 10130.5 10139.7 10277.4 10282.3 10370.0 10393.8 10467.6 10474.9 10483.0 10584.5 7429.8 7513.7 7596.1 7597.8 7602.1 8165.4 8223.6 8253.5 8254.1 8580.8 6027.9 7283.0 7452.3 7628.4 7847.2 6913.8 6928.6 6937.9 6956.9 7026.3 6917.0 6946.9 7004.5 7055.7 7143.7 5272.6 5325.4 5337.9 5367.1 5392.5 4949.3 5074.6 5121.2 5255.3 5462.3 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | [#4] prototype.html Cycles:180 Average:4772.56 Median:5370.32 stddev:1357.94 (25.3%) stddev-sans-first:1320.79 10:16:55 INFO - PROCESS | 12739 | Values: 362.4 371.6 375.0 382.7 383.1 5256.4 5323.7 5477.9 5479.2 5490.8 5242.8 5341.2 5388.6 5390.7 5396.0 4326.5 4334.6 4337.2 4345.6 4345.7 4240.2 4271.5 4305.1 4346.5 4353.5 4259.1 4266.9 4273.5 4285.4 4293.3 4267.1 4267.3 4269.9 4284.8 4311.4 3764.4 3864.2 3869.9 3877.8 3883.7 5254.2 5270.6 5273.9 5286.3 5289.6 4926.3 4928.7 4939.7 4941.6 4947.4 5430.8 5616.4 5671.7 5675.0 5679.4 4222.5 4226.4 4231.5 4232.3 4249.3 5799.2 5866.0 5867.0 5878.9 5883.6 4147.0 4329.5 4344.8 4347.9 4358.3 4354.0 4383.7 4397.6 4398.3 4401.9 4902.4 4902.9 4920.8 4922.0 4934.3 5517.8 5644.9 5654.0 5661.5 5669.4 1458.2 1461.6 1463.7 1470.7 1484.0 986.9 1037.3 1037.7 1042.8 1052.3 5351.2 5361.0 5362.5 5365.2 5375.4 5613.4 5623.0 5625.5 5642.8 5645.4 5096.3 5263.6 5354.6 5380.0 5380.4 2977.2 2978.9 2983.8 2986.6 2997.4 5635.2 5797.7 5805.6 5806.3 5816.4 5687.0 5702.7 5714.9 5724.1 5727.5 5756.6 5790.3 5794.1 5810.0 5829.0 5327.0 5531.6 5564.8 5628.4 5634.5 5502.7 5522.3 5556.2 5559.0 5571.8 5770.6 5789.4 5793.3 5811.5 5824.4 3978.1 4188.6 4218.3 4219.5 4221.2 5769.9 5847.9 5857.3 5871.2 5884.3 5518.8 5685.7 5713.9 5715.6 5719.7 5718.8 5734.9 5743.9 5766.9 5773.3 5679.5 5705.8 5706.5 5713.0 5745.3 5644.9 5742.9 5775.3 5794.0 5799.7 5640.3 5651.7 5657.8 5661.3 5662.3 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - PROCESS | 12739 | [#5] yui.html Cycles:180 Average:18433.43 Median:644.62 stddev:25233.83 (3914.5%) stddev-sans-first:25269.90 10:16:55 INFO - PROCESS | 12739 | Values: 803.8 816.9 857.4 859.3 873.4 14833.0 15182.9 15214.2 15232.7 15235.6 13553.7 14010.4 14018.4 14035.8 14047.8 716.0 732.4 734.8 734.9 736.1 805.2 820.3 821.3 828.8 828.8 892.9 894.1 895.5 896.7 896.7 747.4 885.9 886.9 887.2 887.3 553.3 643.8 645.4 650.8 654.1 12175.4 12199.0 12214.0 12221.6 12229.2 14054.2 14353.3 14639.9 14646.0 14679.5 11698.1 13008.0 13059.1 13114.3 13338.8 4384.3 4438.6 4450.2 4496.5 4558.4 66281.0 67268.7 67282.0 67288.0 67297.3 11503.3 11542.1 11542.7 11557.5 11701.2 19902.7 19942.6 20711.4 21266.1 21438.5 9005.1 9264.7 9283.2 9332.4 9361.8 4816.8 4891.7 4913.9 5080.0 5171.3 3845.5 3953.0 3969.1 3970.0 3974.0 666.8 678.4 680.0 690.1 699.2 729.4 739.6 742.4 745.1 759.4 9016.5 9109.3 9288.3 9330.5 9393.9 671.5 684.4 701.3 701.5 705.4 4264.5 4373.2 4440.9 4454.9 4493.3 89952.6 95817.0 96349.5 97843.0 98496.5 69945.7 81845.6 84018.6 84327.6 84556.6 70730.1 70744.6 71418.3 71418.6 73334.0 8639.6 8847.9 8870.9 8890.3 8892.8 48532.5 48855.8 48927.0 49752.5 49948.8 61047.4 67236.7 67829.7 68148.3 70377.0 11530.1 12507.7 12580.0 12619.1 12748.0 11981.6 12033.0 12080.9 12517.2 12761.2 11276.2 11399.0 11771.7 11826.1 12191.6 11176.7 11341.3 11629.2 11784.9 12030.8 11693.7 11912.6 11925.8 12226.1 12461.2 9564.0 9647.1 9651.7 9692.6 10005.4 8795.9 9805.6 9881.9 10018.1 10027.1 10:16:55 INFO - PROCESS | 12739 | -------- Summary: end -------- 10:16:55 INFO - PROCESS | 12739 | 10:16:55 INFO - TEST-INFO | 12739: exit 0 10:16:55 INFO - TEST-OK | dromaeo_css | took 1114313ms 10:16:55 INFO - TEST-START | kraken 10:16:55 INFO - operating with platform_type : linux_ 10:16:55 INFO - Initialising browser for kraken test... 10:16:55 INFO - TEST-INFO | started process 13054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptcPaAQ/profile http://localhost:58231/getInfo.html) 10:16:58 ERROR - PROCESS | 13054 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 10:16:59 INFO - PROCESS | 13054 | __metrics Screen width/height:1600/1200 10:16:59 INFO - PROCESS | 13054 | colorDepth:24 10:16:59 INFO - PROCESS | 13054 | Browser inner width/height: 1024/697 10:16:59 INFO - PROCESS | 13054 | __metrics 10:17:00 INFO - PROCESS | 13054 | 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" 10:17:00 INFO - PROCESS | 13054 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:00 INFO - PROCESS | 13054 | console.error: PushService: 10:17:00 INFO - PROCESS | 13054 | stateChangeProcessEnqueue: Error transitioning state 10:17:00 INFO - PROCESS | 13054 | UnknownError 10:17:01 INFO - TEST-INFO | 13054: exit 0 10:17:01 INFO - Browser initialized. 10:17:01 INFO - Running cycle 1/1 for kraken test... 10:17:01 INFO - TEST-INFO | started process 13146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptcPaAQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:12 INFO - PROCESS | 13146 | RSS: Main: 144973824 10:17:12 INFO - PROCESS | 13146 | 10:17:15 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58231/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:16 INFO - PROCESS | 13146 | RSS: Main: 185626624 10:17:16 INFO - PROCESS | 13146 | 10:17:18 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58231/tests/kraken/driver.html?testName=audio-dft) 10:17:19 INFO - PROCESS | 13146 | RSS: Main: 175788032 10:17:19 INFO - PROCESS | 13146 | 10:17:22 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58231/tests/kraken/driver.html?testName=audio-fft) 10:17:22 INFO - PROCESS | 13146 | RSS: Main: 267255808 10:17:22 INFO - PROCESS | 13146 | 10:17:24 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58231/tests/kraken/driver.html?testName=audio-oscillator) 10:17:25 INFO - PROCESS | 13146 | RSS: Main: 173514752 10:17:25 INFO - PROCESS | 13146 | 10:17:27 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:28 INFO - PROCESS | 13146 | RSS: Main: 175583232 10:17:28 INFO - PROCESS | 13146 | 10:17:31 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58231/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:31 INFO - PROCESS | 13146 | RSS: Main: 213897216 10:17:31 INFO - PROCESS | 13146 | 10:17:34 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58231/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:35 INFO - PROCESS | 13146 | RSS: Main: 212656128 10:17:35 INFO - PROCESS | 13146 | 10:17:38 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58231/tests/kraken/driver.html?testName=json-parse-financial) 10:17:38 INFO - PROCESS | 13146 | RSS: Main: 211398656 10:17:38 INFO - PROCESS | 13146 | 10:17:40 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:40 INFO - PROCESS | 13146 | RSS: Main: 173924352 10:17:40 INFO - PROCESS | 13146 | 10:17:42 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:43 INFO - PROCESS | 13146 | RSS: Main: 181334016 10:17:43 INFO - PROCESS | 13146 | 10:17:45 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:45 INFO - PROCESS | 13146 | RSS: Main: 190189568 10:17:45 INFO - PROCESS | 13146 | 10:17:48 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:49 INFO - PROCESS | 13146 | RSS: Main: 198791168 10:17:49 INFO - PROCESS | 13146 | 10:17:51 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:52 INFO - PROCESS | 13146 | RSS: Main: 195780608 10:17:52 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | Cycle 1(1): loaded http://localhost:58231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58231/tests/kraken/driver.html?testName=ai-astar) 10:17:54 INFO - PROCESS | 13146 | RSS: Main: 247144448 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | __start_tp_report 10:17:54 INFO - PROCESS | 13146 | _x_x_mozilla_page_load 10:17:54 INFO - PROCESS | 13146 | _x_x_mozilla_page_load_details 10:17:54 INFO - PROCESS | 13146 | |i|pagename|runs| 10:17:54 INFO - PROCESS | 13146 | |0;ai-astar;101;110;112;111;110;110;111;110;110;109 10:17:54 INFO - PROCESS | 13146 | |1;audio-beat-detection;145;122;121;166;122;120;123;126;150;122 10:17:54 INFO - PROCESS | 13146 | |2;audio-dft;161;159;161;159;161;159;160;160;160;160 10:17:54 INFO - PROCESS | 13146 | |3;audio-fft;75;75;75;102;76;76;77;76;103;76 10:17:54 INFO - PROCESS | 13146 | |4;audio-oscillator;82;81;109;81;81;81;102;81;81;109 10:17:54 INFO - PROCESS | 13146 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 10:17:54 INFO - PROCESS | 13146 | |6;imaging-darkroom;147;146;146;146;146;145;146;146;146;146 10:17:54 INFO - PROCESS | 13146 | |7;imaging-desaturate;85;85;85;85;84;84;85;84;85;85 10:17:54 INFO - PROCESS | 13146 | |8;json-parse-financial;51;50;51;50;50;52;50;51;49;50 10:17:54 INFO - PROCESS | 13146 | |9;json-stringify-tinderbox;62;61;60;61;61;61;60;61;61;61 10:17:54 INFO - PROCESS | 13146 | |10;stanford-crypto-aes;75;75;75;78;75;76;75;76;78;75 10:17:54 INFO - PROCESS | 13146 | |11;stanford-crypto-ccm;129;130;130;129;128;125;128;121;167;127 10:17:54 INFO - PROCESS | 13146 | |12;stanford-crypto-pbkdf2;159;157;158;155;163;155;156;165;163;156 10:17:54 INFO - PROCESS | 13146 | |13;stanford-crypto-sha256-iterative;66;62;61;61;62;61;65;61;61;60 10:17:54 INFO - PROCESS | 13146 | __end_tp_report 10:17:54 INFO - PROCESS | 13146 | __start_cc_report 10:17:54 INFO - PROCESS | 13146 | _x_x_mozilla_cycle_collect,1640 10:17:54 INFO - PROCESS | 13146 | __end_cc_report 10:17:54 INFO - PROCESS | 13146 | __startTimestamp1479838674293__endTimestamp 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | ------- Summary: start ------- 10:17:54 INFO - PROCESS | 13146 | Number of tests: 14 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.87 10:17:54 INFO - PROCESS | 13146 | Values: 101.0 110.0 112.0 111.0 110.0 110.0 111.0 110.0 110.0 109.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:124.50 stddev:16.09 (12.9%) stddev-sans-first:16.33 10:17:54 INFO - PROCESS | 13146 | Values: 145.0 122.0 121.0 166.0 122.0 120.0 123.0 126.0 150.0 122.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 10:17:54 INFO - PROCESS | 13146 | Values: 161.0 159.0 161.0 159.0 161.0 159.0 160.0 160.0 160.0 160.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.30 (14.9%) stddev-sans-first:11.77 10:17:54 INFO - PROCESS | 13146 | Values: 75.0 75.0 75.0 102.0 76.0 76.0 77.0 76.0 103.0 76.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:81.00 stddev:12.48 (15.4%) stddev-sans-first:12.99 10:17:54 INFO - PROCESS | 13146 | Values: 82.0 81.0 109.0 81.0 81.0 81.0 102.0 81.0 81.0 109.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:17:54 INFO - PROCESS | 13146 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 10:17:54 INFO - PROCESS | 13146 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 10:17:54 INFO - PROCESS | 13146 | Values: 85.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 85.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.50 stddev:0.84 (1.7%) stddev-sans-first:0.87 10:17:54 INFO - PROCESS | 13146 | Values: 51.0 50.0 51.0 50.0 50.0 52.0 50.0 51.0 49.0 50.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 10:17:54 INFO - PROCESS | 13146 | Values: 62.0 61.0 60.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:1.23 (1.6%) stddev-sans-first:1.27 10:17:54 INFO - PROCESS | 13146 | Values: 75.0 75.0 75.0 78.0 75.0 76.0 75.0 76.0 78.0 75.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:129.00 stddev:12.80 (9.9%) stddev-sans-first:13.55 10:17:54 INFO - PROCESS | 13146 | Values: 129.0 130.0 130.0 129.0 128.0 125.0 128.0 121.0 167.0 127.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:158.50 stddev:3.68 (2.3%) stddev-sans-first:3.91 10:17:54 INFO - PROCESS | 13146 | Values: 159.0 157.0 158.0 155.0 163.0 155.0 156.0 165.0 163.0 156.0 10:17:54 INFO - PROCESS | 13146 | 10:17:54 INFO - PROCESS | 13146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:61.50 stddev:1.94 (3.2%) stddev-sans-first:1.42 10:17:54 INFO - PROCESS | 13146 | Values: 66.0 62.0 61.0 61.0 62.0 61.0 65.0 61.0 61.0 60.0 10:17:54 INFO - PROCESS | 13146 | -------- Summary: end -------- 10:17:54 INFO - PROCESS | 13146 | 10:17:55 INFO - TEST-INFO | 13146: exit 0 10:17:55 INFO - TEST-OK | kraken | took 59351ms 10:17:55 INFO - SUITE-END | took 1173s 10:17:55 INFO - Completed test suite (00:19:33) 10:17:55 INFO - javascript benchmark 10:17:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3194.105650417883, 3224.5002024686173, 3232.143481977275, 3263.689949454801, 3272.263740658352, 5571.997040532708, 5642.463965923236, 5644.915326270099, 5655.462731040545, 5680.9715951420185, 5665.093585026397, 5725.513331366828, 5726.513246374053, 5744.16709577111, 5785.566082543805, 5169.56058735007, 5176.7929282828645, 5190.636655434121, 5226.7909283628605, 5273.077211487994, 4997.875053123683, 5019.899602007958, 5272.762725677354, 5288.524032837044, 5314.654547454423, 5094.694318340911, 5105.540501354877, 5114.181730923053, 5134.25553294772, 5146.691198528081, 5151.922721159186, 5161.4322424533275, 5230.555402790767, 5233.712145831978, 5261.342332208474, 4958.776855041532, 5067.923981140286, 5139.434662187156, 5182.300389447414, 5206.271122042917, 5455.536279416255, 5466.508014278695, 5506.724663766836, 5538.75075621594, 5545.500904918576, 5973.223480947492, 5975.163477113208, 6069.817905462844, 6079.422454866781, 6087.847803804896, 5921.615095018853, 6128.896798576255, 6134.386561343875, 6144.539159563006, 6148.938510614926, 5528.44715528444, 5566.888662226774, 5589.273394458775, 5600.187972744011, 5601.215829783833, 6105.755769769159, 6148.78479253224, 6159.3224745277985, 6160.260768707783, 6164.352742962014, 5769.451902069297, 5908.704564771744, 5913.5564832636865, 5922.0, 5923.111533270044, 5899.262592175978, 5927.792527261525, 5928.673922934194, 5992.460678538865, 5993.910091348634, 5982.162497250389, 6011.579189456784, 6023.427774361517, 6051.152838602599, 6076.5442591805795, 6011.0, 6060.606060606046, 6063.151158837766, 6082.300535438481, 6086.330503644595, 4548.88627784308, 4609.677322587387, 4618.284165954283, 4666.929996050062, 4677.415323084614, 4140.23405669952, 4147.792610369469, 4168.353905144708, 4193.1404062167185, 4229.9365509516765, 5855.970720146457, 5862.472377486047, 5864.472197502245, 5868.149118377812, 5870.647761134345, 5818.127280907897, 6109.908351374733, 6120.510359171256, 6120.66336351496, 6122.234720659918, 5616.241807355955, 5625.184348269478, 5639.182318563785, 5654.604177707521, 5718.885622287531, 5129.769160387791, 5155.097857874857, 5167.379914410295, 5172.043172013189, 5172.146595811724, 6138.355472675394, 6139.416755408229, 6139.693015349126, 6141.631502109888, 6153.261608606996, 5837.737301821343, 5886.146508756121, 6008.609440386361, 6055.909161362495, 6061.0, 6236.937630623635, 6237.376262373908, 6240.875182496234, 6247.250329960434, 6250.0937364082865, 5778.393268706894, 5842.561807864342, 5857.326407463026, 5878.617889837147, 5881.2942446906645, 5871.1486834409625, 5871.324797648325, 5911.733971971357, 5924.31870334917, 5969.343372228965, 5854.619449735754, 5866.765329386777, 5870.735816888336, 5886.087656413263, 5896.528277737856, 5769.884602307847, 5794.652320860593, 5824.417558244142, 5824.970875145597, 5828.504577110993, 5700.686462244616, 5799.420057994167, 5801.448862358069, 5806.941930580809, 5808.854778630568, 5866.735996880236, 5867.647941123546, 5911.674857882857, 6003.5797494174985, 6038.094285857156, 5820.796272130455, 5829.446202610745, 5835.766569337179, 5839.503642190291, 5841.591088623755], "value": 5552.222728594343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6602123672704, 608.6256951974536, 626.5144513002423, 645.8805121052609, 660.1582981698338, 45962.0, 47043.764781176134, 47190.292145617845, 47207.52792472079, 50268.74865625667, 47768.761156194174, 48152.0, 48308.75845620776, 48394.274085888654, 48415.0, 8454.78863028423, 8639.740807775777, 8755.3433492488, 8889.111088891124, 8898.555072246394, 10324.89675103247, 10611.151107911348, 10611.946940265289, 10886.61896833611, 10906.454677266145, 11101.333919964827, 11166.497507612135, 11187.384693841836, 11193.49629266685, 11195.27230730004, 10822.13422926168, 10839.83740243897, 10867.565297388135, 10867.619633312795, 10875.891241087567, 10888.510017049251, 10948.069414099811, 10960.671179864617, 10968.451577421178, 10975.0, 44745.32882006773, 45055.549444505465, 45084.323735144, 45171.774141129084, 45181.54818451806, 3875.786831724254, 3881.3789793633164, 3961.801909904493, 3974.701897357681, 4432.401625780542, 33450.33099338, 33475.665243347496, 33589.49615755765, 33823.15442113967, 33840.83079584611, 4494.5730155635165, 4497.0, 4550.726956382595, 4565.840195593139, 4586.770661466913, 362250.0, 364453.0, 364631.0, 364758.0, 365904.0, 64342.678286608265, 64953.67523162448, 65038.67480662566, 65081.67459162674, 65099.674501628135, 40526.18947621031, 41395.793021034704, 41568.0, 43456.130877382275, 63380.36619633745, 18754.906225469058, 18796.624067518573, 18863.90568047151, 18881.622367552573, 18938.810611893703, 13931.582052538237, 14098.224597647022, 14679.0, 14935.0, 15186.164760938034, 21020.894895525424, 21193.046312915954, 21259.68110478344, 21279.255226067013, 21292.0, 7091.397231235403, 7253.3834624057545, 7349.669264883093, 7420.888686669704, 7425.591592462466, 937.4750139921666, 996.2478328861808, 1025.7845852371086, 1086.8206745886998, 1120.8991190792867, 32907.341853163285, 34050.659493404746, 34274.48588271178, 34426.139346516036, 34481.31037379238, 1098.5166526728215, 1099.9010089092021, 1103.1836441033577, 1132.5243397772956, 1193.4927655746274, 16912.408065717642, 17544.649107017787, 17754.0, 18021.549461263574, 18124.909375453037, 609178.0, 612796.0, 616098.0, 616643.0, 618991.0, 62831.0, 63433.36566634367, 63501.68249158725, 63724.0, 63757.0, 1339.7990301454665, 1380.1374141161773, 1381.6338670252392, 1421.5664222412263, 1437.1018113678952, 32948.341033179684, 35097.0, 35504.43693480787, 35552.28895422129, 35555.466667999484, 53973.0, 54453.18320225279, 54463.72768136134, 54545.0, 54592.0, 404948.0, 405021.0, 405194.0, 405637.0, 406065.0, 29807.0, 30909.0, 31187.84406077955, 32569.674303256663, 32932.67067329392, 50715.23927141022, 51076.489235107176, 51103.0, 51222.48777512177, 51991.480085198666, 43126.78436607797, 43165.568344316154, 43417.0, 44368.334474983545, 44374.11251775011, 43404.78297608492, 43690.78154609207, 43892.122157556034, 44237.77881110574, 44885.775571121936, 42898.0, 43345.34981975336, 43615.781921090194, 44374.55625443704, 44471.11057778891, 36703.449448257765, 38753.0, 39181.2163756729, 39791.60208397879, 39794.0, 28217.569074464132, 28599.28501787472, 28882.0, 28958.7104128956, 29122.417551649272], "value": 21543.358699549477, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.4147590748631, 417.3406018490785, 430.1161113910913, 433.8069559046225, 439.1743522178304, 14726.410943562258, 18958.715619265706, 18974.525636859067, 18982.52543686405, 19499.0, 12838.293893835835, 13336.866631333683, 13406.798898016537, 13426.328683565807, 13453.260070696133, 4184.8744537663915, 4399.736015839044, 5295.8146464873735, 5480.6437581557275, 5483.451654834525, 5669.234653321811, 5896.262967129109, 5958.702064896759, 6040.758369665208, 6041.879162416749, 5696.886062278772, 5957.761689532414, 5996.130561068642, 6028.728707208164, 6039.6980150992495, 6000.279966404016, 6025.096235564656, 6036.245469316335, 6037.667928263943, 6037.698115094249, 5329.760160792774, 5574.191742197399, 5613.747381367848, 5644.8306550803545, 5675.5743319250805, 14456.49402270926, 14758.0, 14778.482753103697, 14829.18439485828, 14962.251887405586, 2371.9525609487887, 2427.381017840457, 2489.751024897514, 2542.987285063563, 2595.8961641534315, 10141.89858101417, 10659.0, 11092.778144437147, 11316.660500185008, 12891.87108128916, 1926.730257763914, 1971.4184315626924, 1986.4239370582513, 1992.9892853241734, 2037.3582321568806, 72881.63559182223, 76778.0, 83328.0, 87069.56465217697, 88682.99999999936, 11571.76856462866, 11745.88254117465, 11808.398438476348, 11865.584704535473, 12003.51985920571, 17107.48677539676, 17110.657786844193, 17124.571885702957, 17128.0, 17129.657406852042, 8816.250618697482, 8854.335924805537, 9019.32355073359, 9070.909290907006, 9139.771505712277, 8600.741977740678, 8615.784605384915, 8633.913660863436, 8774.60514276859, 8833.116688331116, 4597.839075632403, 5143.948560514422, 5153.561947234452, 5201.531862132426, 5253.973730131402, 1926.9325573605138, 1967.331107423483, 2152.171414005588, 2163.880986545755, 2174.4998650310517, 982.5627595719836, 1007.868977032981, 1021.1779517488493, 1027.1269420992096, 1058.8200005999, 19300.1314940828, 19483.707744383846, 19573.314933977526, 19784.802151978296, 19998.20007199696, 1005.1054561440324, 1031.9690409287734, 1042.8644276244192, 1045.7281106912258, 1067.3489171605315, 10299.433531155859, 10759.4748575675, 10887.292325998944, 11168.609098681507, 11381.829272560919, 197493.0, 197948.0, 198129.0, 199237.0, 201069.0, 98908.50545747225, 99840.99999999854, 100818.49590751999, 101068.49465752771, 103514.96485035204, 1067.114295135036, 1101.5043230546125, 1108.3903852881044, 1133.0652211925194, 1134.2627292260097, 17513.299468021647, 17995.460136195936, 18147.183376747813, 18161.36435224761, 18433.35483258133, 41238.1752364945, 43954.34068488911, 46193.30710039285, 46641.53358466508, 47386.578402647974, 58151.70924145352, 59067.704661478136, 59384.40615593789, 60374.0, 61398.386016139266, 8365.163483651586, 8890.644374225218, 9144.908550914406, 9203.953980230055, 9258.675946341846, 13104.082714210295, 13465.865341346853, 13687.178769273876, 13690.794638080635, 13745.931270343985, 11740.58907938218, 11786.823197651871, 11979.760404791681, 12002.0, 12167.33079680626, 11583.884161158618, 11807.232529885874, 11892.583759568373, 12064.75870482568, 12390.504379825066, 11963.700907477383, 12064.577739779066, 12064.75870482603, 12417.813732793835, 12827.615171544869, 8833.514156721441, 8870.778230544289, 9029.142231487998, 9034.45793252407, 9124.224440922597, 9278.211352035152, 11625.360605166798, 11673.182877198515, 11861.822072668745, 11874.584389546324], "value": 9113.475087178565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.2459108150385, 1493.5146077524803, 1668.733002719565, 1760.1111438723442, 1808.222464340333, 7955.92044079559, 8198.139195384489, 8498.235158835703, 9108.54457277136, 9142.085791420863, 8487.108853570364, 8808.11918808119, 8815.691450799224, 9077.0, 9082.455052696827, 2494.925152245431, 2536.5941449368106, 2537.581299085649, 2540.9237722868343, 2548.362909272682, 2261.163369553259, 2329.37106981115, 2518.5214809186195, 2596.6624338835927, 2598.883050262743, 2464.9753502465014, 2533.0627667762956, 2542.364408897776, 2557.808164387669, 2562.359410147463, 2519.8740062996776, 2537.53055684698, 2540.720520742717, 2541.440883005736, 2543.4404431025146, 2554.067765265683, 2558.7313332100234, 2587.974120258792, 2597.8701064946868, 2601.622764699127, 8963.0, 9016.729498115066, 9066.138716821892, 9087.818243635156, 9089.454632722058, 5313.0967735485065, 5478.671279723189, 5480.205370221335, 5489.039418101816, 5491.780328786844, 3491.417799384855, 3572.2498275362204, 3604.4953706481115, 3741.2330472253125, 3757.3612485877466, 1067.1196263082988, 1120.910327173824, 1133.880942501042, 1136.5737848306885, 1165.5745652836738, 12480.625581232487, 12526.498940042387, 12545.811812822814, 12598.622041338866, 12613.486381634262, 5106.285120083191, 5260.079486089919, 5289.47105289468, 5305.4164041955355, 5346.8395948121615, 9740.318177727491, 9742.976987416361, 9787.510624468749, 9797.80404391908, 9839.55721992512, 5583.748731307101, 5606.0, 5626.690532020778, 5633.63381380209, 5641.153826925994, 5025.4974502550185, 5256.92114618281, 5304.443033481506, 5317.494837990384, 5326.866828329245, 3664.2671465706967, 3784.4512545681273, 3814.3896976484184, 3836.616338366141, 3885.630865067814, 1118.2898859224451, 1159.3449700918954, 1160.3675996581883, 1204.7108693913397, 1205.8794120588047, 883.5626364949263, 885.3359980014989, 1034.0280136671504, 1045.0491539960367, 1054.920880933933, 5818.418158184148, 5861.0915308127305, 6146.108814221912, 6195.81412557624, 6396.0, 972.1590823937244, 990.1435258501489, 1005.3415013166388, 1027.440045175381, 1072.9946350268199, 3947.5262968443394, 3972.2651309507833, 4081.591840815954, 4258.212230737324, 4298.946758044237, 9988.200943924468, 10539.63111291101, 10630.30902991303, 10636.574537018432, 10641.5211315491, 10403.791924161475, 10530.262881598215, 10544.947275263574, 10556.208284378703, 10572.577096916037, 8390.874136887951, 8578.78553036179, 8592.613332400057, 8594.5702714864, 8601.78495537604, 6103.931811932983, 6107.9083813741945, 6218.81343559694, 6253.249610046823, 6268.874622507433, 10130.493475326057, 10139.7465063374, 10277.383356998604, 10282.331648442827, 10370.014848589371, 10393.84409233847, 10467.581296748045, 10474.895251047697, 10482.977512950532, 10584.523696433525, 7429.8142546436775, 7513.737019204302, 7596.088469383489, 7597.772066838003, 7602.1257555379625, 8165.387595930448, 8223.588820559067, 8253.504789712397, 8254.133316001733, 8580.841586385757, 6027.909581356195, 7282.96358518204, 7452.292032256927, 7628.38972882157, 7847.176046515034, 6913.827154320981, 6928.584284942919, 6937.93062069393, 6956.930430695831, 7026.262242464468, 6917.0, 6946.930530694628, 7004.509684322048, 7055.682494287872, 7143.714251430092, 5272.604554658493, 5325.387580428301, 5337.919931200958, 5367.114426119647, 5392.5416339611575, 4949.257611358325, 5074.594032477319, 5121.180611102355, 5255.343082114736, 5462.317210348707], "value": 4738.222214864595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.3622424532823, 371.5726914048844, 374.96062913394087, 382.66134470993165, 383.0538569732759, 5256.421793602701, 5323.680579165253, 5477.917831232529, 5479.178123281505, 5490.846922146349, 5242.842714718565, 5341.225522299264, 5388.595855310858, 5390.676559406428, 5395.973020134894, 4326.480822301328, 4334.566543345672, 4337.197618440583, 4345.630621397185, 4345.739255644671, 4240.173166232586, 4271.508776490712, 4305.117450922553, 4346.5436129206455, 4353.521112677603, 4259.10558782656, 4266.850660226893, 4273.487181538219, 4285.400043993828, 4293.270144075499, 4267.103908179286, 4267.317229243306, 4269.914601707964, 4284.843092365044, 4311.396404503341, 3764.4353346997896, 3864.188520410717, 3869.9032524186837, 3877.7867217303037, 3883.7475564088245, 5254.238135470374, 5270.6047046471285, 5273.894522109575, 5286.3127793387, 5289.603279754034, 4926.334944782444, 4928.704277743311, 4939.678920870132, 4941.629377796679, 4947.381577302837, 5430.809921652763, 5616.354119276254, 5671.716414179275, 5675.0, 5679.375268720438, 4222.451081359434, 4226.387173859773, 4231.534531201565, 4232.280512312914, 4249.3413520904305, 5799.246098007232, 5866.0, 5867.037146241164, 5878.913570375587, 5883.588148829584, 4146.979265103655, 4329.5237523872975, 4344.761038142932, 4347.934780978225, 4358.302671572596, 4353.978230108829, 4383.671224658164, 4397.6042156206095, 4398.252297109499, 4401.92152922536, 4902.362692849907, 4902.901941961212, 4920.778564964585, 4921.975390123026, 4934.309196712463, 5517.834464966058, 5644.923516683418, 5654.0, 5661.462161094772, 5669.41256448187, 1458.183417286323, 1461.6053665510465, 1463.7072585482733, 1470.669099452636, 1484.0, 986.8815742110993, 1037.273908264218, 1037.7457522906784, 1042.8122937871103, 1052.347544522401, 5351.224072509464, 5361.0, 5362.498500419811, 5365.195220716846, 5375.435579264199, 5613.382527921925, 5623.044082505984, 5625.521830644359, 5642.830715078554, 5645.407232240637, 5096.311997880312, 5263.605229607795, 5354.598405119632, 5380.0, 5380.354357477127, 2977.211039074647, 2978.8510574471625, 2983.8060526065738, 2986.6117404737247, 2997.385535965122, 5635.239242702265, 5797.710114494343, 5805.564582656318, 5806.332271788714, 5816.35355913067, 5687.0, 5702.6863522506665, 5714.914276285859, 5724.084146536534, 5727.455891690282, 5756.625819321731, 5790.276215473066, 5794.101914203306, 5809.970950145223, 5828.970855145697, 5327.0, 5531.612787104864, 5564.805231816867, 5628.409017053151, 5634.464725851038, 5502.669839809624, 5522.2544956430365, 5556.194351818883, 5558.972205138948, 5571.777128914798, 5770.595348744261, 5789.421057894177, 5793.275840519935, 5811.535077193899, 5824.359320474659, 3978.144698889753, 4188.560201178954, 4218.261804184194, 4219.472565929259, 4221.2190744712325, 5769.8557536061935, 5847.859667364823, 5857.339163023111, 5871.211174692158, 5884.264466941632, 5518.779248830002, 5685.715714214355, 5713.857153571194, 5715.5713321500225, 5719.685417301922, 5718.828435146952, 5734.856628584319, 5743.913841292468, 5766.855828604318, 5773.278340207474, 5679.488846003879, 5705.800296989585, 5706.457886500776, 5712.971435142797, 5745.339285982165, 5644.915326270191, 5742.913856292243, 5775.33583637887, 5794.0, 5799.710014499174, 5640.266765320482, 5651.660900345993, 5657.830265092054, 5661.2923384576925, 5662.320521537442], "value": 4351.785041725243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.8070862992884, 816.8693009118542, 857.352698712472, 859.2867919626708, 873.3755364914085, 14833.0, 15182.924085379585, 15214.16322102284, 15232.695346093085, 15235.619109522253, 13553.72892542151, 14010.369533370997, 14018.439262429516, 14035.789463158035, 14047.789283160735, 716.0476566166985, 732.3738203835724, 734.8456824066952, 734.8640501507211, 736.105631657536, 805.1948051948052, 820.3396266005863, 821.2813787935556, 828.7638023163399, 828.8176601147737, 892.9330300227509, 894.0969620683125, 895.4895709445618, 896.6547879066574, 896.6906417286059, 747.3535391885979, 885.8671199320089, 886.9379143459961, 887.1837909123622, 887.2768693514765, 553.2945494494511, 643.8165122939939, 645.4255712415953, 650.7592190889401, 654.0614218596329, 12175.391230438443, 12199.024078073733, 12214.0, 12221.572244971383, 12229.205101668453, 14054.227017514033, 14353.282335883268, 14639.92680036593, 14646.0, 14679.486217982427, 11698.064154867676, 13008.0, 13059.085863989525, 13114.278714670689, 13338.799918001238, 4384.298512238027, 4438.60052595268, 4450.154470650598, 4496.4829044659955, 4558.361829343895, 66281.0, 67268.66365668189, 67282.0, 67287.99068013983, 67297.32702672959, 11503.309801411775, 11542.07663386927, 11542.653720388402, 11557.537698491966, 11701.180917335705, 19902.701459478118, 19942.60114797696, 20711.378658640264, 21266.149354025976, 21438.464038399165, 9005.14451127142, 9264.675736349196, 9283.210927071275, 9332.44005359667, 9361.812763744823, 4816.831410900601, 4891.706497610155, 4913.901721965541, 5079.974600126976, 5171.250168725589, 3845.4616353710503, 3952.960470395317, 3969.0871099647243, 3969.980150099231, 3974.0462289050997, 666.7732970789955, 678.389449495458, 680.0479328939524, 690.1304356510833, 699.1959246866043, 729.3946024799404, 739.593223726948, 742.38011260598, 745.143085451724, 759.3886921028625, 9016.459012459274, 9109.271258299452, 9288.256939444827, 9330.533473326306, 9393.859092113624, 671.4796033074407, 684.4216636941776, 701.2531653788699, 701.5475018613068, 705.4215543254585, 4264.488261408589, 4373.234683930299, 4440.933385999213, 4454.866354009385, 4493.258612328995, 89952.5502372497, 95817.0, 96349.51825240969, 97843.0, 98496.50751746338, 69945.65027174831, 81845.59077204695, 84018.57990710008, 84327.57836210902, 84556.57721711475, 70730.10984395805, 70744.64627676932, 71418.2858171422, 71418.64290678513, 73334.0, 8639.568021598769, 8847.911520884709, 8870.911290887008, 8890.288776897703, 8892.777680558038, 48532.51467485421, 48855.75572122117, 48927.0, 49752.50247497624, 49948.75025624849, 61047.389526105944, 67236.66381668061, 67829.66085169543, 68148.31851681619, 70377.0, 11530.135239857213, 12507.749845002867, 12580.0, 12619.053570982029, 12747.980161587237, 11981.580644677395, 12033.0, 12080.939595301967, 12517.24896506176, 12761.170523916287, 11276.210665253353, 11399.0, 11771.705707357385, 11826.113041521749, 12191.573294934635, 11176.720581985515, 11341.26281791681, 11629.24409913353, 11784.941075294568, 12030.819537707117, 11693.707657308636, 11912.642620721392, 11925.821112683143, 12226.144169908377, 12461.1900226485, 9563.952180239054, 9647.083527064917, 9651.662191823252, 9692.563834627317, 10005.399676019462, 8795.91204087951, 9805.558749856416, 9881.901180988098, 10018.09837114634, 10027.097561219525], "value": 7224.732521018647, "unit": "score"}], "name": "dromaeo_css", "value": 7386.447655365802, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 112.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 121.0, 166.0, 122.0, 120.0, 123.0, 126.0, 150.0, 122.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 159.0, 161.0, 159.0, 160.0, 160.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 102.0, 76.0, 76.0, 77.0, 76.0, 103.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 81.0, 81.0, 81.0, 102.0, 81.0, 81.0, 109.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 50.0, 52.0, 50.0, 51.0, 49.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 78.0, 75.0, 76.0, 75.0, 76.0, 78.0, 75.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 130.0, 129.0, 128.0, 125.0, 128.0, 121.0, 167.0, 127.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 158.0, 155.0, 163.0, 155.0, 156.0, 165.0, 163.0, 156.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 61.0, 61.0, 62.0, 61.0, 65.0, 61.0, 61.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1457.9, "alertThreshold": 2.0}]} 10:17:55 INFO - Return code: 0 10:17:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:17:55 ERROR - # TBPL SUCCESS # 10:17:55 INFO - Running post-action listener: _resource_record_post_action 10:17:55 INFO - [mozharness: 2016-11-22 18:17:55.580034Z] Finished run-tests step (success) 10:17:55 INFO - Running post-run listener: _resource_record_post_run 10:17:55 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 353734656; Read time: 12; Write time: 273292 10:17:55 INFO - TinderboxPrint: CPU usage
13.0% 10:17:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:17:55 INFO - TinderboxPrint: I/O write bytes / time
353,734,656 / 273,292 10:17:55 INFO - TinderboxPrint: CPU idle
8,262.7 (87.0%) 10:17:55 INFO - TinderboxPrint: CPU user
1,189.7 (12.5%) 10:17:55 INFO - TinderboxPrint: Swap in / out
0 / 0 10:17:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115765248; Read time: 0; Write time: 91220 10:17:55 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 237969408; Read time: 0; Write time: 182072 10:17:56 INFO - Running post-run listener: _upload_blobber_files 10:17:56 INFO - Blob upload gear active. 10:17:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:56 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 10:17:56 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'] 10:17:56 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 10:17:56 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:57 INFO - (blobuploader) - INFO - Done attempting. 10:17:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:17:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:00 INFO - (blobuploader) - INFO - Done attempting. 10:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:01 INFO - (blobuploader) - INFO - Done attempting. 10:18:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:01 INFO - Return code: 0 10:18:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43d0ca19e4bfed96befadcc1556b0664a4e700bf63a436c35ae63996b600234f032cc24e4488b1ada7480618560f328a7753a95389aae5822ab2aeb60044e002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bac282734504b233613d63b8bac236543c4f5f07ddb9965cabf2e5a855f26ccf9dfe8841968f2a0f81da624ef5f4fcca21e92b707d37046c25b2948e1342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb98098a0a9ee6aa6b0be5fb2f256f3d075384bc2adb81e3e489ac9458cb2662ba43c73a23834e9b4b05e3417217887ba5d7ea62a81300113ba535803d276701"} 10:18:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:01 INFO - Contents: 10:18:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43d0ca19e4bfed96befadcc1556b0664a4e700bf63a436c35ae63996b600234f032cc24e4488b1ada7480618560f328a7753a95389aae5822ab2aeb60044e002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bac282734504b233613d63b8bac236543c4f5f07ddb9965cabf2e5a855f26ccf9dfe8841968f2a0f81da624ef5f4fcca21e92b707d37046c25b2948e1342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb98098a0a9ee6aa6b0be5fb2f256f3d075384bc2adb81e3e489ac9458cb2662ba43c73a23834e9b4b05e3417217887ba5d7ea62a81300113ba535803d276701"} 10:18:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:01 INFO - Copying logs to upload dir... 10:18:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.465323 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-22 10:18:01.404376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 10:18:01.407513) ========= 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-1479837445.764641-904716275 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/43d0ca19e4bfed96befadcc1556b0664a4e700bf63a436c35ae63996b600234f032cc24e4488b1ada7480618560f328a7753a95389aae5822ab2aeb60044e002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bac282734504b233613d63b8bac236543c4f5f07ddb9965cabf2e5a855f26ccf9dfe8841968f2a0f81da624ef5f4fcca21e92b707d37046c25b2948e1342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb98098a0a9ee6aa6b0be5fb2f256f3d075384bc2adb81e3e489ac9458cb2662ba43c73a23834e9b4b05e3417217887ba5d7ea62a81300113ba535803d276701"} build_url:https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011712 build_url: 'https://queue.taskcluster.net/v1/task/BfcQNg0rSvmV0JXOvMD9YA/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/43d0ca19e4bfed96befadcc1556b0664a4e700bf63a436c35ae63996b600234f032cc24e4488b1ada7480618560f328a7753a95389aae5822ab2aeb60044e002", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bac282734504b233613d63b8bac236543c4f5f07ddb9965cabf2e5a855f26ccf9dfe8841968f2a0f81da624ef5f4fcca21e92b707d37046c25b2948e1342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb98098a0a9ee6aa6b0be5fb2f256f3d075384bc2adb81e3e489ac9458cb2662ba43c73a23834e9b4b05e3417217887ba5d7ea62a81300113ba535803d276701"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 10:18:01.433864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:18:01.434261) ========= 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-1479837445.764641-904716275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:18:01.519422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 10:18:01.519783) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 10:18:01.520121) ========= ========= Total master_lag: 0.17 =========