builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1482575526.56 results: success (0) buildid: 20161224004004 builduid: 5cce009b48fc49dbaed57b4ea4656770 revision: ec2672807887aa46bb4c2966478afa08d610d72d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.557443) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.557915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.558192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.572462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.572752) ========= 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=af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-24 02:32:07-- 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% 103M=0s 2016-12-24 02:32:07 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.705920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.706223) ========= 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=af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.755494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:06.756131) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ec2672807887aa46bb4c2966478afa08d610d72d --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 ec2672807887aa46bb4c2966478afa08d610d72d --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=af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-24 02:32:07,370 truncating revision to first 12 chars 2016-12-24 02:32:07,370 Setting DEBUG logging. 2016-12-24 02:32:07,370 attempt 1/10 2016-12-24 02:32:07,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ec2672807887?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-24 02:32:07,799 unpacking tar archive at: mozilla-aurora-ec2672807887/testing/mozharness/ program finished with exit code 0 elapsedTime=0.786145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:07.556150) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:07.556464) ========= script_repo_revision: ec2672807887aa46bb4c2966478afa08d610d72d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:07.556842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:07.557116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-24 02:32:07.570062) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-24 02:32:07.570351) ========= /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=af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:32:08 INFO - MultiFileLogger online at 20161224 02:32:08 in /builds/slave/test 02:32:08 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 02:32:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:08 INFO - {'append_to_log': False, 02:32:08 INFO - 'base_work_dir': '/builds/slave/test', 02:32:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:32:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:08 INFO - 'branch': 'Mozilla-Aurora', 02:32:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:08 INFO - 'config_files': ('talos/linux_config.py',), 02:32:08 INFO - 'default_actions': ('clobber', 02:32:08 INFO - 'read-buildbot-config', 02:32:08 INFO - 'download-and-extract', 02:32:08 INFO - 'populate-webroot', 02:32:08 INFO - 'create-virtualenv', 02:32:08 INFO - 'install', 02:32:08 INFO - 'run-tests'), 02:32:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:08 INFO - 'download_minidump_stackwalk': True, 02:32:08 INFO - 'download_symbols': 'ondemand', 02:32:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:08 INFO - 'installer_path': 'installer.exe', 02:32:08 INFO - 'log_level': 'info', 02:32:08 INFO - 'log_name': 'talos', 02:32:08 INFO - 'log_to_console': True, 02:32:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:32:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:32:08 INFO - 'opt_config_files': (), 02:32:08 INFO - 'pip_index': False, 02:32:08 INFO - 'sps_profile': False, 02:32:08 INFO - 'sps_profile_interval': 0, 02:32:08 INFO - 'suite': 'dromaeojs', 02:32:08 INFO - 'system_bits': '32', 02:32:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:08 INFO - 'title': 'talos-linux64-ix-020', 02:32:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:08 INFO - 'use_talos_json': True, 02:32:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:08 INFO - 'work_dir': 'build'} 02:32:08 INFO - [mozharness: 2016-12-24 10:32:08.285091Z] Running clobber step. 02:32:08 INFO - Running pre-action listener: _resource_record_pre_action 02:32:08 INFO - Running main action method: clobber 02:32:08 INFO - rmtree: /builds/slave/test/build 02:32:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:08 INFO - Running post-action listener: _resource_record_post_action 02:32:08 INFO - [mozharness: 2016-12-24 10:32:08.741948Z] Finished clobber step (success) 02:32:08 INFO - [mozharness: 2016-12-24 10:32:08.742047Z] Running read-buildbot-config step. 02:32:08 INFO - Running pre-action listener: _resource_record_pre_action 02:32:08 INFO - Running main action method: read_buildbot_config 02:32:08 INFO - Using buildbot properties: 02:32:08 INFO - { 02:32:08 INFO - "project": "", 02:32:08 INFO - "product": "firefox", 02:32:08 INFO - "script_repo_revision": "production", 02:32:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:32:08 INFO - "repository": "", 02:32:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:32:08 INFO - "buildid": "20161224004004", 02:32:08 INFO - "stage_platform": "linux64-pgo", 02:32:08 INFO - "basedir": "/builds/slave/test", 02:32:08 INFO - "nightly_build": "True", 02:32:08 INFO - "buildnumber": 988, 02:32:08 INFO - "slavename": "talos-linux64-ix-020", 02:32:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:32:08 INFO - "platform": "ubuntu64_hw", 02:32:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:32:08 INFO - "branch": "mozilla-aurora", 02:32:08 INFO - "repo_path": "releases/mozilla-aurora", 02:32:08 INFO - "revision": "ec2672807887aa46bb4c2966478afa08d610d72d", 02:32:08 INFO - "pgo_build": "True", 02:32:08 INFO - "builduid": "5cce009b48fc49dbaed57b4ea4656770", 02:32:08 INFO - "slavebuilddir": "test" 02:32:08 INFO - } 02:32:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:32:08 INFO - Running post-action listener: _resource_record_post_action 02:32:08 INFO - [mozharness: 2016-12-24 10:32:08.744549Z] Finished read-buildbot-config step (success) 02:32:08 INFO - [mozharness: 2016-12-24 10:32:08.744638Z] Running download-and-extract step. 02:32:08 INFO - Running pre-action listener: _resource_record_pre_action 02:32:08 INFO - Running main action method: download_and_extract 02:32:08 INFO - mkdir: /builds/slave/test/build/tests 02:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:08 INFO - trying https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:32:08 INFO - Downloading https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/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 02:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/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 02:32:09 INFO - Downloaded 1361 bytes. 02:32:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:32:09 INFO - Using the following test package requirements: 02:32:09 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:32:09 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:32:09 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:32:09 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'jsshell-linux-x86_64.zip'], 02:32:09 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:32:09 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:32:09 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:32:09 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:32:09 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:32:09 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:32:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:32:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:32:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:32:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:09 INFO - Fetch https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:32:09 INFO - Http code: 200 02:32:09 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 02:32:09 INFO - x-amz-cf-id: XkCzp0k-nCYbwV-aKv4Cb3U5Luhd0j8UEcfMOkgBMkS0ttft0nNTsw== 02:32:09 INFO - x-amz-version-id: HMkVbgvMotX0a8ecGxpRYVSdNhVs9Bwd 02:32:10 INFO - Expected file size: 21943802 02:32:10 INFO - Obtained file size: 21943802 02:32:14 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 02:32:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:32:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:14 INFO - Fetch https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:32:14 INFO - Http code: 200 02:32:14 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 02:32:14 INFO - x-amz-cf-id: wJMWsglrnLyo6Rcy5K0YMQJ0tIAGKILuIkb2RZIzjfgksCd8lK_HLA== 02:32:14 INFO - x-amz-version-id: HMkVbgvMotX0a8ecGxpRYVSdNhVs9Bwd 02:32:14 INFO - Expected file size: 21943802 02:32:14 INFO - Obtained file size: 21943802 02:32:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:32:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:32:19 INFO - Fetch https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:32:19 INFO - Http code: 200 02:32:19 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 02:32:19 INFO - x-amz-cf-id: jNz4kM1VBeuAF5U_lsKAay2y18ADrjllBzomfnfK1BX7aaCZfY19bw== 02:32:19 INFO - x-amz-version-id: wJs22q4XF7wD9DDt4UMEJEVSWEhfP3zK 02:32:20 INFO - Expected file size: 14409038 02:32:20 INFO - Obtained file size: 14409038 02:32:20 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')]} 02:32:20 INFO - trying https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:32:20 INFO - Downloading https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/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 02:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/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 02:32:21 INFO - Downloaded 63966543 bytes. 02:32:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:32:21 INFO - mkdir: /builds/slave/test/properties 02:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:21 INFO - Contents: 02:32:21 INFO - build_url:https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:32:22 INFO - Running post-action listener: _resource_record_post_action 02:32:22 INFO - Running post-action listener: set_extra_try_arguments 02:32:22 INFO - [mozharness: 2016-12-24 10:32:22.148003Z] Finished download-and-extract step (success) 02:32:22 INFO - [mozharness: 2016-12-24 10:32:22.148301Z] Running populate-webroot step. 02:32:22 INFO - Running pre-action listener: _resource_record_pre_action 02:32:22 INFO - Running main action method: populate_webroot 02:32:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:22 INFO - '--tppagecycles', 02:32:22 INFO - '7'], 02:32:22 INFO - 'tests': ['tsvgm']}}, 02:32:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['damp', 'tps']}, 02:32:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'tests': ['damp', 'tps']}, 02:32:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['dromaeo_dom']}, 02:32:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['basic_compositor_video']}, 02:32:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['a11yr', 02:32:22 INFO - 'ts_paint', 02:32:22 INFO - 'tpaint', 02:32:22 INFO - 'sessionrestore', 02:32:22 INFO - 'sessionrestore_no_auto_restore', 02:32:22 INFO - 'tabpaint']}, 02:32:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:22 INFO - 'ts_paint', 02:32:22 INFO - 'tpaint', 02:32:22 INFO - 'sessionrestore', 02:32:22 INFO - 'sessionrestore_no_auto_restore', 02:32:22 INFO - 'tabpaint']}, 02:32:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:22 INFO - 'ts_paint', 02:32:22 INFO - 'tpaint', 02:32:22 INFO - 'sessionrestore', 02:32:22 INFO - 'sessionrestore_no_auto_restore', 02:32:22 INFO - 'tabpaint']}, 02:32:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:22 INFO - 'ts_paint', 02:32:22 INFO - 'tpaint', 02:32:22 INFO - 'sessionrestore', 02:32:22 INFO - 'sessionrestore_no_auto_restore', 02:32:22 INFO - 'tabpaint']}, 02:32:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['a11yr', 02:32:22 INFO - 'ts_paint', 02:32:22 INFO - 'tpaint', 02:32:22 INFO - 'sessionrestore', 02:32:22 INFO - 'sessionrestore_no_auto_restore', 02:32:22 INFO - 'tabpaint']}, 02:32:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['a11yr', 02:32:22 INFO - 'ts_paint', 02:32:22 INFO - 'tpaint', 02:32:22 INFO - 'sessionrestore', 02:32:22 INFO - 'sessionrestore_no_auto_restore', 02:32:22 INFO - 'tabpaint']}, 02:32:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['tsvgx', 02:32:22 INFO - 'tsvgr_opacity', 02:32:22 INFO - 'tart', 02:32:22 INFO - 'tscrollx', 02:32:22 INFO - 'cart']}, 02:32:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:22 INFO - 'tsvgr_opacity', 02:32:22 INFO - 'tart', 02:32:22 INFO - 'tscrollx', 02:32:22 INFO - 'cart']}, 02:32:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'talos_options': ['--disable-e10s'], 02:32:22 INFO - 'tests': ['tp5o']}, 02:32:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'tests': ['tp5o']}, 02:32:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'talos_options': ['--disable-e10s', 02:32:22 INFO - '--xperf_path', 02:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:22 INFO - 'tests': ['tp5n']}, 02:32:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:22 INFO - 'talos_options': ['--xperf_path', 02:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:22 INFO - 'tests': ['tp5n']}}, 02:32:22 INFO - 'talos.zip': {'path': '', 02:32:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:22 INFO - Running post-action listener: _resource_record_post_action 02:32:22 INFO - [mozharness: 2016-12-24 10:32:22.166996Z] Finished populate-webroot step (success) 02:32:22 INFO - [mozharness: 2016-12-24 10:32:22.167088Z] Running create-virtualenv step. 02:32:22 INFO - Running pre-action listener: _resource_record_pre_action 02:32:22 INFO - Running main action method: create_virtualenv 02:32:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:22 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 02:32:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:22 INFO - Using real prefix '/usr' 02:32:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:22 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:24 INFO - Installing pip.................done. 02:32:24 INFO - Return code: 0 02:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:24 INFO - Reading from file tmpfile_stdout 02:32:24 INFO - Output received: 02:32:24 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) 02:32:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:24 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')]} 02:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 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')]} 02:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:24 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 02:32:24 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 02:32:24 INFO - Using env: {'DISPLAY': ':0', 02:32:24 INFO - 'HOME': '/home/cltbld', 02:32:24 INFO - 'LANG': 'en_US.UTF-8', 02:32:24 INFO - 'LANGUAGE': 'en_US:en', 02:32:24 INFO - 'LOGNAME': 'cltbld', 02:32:24 INFO - 'MAIL': '/var/mail/cltbld', 02:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:24 INFO - 'MOZ_NO_REMOTE': '1', 02:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:24 INFO - 'NO_EM_RESTART': '1', 02:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:24 INFO - 'PWD': '/builds/slave/test', 02:32:24 INFO - 'SHELL': '/bin/bash', 02:32:24 INFO - 'SHLVL': '1', 02:32:24 INFO - 'TERM': 'linux', 02:32:24 INFO - 'TMOUT': '86400', 02:32:24 INFO - 'USER': 'cltbld', 02:32:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:24 INFO - '_': '/tools/buildbot/bin/python'} 02:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:25 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 02:32:25 INFO - Cleaning up... 02:32:25 INFO - Return code: 0 02:32:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:32:25 INFO - Using env: {'DISPLAY': ':0', 02:32:25 INFO - 'HOME': '/home/cltbld', 02:32:25 INFO - 'LANG': 'en_US.UTF-8', 02:32:25 INFO - 'LANGUAGE': 'en_US:en', 02:32:25 INFO - 'LOGNAME': 'cltbld', 02:32:25 INFO - 'MAIL': '/var/mail/cltbld', 02:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:25 INFO - 'MOZ_NO_REMOTE': '1', 02:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:25 INFO - 'NO_EM_RESTART': '1', 02:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:25 INFO - 'PWD': '/builds/slave/test', 02:32:25 INFO - 'SHELL': '/bin/bash', 02:32:25 INFO - 'SHLVL': '1', 02:32:25 INFO - 'TERM': 'linux', 02:32:25 INFO - 'TMOUT': '86400', 02:32:25 INFO - 'USER': 'cltbld', 02:32:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:25 INFO - '_': '/tools/buildbot/bin/python'} 02:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:25 INFO - Downloading/unpacking psutil>=3.1.1 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:27 INFO - Installing collected packages: psutil 02:32:27 INFO - Running setup.py install for psutil 02:32:27 INFO - building 'psutil._psutil_linux' extension 02:32:27 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 02:32:27 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 02:32:27 INFO - building 'psutil._psutil_posix' extension 02:32:27 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 02:32:27 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 02:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:27 INFO - Successfully installed psutil 02:32:27 INFO - Cleaning up... 02:32:28 INFO - Return code: 0 02:32:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:32:28 INFO - Using env: {'DISPLAY': ':0', 02:32:28 INFO - 'HOME': '/home/cltbld', 02:32:28 INFO - 'LANG': 'en_US.UTF-8', 02:32:28 INFO - 'LANGUAGE': 'en_US:en', 02:32:28 INFO - 'LOGNAME': 'cltbld', 02:32:28 INFO - 'MAIL': '/var/mail/cltbld', 02:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:28 INFO - 'MOZ_NO_REMOTE': '1', 02:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:28 INFO - 'NO_EM_RESTART': '1', 02:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:28 INFO - 'PWD': '/builds/slave/test', 02:32:28 INFO - 'SHELL': '/bin/bash', 02:32:28 INFO - 'SHLVL': '1', 02:32:28 INFO - 'TERM': 'linux', 02:32:28 INFO - 'TMOUT': '86400', 02:32:28 INFO - 'USER': 'cltbld', 02:32:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:28 INFO - '_': '/tools/buildbot/bin/python'} 02:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:30 INFO - Installing collected packages: mozsystemmonitor 02:32:30 INFO - Running setup.py install for mozsystemmonitor 02:32:30 INFO - Successfully installed mozsystemmonitor 02:32:30 INFO - Cleaning up... 02:32:30 INFO - Return code: 0 02:32:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:32:30 INFO - Using env: {'DISPLAY': ':0', 02:32:30 INFO - 'HOME': '/home/cltbld', 02:32:30 INFO - 'LANG': 'en_US.UTF-8', 02:32:30 INFO - 'LANGUAGE': 'en_US:en', 02:32:30 INFO - 'LOGNAME': 'cltbld', 02:32:30 INFO - 'MAIL': '/var/mail/cltbld', 02:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:30 INFO - 'MOZ_NO_REMOTE': '1', 02:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:30 INFO - 'NO_EM_RESTART': '1', 02:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:30 INFO - 'PWD': '/builds/slave/test', 02:32:30 INFO - 'SHELL': '/bin/bash', 02:32:30 INFO - 'SHLVL': '1', 02:32:30 INFO - 'TERM': 'linux', 02:32:30 INFO - 'TMOUT': '86400', 02:32:30 INFO - 'USER': 'cltbld', 02:32:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:30 INFO - '_': '/tools/buildbot/bin/python'} 02:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:30 INFO - Downloading/unpacking jsonschema==2.5.1 02:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32:32 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 02:32:32 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 02:32:32 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 02:32:32 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 02:32:32 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 02:32:32 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 02:32:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:33 INFO - warning: no files found matching '*.txt' 02:32:33 INFO - no previously-included directories found matching 'build' 02:32:33 INFO - no previously-included directories found matching 'dist' 02:32:33 INFO - no previously-included directories found matching '.git*' 02:32:33 INFO - Installing collected packages: jsonschema, functools32 02:32:33 INFO - Running setup.py install for functools32 02:32:33 INFO - warning: no files found matching '*.txt' 02:32:33 INFO - no previously-included directories found matching 'build' 02:32:33 INFO - no previously-included directories found matching 'dist' 02:32:33 INFO - no previously-included directories found matching '.git*' 02:32:33 INFO - Successfully installed jsonschema functools32 02:32:33 INFO - Cleaning up... 02:32:33 INFO - Return code: 0 02:32:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32:33 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')]} 02:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:33 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')]} 02:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:33 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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:33 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 02:32:33 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 02:32:33 INFO - Using env: {'DISPLAY': ':0', 02:32:33 INFO - 'HOME': '/home/cltbld', 02:32:33 INFO - 'LANG': 'en_US.UTF-8', 02:32:33 INFO - 'LANGUAGE': 'en_US:en', 02:32:33 INFO - 'LOGNAME': 'cltbld', 02:32:33 INFO - 'MAIL': '/var/mail/cltbld', 02:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:33 INFO - 'MOZ_NO_REMOTE': '1', 02:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:33 INFO - 'NO_EM_RESTART': '1', 02:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:33 INFO - 'PWD': '/builds/slave/test', 02:32:33 INFO - 'SHELL': '/bin/bash', 02:32:33 INFO - 'SHLVL': '1', 02:32:33 INFO - 'TERM': 'linux', 02:32:33 INFO - 'TMOUT': '86400', 02:32:33 INFO - 'USER': 'cltbld', 02:32:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:33 INFO - '_': '/tools/buildbot/bin/python'} 02:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:33 INFO - Cleaning up... 02:32:33 INFO - Return code: 0 02:32:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32:33 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')]} 02:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:33 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')]} 02:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:33 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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:33 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 02:32:33 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 02:32:33 INFO - Using env: {'DISPLAY': ':0', 02:32:33 INFO - 'HOME': '/home/cltbld', 02:32:33 INFO - 'LANG': 'en_US.UTF-8', 02:32:33 INFO - 'LANGUAGE': 'en_US:en', 02:32:33 INFO - 'LOGNAME': 'cltbld', 02:32:33 INFO - 'MAIL': '/var/mail/cltbld', 02:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:33 INFO - 'MOZ_NO_REMOTE': '1', 02:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:33 INFO - 'NO_EM_RESTART': '1', 02:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:33 INFO - 'PWD': '/builds/slave/test', 02:32:33 INFO - 'SHELL': '/bin/bash', 02:32:33 INFO - 'SHLVL': '1', 02:32:33 INFO - 'TERM': 'linux', 02:32:33 INFO - 'TMOUT': '86400', 02:32:33 INFO - 'USER': 'cltbld', 02:32:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:33 INFO - '_': '/tools/buildbot/bin/python'} 02:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:35 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:36 INFO - Downloading docopt-0.6.1.tar.gz 02:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:36 INFO - Running setup.py install for blobuploader 02:32:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:36 INFO - Running setup.py install for requests 02:32:37 INFO - Running setup.py install for docopt 02:32:37 INFO - Successfully installed blobuploader requests docopt 02:32:37 INFO - Cleaning up... 02:32:37 INFO - Return code: 0 02:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:37 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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:37 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 02:32:37 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 02:32:37 INFO - Using env: {'DISPLAY': ':0', 02:32:37 INFO - 'HOME': '/home/cltbld', 02:32:37 INFO - 'LANG': 'en_US.UTF-8', 02:32:37 INFO - 'LANGUAGE': 'en_US:en', 02:32:37 INFO - 'LOGNAME': 'cltbld', 02:32:37 INFO - 'MAIL': '/var/mail/cltbld', 02:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:37 INFO - 'MOZ_NO_REMOTE': '1', 02:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:37 INFO - 'NO_EM_RESTART': '1', 02:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:37 INFO - 'PWD': '/builds/slave/test', 02:32:37 INFO - 'SHELL': '/bin/bash', 02:32:37 INFO - 'SHLVL': '1', 02:32:37 INFO - 'TERM': 'linux', 02:32:37 INFO - 'TMOUT': '86400', 02:32:37 INFO - 'USER': 'cltbld', 02:32:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:37 INFO - '_': '/tools/buildbot/bin/python'} 02:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:37 INFO - Running setup.py (path:/tmp/pip-ZXiJqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:37 INFO - Running setup.py (path:/tmp/pip-kyuF2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:37 INFO - Running setup.py (path:/tmp/pip-PucOb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:37 INFO - Running setup.py (path:/tmp/pip-ICGTpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:37 INFO - Running setup.py (path:/tmp/pip-h8G5hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:37 INFO - Running setup.py (path:/tmp/pip-Gg72yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:38 INFO - Running setup.py (path:/tmp/pip-vBeaRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:38 INFO - Running setup.py (path:/tmp/pip-HiddmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:38 INFO - Running setup.py (path:/tmp/pip-Z1SNAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:38 INFO - Running setup.py (path:/tmp/pip-2Qmoo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:38 INFO - Running setup.py (path:/tmp/pip-jTPXMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:38 INFO - Running setup.py (path:/tmp/pip-MfK0a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:38 INFO - Running setup.py (path:/tmp/pip-JrdNc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:38 INFO - Running setup.py (path:/tmp/pip-eWRm0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:38 INFO - Running setup.py (path:/tmp/pip-SDbD6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:38 INFO - Running setup.py (path:/tmp/pip-FiSrxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:38 INFO - Running setup.py (path:/tmp/pip-jaXRkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:38 INFO - Running setup.py install for manifestparser 02:32:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:38 INFO - Running setup.py install for mozcrash 02:32:39 INFO - Running setup.py install for mozdebug 02:32:39 INFO - Running setup.py install for mozdevice 02:32:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Running setup.py install for mozfile 02:32:39 INFO - Running setup.py install for mozhttpd 02:32:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Running setup.py install for mozinfo 02:32:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Running setup.py install for mozInstall 02:32:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Running setup.py install for mozleak 02:32:39 INFO - Running setup.py install for mozlog 02:32:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Running setup.py install for moznetwork 02:32:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:39 INFO - Running setup.py install for mozprocess 02:32:40 INFO - Running setup.py install for mozprofile 02:32:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:40 INFO - Running setup.py install for mozrunner 02:32:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:40 INFO - Running setup.py install for mozscreenshot 02:32:40 INFO - Running setup.py install for moztest 02:32:40 INFO - Running setup.py install for mozversion 02:32:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:40 INFO - Cleaning up... 02:32:40 INFO - Return code: 0 02:32:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:40 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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:40 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 02:32:40 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 02:32:40 INFO - Using env: {'DISPLAY': ':0', 02:32:40 INFO - 'HOME': '/home/cltbld', 02:32:40 INFO - 'LANG': 'en_US.UTF-8', 02:32:40 INFO - 'LANGUAGE': 'en_US:en', 02:32:40 INFO - 'LOGNAME': 'cltbld', 02:32:40 INFO - 'MAIL': '/var/mail/cltbld', 02:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:40 INFO - 'MOZ_NO_REMOTE': '1', 02:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:40 INFO - 'NO_EM_RESTART': '1', 02:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:40 INFO - 'PWD': '/builds/slave/test', 02:32:40 INFO - 'SHELL': '/bin/bash', 02:32:40 INFO - 'SHLVL': '1', 02:32:40 INFO - 'TERM': 'linux', 02:32:40 INFO - 'TMOUT': '86400', 02:32:40 INFO - 'USER': 'cltbld', 02:32:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:40 INFO - '_': '/tools/buildbot/bin/python'} 02:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:40 INFO - Running setup.py (path:/tmp/pip-twdVWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:40 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)) 02:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:40 INFO - Running setup.py (path:/tmp/pip-CueF1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:40 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)) 02:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:40 INFO - Running setup.py (path:/tmp/pip-GpAKSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:41 INFO - Running setup.py (path:/tmp/pip-NXeivM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:41 INFO - Running setup.py (path:/tmp/pip-KrRymL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:41 INFO - Running setup.py (path:/tmp/pip-EbOzLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:41 INFO - Running setup.py (path:/tmp/pip-e2VFrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:41 INFO - Running setup.py (path:/tmp/pip-j52M0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:41 INFO - Running setup.py (path:/tmp/pip-UR707Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:41 INFO - Running setup.py (path:/tmp/pip-SpHdEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:41 INFO - Running setup.py (path:/tmp/pip-KeAjJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:41 INFO - Running setup.py (path:/tmp/pip-dbBsVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:41 INFO - Running setup.py (path:/tmp/pip-s7FAia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:41 INFO - Running setup.py (path:/tmp/pip-BwlJMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:41 INFO - Running setup.py (path:/tmp/pip-MJG6EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:41 INFO - Running setup.py (path:/tmp/pip-Is77XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:41 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)) 02:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:41 INFO - Running setup.py (path:/tmp/pip-hquPgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:42 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)) 02:32:42 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)) 02:32:42 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)) 02:32:42 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)) 02:32:42 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)) 02:32:42 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)) 02:32:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:44 INFO - Downloading blessings-1.6.tar.gz 02:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:44 INFO - Installing collected packages: blessings 02:32:44 INFO - Running setup.py install for blessings 02:32:44 INFO - Successfully installed blessings 02:32:44 INFO - Cleaning up... 02:32:44 INFO - Return code: 0 02:32:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:44 INFO - Reading from file tmpfile_stdout 02:32:44 INFO - Current package versions: 02:32:44 INFO - argparse == 1.2.1 02:32:44 INFO - blessings == 1.6 02:32:44 INFO - blobuploader == 1.2.4 02:32:44 INFO - docopt == 0.6.1 02:32:44 INFO - functools32 == 3.2.3-2 02:32:44 INFO - jsonschema == 2.5.1 02:32:44 INFO - manifestparser == 1.1 02:32:44 INFO - mozInstall == 1.12 02:32:44 INFO - mozcrash == 1.0 02:32:44 INFO - mozdebug == 0.1 02:32:44 INFO - mozdevice == 0.48 02:32:44 INFO - mozfile == 1.2 02:32:44 INFO - mozhttpd == 0.7 02:32:44 INFO - mozinfo == 0.9 02:32:44 INFO - mozleak == 0.1 02:32:44 INFO - mozlog == 3.4 02:32:44 INFO - moznetwork == 0.27 02:32:44 INFO - mozprocess == 0.23 02:32:44 INFO - mozprofile == 0.28 02:32:44 INFO - mozrunner == 6.13 02:32:44 INFO - mozscreenshot == 0.1 02:32:44 INFO - mozsystemmonitor == 0.3 02:32:44 INFO - moztest == 0.7 02:32:44 INFO - mozversion == 1.4 02:32:44 INFO - psutil == 3.1.1 02:32:44 INFO - requests == 1.2.3 02:32:44 INFO - wsgiref == 0.1.2 02:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:44 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 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:44 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 02:32:44 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 02:32:44 INFO - Using env: {'DISPLAY': ':0', 02:32:44 INFO - 'HOME': '/home/cltbld', 02:32:44 INFO - 'LANG': 'en_US.UTF-8', 02:32:44 INFO - 'LANGUAGE': 'en_US:en', 02:32:44 INFO - 'LOGNAME': 'cltbld', 02:32:44 INFO - 'MAIL': '/var/mail/cltbld', 02:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:44 INFO - 'MOZ_NO_REMOTE': '1', 02:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:44 INFO - 'NO_EM_RESTART': '1', 02:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:44 INFO - 'PWD': '/builds/slave/test', 02:32:44 INFO - 'SHELL': '/bin/bash', 02:32:44 INFO - 'SHLVL': '1', 02:32:44 INFO - 'TERM': 'linux', 02:32:44 INFO - 'TMOUT': '86400', 02:32:44 INFO - 'USER': 'cltbld', 02:32:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:44 INFO - '_': '/tools/buildbot/bin/python'} 02:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 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)) 02:32:44 INFO - Cleaning up... 02:32:44 INFO - Return code: 0 02:32:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6eb638af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', '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 02:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:32:44 INFO - Using env: {'DISPLAY': ':0', 02:32:44 INFO - 'HOME': '/home/cltbld', 02:32:44 INFO - 'LANG': 'en_US.UTF-8', 02:32:44 INFO - 'LANGUAGE': 'en_US:en', 02:32:44 INFO - 'LOGNAME': 'cltbld', 02:32:44 INFO - 'MAIL': '/var/mail/cltbld', 02:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:44 INFO - 'MOZ_NO_REMOTE': '1', 02:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:44 INFO - 'NO_EM_RESTART': '1', 02:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:44 INFO - 'PWD': '/builds/slave/test', 02:32:44 INFO - 'SHELL': '/bin/bash', 02:32:44 INFO - 'SHLVL': '1', 02:32:44 INFO - 'TERM': 'linux', 02:32:44 INFO - 'TMOUT': '86400', 02:32:44 INFO - 'USER': 'cltbld', 02:32:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:44 INFO - '_': '/tools/buildbot/bin/python'} 02:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:44 INFO - Cleaning up... 02:32:44 INFO - Return code: 0 02:32:44 INFO - Running post-action listener: _resource_record_post_action 02:32:44 INFO - Running post-action listener: _start_resource_monitoring 02:32:45 INFO - Starting resource monitoring. 02:32:45 INFO - [mozharness: 2016-12-24 10:32:45.004913Z] Finished create-virtualenv step (success) 02:32:45 INFO - [mozharness: 2016-12-24 10:32:45.005378Z] Running install step. 02:32:45 INFO - Running pre-action listener: _resource_record_pre_action 02:32:45 INFO - Running main action method: install 02:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:45 INFO - Reading from file tmpfile_stdout 02:32:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:45 INFO - Reading from file tmpfile_stdout 02:32:45 INFO - Output received: 02:32:45 INFO - Usage: mozinstall [options] installer 02:32:45 INFO - Options: 02:32:45 INFO - -h, --help show this help message and exit 02:32:45 INFO - -d DEST, --destination=DEST 02:32:45 INFO - Directory to install application into. [default: 02:32:45 INFO - "/builds/slave/test"] 02:32:45 INFO - --app=APP Application being installed. [default: firefox] 02:32:45 INFO - mkdir: /builds/slave/test/build/application 02:32:45 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'] 02:32:45 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 02:33:01 INFO - Reading from file tmpfile_stdout 02:33:01 INFO - Output received: 02:33:01 INFO - /builds/slave/test/build/application/firefox/firefox 02:33:01 INFO - Running post-action listener: _resource_record_post_action 02:33:01 INFO - [mozharness: 2016-12-24 10:33:01.211848Z] Finished install step (success) 02:33:01 INFO - [mozharness: 2016-12-24 10:33:01.212090Z] Running run-tests step. 02:33:01 INFO - Running pre-action listener: _resource_record_pre_action 02:33:01 INFO - Running main action method: run_tests 02:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:01 INFO - Python 2.7.3 02:33:01 INFO - Return code: 0 02:33:01 INFO - grabbing minidump binary from tooltool 02:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:01 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 0x18c6f60>, '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 0x18c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:01 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 02:33:01 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 02:33:01 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 02:33:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:01 INFO - Return code: 0 02:33:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:33:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:33:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:01 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/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 02:33:01 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/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 02:33:01 INFO - Using env: {'DISPLAY': ':0', 02:33:01 INFO - 'HOME': '/home/cltbld', 02:33:01 INFO - 'LANG': 'en_US.UTF-8', 02:33:01 INFO - 'LANGUAGE': 'en_US:en', 02:33:01 INFO - 'LOGNAME': 'cltbld', 02:33:01 INFO - 'MAIL': '/var/mail/cltbld', 02:33:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:01 INFO - 'MOZ_NO_REMOTE': '1', 02:33:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:01 INFO - 'NO_EM_RESTART': '1', 02:33:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:01 INFO - 'PWD': '/builds/slave/test', 02:33:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:01 INFO - 'SHELL': '/bin/bash', 02:33:01 INFO - 'SHLVL': '1', 02:33:01 INFO - 'TERM': 'linux', 02:33:01 INFO - 'TMOUT': '86400', 02:33:01 INFO - 'USER': 'cltbld', 02:33:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009', 02:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:01 INFO - '_': '/tools/buildbot/bin/python'} 02:33:01 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/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 02:33:01 INFO - mozversion application_buildid: 20161224004004 02:33:01 INFO - mozversion application_changeset: ec2672807887aa46bb4c2966478afa08d610d72d 02:33:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:33:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:01 INFO - mozversion application_name: Firefox 02:33:01 INFO - mozversion application_remotingname: firefox-dev 02:33:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:01 INFO - mozversion application_vendor: Mozilla 02:33:01 INFO - mozversion application_version: 52.0a2 02:33:01 INFO - mozversion platform_buildid: 20161224004004 02:33:01 INFO - mozversion platform_changeset: ec2672807887aa46bb4c2966478afa08d610d72d 02:33:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:01 INFO - mozversion platform_version: 52.0a2 02:33:01 INFO - using testdate: 1482575581 02:33:01 INFO - actual date: 1482575581 02:33:01 INFO - starting webserver on 'localhost:32845' 02:33:01 INFO - SUITE-START | Running 2 tests 02:33:01 INFO - TEST-START | dromaeo_css 02:33:01 INFO - operating with platform_type : linux_ 02:33:01 INFO - Initialising browser for dromaeo_css test... 02:33:01 INFO - TEST-INFO | started process 30905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhIRfX/profile http://localhost:32845/getInfo.html) 02:33:05 INFO - PROCESS | 30905 | __metrics Screen width/height:1600/1200 02:33:05 INFO - PROCESS | 30905 | colorDepth:24 02:33:05 INFO - PROCESS | 30905 | Browser inner width/height: 1024/697 02:33:05 INFO - PROCESS | 30905 | __metrics 02:33:06 INFO - PROCESS | 30905 | 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" 02:33:06 INFO - PROCESS | 30905 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:07 INFO - PROCESS | 30905 | console.error: PushService: 02:33:07 INFO - PROCESS | 30905 | stateChangeProcessEnqueue: Error transitioning state 02:33:07 INFO - PROCESS | 30905 | UnknownError 02:33:07 INFO - TEST-INFO | 30905: exit 0 02:33:07 INFO - Browser initialized. 02:33:07 INFO - Running cycle 1/1 for dromaeo_css test... 02:33:07 INFO - TEST-INFO | started process 30999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhIRfX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:19 INFO - PROCESS | 30999 | RSS: Main: 144769024 02:33:19 INFO - PROCESS | 30999 | 02:34:11 INFO - PROCESS | 30999 | 1482575651119 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] 02:36:21 INFO - PROCESS | 30999 | Cycle 1(1): loaded http://localhost:32845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32845/tests/dromaeo/cssquery-ext.html) 02:36:22 INFO - PROCESS | 30999 | RSS: Main: 239304704 02:36:22 INFO - PROCESS | 30999 | 02:39:25 INFO - PROCESS | 30999 | Cycle 1(1): loaded http://localhost:32845/tests/dromaeo/cssquery-ext.html (next: http://localhost:32845/tests/dromaeo/cssquery-jquery.html) 02:39:25 INFO - PROCESS | 30999 | RSS: Main: 225677312 02:39:25 INFO - PROCESS | 30999 | 02:42:27 INFO - PROCESS | 30999 | Cycle 1(1): loaded http://localhost:32845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32845/tests/dromaeo/cssquery-mootools.html) 02:42:28 INFO - PROCESS | 30999 | RSS: Main: 176193536 02:42:28 INFO - PROCESS | 30999 | 02:45:30 INFO - PROCESS | 30999 | Cycle 1(1): loaded http://localhost:32845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32845/tests/dromaeo/cssquery-prototype.html) 02:45:30 INFO - PROCESS | 30999 | RSS: Main: 184635392 02:45:30 INFO - PROCESS | 30999 | 02:48:33 INFO - PROCESS | 30999 | Cycle 1(1): loaded http://localhost:32845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32845/tests/dromaeo/cssquery-yui.html) 02:48:34 INFO - PROCESS | 30999 | RSS: Main: 175935488 02:48:34 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | Cycle 1(1): loaded http://localhost:32845/tests/dromaeo/cssquery-yui.html (next: http://localhost:32845/tests/dromaeo/cssquery-dojo.html) 02:51:36 INFO - PROCESS | 30999 | RSS: Main: 261238784 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | __start_tp_report 02:51:36 INFO - PROCESS | 30999 | _x_x_mozilla_page_load 02:51:36 INFO - PROCESS | 30999 | _x_x_mozilla_page_load_details 02:51:36 INFO - PROCESS | 30999 | |i|pagename|runs| 02:51:36 INFO - PROCESS | 30999 | |0;dojo.html;3224.2906560556676;3229.5155726641;3272.1001724525768;3289.259916518782;3295.0938491914735;5524.696141712209;5604.327480702316;5605.495505404513;5616.354119276284;5620.831375058745;5639.971800140994;5700.458456446631;5711;5712.771489140429;5733.340665823432;5130.589552835773;5146.150885103953;5179.766910489037;5209.244659524366;5222.8694282642855;5050.898982020358;5220.6606570572985;5234.136367499358;5235.319408476893;5239.161734122541;5048.873778155557;5108.1060814357525;5108.259302401149;5115.923261151067;5154.278401023859;5158.045761534109;5201.349831271091;5201.505856943584;5233.633645644806;5247.632665713401;5062.898742025176;5088.6692364996525;5178.637495375326;5197.714125723083;5223;5455.536279416255;5461.9453805461835;5508.834734957958;5537.58468114893;5539.778408863641;5943.851403714899;5956.612820166675;5970.194023806774;6047.15339852421;6051.1225872248715;6115.724792384353;6119.847003824895;6124.35694252106;6126.264848218242;6132.294786099566;5454.236406903036;5462.481064298885;5494.8076817312;5504.091824848895;5538.280023596987;6030.758769649253;6035.486983606354;6038.033914573647;6040.939590604125;6041.607295525777;5759.539236861041;5773.134029895466;5773.538116950634;5835.679037652885;5845.532357411397;5831.300243970666;5884.676342801102;5909.3204281507315;5933.525317974551;5991.131285963511;6016.729247183887;6029.728662210211;6030.276366836008;6045.6070355426755;6066.666333351708;5979.013462778593;6042.093685947143;6052.425019623129;6058.0610005449225;6064.9090263646085;4517.164324599959;4568.383268258743;4608.769561521911;4680.461746899082;4681.9297710534365;4170.812313445902;4182.56083111275;4213.810378532973;4235.2588297048505;4251.043515209115;5798.623089499253;5808.854778630483;5812.970935145382;5820.563457740686;5846.795362162389;5875.823725288248;5923.614965027259;6096.268447786294;6106.847328816815;6114.724837382329;5518.558515318765;5583.190437386556;5607.579431542651;5633.521150702236;5668.489835914787;5037.143685573388;5037.722925239073;5041.269015992661;5102.948970510248;5169.017886601534;6018.247719035121;6158.568900176944;6192.287886893065;6213.378662133841;6221.129041934133;5873.647581145145;5901.026330655565;5939.940600593939;5951.077582974646;6047.879042419039;6190.659513726789;6210.72051757681;6211.440970312694;6216.689165541795;6278.246610406781;5816.854578635568;5817.331006934088;5820;5835.696870179764;5857.209276747584;5894.2926848778425;5897.764089436375;5986.551008674454;6019.4883434908525;6027.336992930686;5937.317208521075;5937.406259374028;5944.524438045032;5952.255968003999;5962.284525856925;5800.767969281182;5819.243498345188;5824.679642619697;5829.621074630136;5858.5898987070495;5638.887222255614;5678.858028549319;5820.796272130455;5824.039033559416;5904.291485021825;5944.405559444021;5954.315253745702;5956;5958.1658567801405;5975.850603734942;5559.971405290034;5745.368009518866;5796.855078623068;5811.331696854747;5815.04051831443 02:51:36 INFO - PROCESS | 30999 | |1;ext.html;584.1529781816365;628.2806186915981;647.7376662451705;649.7595889520878;686.9523975936693;35330.82334588327;46762;48335.75832120835;48338;48355.27467087997;47782.76108619461;48263.75868120654;48433.273500897514;48531.757341213335;48567.27149092766;8317.500949942993;8598.183172598594;8968.282537397008;9119.270458363348;9123.361364704473;10704.090152337061;10998.780024399508;11004.504797284142;11361.488733006992;11366.71583210418;11036.392998385085;11082.113430925507;11085.612003579876;11116.221864469491;11121.443927803577;10810.67567972962;10827.566897324137;10837.403942783143;10861.294015888981;10863.076638485738;10825;10869.67390978272;10915.235933484659;10973.451327433677;10976.231663783537;44826.55173448289;45273;45288.54711452876;45296.54703452956;45326.54673453256;3639.1432725310506;3843.577206507282;3957;4095.317566993594;4406.074724307867;33732.83133584341;34117.31765364679;34198.316033679184;34342.82828585866;34906.127346816276;4165.083681590046;4239.1521695660995;4319.632831209351;4349.956500434987;4392.407025051609;367730;369656;369660.1516992425;369848;370060;65907;66748.66625666841;66839.66580167165;66920;66929;40781.79609101995;41561.792191038854;41910.371344429856;44074.77962610166;44269.11461770746;19167.52081197981;19342.8065719341;19367.903160484108;19419.4174174775;19421.805781942283;13608.319584020759;13821.723565528835;14329.068610540282;14764.63088422798;14934.70130597382;20889.16443342249;21141.471463213235;21181.894090529448;21297.57404851894;21384.893075534525;7450.701971921062;7585.317321441097;7709.38324934004;7791.532508049535;7861.331786798186;993.380789313429;1042.2287507244585;1100.0759362135684;1168.8129899216085;1192.5587532612988;34824.12939676528;35097.1225719354;35147.4727879082;35505.15976625637;35520.82239588785;1009.5154325923451;1136.3409222650844;1138.869030061537;1153.1063425845036;1209.818527220924;15886.364545418053;18005.7299140513;18252.63494730098;19040.52398690044;19297.228110875687;549097;551009;551773;551812;552810;65151.34848651453;65551.34448655452;65613;65692.67153664201;65797.34202657912;1313.638749343919;1357.2806412601337;1361.5983284931167;1406.3249640172774;1451.8185226846645;27249.86375068112;30759.846200768854;31366;31853.681463185072;34642.65357346394;56737.730490779904;63935.68032159809;63979.36020639734;63981.680091601105;63998.36001639924;499244;503840;503940;504251;505392;27525.31186720348;28505;28583.14250572486;29691.703082968892;29755.107346778765;51579;51860.481395187075;52196.21705674342;52502;52957.77175213359;43881;43916;43975.340369893835;44353;45536.316955245034;40968.975775605846;44110.55889441064;46601.53398465972;46797;48623.02753944972;44001.77999109984;47412.59090795436;47461;47562.28656570085;47813.28280075732;45295.320570190815;45402.31896521621;45527.089458209986;45976.77011614921;46901.530984689714;35474;36511.45232821563;36534.63465365312;36547.81726091352;36679.449808253434 02:51:36 INFO - PROCESS | 30999 | |2;jquery.html;398.0970958816853;427.86094519281244;436.28013777267506;445.3097698567222;445.65239113491475;17237.913810430946;19939.202431902708;20586.691199632016;20644.48388790281;20840.89579552104;20378.89810550949;20399.184032638714;20419;20454.795452045513;20688.68966965493;5586.273784408021;5608.915866261999;5777.855553611173;5799.043157878945;5809.9709501452435;5691.345495268035;5761.395053519383;5769.653820770746;5770.076787713967;5771.797987070453;5551;5708.743106560215;5740.024195886709;5745;5749.166370876221;5690.430956904318;5734.627249228787;5762.1068734346245;5776.740046697909;5781.768729250846;5166.741662916839;5223.73881305937;5230.843074707726;5232.581393488512;5232.659877107976;23062.308130756104;23196.53606927869;23247.53504929892;23248;23363.182288619988;2181.727284089489;2307.5038866643586;2371.4901296221396;2549.579319412295;2684.3691732442862;9113.498757568332;10694.30487018349;11021.283616564897;11154.944225278903;11166.162537809616;1898.0889173196804;1928.662484065283;1931.5557421792926;1950.229659284589;1963.4404194804556;90589;93296.53351733266;94627.52686236594;94659.52670236674;94895;11425.542978280942;11468.254563453516;11704.590339338083;11788.29270243788;11998.880011199952;16541.421050263183;16593.253303601126;16623.168841558116;16630.916845415937;16647;8542.701005464778;8775.122487751174;8801.911980880237;8827.779305517413;8967.686130985385;8515.19105684959;8531.95734021326;8565.700200492953;8765.07966663504;8795.780105497413;4990.6257030722845;5013.699178049329;5102.729285467931;5111.182210846247;5158.664686795346;2001.1495114576537;2019.4850313170048;2027.9797202027792;2056.341970569403;2072.243631074647;968.9612415503301;975.5219942228257;985.6008316631776;1015.167562598662;1074.0762943868267;19347.90326048389;20176.679681836777;20333.389998300074;20847.37457876266;21201;1007.7430255285002;1027.111548510533;1036.8548403223556;1062.0706881478707;1114.9777004460027;10648.307859989076;11191.440427978569;11219.214654974074;11272.323660580392;11359.659210223706;527350;528222;531539;535762;561992;96133.5193324029;97303;100362;101137;103273.48363258287;1062.2245760594808;1092.1317552545586;1115.1079136690614;1126.5719026769775;1129.9604513841975;17640.823591763918;17850.464486065437;17907.641847162722;18116.18477168557;18420.171092301145;42862.57137428711;43095.35356969711;43358.34962475502;43904.12191756211;44034.55965440433;58914.41085589089;59406.70296648489;59446.40553594409;59757.40242597518;60444;8643.222110009878;8693.30453563726;8754.824903502022;8790.113116870754;9087.818243635222;9529.568750531036;12718.872811271769;13010.414531345923;13210.537631182862;13274.668133296746;11491.367974761468;11868.347240901834;12028;12053.819192712292;12102.636920892388;11428.828567571327;11539.076873849905;11547.249428787101;11639.243449175776;11663.76672466563;11661.416929153678;11695.356755378536;11778.46996885125;12024.579139730417;12172.939135304267;8029.397795165502;8637.495482740485;8693.956530217309;8956.28349732033;9043.23132533742;11334.829977550507;11646.767064658829;11723.41382930867;11740.882591173979;12173.817392739293 02:51:36 INFO - PROCESS | 30999 | |3;mootools.html;1293.7477191947562;1508.6907184027273;1517.4992252556656;1676.5473322203006;1811.6376724655072;7481.139668938074;8242.75271741848;8540.530270835101;8568.742937711862;8576.485410875352;8402.91597084029;8562.571871406435;8770.56147192641;8771.868421973675;8776.034636190014;2437;2474.5298393305306;2478.8388754730886;2479.2562231330617;2480.4295012147218;2429.5019520998153;2501.0996041425074;2503.849769013856;2504.499100179962;2508.347829564317;2439.426734717349;2449.534588428202;2473.5300292944285;2478.021181633254;2481.801455883534;2397.712274527059;2419.9395015124674;2452.6566280720713;2459.0286836699493;2463.2363967170054;2411.047636183715;2436.3056528889183;2458.6189140683223;2458.791002764767;2465.654808326836;8480.067192608809;8579.914200857975;8636.179562941574;8739.126087391274;8747.868781968276;5373.113436283009;5515.09001014832;5520.944790552083;5522.0336441123045;5525.972370138164;3369.5451114099774;3518.47222916562;3530.1527633368064;3583.7133029357587;3597.7661452005536;1135.8636963564343;1162.4594563527914;1181.6986668399588;1209.0750575809514;1215.3376409856562;11912.225705329125;12127.514899404014;12142.332171730552;12159.148859579744;12167.574134905324;4824.155772739757;4920.163572192736;5001.399832020108;5022.723750193774;5054.292399064134;10359.84460233082;10365.429901355497;10366.429846358522;10373.896261037444;10387.636432724817;5546.805861794818;5552.41699621542;5555.194496797942;5560.694161821139;5561.555075593943;4213.620774130343;4454.064646424223;4577.977110114428;4584.564466375689;5103.260027296022;4192.874213773531;4196.685248606367;4336.436263285753;4354.521002689701;4360.49854266757;1392.5752645443238;1434.763264061418;1436;1442.0820308989018;1468.4052958551804;849.002422153979;866.1035827918074;870.7648934787572;879.2789912271876;892.8616064510011;5500.642458240201;5572.944270557324;5577.972110139504;5671.404502527175;5927.318358388754;497.5099526965936;502.92456131580553;507.3024591187118;510.0462135805992;511.40166005773335;3810.447485114643;3832.5400951885954;3979.7612143270917;3980.66647673027;3997.7401468904427;9939.353941993748;10594.15246780271;10690.572377104983;10715.946420267848;10718.08896243828;10449.425281609585;10654.733631659115;10660.893391066145;10664.466776661136;10754.731131721614;8193.79515512105;8289.958550207331;8296.626651800683;8308.418410711192;8311.33509319253;5556.277683901067;5680.829575112753;5695.601307908407;5725.51333136688;5782.739776710142;9805.509724513888;9807.656732014346;9877.209823213982;9896.406215627085;9924.603015879284;8515.446495977742;8809.207171354608;9457.905420945703;9701.611935522782;9931.255155863484;7333.266673332624;7539.962300188464;7559.244075592397;7562.319391254813;7649.235076492307;8134.918650813416;8163.1836816320265;8189.672413103409;8213.219744124299;8219.630116644885;7149.964250178716;7430.96284518574;7458.664360103917;7513.924860751323;7674.6162691864065;7408.370288525536;7437.144728356092;7444.664990075351;7501.287377699328;7516.736914207976;6932.826679333057;6935.791926242221;6991.370776630128;6999.440044796506;7000.579965202104;4877.731724755173;4935.925961110658;5017.724025178651;5025.874353141201;5145.45972672864;5011.949880501148;5114.33513643224;5195.870103247449;5242.135047717084;5324.148136298174 02:51:36 INFO - PROCESS | 30999 | |4;prototype.html;344.1310690506472;352.3252970561375;357.0805176670074;360.9296187243487;362.8802495176592;5131.717755523445;5262.342207224097;5279.577633789298;5312.2828418163535;5317.2821669074665;5070.619703522232;5195.532402083812;5215.58275337973;5217.243499692542;5222.529972302492;4169.520505141917;4174.102567947891;4180.080382315886;4181.829087855398;4186.476690413699;3885.592012838654;3947.8223479943326;4134.937975930364;4150.024744185129;4151.605597468236;4138;4152.813123409439;4155.522114956773;4161.750294982296;4163.271427500191;4155.127423241123;4157.438745769343;4160.604742549453;4165.875023749292;4166.791660416998;3502.842372093262;3699.130704284491;3702.8148592570265;3703.5926048134684;3710.2764960832646;5126.538611524943;5136.152534831748;5149.433562308143;5154.252633368141;5157;4713.552212539803;4721.24460086388;4728.787204575802;4734.597559207472;4746.288056791474;5391.541718953894;5500.779968801243;5514.558835293167;5518.586106042023;5550.361708403505;4030.45588845505;4036.3945408189006;4039.555648878621;4043.676505879552;4047.271491131595;5672.432756724335;5680.488756011938;5693.943060569382;5694.601377903548;5709.887341683604;4019.3970904363996;4091.0386059276047;4102.400063975052;4114.341705327133;4119.443875076886;4136.234796562646;4161.771102589326;4162.708610397303;4165.91668166635;4171.666266698657;4663.487016428258;4672.299155126758;4689.577937985598;4692.6245900327895;4693.530646935279;5476.863078422992;5479.369872464717;5509.752061157257;5511.476409741068;5521.365043020024;1350.993509835179;1399.5451478269604;1400.4538230090272;1402.656349194454;1412.7598308287616;951.7906060666643;974.2352253480983;988.5551501824208;990.1732053735212;996.7508122969258;5176.689398636094;5183.781811274347;5199.740012999335;5206.245094461282;5207;5382.354117505846;5426.131818908955;5447.210154527571;5454.972725136428;5461.563074953994;5134.2298655201275;5163.690178589297;5215.843524694265;5226.439044867987;5425.701586412785;2876.2521744346623;2907.7433274732434;2914.2460374945895;2919.3723349479965;2919.5182794838615;5726.312842458931;5739;5754.712264386764;5773.740181691834;5782;5446.537044351196;5630.380658127603;5655.390856452061;5656.575756818255;5678.659280443187;5758.882399084675;5768.817392434625;5771.912027065499;5779.566532510079;5780.88438231233;5388.865278368072;5540.501354877919;5563.221149039218;5587.876606889356;5595.412481689364;5430.647007944471;5444.482774136451;5446.945530544803;5452.6183167177915;5473.28847249855;5719.399463056486;5740.6268592541355;5747.752519826452;5758;5782.311225280265;3898.187342885572;4009.8547277206553;4013.458183145238;4015.8393664253103;4029.979850100731;5454.854480559127;5469.671819690831;5487.341519017744;5497.917531237114;5511.559075273888;5370.777533479881;5396.244525766474;5412.702301373305;5413.350397952271;5426.158945363475;5180.61145414103;5332.546733527538;5450.5367043801725;5481.232627432242;5500.477454641963;5539.950218419211;5543.3902270751;5545.445455454423;5546.140348246028;5551.444855514416;5374.704391258362;5620.4660557247;5621.943780562142;5624.606277560531;5646.520045796154;5452.291202143696;5461.590380721383;5470.480304371078;5481.984908300339;5497.945020549743 02:51:36 INFO - PROCESS | 30999 | |5;yui.html;697.4838619421627;727.5416487612803;781.597477299191;787.8306164174701;811.1685522339604;15650.686986260267;16444.506664800047;16451.670966580663;16458.341666333334;16493.505194844158;15114.546563603082;15259.542213733577;15261.77107343388;15262.160581168031;15264.923675381608;720.0890873045602;733.3180142467503;820.995895020524;841.188253335531;843.2158092973548;847.3644766425181;849.817289282804;852.4586887326531;853.1042405474227;853.9837593263996;890.4746199742151;894.6466145872377;898.4115404410122;898.7034278688018;901.6393442622971;765.0857225615392;888.1873086126187;890.2655309369763;890.9465432074096;891.0821853490914;574.2936188488142;654.8919428294325;667.3760034367882;669.0265663459654;670.1991120610872;14480.493182738554;14482.058666186664;14523.78214326786;14532.782008269884;14537.273136343141;13654.658633534142;13914.652133696638;14065.64835879101;14066.437342506288;14111.294435278298;12579.93710031444;12678.936605316914;12708.809367859489;12821.294828784414;12855.807162892565;4210.094829611618;4225.471816022997;4227.175700738358;4272.444582204324;4308.332208507686;66761.99857002101;67416;67447.66276168637;67560.3243967559;68099;10783.406912619881;10823.891761082446;10851.51168197433;11127.72180695489;11544.88455115455;21206.681899771516;21241.468963276042;21294.467638309165;21365.35903922885;21406.25078122258;8317.584120794058;8551.700690475804;8608.784780380416;8635.395522313504;8667.393282470166;4767.427908650984;4815.470298267188;4853.757312134379;4901.264810278487;4983.152864013126;3447.1554469155217;3547.396942519778;3551.076720052753;3554.289142171576;3555.040139162412;608.0332271687948;610.4475449718012;615.7290792051483;627.4039662320813;627.7269387816315;659.1167835100988;662.4104546953215;688.8702527854323;714.3642158478958;736.4035131543467;8555.657773689107;8951.507667078373;8993.865092023625;9035.277177825757;9097.863532047024;571.6455797405636;628.2680677011231;679.3987321220756;708.9610071446017;721.469719755979;4276.87169384919;4476.574725401082;4496.752678602643;4521;4622.375979242759;87158;90057.54971225232;93516.53241733748;94918.52540737252;98546.50726746464;70651.64674176596;72371.27628723645;80905.19094808976;81084.59457702674;81719;58402.415975840544;59215.335309911155;68186;69992;70006;9538.189253913217;9887;10329.729514082977;10391.84412233802;10511.842322365017;34043;38274.425883612326;46339.536604633526;47750.283745744535;48648.2702759466;57203.42796572147;57397.42602573921;59065.70467147637;63759;68153.97769033369;12257.38713064361;12322.876771232173;12798.232106073665;13029.674258143623;13186.80219796723;14512;14640.121592704472;14925.477608283658;15018.924905375403;15587.610309742347;11350.94324528372;11749.236299640495;13138.540151094665;13571.728565428439;14435.78346324827;11321.660350189508;12531.18547294423;12660.683482913;12753;12818.61544153677;11974.64076077719;12248.75502489963;13226;13304.201747895157;13424.328783560588;9868.259880509135;9944.45305508204;10193.592256309665;10378.792424151627;10721.678349649523;10218.642347517802;10258.230632702427;10263.178945684476;10338.431386273827;10669.986351296615 02:51:36 INFO - PROCESS | 30999 | __end_tp_report 02:51:36 INFO - PROCESS | 30999 | __start_cc_report 02:51:36 INFO - PROCESS | 30999 | _x_x_mozilla_cycle_collect,1000 02:51:36 INFO - PROCESS | 30999 | __end_cc_report 02:51:36 INFO - PROCESS | 30999 | __startTimestamp1482576696951__endTimestamp 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | ------- Summary: start ------- 02:51:36 INFO - PROCESS | 30999 | Number of tests: 6 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | [#0] dojo.html Cycles:165 Average:5576.94 Median:5812.97 stddev:614.92 (10.6%) stddev-sans-first:588.45 02:51:36 INFO - PROCESS | 30999 | Values: 3224.3 3229.5 3272.1 3289.3 3295.1 5524.7 5604.3 5605.5 5616.4 5620.8 5640.0 5700.5 5711.0 5712.8 5733.3 5130.6 5146.2 5179.8 5209.2 5222.9 5050.9 5220.7 5234.1 5235.3 5239.2 5048.9 5108.1 5108.3 5115.9 5154.3 5158.0 5201.3 5201.5 5233.6 5247.6 5062.9 5088.7 5178.6 5197.7 5223.0 5455.5 5461.9 5508.8 5537.6 5539.8 5943.9 5956.6 5970.2 6047.2 6051.1 6115.7 6119.8 6124.4 6126.3 6132.3 5454.2 5462.5 5494.8 5504.1 5538.3 6030.8 6035.5 6038.0 6040.9 6041.6 5759.5 5773.1 5773.5 5835.7 5845.5 5831.3 5884.7 5909.3 5933.5 5991.1 6016.7 6029.7 6030.3 6045.6 6066.7 5979.0 6042.1 6052.4 6058.1 6064.9 4517.2 4568.4 4608.8 4680.5 4681.9 4170.8 4182.6 4213.8 4235.3 4251.0 5798.6 5808.9 5813.0 5820.6 5846.8 5875.8 5923.6 6096.3 6106.8 6114.7 5518.6 5583.2 5607.6 5633.5 5668.5 5037.1 5037.7 5041.3 5102.9 5169.0 6018.2 6158.6 6192.3 6213.4 6221.1 5873.6 5901.0 5939.9 5951.1 6047.9 6190.7 6210.7 6211.4 6216.7 6278.2 5816.9 5817.3 5820.0 5835.7 5857.2 5894.3 5897.8 5986.6 6019.5 6027.3 5937.3 5937.4 5944.5 5952.3 5962.3 5800.8 5819.2 5824.7 5829.6 5858.6 5638.9 5678.9 5820.8 5824.0 5904.3 5944.4 5954.3 5956.0 5958.2 5975.9 5560.0 5745.4 5796.9 5811.3 5815.0 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | [#1] ext.html Cycles:180 Average:65182.53 Median:41265.38 stddev:127320.26 (308.5%) stddev-sans-first:127585.04 02:51:36 INFO - PROCESS | 30999 | Values: 584.2 628.3 647.7 649.8 687.0 35330.8 46762.0 48335.8 48338.0 48355.3 47782.8 48263.8 48433.3 48531.8 48567.3 8317.5 8598.2 8968.3 9119.3 9123.4 10704.1 10998.8 11004.5 11361.5 11366.7 11036.4 11082.1 11085.6 11116.2 11121.4 10810.7 10827.6 10837.4 10861.3 10863.1 10825.0 10869.7 10915.2 10973.5 10976.2 44826.6 45273.0 45288.5 45296.5 45326.5 3639.1 3843.6 3957.0 4095.3 4406.1 33732.8 34117.3 34198.3 34342.8 34906.1 4165.1 4239.2 4319.6 4350.0 4392.4 367730.0 369656.0 369660.2 369848.0 370060.0 65907.0 66748.7 66839.7 66920.0 66929.0 40781.8 41561.8 41910.4 44074.8 44269.1 19167.5 19342.8 19367.9 19419.4 19421.8 13608.3 13821.7 14329.1 14764.6 14934.7 20889.2 21141.5 21181.9 21297.6 21384.9 7450.7 7585.3 7709.4 7791.5 7861.3 993.4 1042.2 1100.1 1168.8 1192.6 34824.1 35097.1 35147.5 35505.2 35520.8 1009.5 1136.3 1138.9 1153.1 1209.8 15886.4 18005.7 18252.6 19040.5 19297.2 549097.0 551009.0 551773.0 551812.0 552810.0 65151.3 65551.3 65613.0 65692.7 65797.3 1313.6 1357.3 1361.6 1406.3 1451.8 27249.9 30759.8 31366.0 31853.7 34642.7 56737.7 63935.7 63979.4 63981.7 63998.4 499244.0 503840.0 503940.0 504251.0 505392.0 27525.3 28505.0 28583.1 29691.7 29755.1 51579.0 51860.5 52196.2 52502.0 52957.8 43881.0 43916.0 43975.3 44353.0 45536.3 40969.0 44110.6 46601.5 46797.0 48623.0 44001.8 47412.6 47461.0 47562.3 47813.3 45295.3 45402.3 45527.1 45976.8 46901.5 35474.0 36511.5 36534.6 36547.8 36679.4 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | [#2] jquery.html Cycles:180 Average:31186.64 Median:12752.02 stddev:88688.54 (695.5%) stddev-sans-first:88907.20 02:51:36 INFO - PROCESS | 30999 | Values: 398.1 427.9 436.3 445.3 445.7 17237.9 19939.2 20586.7 20644.5 20840.9 20378.9 20399.2 20419.0 20454.8 20688.7 5586.3 5608.9 5777.9 5799.0 5810.0 5691.3 5761.4 5769.7 5770.1 5771.8 5551.0 5708.7 5740.0 5745.0 5749.2 5690.4 5734.6 5762.1 5776.7 5781.8 5166.7 5223.7 5230.8 5232.6 5232.7 23062.3 23196.5 23247.5 23248.0 23363.2 2181.7 2307.5 2371.5 2549.6 2684.4 9113.5 10694.3 11021.3 11154.9 11166.2 1898.1 1928.7 1931.6 1950.2 1963.4 90589.0 93296.5 94627.5 94659.5 94895.0 11425.5 11468.3 11704.6 11788.3 11998.9 16541.4 16593.3 16623.2 16630.9 16647.0 8542.7 8775.1 8801.9 8827.8 8967.7 8515.2 8532.0 8565.7 8765.1 8795.8 4990.6 5013.7 5102.7 5111.2 5158.7 2001.1 2019.5 2028.0 2056.3 2072.2 969.0 975.5 985.6 1015.2 1074.1 19347.9 20176.7 20333.4 20847.4 21201.0 1007.7 1027.1 1036.9 1062.1 1115.0 10648.3 11191.4 11219.2 11272.3 11359.7 527350.0 528222.0 531539.0 535762.0 561992.0 96133.5 97303.0 100362.0 101137.0 103273.5 1062.2 1092.1 1115.1 1126.6 1130.0 17640.8 17850.5 17907.6 18116.2 18420.2 42862.6 43095.4 43358.3 43904.1 44034.6 58914.4 59406.7 59446.4 59757.4 60444.0 8643.2 8693.3 8754.8 8790.1 9087.8 9529.6 12718.9 13010.4 13210.5 13274.7 11491.4 11868.3 12028.0 12053.8 12102.6 11428.8 11539.1 11547.2 11639.2 11663.8 11661.4 11695.4 11778.5 12024.6 12172.9 8029.4 8637.5 8694.0 8956.3 9043.2 11334.8 11646.8 11723.4 11740.9 12173.8 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | [#3] mootools.html Cycles:180 Average:5720.55 Median:508.67 stddev:3173.20 (623.8%) stddev-sans-first:3164.65 02:51:36 INFO - PROCESS | 30999 | Values: 1293.7 1508.7 1517.5 1676.5 1811.6 7481.1 8242.8 8540.5 8568.7 8576.5 8402.9 8562.6 8770.6 8771.9 8776.0 2437.0 2474.5 2478.8 2479.3 2480.4 2429.5 2501.1 2503.8 2504.5 2508.3 2439.4 2449.5 2473.5 2478.0 2481.8 2397.7 2419.9 2452.7 2459.0 2463.2 2411.0 2436.3 2458.6 2458.8 2465.7 8480.1 8579.9 8636.2 8739.1 8747.9 5373.1 5515.1 5520.9 5522.0 5526.0 3369.5 3518.5 3530.2 3583.7 3597.8 1135.9 1162.5 1181.7 1209.1 1215.3 11912.2 12127.5 12142.3 12159.1 12167.6 4824.2 4920.2 5001.4 5022.7 5054.3 10359.8 10365.4 10366.4 10373.9 10387.6 5546.8 5552.4 5555.2 5560.7 5561.6 4213.6 4454.1 4578.0 4584.6 5103.3 4192.9 4196.7 4336.4 4354.5 4360.5 1392.6 1434.8 1436.0 1442.1 1468.4 849.0 866.1 870.8 879.3 892.9 5500.6 5572.9 5578.0 5671.4 5927.3 497.5 502.9 507.3 510.0 511.4 3810.4 3832.5 3979.8 3980.7 3997.7 9939.4 10594.2 10690.6 10715.9 10718.1 10449.4 10654.7 10660.9 10664.5 10754.7 8193.8 8290.0 8296.6 8308.4 8311.3 5556.3 5680.8 5695.6 5725.5 5782.7 9805.5 9807.7 9877.2 9896.4 9924.6 8515.4 8809.2 9457.9 9701.6 9931.3 7333.3 7540.0 7559.2 7562.3 7649.2 8134.9 8163.2 8189.7 8213.2 8219.6 7150.0 7431.0 7458.7 7513.9 7674.6 7408.4 7437.1 7444.7 7501.3 7516.7 6932.8 6935.8 6991.4 6999.4 7000.6 4877.7 4935.9 5017.7 5025.9 5145.5 5011.9 5114.3 5195.9 5242.1 5324.1 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | [#4] prototype.html Cycles:180 Average:4622.95 Median:5244.39 stddev:1335.78 (25.5%) stddev-sans-first:1300.35 02:51:36 INFO - PROCESS | 30999 | Values: 344.1 352.3 357.1 360.9 362.9 5131.7 5262.3 5279.6 5312.3 5317.3 5070.6 5195.5 5215.6 5217.2 5222.5 4169.5 4174.1 4180.1 4181.8 4186.5 3885.6 3947.8 4134.9 4150.0 4151.6 4138.0 4152.8 4155.5 4161.8 4163.3 4155.1 4157.4 4160.6 4165.9 4166.8 3502.8 3699.1 3702.8 3703.6 3710.3 5126.5 5136.2 5149.4 5154.3 5157.0 4713.6 4721.2 4728.8 4734.6 4746.3 5391.5 5500.8 5514.6 5518.6 5550.4 4030.5 4036.4 4039.6 4043.7 4047.3 5672.4 5680.5 5693.9 5694.6 5709.9 4019.4 4091.0 4102.4 4114.3 4119.4 4136.2 4161.8 4162.7 4165.9 4171.7 4663.5 4672.3 4689.6 4692.6 4693.5 5476.9 5479.4 5509.8 5511.5 5521.4 1351.0 1399.5 1400.5 1402.7 1412.8 951.8 974.2 988.6 990.2 996.8 5176.7 5183.8 5199.7 5206.2 5207.0 5382.4 5426.1 5447.2 5455.0 5461.6 5134.2 5163.7 5215.8 5226.4 5425.7 2876.3 2907.7 2914.2 2919.4 2919.5 5726.3 5739.0 5754.7 5773.7 5782.0 5446.5 5630.4 5655.4 5656.6 5678.7 5758.9 5768.8 5771.9 5779.6 5780.9 5388.9 5540.5 5563.2 5587.9 5595.4 5430.6 5444.5 5446.9 5452.6 5473.3 5719.4 5740.6 5747.8 5758.0 5782.3 3898.2 4009.9 4013.5 4015.8 4030.0 5454.9 5469.7 5487.3 5497.9 5511.6 5370.8 5396.2 5412.7 5413.4 5426.2 5180.6 5332.5 5450.5 5481.2 5500.5 5540.0 5543.4 5545.4 5546.1 5551.4 5374.7 5620.5 5621.9 5624.6 5646.5 5452.3 5461.6 5470.5 5482.0 5497.9 02:51:36 INFO - PROCESS | 30999 | 02:51:36 INFO - PROCESS | 30999 | [#5] yui.html Cycles:180 Average:18051.27 Median:26282.88 stddev:23888.26 (90.9%) stddev-sans-first:23919.73 02:51:36 INFO - PROCESS | 30999 | Values: 697.5 727.5 781.6 787.8 811.2 15650.7 16444.5 16451.7 16458.3 16493.5 15114.5 15259.5 15261.8 15262.2 15264.9 720.1 733.3 821.0 841.2 843.2 847.4 849.8 852.5 853.1 854.0 890.5 894.6 898.4 898.7 901.6 765.1 888.2 890.3 890.9 891.1 574.3 654.9 667.4 669.0 670.2 14480.5 14482.1 14523.8 14532.8 14537.3 13654.7 13914.7 14065.6 14066.4 14111.3 12579.9 12678.9 12708.8 12821.3 12855.8 4210.1 4225.5 4227.2 4272.4 4308.3 66762.0 67416.0 67447.7 67560.3 68099.0 10783.4 10823.9 10851.5 11127.7 11544.9 21206.7 21241.5 21294.5 21365.4 21406.3 8317.6 8551.7 8608.8 8635.4 8667.4 4767.4 4815.5 4853.8 4901.3 4983.2 3447.2 3547.4 3551.1 3554.3 3555.0 608.0 610.4 615.7 627.4 627.7 659.1 662.4 688.9 714.4 736.4 8555.7 8951.5 8993.9 9035.3 9097.9 571.6 628.3 679.4 709.0 721.5 4276.9 4476.6 4496.8 4521.0 4622.4 87158.0 90057.5 93516.5 94918.5 98546.5 70651.6 72371.3 80905.2 81084.6 81719.0 58402.4 59215.3 68186.0 69992.0 70006.0 9538.2 9887.0 10329.7 10391.8 10511.8 34043.0 38274.4 46339.5 47750.3 48648.3 57203.4 57397.4 59065.7 63759.0 68154.0 12257.4 12322.9 12798.2 13029.7 13186.8 14512.0 14640.1 14925.5 15018.9 15587.6 11350.9 11749.2 13138.5 13571.7 14435.8 11321.7 12531.2 12660.7 12753.0 12818.6 11974.6 12248.8 13226.0 13304.2 13424.3 9868.3 9944.5 10193.6 10378.8 10721.7 10218.6 10258.2 10263.2 10338.4 10670.0 02:51:36 INFO - PROCESS | 30999 | -------- Summary: end -------- 02:51:36 INFO - PROCESS | 30999 | 02:51:37 INFO - TEST-INFO | 30999: exit 0 02:51:37 INFO - TEST-OK | dromaeo_css | took 1116310ms 02:51:37 INFO - TEST-START | kraken 02:51:37 INFO - operating with platform_type : linux_ 02:51:37 INFO - Initialising browser for kraken test... 02:51:37 INFO - TEST-INFO | started process 31313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpls9CRQ/profile http://localhost:32845/getInfo.html) 02:51:41 INFO - PROCESS | 31313 | __metrics Screen width/height:1600/1200 02:51:41 INFO - PROCESS | 31313 | colorDepth:24 02:51:41 INFO - PROCESS | 31313 | Browser inner width/height: 1024/697 02:51:41 INFO - PROCESS | 31313 | __metrics 02:51:42 INFO - PROCESS | 31313 | 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" 02:51:42 INFO - PROCESS | 31313 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:43 INFO - PROCESS | 31313 | console.error: PushService: 02:51:43 INFO - PROCESS | 31313 | stateChangeProcessEnqueue: Error transitioning state 02:51:43 INFO - PROCESS | 31313 | UnknownError 02:51:43 INFO - TEST-INFO | 31313: exit 0 02:51:43 INFO - Browser initialized. 02:51:43 INFO - Running cycle 1/1 for kraken test... 02:51:43 INFO - TEST-INFO | started process 31405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpls9CRQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:55 INFO - PROCESS | 31405 | RSS: Main: 144945152 02:51:55 INFO - PROCESS | 31405 | 02:51:58 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32845/tests/kraken/driver.html?testName=audio-beat-detection) 02:51:58 INFO - PROCESS | 31405 | RSS: Main: 185802752 02:51:58 INFO - PROCESS | 31405 | 02:52:01 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32845/tests/kraken/driver.html?testName=audio-dft) 02:52:02 INFO - PROCESS | 31405 | RSS: Main: 175509504 02:52:02 INFO - PROCESS | 31405 | 02:52:04 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32845/tests/kraken/driver.html?testName=audio-fft) 02:52:05 INFO - PROCESS | 31405 | RSS: Main: 266657792 02:52:05 INFO - PROCESS | 31405 | 02:52:07 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32845/tests/kraken/driver.html?testName=audio-oscillator) 02:52:08 INFO - PROCESS | 31405 | RSS: Main: 173268992 02:52:08 INFO - PROCESS | 31405 | 02:52:10 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:10 INFO - PROCESS | 31405 | RSS: Main: 176050176 02:52:10 INFO - PROCESS | 31405 | 02:52:13 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32845/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:14 INFO - PROCESS | 31405 | RSS: Main: 214593536 02:52:14 INFO - PROCESS | 31405 | 02:52:17 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32845/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:18 INFO - PROCESS | 31405 | RSS: Main: 213221376 02:52:18 INFO - PROCESS | 31405 | 02:52:20 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32845/tests/kraken/driver.html?testName=json-parse-financial) 02:52:21 INFO - PROCESS | 31405 | RSS: Main: 211902464 02:52:21 INFO - PROCESS | 31405 | 02:52:23 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:23 INFO - PROCESS | 31405 | RSS: Main: 173789184 02:52:23 INFO - PROCESS | 31405 | 02:52:25 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:26 INFO - PROCESS | 31405 | RSS: Main: 180637696 02:52:26 INFO - PROCESS | 31405 | 02:52:27 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:28 INFO - PROCESS | 31405 | RSS: Main: 190091264 02:52:28 INFO - PROCESS | 31405 | 02:52:31 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:31 INFO - PROCESS | 31405 | RSS: Main: 198410240 02:52:31 INFO - PROCESS | 31405 | 02:52:34 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:52:34 INFO - PROCESS | 31405 | RSS: Main: 195604480 02:52:35 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | Cycle 1(1): loaded http://localhost:32845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32845/tests/kraken/driver.html?testName=ai-astar) 02:52:36 INFO - PROCESS | 31405 | RSS: Main: 246427648 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | __start_tp_report 02:52:36 INFO - PROCESS | 31405 | _x_x_mozilla_page_load 02:52:36 INFO - PROCESS | 31405 | _x_x_mozilla_page_load_details 02:52:36 INFO - PROCESS | 31405 | |i|pagename|runs| 02:52:36 INFO - PROCESS | 31405 | |0;ai-astar;101;110;109;109;111;110;110;109;110;110 02:52:36 INFO - PROCESS | 31405 | |1;audio-beat-detection;144;119;123;159;119;118;117;119;144;123 02:52:36 INFO - PROCESS | 31405 | |2;audio-dft;161;160;160;161;161;162;161;162;159;163 02:52:36 INFO - PROCESS | 31405 | |3;audio-fft;76;76;75;110;77;74;75;75;105;75 02:52:36 INFO - PROCESS | 31405 | |4;audio-oscillator;83;82;107;81;81;82;106;81;81;116 02:52:36 INFO - PROCESS | 31405 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;116;117 02:52:36 INFO - PROCESS | 31405 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 02:52:36 INFO - PROCESS | 31405 | |7;imaging-desaturate;85;84;85;85;84;85;85;84;85;85 02:52:36 INFO - PROCESS | 31405 | |8;json-parse-financial;50;51;52;51;51;51;52;52;50;49 02:52:36 INFO - PROCESS | 31405 | |9;json-stringify-tinderbox;59;59;59;62;61;59;59;60;60;61 02:52:36 INFO - PROCESS | 31405 | |10;stanford-crypto-aes;80;82;74;83;75;75;75;79;75;74 02:52:36 INFO - PROCESS | 31405 | |11;stanford-crypto-ccm;124;123;132;125;121;118;121;124;169;140 02:52:36 INFO - PROCESS | 31405 | |12;stanford-crypto-pbkdf2;150;150;151;151;151;152;151;151;154;151 02:52:36 INFO - PROCESS | 31405 | |13;stanford-crypto-sha256-iterative;66;62;63;62;61;65;61;64;62;60 02:52:36 INFO - PROCESS | 31405 | __end_tp_report 02:52:36 INFO - PROCESS | 31405 | __start_cc_report 02:52:36 INFO - PROCESS | 31405 | _x_x_mozilla_cycle_collect,1609 02:52:36 INFO - PROCESS | 31405 | __end_cc_report 02:52:36 INFO - PROCESS | 31405 | __startTimestamp1482576756883__endTimestamp 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | ------- Summary: start ------- 02:52:36 INFO - PROCESS | 31405 | Number of tests: 14 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.85 (2.6%) stddev-sans-first:0.67 02:52:36 INFO - PROCESS | 31405 | Values: 101.0 110.0 109.0 109.0 111.0 110.0 110.0 109.0 110.0 110.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:123.00 stddev:14.85 (12.1%) stddev-sans-first:14.65 02:52:36 INFO - PROCESS | 31405 | Values: 144.0 119.0 123.0 159.0 119.0 118.0 117.0 119.0 144.0 123.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 02:52:36 INFO - PROCESS | 31405 | Values: 161.0 160.0 160.0 161.0 161.0 162.0 161.0 162.0 159.0 163.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:13.62 (18.2%) stddev-sans-first:14.28 02:52:36 INFO - PROCESS | 31405 | Values: 76.0 76.0 75.0 110.0 77.0 74.0 75.0 75.0 105.0 75.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:81.00 stddev:13.83 (17.1%) stddev-sans-first:14.44 02:52:36 INFO - PROCESS | 31405 | Values: 83.0 82.0 107.0 81.0 81.0 82.0 106.0 81.0 81.0 116.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:52:36 INFO - PROCESS | 31405 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 02:52:36 INFO - PROCESS | 31405 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 02:52:36 INFO - PROCESS | 31405 | Values: 85.0 84.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 02:52:36 INFO - PROCESS | 31405 | Values: 50.0 51.0 52.0 51.0 51.0 51.0 52.0 52.0 50.0 49.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:1.12 02:52:36 INFO - PROCESS | 31405 | Values: 59.0 59.0 59.0 62.0 61.0 59.0 59.0 60.0 60.0 61.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:3.46 (4.5%) stddev-sans-first:3.52 02:52:36 INFO - PROCESS | 31405 | Values: 80.0 82.0 74.0 83.0 75.0 75.0 75.0 79.0 75.0 74.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:124.50 stddev:15.19 (12.2%) stddev-sans-first:15.97 02:52:36 INFO - PROCESS | 31405 | Values: 124.0 123.0 132.0 125.0 121.0 118.0 121.0 124.0 169.0 140.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:151.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 02:52:36 INFO - PROCESS | 31405 | Values: 150.0 150.0 151.0 151.0 151.0 152.0 151.0 151.0 154.0 151.0 02:52:36 INFO - PROCESS | 31405 | 02:52:36 INFO - PROCESS | 31405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:1.90 (3.0%) stddev-sans-first:1.56 02:52:36 INFO - PROCESS | 31405 | Values: 66.0 62.0 63.0 62.0 61.0 65.0 61.0 64.0 62.0 60.0 02:52:36 INFO - PROCESS | 31405 | -------- Summary: end -------- 02:52:36 INFO - PROCESS | 31405 | 02:52:37 INFO - TEST-INFO | 31405: exit 0 02:52:37 INFO - TEST-OK | kraken | took 60154ms 02:52:37 INFO - SUITE-END | took 1176s 02:52:38 INFO - Completed test suite (00:19:36) 02:52:38 INFO - javascript benchmark 02:52:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.2906560556676, 3229.5155726641, 3272.1001724525768, 3289.259916518782, 3295.0938491914735, 5524.696141712209, 5604.327480702316, 5605.495505404513, 5616.354119276284, 5620.831375058745, 5639.971800140994, 5700.458456446631, 5711.0, 5712.771489140429, 5733.340665823432, 5130.589552835773, 5146.150885103953, 5179.766910489037, 5209.244659524366, 5222.8694282642855, 5050.898982020358, 5220.6606570572985, 5234.136367499358, 5235.319408476893, 5239.161734122541, 5048.873778155557, 5108.1060814357525, 5108.259302401149, 5115.923261151067, 5154.278401023859, 5158.045761534109, 5201.349831271091, 5201.505856943584, 5233.633645644806, 5247.632665713401, 5062.898742025176, 5088.6692364996525, 5178.637495375326, 5197.714125723083, 5223.0, 5455.536279416255, 5461.9453805461835, 5508.834734957958, 5537.58468114893, 5539.778408863641, 5943.851403714899, 5956.612820166675, 5970.194023806774, 6047.15339852421, 6051.1225872248715, 6115.724792384353, 6119.847003824895, 6124.35694252106, 6126.264848218242, 6132.294786099566, 5454.236406903036, 5462.481064298885, 5494.8076817312, 5504.091824848895, 5538.280023596987, 6030.758769649253, 6035.486983606354, 6038.033914573647, 6040.939590604125, 6041.607295525777, 5759.539236861041, 5773.134029895466, 5773.538116950634, 5835.679037652885, 5845.532357411397, 5831.300243970666, 5884.676342801102, 5909.3204281507315, 5933.525317974551, 5991.131285963511, 6016.729247183887, 6029.728662210211, 6030.276366836008, 6045.6070355426755, 6066.666333351708, 5979.013462778593, 6042.093685947143, 6052.425019623129, 6058.0610005449225, 6064.9090263646085, 4517.164324599959, 4568.383268258743, 4608.769561521911, 4680.461746899082, 4681.9297710534365, 4170.812313445902, 4182.56083111275, 4213.810378532973, 4235.2588297048505, 4251.043515209115, 5798.623089499253, 5808.854778630483, 5812.970935145382, 5820.563457740686, 5846.795362162389, 5875.823725288248, 5923.614965027259, 6096.268447786294, 6106.847328816815, 6114.724837382329, 5518.558515318765, 5583.190437386556, 5607.579431542651, 5633.521150702236, 5668.489835914787, 5037.143685573388, 5037.722925239073, 5041.269015992661, 5102.948970510248, 5169.017886601534, 6018.247719035121, 6158.568900176944, 6192.287886893065, 6213.378662133841, 6221.129041934133, 5873.647581145145, 5901.026330655565, 5939.940600593939, 5951.077582974646, 6047.879042419039, 6190.659513726789, 6210.72051757681, 6211.440970312694, 6216.689165541795, 6278.246610406781, 5816.854578635568, 5817.331006934088, 5820.0, 5835.696870179764, 5857.209276747584, 5894.2926848778425, 5897.764089436375, 5986.551008674454, 6019.4883434908525, 6027.336992930686, 5937.317208521075, 5937.406259374028, 5944.524438045032, 5952.255968003999, 5962.284525856925, 5800.767969281182, 5819.243498345188, 5824.679642619697, 5829.621074630136, 5858.5898987070495, 5638.887222255614, 5678.858028549319, 5820.796272130455, 5824.039033559416, 5904.291485021825, 5944.405559444021, 5954.315253745702, 5956.0, 5958.1658567801405, 5975.850603734942, 5559.971405290034, 5745.368009518866, 5796.855078623068, 5811.331696854747, 5815.04051831443], "value": 5536.599640850899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1529781816365, 628.2806186915981, 647.7376662451705, 649.7595889520878, 686.9523975936693, 35330.82334588327, 46762.0, 48335.75832120835, 48338.0, 48355.27467087997, 47782.76108619461, 48263.75868120654, 48433.273500897514, 48531.757341213335, 48567.27149092766, 8317.500949942993, 8598.183172598594, 8968.282537397008, 9119.270458363348, 9123.361364704473, 10704.090152337061, 10998.780024399508, 11004.504797284142, 11361.488733006992, 11366.71583210418, 11036.392998385085, 11082.113430925507, 11085.612003579876, 11116.221864469491, 11121.443927803577, 10810.67567972962, 10827.566897324137, 10837.403942783143, 10861.294015888981, 10863.076638485738, 10825.0, 10869.67390978272, 10915.235933484659, 10973.451327433677, 10976.231663783537, 44826.55173448289, 45273.0, 45288.54711452876, 45296.54703452956, 45326.54673453256, 3639.1432725310506, 3843.577206507282, 3957.0, 4095.317566993594, 4406.074724307867, 33732.83133584341, 34117.31765364679, 34198.316033679184, 34342.82828585866, 34906.127346816276, 4165.083681590046, 4239.1521695660995, 4319.632831209351, 4349.956500434987, 4392.407025051609, 367730.0, 369656.0, 369660.1516992425, 369848.0, 370060.0, 65907.0, 66748.66625666841, 66839.66580167165, 66920.0, 66929.0, 40781.79609101995, 41561.792191038854, 41910.371344429856, 44074.77962610166, 44269.11461770746, 19167.52081197981, 19342.8065719341, 19367.903160484108, 19419.4174174775, 19421.805781942283, 13608.319584020759, 13821.723565528835, 14329.068610540282, 14764.63088422798, 14934.70130597382, 20889.16443342249, 21141.471463213235, 21181.894090529448, 21297.57404851894, 21384.893075534525, 7450.701971921062, 7585.317321441097, 7709.38324934004, 7791.532508049535, 7861.331786798186, 993.380789313429, 1042.2287507244585, 1100.0759362135684, 1168.8129899216085, 1192.5587532612988, 34824.12939676528, 35097.1225719354, 35147.4727879082, 35505.15976625637, 35520.82239588785, 1009.5154325923451, 1136.3409222650844, 1138.869030061537, 1153.1063425845036, 1209.818527220924, 15886.364545418053, 18005.7299140513, 18252.63494730098, 19040.52398690044, 19297.228110875687, 549097.0, 551009.0, 551773.0, 551812.0, 552810.0, 65151.34848651453, 65551.34448655452, 65613.0, 65692.67153664201, 65797.34202657912, 1313.638749343919, 1357.2806412601337, 1361.5983284931167, 1406.3249640172774, 1451.8185226846645, 27249.86375068112, 30759.846200768854, 31366.0, 31853.681463185072, 34642.65357346394, 56737.730490779904, 63935.68032159809, 63979.36020639734, 63981.680091601105, 63998.36001639924, 499244.0, 503840.0, 503940.0, 504251.0, 505392.0, 27525.31186720348, 28505.0, 28583.14250572486, 29691.703082968892, 29755.107346778765, 51579.0, 51860.481395187075, 52196.21705674342, 52502.0, 52957.77175213359, 43881.0, 43916.0, 43975.340369893835, 44353.0, 45536.316955245034, 40968.975775605846, 44110.55889441064, 46601.53398465972, 46797.0, 48623.02753944972, 44001.77999109984, 47412.59090795436, 47461.0, 47562.28656570085, 47813.28280075732, 45295.320570190815, 45402.31896521621, 45527.089458209986, 45976.77011614921, 46901.530984689714, 35474.0, 36511.45232821563, 36534.63465365312, 36547.81726091352, 36679.449808253434], "value": 21982.511258086593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.0970958816853, 427.86094519281244, 436.28013777267506, 445.3097698567222, 445.65239113491475, 17237.913810430946, 19939.202431902708, 20586.691199632016, 20644.48388790281, 20840.89579552104, 20378.89810550949, 20399.184032638714, 20419.0, 20454.795452045513, 20688.68966965493, 5586.273784408021, 5608.915866261999, 5777.855553611173, 5799.043157878945, 5809.9709501452435, 5691.345495268035, 5761.395053519383, 5769.653820770746, 5770.076787713967, 5771.797987070453, 5551.0, 5708.743106560215, 5740.024195886709, 5745.0, 5749.166370876221, 5690.430956904318, 5734.627249228787, 5762.1068734346245, 5776.740046697909, 5781.768729250846, 5166.741662916839, 5223.73881305937, 5230.843074707726, 5232.581393488512, 5232.659877107976, 23062.308130756104, 23196.53606927869, 23247.53504929892, 23248.0, 23363.182288619988, 2181.727284089489, 2307.5038866643586, 2371.4901296221396, 2549.579319412295, 2684.3691732442862, 9113.498757568332, 10694.30487018349, 11021.283616564897, 11154.944225278903, 11166.162537809616, 1898.0889173196804, 1928.662484065283, 1931.5557421792926, 1950.229659284589, 1963.4404194804556, 90589.0, 93296.53351733266, 94627.52686236594, 94659.52670236674, 94895.0, 11425.542978280942, 11468.254563453516, 11704.590339338083, 11788.29270243788, 11998.880011199952, 16541.421050263183, 16593.253303601126, 16623.168841558116, 16630.916845415937, 16647.0, 8542.701005464778, 8775.122487751174, 8801.911980880237, 8827.779305517413, 8967.686130985385, 8515.19105684959, 8531.95734021326, 8565.700200492953, 8765.07966663504, 8795.780105497413, 4990.6257030722845, 5013.699178049329, 5102.729285467931, 5111.182210846247, 5158.664686795346, 2001.1495114576537, 2019.4850313170048, 2027.9797202027792, 2056.341970569403, 2072.243631074647, 968.9612415503301, 975.5219942228257, 985.6008316631776, 1015.167562598662, 1074.0762943868267, 19347.90326048389, 20176.679681836777, 20333.389998300074, 20847.37457876266, 21201.0, 1007.7430255285002, 1027.111548510533, 1036.8548403223556, 1062.0706881478707, 1114.9777004460027, 10648.307859989076, 11191.440427978569, 11219.214654974074, 11272.323660580392, 11359.659210223706, 527350.0, 528222.0, 531539.0, 535762.0, 561992.0, 96133.5193324029, 97303.0, 100362.0, 101137.0, 103273.48363258287, 1062.2245760594808, 1092.1317552545586, 1115.1079136690614, 1126.5719026769775, 1129.9604513841975, 17640.823591763918, 17850.464486065437, 17907.641847162722, 18116.18477168557, 18420.171092301145, 42862.57137428711, 43095.35356969711, 43358.34962475502, 43904.12191756211, 44034.55965440433, 58914.41085589089, 59406.70296648489, 59446.40553594409, 59757.40242597518, 60444.0, 8643.222110009878, 8693.30453563726, 8754.824903502022, 8790.113116870754, 9087.818243635222, 9529.568750531036, 12718.872811271769, 13010.414531345923, 13210.537631182862, 13274.668133296746, 11491.367974761468, 11868.347240901834, 12028.0, 12053.819192712292, 12102.636920892388, 11428.828567571327, 11539.076873849905, 11547.249428787101, 11639.243449175776, 11663.76672466563, 11661.416929153678, 11695.356755378536, 11778.46996885125, 12024.579139730417, 12172.939135304267, 8029.397795165502, 8637.495482740485, 8693.956530217309, 8956.28349732033, 9043.23132533742, 11334.829977550507, 11646.767064658829, 11723.41382930867, 11740.882591173979, 12173.817392739293], "value": 9553.506601799281, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.7477191947562, 1508.6907184027273, 1517.4992252556656, 1676.5473322203006, 1811.6376724655072, 7481.139668938074, 8242.75271741848, 8540.530270835101, 8568.742937711862, 8576.485410875352, 8402.91597084029, 8562.571871406435, 8770.56147192641, 8771.868421973675, 8776.034636190014, 2437.0, 2474.5298393305306, 2478.8388754730886, 2479.2562231330617, 2480.4295012147218, 2429.5019520998153, 2501.0996041425074, 2503.849769013856, 2504.499100179962, 2508.347829564317, 2439.426734717349, 2449.534588428202, 2473.5300292944285, 2478.021181633254, 2481.801455883534, 2397.712274527059, 2419.9395015124674, 2452.6566280720713, 2459.0286836699493, 2463.2363967170054, 2411.047636183715, 2436.3056528889183, 2458.6189140683223, 2458.791002764767, 2465.654808326836, 8480.067192608809, 8579.914200857975, 8636.179562941574, 8739.126087391274, 8747.868781968276, 5373.113436283009, 5515.09001014832, 5520.944790552083, 5522.0336441123045, 5525.972370138164, 3369.5451114099774, 3518.47222916562, 3530.1527633368064, 3583.7133029357587, 3597.7661452005536, 1135.8636963564343, 1162.4594563527914, 1181.6986668399588, 1209.0750575809514, 1215.3376409856562, 11912.225705329125, 12127.514899404014, 12142.332171730552, 12159.148859579744, 12167.574134905324, 4824.155772739757, 4920.163572192736, 5001.399832020108, 5022.723750193774, 5054.292399064134, 10359.84460233082, 10365.429901355497, 10366.429846358522, 10373.896261037444, 10387.636432724817, 5546.805861794818, 5552.41699621542, 5555.194496797942, 5560.694161821139, 5561.555075593943, 4213.620774130343, 4454.064646424223, 4577.977110114428, 4584.564466375689, 5103.260027296022, 4192.874213773531, 4196.685248606367, 4336.436263285753, 4354.521002689701, 4360.49854266757, 1392.5752645443238, 1434.763264061418, 1436.0, 1442.0820308989018, 1468.4052958551804, 849.002422153979, 866.1035827918074, 870.7648934787572, 879.2789912271876, 892.8616064510011, 5500.642458240201, 5572.944270557324, 5577.972110139504, 5671.404502527175, 5927.318358388754, 497.5099526965936, 502.92456131580553, 507.3024591187118, 510.0462135805992, 511.40166005773335, 3810.447485114643, 3832.5400951885954, 3979.7612143270917, 3980.66647673027, 3997.7401468904427, 9939.353941993748, 10594.15246780271, 10690.572377104983, 10715.946420267848, 10718.08896243828, 10449.425281609585, 10654.733631659115, 10660.893391066145, 10664.466776661136, 10754.731131721614, 8193.79515512105, 8289.958550207331, 8296.626651800683, 8308.418410711192, 8311.33509319253, 5556.277683901067, 5680.829575112753, 5695.601307908407, 5725.51333136688, 5782.739776710142, 9805.509724513888, 9807.656732014346, 9877.209823213982, 9896.406215627085, 9924.603015879284, 8515.446495977742, 8809.207171354608, 9457.905420945703, 9701.611935522782, 9931.255155863484, 7333.266673332624, 7539.962300188464, 7559.244075592397, 7562.319391254813, 7649.235076492307, 8134.918650813416, 8163.1836816320265, 8189.672413103409, 8213.219744124299, 8219.630116644885, 7149.964250178716, 7430.96284518574, 7458.664360103917, 7513.924860751323, 7674.6162691864065, 7408.370288525536, 7437.144728356092, 7444.664990075351, 7501.287377699328, 7516.736914207976, 6932.826679333057, 6935.791926242221, 6991.370776630128, 6999.440044796506, 7000.579965202104, 4877.731724755173, 4935.925961110658, 5017.724025178651, 5025.874353141201, 5145.45972672864, 5011.949880501148, 5114.33513643224, 5195.870103247449, 5242.135047717084, 5324.148136298174], "value": 4569.680882022099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.1310690506472, 352.3252970561375, 357.0805176670074, 360.9296187243487, 362.8802495176592, 5131.717755523445, 5262.342207224097, 5279.577633789298, 5312.2828418163535, 5317.2821669074665, 5070.619703522232, 5195.532402083812, 5215.58275337973, 5217.243499692542, 5222.529972302492, 4169.520505141917, 4174.102567947891, 4180.080382315886, 4181.829087855398, 4186.476690413699, 3885.592012838654, 3947.8223479943326, 4134.937975930364, 4150.024744185129, 4151.605597468236, 4138.0, 4152.813123409439, 4155.522114956773, 4161.750294982296, 4163.271427500191, 4155.127423241123, 4157.438745769343, 4160.604742549453, 4165.875023749292, 4166.791660416998, 3502.842372093262, 3699.130704284491, 3702.8148592570265, 3703.5926048134684, 3710.2764960832646, 5126.538611524943, 5136.152534831748, 5149.433562308143, 5154.252633368141, 5157.0, 4713.552212539803, 4721.24460086388, 4728.787204575802, 4734.597559207472, 4746.288056791474, 5391.541718953894, 5500.779968801243, 5514.558835293167, 5518.586106042023, 5550.361708403505, 4030.45588845505, 4036.3945408189006, 4039.555648878621, 4043.676505879552, 4047.271491131595, 5672.432756724335, 5680.488756011938, 5693.943060569382, 5694.601377903548, 5709.887341683604, 4019.3970904363996, 4091.0386059276047, 4102.400063975052, 4114.341705327133, 4119.443875076886, 4136.234796562646, 4161.771102589326, 4162.708610397303, 4165.91668166635, 4171.666266698657, 4663.487016428258, 4672.299155126758, 4689.577937985598, 4692.6245900327895, 4693.530646935279, 5476.863078422992, 5479.369872464717, 5509.752061157257, 5511.476409741068, 5521.365043020024, 1350.993509835179, 1399.5451478269604, 1400.4538230090272, 1402.656349194454, 1412.7598308287616, 951.7906060666643, 974.2352253480983, 988.5551501824208, 990.1732053735212, 996.7508122969258, 5176.689398636094, 5183.781811274347, 5199.740012999335, 5206.245094461282, 5207.0, 5382.354117505846, 5426.131818908955, 5447.210154527571, 5454.972725136428, 5461.563074953994, 5134.2298655201275, 5163.690178589297, 5215.843524694265, 5226.439044867987, 5425.701586412785, 2876.2521744346623, 2907.7433274732434, 2914.2460374945895, 2919.3723349479965, 2919.5182794838615, 5726.312842458931, 5739.0, 5754.712264386764, 5773.740181691834, 5782.0, 5446.537044351196, 5630.380658127603, 5655.390856452061, 5656.575756818255, 5678.659280443187, 5758.882399084675, 5768.817392434625, 5771.912027065499, 5779.566532510079, 5780.88438231233, 5388.865278368072, 5540.501354877919, 5563.221149039218, 5587.876606889356, 5595.412481689364, 5430.647007944471, 5444.482774136451, 5446.945530544803, 5452.6183167177915, 5473.28847249855, 5719.399463056486, 5740.6268592541355, 5747.752519826452, 5758.0, 5782.311225280265, 3898.187342885572, 4009.8547277206553, 4013.458183145238, 4015.8393664253103, 4029.979850100731, 5454.854480559127, 5469.671819690831, 5487.341519017744, 5497.917531237114, 5511.559075273888, 5370.777533479881, 5396.244525766474, 5412.702301373305, 5413.350397952271, 5426.158945363475, 5180.61145414103, 5332.546733527538, 5450.5367043801725, 5481.232627432242, 5500.477454641963, 5539.950218419211, 5543.3902270751, 5545.445455454423, 5546.140348246028, 5551.444855514416, 5374.704391258362, 5620.4660557247, 5621.943780562142, 5624.606277560531, 5646.520045796154, 5452.291202143696, 5461.590380721383, 5470.480304371078, 5481.984908300339, 5497.945020549743], "value": 4205.858719340185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.4838619421627, 727.5416487612803, 781.597477299191, 787.8306164174701, 811.1685522339604, 15650.686986260267, 16444.506664800047, 16451.670966580663, 16458.341666333334, 16493.505194844158, 15114.546563603082, 15259.542213733577, 15261.77107343388, 15262.160581168031, 15264.923675381608, 720.0890873045602, 733.3180142467503, 820.995895020524, 841.188253335531, 843.2158092973548, 847.3644766425181, 849.817289282804, 852.4586887326531, 853.1042405474227, 853.9837593263996, 890.4746199742151, 894.6466145872377, 898.4115404410122, 898.7034278688018, 901.6393442622971, 765.0857225615392, 888.1873086126187, 890.2655309369763, 890.9465432074096, 891.0821853490914, 574.2936188488142, 654.8919428294325, 667.3760034367882, 669.0265663459654, 670.1991120610872, 14480.493182738554, 14482.058666186664, 14523.78214326786, 14532.782008269884, 14537.273136343141, 13654.658633534142, 13914.652133696638, 14065.64835879101, 14066.437342506288, 14111.294435278298, 12579.93710031444, 12678.936605316914, 12708.809367859489, 12821.294828784414, 12855.807162892565, 4210.094829611618, 4225.471816022997, 4227.175700738358, 4272.444582204324, 4308.332208507686, 66761.99857002101, 67416.0, 67447.66276168637, 67560.3243967559, 68099.0, 10783.406912619881, 10823.891761082446, 10851.51168197433, 11127.72180695489, 11544.88455115455, 21206.681899771516, 21241.468963276042, 21294.467638309165, 21365.35903922885, 21406.25078122258, 8317.584120794058, 8551.700690475804, 8608.784780380416, 8635.395522313504, 8667.393282470166, 4767.427908650984, 4815.470298267188, 4853.757312134379, 4901.264810278487, 4983.152864013126, 3447.1554469155217, 3547.396942519778, 3551.076720052753, 3554.289142171576, 3555.040139162412, 608.0332271687948, 610.4475449718012, 615.7290792051483, 627.4039662320813, 627.7269387816315, 659.1167835100988, 662.4104546953215, 688.8702527854323, 714.3642158478958, 736.4035131543467, 8555.657773689107, 8951.507667078373, 8993.865092023625, 9035.277177825757, 9097.863532047024, 571.6455797405636, 628.2680677011231, 679.3987321220756, 708.9610071446017, 721.469719755979, 4276.87169384919, 4476.574725401082, 4496.752678602643, 4521.0, 4622.375979242759, 87158.0, 90057.54971225232, 93516.53241733748, 94918.52540737252, 98546.50726746464, 70651.64674176596, 72371.27628723645, 80905.19094808976, 81084.59457702674, 81719.0, 58402.415975840544, 59215.335309911155, 68186.0, 69992.0, 70006.0, 9538.189253913217, 9887.0, 10329.729514082977, 10391.84412233802, 10511.842322365017, 34043.0, 38274.425883612326, 46339.536604633526, 47750.283745744535, 48648.2702759466, 57203.42796572147, 57397.42602573921, 59065.70467147637, 63759.0, 68153.97769033369, 12257.38713064361, 12322.876771232173, 12798.232106073665, 13029.674258143623, 13186.80219796723, 14512.0, 14640.121592704472, 14925.477608283658, 15018.924905375403, 15587.610309742347, 11350.94324528372, 11749.236299640495, 13138.540151094665, 13571.728565428439, 14435.78346324827, 11321.660350189508, 12531.18547294423, 12660.683482913, 12753.0, 12818.61544153677, 11974.64076077719, 12248.75502489963, 13226.0, 13304.201747895157, 13424.328783560588, 9868.259880509135, 9944.45305508204, 10193.592256309665, 10378.792424151627, 10721.678349649523, 10218.642347517802, 10258.230632702427, 10263.178945684476, 10338.431386273827, 10669.986351296615], "value": 7253.958740256881, "unit": "score"}], "name": "dromaeo_css", "value": 7384.276770618222, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 123.0, 159.0, 119.0, 118.0, 117.0, 119.0, 144.0, 123.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 159.0, 163.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 110.0, 77.0, 74.0, 75.0, 75.0, 105.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 81.0, 81.0, 82.0, 106.0, 81.0, 81.0, 116.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.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, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 51.0, 51.0, 51.0, 52.0, 52.0, 50.0, 49.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 62.0, 61.0, 59.0, 59.0, 60.0, 60.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 74.0, 83.0, 75.0, 75.0, 75.0, 79.0, 75.0, 74.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 132.0, 125.0, 121.0, 118.0, 121.0, 124.0, 169.0, 140.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 151.0, 152.0, 151.0, 151.0, 154.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 62.0, 61.0, 65.0, 61.0, 64.0, 62.0, 60.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1449.1000000000001, "alertThreshold": 2.0}]} 02:52:38 INFO - Return code: 0 02:52:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:52:38 INFO - # TBPL SUCCESS # 02:52:38 INFO - Running post-action listener: _resource_record_post_action 02:52:38 INFO - [mozharness: 2016-12-24 10:52:38.213834Z] Finished run-tests step (success) 02:52:38 INFO - Running post-run listener: _resource_record_post_run 02:52:38 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365522944; Read time: 36; Write time: 454956 02:52:38 INFO - TinderboxPrint: CPU usage
13.0% 02:52:38 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 02:52:38 INFO - TinderboxPrint: I/O write bytes / time
365,522,944 / 454,956 02:52:38 INFO - TinderboxPrint: CPU idle
8,283.7 (87.0%) 02:52:38 INFO - TinderboxPrint: CPU user
1,191.5 (12.5%) 02:52:38 INFO - TinderboxPrint: Swap in / out
0 / 0 02:52:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118657024; Read time: 0; Write time: 197520 02:52:38 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246861824; Read time: 20; Write time: 257436 02:52:38 INFO - Running post-run listener: _upload_blobber_files 02:52:38 INFO - Blob upload gear active. 02:52:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:52:38 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 02:52:38 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'] 02:52:38 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 02:52:39 INFO - (blobuploader) - INFO - Open directory for files ... 02:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:42 INFO - (blobuploader) - INFO - Done attempting. 02:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:43 INFO - (blobuploader) - INFO - Done attempting. 02:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:43 INFO - (blobuploader) - INFO - Done attempting. 02:52:43 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:43 INFO - Return code: 0 02:52:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08fb70f0e3519a50f7d903e06c8c833800c51138478e46dba0eb6b7fa4c5228d55d132f03fba78b5aa0c44db2f8b3eba20ad3365baea260a436ee3dadf31c4a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8639265749cd332553ccf8000983a74776dac87761de59de7f011f8b87dfd3d34a50838746fc4a155761237f6fa30212f0372043e130995007839a3d3a1ee8bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e056143e7fcecc38ed6e4e9278f5b5d2cbda2177b600d6bd87a5dfd55f80d2dd1388fdbb88d505f39f0d5b4352d31585b9db23bd753f32d148006ab5bfa4ee6e"} 02:52:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:43 INFO - Contents: 02:52:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08fb70f0e3519a50f7d903e06c8c833800c51138478e46dba0eb6b7fa4c5228d55d132f03fba78b5aa0c44db2f8b3eba20ad3365baea260a436ee3dadf31c4a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8639265749cd332553ccf8000983a74776dac87761de59de7f011f8b87dfd3d34a50838746fc4a155761237f6fa30212f0372043e130995007839a3d3a1ee8bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e056143e7fcecc38ed6e4e9278f5b5d2cbda2177b600d6bd87a5dfd55f80d2dd1388fdbb88d505f39f0d5b4352d31585b9db23bd753f32d148006ab5bfa4ee6e"} 02:52:43 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:43 INFO - Copying logs to upload dir... 02:52:43 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.795467 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-24 02:52:43.377148) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-24 02:52:43.382718) ========= 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=af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009 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/08fb70f0e3519a50f7d903e06c8c833800c51138478e46dba0eb6b7fa4c5228d55d132f03fba78b5aa0c44db2f8b3eba20ad3365baea260a436ee3dadf31c4a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8639265749cd332553ccf8000983a74776dac87761de59de7f011f8b87dfd3d34a50838746fc4a155761237f6fa30212f0372043e130995007839a3d3a1ee8bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e056143e7fcecc38ed6e4e9278f5b5d2cbda2177b600d6bd87a5dfd55f80d2dd1388fdbb88d505f39f0d5b4352d31585b9db23bd753f32d148006ab5bfa4ee6e"} build_url:https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011568 build_url: 'https://queue.taskcluster.net/v1/task/VE3DghuxSw-brz4y6MJQkw/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/08fb70f0e3519a50f7d903e06c8c833800c51138478e46dba0eb6b7fa4c5228d55d132f03fba78b5aa0c44db2f8b3eba20ad3365baea260a436ee3dadf31c4a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8639265749cd332553ccf8000983a74776dac87761de59de7f011f8b87dfd3d34a50838746fc4a155761237f6fa30212f0372043e130995007839a3d3a1ee8bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e056143e7fcecc38ed6e4e9278f5b5d2cbda2177b600d6bd87a5dfd55f80d2dd1388fdbb88d505f39f0d5b4352d31585b9db23bd753f32d148006ab5bfa4ee6e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-24 02:52:43.407816) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:52:43.408140) ========= 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=af724c981e2a0f424dbabf99000001e7-1482557104.416191-310291009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 02:52:43.493203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-24 02:52:43.493537) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-24 02:52:43.493845) ========= ========= Total master_lag: 0.16 =========