builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1475177424.82 results: success (0) buildid: 20160929093015 builduid: 8adc7087bca142beb43d2eb7fec053af revision: 2027e4ba3584e9bb84ca452ed4d50d180b3cae62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:24.821471) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:24.822625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:24.823364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:24.840023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:24.840723) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 12:30:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-09-29 12:30:25 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:24.978620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:24.979431) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022224 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:25.033426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:30:25.034217) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2027e4ba3584e9bb84ca452ed4d50d180b3cae62 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2027e4ba3584e9bb84ca452ed4d50d180b3cae62 --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=6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 12:30:25,308 truncating revision to first 12 chars 2016-09-29 12:30:25,308 Setting DEBUG logging. 2016-09-29 12:30:25,308 attempt 1/10 2016-09-29 12:30:25,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2027e4ba3584?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 12:30:26,509 unpacking tar archive at: fx-team-2027e4ba3584/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590105 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:30:26.639071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:26.639436) ========= script_repo_revision: 2027e4ba3584e9bb84ca452ed4d50d180b3cae62 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:26.639919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:26.640224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:30:26.649346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-29 12:30:26.649694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:30:27 INFO - MultiFileLogger online at 20160929 12:30:27 in /builds/slave/test 12:30:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:30:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:30:27 INFO - {'append_to_log': False, 12:30:27 INFO - 'base_work_dir': '/builds/slave/test', 12:30:27 INFO - 'blob_upload_branch': 'Fx-Team', 12:30:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:30:27 INFO - 'branch': 'Fx-Team', 12:30:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:30:27 INFO - 'config_files': ('talos/linux_config.py',), 12:30:27 INFO - 'default_actions': ('clobber', 12:30:27 INFO - 'read-buildbot-config', 12:30:27 INFO - 'download-and-extract', 12:30:27 INFO - 'populate-webroot', 12:30:27 INFO - 'create-virtualenv', 12:30:27 INFO - 'install', 12:30:27 INFO - 'run-tests'), 12:30:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:30:27 INFO - 'download_minidump_stackwalk': True, 12:30:27 INFO - 'download_symbols': 'ondemand', 12:30:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:30:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:30:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:30:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:30:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:30:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:30:27 INFO - 'installer_path': 'installer.exe', 12:30:27 INFO - 'log_level': 'info', 12:30:27 INFO - 'log_name': 'talos', 12:30:27 INFO - 'log_to_console': True, 12:30:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:30:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:30:27 INFO - 'opt_config_files': (), 12:30:27 INFO - 'pip_index': False, 12:30:27 INFO - 'sps_profile': False, 12:30:27 INFO - 'sps_profile_interval': 0, 12:30:27 INFO - 'suite': 'dromaeojs-e10s', 12:30:27 INFO - 'system_bits': '32', 12:30:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:30:27 INFO - 'title': 'talos-linux64-ix-023', 12:30:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:30:27 INFO - 'use_talos_json': True, 12:30:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:30:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:30:27 INFO - 'work_dir': 'build'} 12:30:27 INFO - [mozharness: 2016-09-29 19:30:27.026988Z] Running clobber step. 12:30:27 INFO - Running pre-action listener: _resource_record_pre_action 12:30:27 INFO - Running main action method: clobber 12:30:27 INFO - rmtree: /builds/slave/test/build 12:30:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:30:27 INFO - Running post-action listener: _resource_record_post_action 12:30:27 INFO - [mozharness: 2016-09-29 19:30:27.481723Z] Finished clobber step (success) 12:30:27 INFO - [mozharness: 2016-09-29 19:30:27.481822Z] Running read-buildbot-config step. 12:30:27 INFO - Running pre-action listener: _resource_record_pre_action 12:30:27 INFO - Running main action method: read_buildbot_config 12:30:27 INFO - Using buildbot properties: 12:30:27 INFO - { 12:30:27 INFO - "project": "", 12:30:27 INFO - "product": "firefox", 12:30:27 INFO - "script_repo_revision": "production", 12:30:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:30:27 INFO - "repository": "", 12:30:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:30:27 INFO - "buildid": "20160929093015", 12:30:27 INFO - "pgo_build": "True", 12:30:27 INFO - "basedir": "/builds/slave/test", 12:30:27 INFO - "buildnumber": 810, 12:30:27 INFO - "slavename": "talos-linux64-ix-023", 12:30:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:30:27 INFO - "platform": "ubuntu64_hw", 12:30:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:30:27 INFO - "branch": "fx-team", 12:30:27 INFO - "repo_path": "integration/fx-team", 12:30:27 INFO - "revision": "2027e4ba3584e9bb84ca452ed4d50d180b3cae62", 12:30:27 INFO - "stage_platform": "linux64-pgo", 12:30:27 INFO - "builduid": "8adc7087bca142beb43d2eb7fec053af", 12:30:27 INFO - "slavebuilddir": "test" 12:30:27 INFO - } 12:30:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:30:27 INFO - Running post-action listener: _resource_record_post_action 12:30:27 INFO - [mozharness: 2016-09-29 19:30:27.484249Z] Finished read-buildbot-config step (success) 12:30:27 INFO - [mozharness: 2016-09-29 19:30:27.484338Z] Running download-and-extract step. 12:30:27 INFO - Running pre-action listener: _resource_record_pre_action 12:30:27 INFO - Running main action method: download_and_extract 12:30:27 INFO - mkdir: /builds/slave/test/build/tests 12:30:27 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')]} 12:30:27 INFO - trying https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:30:27 INFO - Downloading https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:30:28 INFO - Downloaded 1361 bytes. 12:30:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:30:28 INFO - Using the following test package requirements: 12:30:28 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:30:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:30:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'jsshell-linux-x86_64.zip'], 12:30:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:30:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:30:28 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:30:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:30:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:30:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:30:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:30:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:30:28 INFO - Fetch https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:30:29 INFO - Http code: 200 12:30:29 INFO - Content-Encoding: None 12:30:29 INFO - Content-Type: application/zip 12:30:29 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 12:30:29 INFO - x-amz-cf-id: hZjtHCPSy9L1O7AKXQeAPQaFZZPLrsG7Tw07EAGklY5VY6S6SwipkA== 12:30:29 INFO - x-amz-version-id: THs8rw7HiQQtduZ0Yc_wZtH1UMCHFQY0 12:30:29 INFO - x-cache: Hit from cloudfront 12:30:29 INFO - Expected file size: 21988995 12:30:29 INFO - Obtained file size: 21988995 12:30:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:30:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:30:33 INFO - Fetch https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:30:34 INFO - Http code: 200 12:30:34 INFO - Content-Encoding: None 12:30:34 INFO - Content-Type: application/zip 12:30:34 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 12:30:34 INFO - x-amz-cf-id: d2LN-p7QqKeihY72v6wv7BssFQeRgoi3v4TqZ_XsLwucmei09OSSBQ== 12:30:34 INFO - x-amz-version-id: THs8rw7HiQQtduZ0Yc_wZtH1UMCHFQY0 12:30:34 INFO - x-cache: Hit from cloudfront 12:30:34 INFO - Expected file size: 21988995 12:30:34 INFO - Obtained file size: 21988995 12:30:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:30:39 INFO - Fetch https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:30:39 INFO - Http code: 200 12:30:39 INFO - Content-Encoding: None 12:30:39 INFO - Content-Type: application/zip 12:30:39 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 12:30:39 INFO - x-amz-cf-id: gtJsRMwnAEcz7tOY3DV9SOlnwPhMDuyTAelrnNLE5d5UWvLEAmeJXg== 12:30:39 INFO - x-amz-version-id: bUMf3M2XwX.SEDlt.Y5z68JffwjXpHsq 12:30:39 INFO - x-cache: Hit from cloudfront 12:30:39 INFO - Expected file size: 14414067 12:30:39 INFO - Obtained file size: 14414067 12:30: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')]} 12:30:40 INFO - trying https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:30:40 INFO - Downloading https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:30:41 INFO - Downloaded 59747855 bytes. 12:30:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:30:41 INFO - mkdir: /builds/slave/test/properties 12:30:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:30:41 INFO - Writing to file /builds/slave/test/properties/build_url 12:30:41 INFO - Contents: 12:30:41 INFO - build_url:https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:30:41 INFO - Running post-action listener: _resource_record_post_action 12:30:41 INFO - Running post-action listener: set_extra_try_arguments 12:30:41 INFO - [mozharness: 2016-09-29 19:30:41.941961Z] Finished download-and-extract step (success) 12:30:41 INFO - [mozharness: 2016-09-29 19:30:41.942186Z] Running populate-webroot step. 12:30:41 INFO - Running pre-action listener: _resource_record_pre_action 12:30:41 INFO - Running main action method: populate_webroot 12:30:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:30:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:30:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:30:41 INFO - '--tppagecycles', 12:30:41 INFO - '7'], 12:30:41 INFO - 'tests': ['tsvgm']}}, 12:30:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:30:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:30:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:30:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:30:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['damp', 'tps']}, 12:30:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'tests': ['damp', 'tps']}, 12:30:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['dromaeo_dom']}, 12:30:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:30:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['basic_compositor_video']}, 12:30:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:30:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other-e10s': {'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tsvgx', 12:30:41 INFO - 'tsvgr_opacity', 12:30:41 INFO - 'tart', 12:30:41 INFO - 'tscrollx', 12:30:41 INFO - 'cart']}, 12:30:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:30:41 INFO - 'tsvgr_opacity', 12:30:41 INFO - 'tart', 12:30:41 INFO - 'tscrollx', 12:30:41 INFO - 'cart']}, 12:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tp5o']}, 12:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'tests': ['tp5o']}, 12:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s', 12:30:41 INFO - '--xperf_path', 12:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:41 INFO - 'tests': ['tp5n']}, 12:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--xperf_path', 12:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:41 INFO - 'tests': ['tp5n']}}, 12:30:41 INFO - 'talos.zip': {'path': '', 12:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:30:41 INFO - Running post-action listener: _resource_record_post_action 12:30:41 INFO - [mozharness: 2016-09-29 19:30:41.962118Z] Finished populate-webroot step (success) 12:30:41 INFO - [mozharness: 2016-09-29 19:30:41.962206Z] Running create-virtualenv step. 12:30:41 INFO - Running pre-action listener: _resource_record_pre_action 12:30:41 INFO - Running main action method: create_virtualenv 12:30:41 INFO - Creating virtualenv /builds/slave/test/build/venv 12:30:41 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 12:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:30:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:30:42 INFO - Using real prefix '/usr' 12:30:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:30:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:30:44 INFO - Installing pip.................done. 12:30:44 INFO - Return code: 0 12:30:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:30:44 INFO - Reading from file tmpfile_stdout 12:30:44 INFO - Output received: 12:30:44 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) 12:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30: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', 'pip>=1.5'] in /builds/slave/test/build 12:30: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 pip>=1.5 12:30:44 INFO - Using env: {'DISPLAY': ':0', 12:30:44 INFO - 'HOME': '/home/cltbld', 12:30:44 INFO - 'LANG': 'en_US.UTF-8', 12:30:44 INFO - 'LANGUAGE': 'en_US:en', 12:30:44 INFO - 'LOGNAME': 'cltbld', 12:30:44 INFO - 'MAIL': '/var/mail/cltbld', 12:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:44 INFO - 'MOZ_NO_REMOTE': '1', 12:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:44 INFO - 'NO_EM_RESTART': '1', 12:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:44 INFO - 'PWD': '/builds/slave/test', 12:30:44 INFO - 'SHELL': '/bin/bash', 12:30:44 INFO - 'SHLVL': '1', 12:30:44 INFO - 'TERM': 'linux', 12:30:44 INFO - 'TMOUT': '86400', 12:30:44 INFO - 'USER': 'cltbld', 12:30:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:44 INFO - '_': '/tools/buildbot/bin/python'} 12:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:44 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 12:30:44 INFO - Cleaning up... 12:30:44 INFO - Return code: 0 12:30:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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', '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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:30: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 psutil>=3.1.1 12:30:44 INFO - Using env: {'DISPLAY': ':0', 12:30:44 INFO - 'HOME': '/home/cltbld', 12:30:44 INFO - 'LANG': 'en_US.UTF-8', 12:30:44 INFO - 'LANGUAGE': 'en_US:en', 12:30:44 INFO - 'LOGNAME': 'cltbld', 12:30:44 INFO - 'MAIL': '/var/mail/cltbld', 12:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:44 INFO - 'MOZ_NO_REMOTE': '1', 12:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:44 INFO - 'NO_EM_RESTART': '1', 12:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:44 INFO - 'PWD': '/builds/slave/test', 12:30:44 INFO - 'SHELL': '/bin/bash', 12:30:44 INFO - 'SHLVL': '1', 12:30:44 INFO - 'TERM': 'linux', 12:30:44 INFO - 'TMOUT': '86400', 12:30:44 INFO - 'USER': 'cltbld', 12:30:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:44 INFO - '_': '/tools/buildbot/bin/python'} 12:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:45 INFO - Downloading/unpacking psutil>=3.1.1 12:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:47 INFO - Installing collected packages: psutil 12:30:47 INFO - Running setup.py install for psutil 12:30:47 INFO - building 'psutil._psutil_linux' extension 12:30:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:30:47 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 12:30:47 INFO - building 'psutil._psutil_posix' extension 12:30:47 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 12:30:47 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 12:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:47 INFO - Successfully installed psutil 12:30:47 INFO - Cleaning up... 12:30:47 INFO - Return code: 0 12:30:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:30:47 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')]} 12:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:47 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')]} 12:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:47 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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30:47 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 12:30:47 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 12:30:47 INFO - Using env: {'DISPLAY': ':0', 12:30:47 INFO - 'HOME': '/home/cltbld', 12:30:47 INFO - 'LANG': 'en_US.UTF-8', 12:30:47 INFO - 'LANGUAGE': 'en_US:en', 12:30:47 INFO - 'LOGNAME': 'cltbld', 12:30:47 INFO - 'MAIL': '/var/mail/cltbld', 12:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:47 INFO - 'MOZ_NO_REMOTE': '1', 12:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:47 INFO - 'NO_EM_RESTART': '1', 12:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:47 INFO - 'PWD': '/builds/slave/test', 12:30:47 INFO - 'SHELL': '/bin/bash', 12:30:47 INFO - 'SHLVL': '1', 12:30:47 INFO - 'TERM': 'linux', 12:30:47 INFO - 'TMOUT': '86400', 12:30:47 INFO - 'USER': 'cltbld', 12:30:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:47 INFO - '_': '/tools/buildbot/bin/python'} 12:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:30:47 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 12:30:47 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 12:30:47 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 12:30:47 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 12:30:47 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 12:30:47 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 12:30:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:30:49 INFO - Installing collected packages: mozsystemmonitor 12:30:49 INFO - Running setup.py install for mozsystemmonitor 12:30:49 INFO - Successfully installed mozsystemmonitor 12:30:49 INFO - Cleaning up... 12:30:50 INFO - Return code: 0 12:30:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:30:50 INFO - Using env: {'DISPLAY': ':0', 12:30:50 INFO - 'HOME': '/home/cltbld', 12:30:50 INFO - 'LANG': 'en_US.UTF-8', 12:30:50 INFO - 'LANGUAGE': 'en_US:en', 12:30:50 INFO - 'LOGNAME': 'cltbld', 12:30:50 INFO - 'MAIL': '/var/mail/cltbld', 12:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:50 INFO - 'MOZ_NO_REMOTE': '1', 12:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:50 INFO - 'NO_EM_RESTART': '1', 12:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:50 INFO - 'PWD': '/builds/slave/test', 12:30:50 INFO - 'SHELL': '/bin/bash', 12:30:50 INFO - 'SHLVL': '1', 12:30:50 INFO - 'TERM': 'linux', 12:30:50 INFO - 'TMOUT': '86400', 12:30:50 INFO - 'USER': 'cltbld', 12:30:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:50 INFO - '_': '/tools/buildbot/bin/python'} 12:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:50 INFO - Downloading/unpacking jsonschema==2.5.1 12:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:30:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:30:52 INFO - warning: no files found matching '*.txt' 12:30:52 INFO - no previously-included directories found matching 'build' 12:30:52 INFO - no previously-included directories found matching 'dist' 12:30:52 INFO - no previously-included directories found matching '.git*' 12:30:52 INFO - Installing collected packages: jsonschema, functools32 12:30:52 INFO - Running setup.py install for functools32 12:30:52 INFO - warning: no files found matching '*.txt' 12:30:52 INFO - no previously-included directories found matching 'build' 12:30:52 INFO - no previously-included directories found matching 'dist' 12:30:52 INFO - no previously-included directories found matching '.git*' 12:30:52 INFO - Successfully installed jsonschema functools32 12:30:52 INFO - Cleaning up... 12:30:52 INFO - Return code: 0 12:30:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:30:52 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')]} 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 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')]} 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30:52 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 12:30:52 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 12:30:52 INFO - Using env: {'DISPLAY': ':0', 12:30:52 INFO - 'HOME': '/home/cltbld', 12:30:52 INFO - 'LANG': 'en_US.UTF-8', 12:30:52 INFO - 'LANGUAGE': 'en_US:en', 12:30:52 INFO - 'LOGNAME': 'cltbld', 12:30:52 INFO - 'MAIL': '/var/mail/cltbld', 12:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:52 INFO - 'MOZ_NO_REMOTE': '1', 12:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:52 INFO - 'NO_EM_RESTART': '1', 12:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:52 INFO - 'PWD': '/builds/slave/test', 12:30:52 INFO - 'SHELL': '/bin/bash', 12:30:52 INFO - 'SHLVL': '1', 12:30:52 INFO - 'TERM': 'linux', 12:30:52 INFO - 'TMOUT': '86400', 12:30:52 INFO - 'USER': 'cltbld', 12:30:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:52 INFO - '_': '/tools/buildbot/bin/python'} 12:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:30:52 INFO - Cleaning up... 12:30:52 INFO - Return code: 0 12:30:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:30:52 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')]} 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 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')]} 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30:52 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 12:30:52 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 12:30:52 INFO - Using env: {'DISPLAY': ':0', 12:30:52 INFO - 'HOME': '/home/cltbld', 12:30:52 INFO - 'LANG': 'en_US.UTF-8', 12:30:52 INFO - 'LANGUAGE': 'en_US:en', 12:30:52 INFO - 'LOGNAME': 'cltbld', 12:30:52 INFO - 'MAIL': '/var/mail/cltbld', 12:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:52 INFO - 'MOZ_NO_REMOTE': '1', 12:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:52 INFO - 'NO_EM_RESTART': '1', 12:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:52 INFO - 'PWD': '/builds/slave/test', 12:30:52 INFO - 'SHELL': '/bin/bash', 12:30:52 INFO - 'SHLVL': '1', 12:30:52 INFO - 'TERM': 'linux', 12:30:52 INFO - 'TMOUT': '86400', 12:30:52 INFO - 'USER': 'cltbld', 12:30:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:52 INFO - '_': '/tools/buildbot/bin/python'} 12:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:54 INFO - Downloading blobuploader-1.2.4.tar.gz 12:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:30:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:30:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:55 INFO - Downloading docopt-0.6.1.tar.gz 12:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:30:55 INFO - Installing collected packages: blobuploader, requests, docopt 12:30:55 INFO - Running setup.py install for blobuploader 12:30:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:30:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:30:55 INFO - Running setup.py install for requests 12:30:56 INFO - Running setup.py install for docopt 12:30:56 INFO - Successfully installed blobuploader requests docopt 12:30:56 INFO - Cleaning up... 12:30:56 INFO - Return code: 0 12:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:56 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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30:56 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 12:30:56 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 12:30:56 INFO - Using env: {'DISPLAY': ':0', 12:30:56 INFO - 'HOME': '/home/cltbld', 12:30:56 INFO - 'LANG': 'en_US.UTF-8', 12:30:56 INFO - 'LANGUAGE': 'en_US:en', 12:30:56 INFO - 'LOGNAME': 'cltbld', 12:30:56 INFO - 'MAIL': '/var/mail/cltbld', 12:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:56 INFO - 'MOZ_NO_REMOTE': '1', 12:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:56 INFO - 'NO_EM_RESTART': '1', 12:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:56 INFO - 'PWD': '/builds/slave/test', 12:30:56 INFO - 'SHELL': '/bin/bash', 12:30:56 INFO - 'SHLVL': '1', 12:30:56 INFO - 'TERM': 'linux', 12:30:56 INFO - 'TMOUT': '86400', 12:30:56 INFO - 'USER': 'cltbld', 12:30:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:56 INFO - '_': '/tools/buildbot/bin/python'} 12:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:30:56 INFO - Running setup.py (path:/tmp/pip-MyBlsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:30:56 INFO - Running setup.py (path:/tmp/pip-fBPz6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:30:56 INFO - Running setup.py (path:/tmp/pip-JqnI9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:30:56 INFO - Running setup.py (path:/tmp/pip-HQDYjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:30:56 INFO - Running setup.py (path:/tmp/pip-wMwwmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:30:56 INFO - Running setup.py (path:/tmp/pip-MlcVz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:30:57 INFO - Running setup.py (path:/tmp/pip-YBbzOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:30:57 INFO - Running setup.py (path:/tmp/pip-ITu2PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:30:57 INFO - Running setup.py (path:/tmp/pip-uLTtCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:30:57 INFO - Running setup.py (path:/tmp/pip-vksPhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:30:57 INFO - Running setup.py (path:/tmp/pip-a7dN9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:30:57 INFO - Running setup.py (path:/tmp/pip-eZcmLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:30:57 INFO - Running setup.py (path:/tmp/pip-8jycNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:30:57 INFO - Running setup.py (path:/tmp/pip-xFApWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:57 INFO - Running setup.py (path:/tmp/pip-oZqxyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:30:57 INFO - Running setup.py (path:/tmp/pip-PZ4xAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:30:57 INFO - Running setup.py (path:/tmp/pip-sSSgem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:30:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:30:57 INFO - Running setup.py install for manifestparser 12:30:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:30:57 INFO - Running setup.py install for mozcrash 12:30:57 INFO - Running setup.py install for mozdebug 12:30:58 INFO - Running setup.py install for mozdevice 12:30:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Running setup.py install for mozfile 12:30:58 INFO - Running setup.py install for mozhttpd 12:30:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Running setup.py install for mozinfo 12:30:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Running setup.py install for mozInstall 12:30:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Running setup.py install for mozleak 12:30:58 INFO - Running setup.py install for mozlog 12:30:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Running setup.py install for moznetwork 12:30:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:30:58 INFO - Running setup.py install for mozprocess 12:30:59 INFO - Running setup.py install for mozprofile 12:30:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:30:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:30:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:30:59 INFO - Running setup.py install for mozrunner 12:30:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:30:59 INFO - Running setup.py install for mozscreenshot 12:30:59 INFO - Running setup.py install for moztest 12:30:59 INFO - Running setup.py install for mozversion 12:30:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:30:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:30:59 INFO - Cleaning up... 12:30:59 INFO - Return code: 0 12:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:59 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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:30:59 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 12:30:59 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 12:30:59 INFO - Using env: {'DISPLAY': ':0', 12:30:59 INFO - 'HOME': '/home/cltbld', 12:30:59 INFO - 'LANG': 'en_US.UTF-8', 12:30:59 INFO - 'LANGUAGE': 'en_US:en', 12:30:59 INFO - 'LOGNAME': 'cltbld', 12:30:59 INFO - 'MAIL': '/var/mail/cltbld', 12:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:59 INFO - 'MOZ_NO_REMOTE': '1', 12:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:59 INFO - 'NO_EM_RESTART': '1', 12:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:59 INFO - 'PWD': '/builds/slave/test', 12:30:59 INFO - 'SHELL': '/bin/bash', 12:30:59 INFO - 'SHLVL': '1', 12:30:59 INFO - 'TERM': 'linux', 12:30:59 INFO - 'TMOUT': '86400', 12:30:59 INFO - 'USER': 'cltbld', 12:30:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:59 INFO - '_': '/tools/buildbot/bin/python'} 12:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:30:59 INFO - Running setup.py (path:/tmp/pip-tMxAO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:30:59 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)) 12:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:30:59 INFO - Running setup.py (path:/tmp/pip-gwWV0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:30:59 INFO - Running setup.py (path:/tmp/pip-htd5l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:00 INFO - Running setup.py (path:/tmp/pip-lt_iI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:00 INFO - Running setup.py (path:/tmp/pip-KFzgmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:00 INFO - Running setup.py (path:/tmp/pip-pPh5G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:00 INFO - Running setup.py (path:/tmp/pip-l5MTeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:00 INFO - Running setup.py (path:/tmp/pip-NVGKbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:00 INFO - Running setup.py (path:/tmp/pip-UMq3p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:00 INFO - Running setup.py (path:/tmp/pip-84EXtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:00 INFO - Running setup.py (path:/tmp/pip-QA9QDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:00 INFO - Running setup.py (path:/tmp/pip-9qb6Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:00 INFO - Running setup.py (path:/tmp/pip-qXGI6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:00 INFO - Running setup.py (path:/tmp/pip-IF4Zov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:00 INFO - Running setup.py (path:/tmp/pip-zPQXy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:00 INFO - Running setup.py (path:/tmp/pip-p9Z0jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:00 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)) 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:00 INFO - Running setup.py (path:/tmp/pip-f95uVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:02 INFO - Downloading blessings-1.6.tar.gz 12:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:03 INFO - Installing collected packages: blessings 12:31:03 INFO - Running setup.py install for blessings 12:31:03 INFO - Successfully installed blessings 12:31:03 INFO - Cleaning up... 12:31:03 INFO - Return code: 0 12:31:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:03 INFO - Reading from file tmpfile_stdout 12:31:03 INFO - Current package versions: 12:31:03 INFO - argparse == 1.2.1 12:31:03 INFO - blessings == 1.6 12:31:03 INFO - blobuploader == 1.2.4 12:31:03 INFO - docopt == 0.6.1 12:31:03 INFO - functools32 == 3.2.3-2 12:31:03 INFO - jsonschema == 2.5.1 12:31:03 INFO - manifestparser == 1.1 12:31:03 INFO - mozInstall == 1.12 12:31:03 INFO - mozcrash == 0.17 12:31:03 INFO - mozdebug == 0.1 12:31:03 INFO - mozdevice == 0.48 12:31:03 INFO - mozfile == 1.2 12:31:03 INFO - mozhttpd == 0.7 12:31:03 INFO - mozinfo == 0.9 12:31:03 INFO - mozleak == 0.1 12:31:03 INFO - mozlog == 3.4 12:31:03 INFO - moznetwork == 0.27 12:31:03 INFO - mozprocess == 0.23 12:31:03 INFO - mozprofile == 0.28 12:31:03 INFO - mozrunner == 6.12 12:31:03 INFO - mozscreenshot == 0.1 12:31:03 INFO - mozsystemmonitor == 0.3 12:31:03 INFO - moztest == 0.7 12:31:03 INFO - mozversion == 1.4 12:31:03 INFO - psutil == 3.1.1 12:31:03 INFO - requests == 1.2.3 12:31:03 INFO - wsgiref == 0.1.2 12:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:03 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')]} 12:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 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')]} 12:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:31:03 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 12:31:03 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 12:31:03 INFO - Using env: {'DISPLAY': ':0', 12:31:03 INFO - 'HOME': '/home/cltbld', 12:31:03 INFO - 'LANG': 'en_US.UTF-8', 12:31:03 INFO - 'LANGUAGE': 'en_US:en', 12:31:03 INFO - 'LOGNAME': 'cltbld', 12:31:03 INFO - 'MAIL': '/var/mail/cltbld', 12:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:03 INFO - 'MOZ_NO_REMOTE': '1', 12:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:03 INFO - 'NO_EM_RESTART': '1', 12:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:03 INFO - 'PWD': '/builds/slave/test', 12:31:03 INFO - 'SHELL': '/bin/bash', 12:31:03 INFO - 'SHLVL': '1', 12:31:03 INFO - 'TERM': 'linux', 12:31:03 INFO - 'TMOUT': '86400', 12:31:03 INFO - 'USER': 'cltbld', 12:31:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:03 INFO - '_': '/tools/buildbot/bin/python'} 12:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 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)) 12:31:03 INFO - Cleaning up... 12:31:03 INFO - Return code: 0 12:31:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:31:03 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')]} 12:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 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')]} 12:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 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 0x7febb6f74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', '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 12:31:03 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 12:31:03 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 12:31:03 INFO - Using env: {'DISPLAY': ':0', 12:31:03 INFO - 'HOME': '/home/cltbld', 12:31:03 INFO - 'LANG': 'en_US.UTF-8', 12:31:03 INFO - 'LANGUAGE': 'en_US:en', 12:31:03 INFO - 'LOGNAME': 'cltbld', 12:31:03 INFO - 'MAIL': '/var/mail/cltbld', 12:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:03 INFO - 'MOZ_NO_REMOTE': '1', 12:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:03 INFO - 'NO_EM_RESTART': '1', 12:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:03 INFO - 'PWD': '/builds/slave/test', 12:31:03 INFO - 'SHELL': '/bin/bash', 12:31:03 INFO - 'SHLVL': '1', 12:31:03 INFO - 'TERM': 'linux', 12:31:03 INFO - 'TMOUT': '86400', 12:31:03 INFO - 'USER': 'cltbld', 12:31:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:03 INFO - '_': '/tools/buildbot/bin/python'} 12:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:31:03 INFO - Cleaning up... 12:31:03 INFO - Return code: 0 12:31:03 INFO - Running post-action listener: _resource_record_post_action 12:31:03 INFO - Running post-action listener: _start_resource_monitoring 12:31:03 INFO - Starting resource monitoring. 12:31:03 INFO - [mozharness: 2016-09-29 19:31:03.952156Z] Finished create-virtualenv step (success) 12:31:03 INFO - [mozharness: 2016-09-29 19:31:03.952701Z] Running install step. 12:31:03 INFO - Running pre-action listener: _resource_record_pre_action 12:31:03 INFO - Running main action method: install 12:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:04 INFO - Reading from file tmpfile_stdout 12:31:04 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:04 INFO - Reading from file tmpfile_stdout 12:31:04 INFO - Output received: 12:31:04 INFO - Usage: mozinstall [options] installer 12:31:04 INFO - Options: 12:31:04 INFO - -h, --help show this help message and exit 12:31:04 INFO - -d DEST, --destination=DEST 12:31:04 INFO - Directory to install application into. [default: 12:31:04 INFO - "/builds/slave/test"] 12:31:04 INFO - --app=APP Application being installed. [default: firefox] 12:31:04 INFO - mkdir: /builds/slave/test/build/application 12:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:31:21 INFO - Reading from file tmpfile_stdout 12:31:21 INFO - Output received: 12:31:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:31:21 INFO - Running post-action listener: _resource_record_post_action 12:31:21 INFO - [mozharness: 2016-09-29 19:31:21.243865Z] Finished install step (success) 12:31:21 INFO - [mozharness: 2016-09-29 19:31:21.244108Z] Running run-tests step. 12:31:21 INFO - Running pre-action listener: _resource_record_pre_action 12:31:21 INFO - Running main action method: run_tests 12:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:21 INFO - Python 2.7.3 12:31:21 INFO - Return code: 0 12:31:21 INFO - grabbing minidump binary from tooltool 12:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fc790>, '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 0x19fd690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:31:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:31:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:31:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:21 INFO - Return code: 0 12:31:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:31:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:31:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:31:21 INFO - Using env: {'DISPLAY': ':0', 12:31:21 INFO - 'HOME': '/home/cltbld', 12:31:21 INFO - 'LANG': 'en_US.UTF-8', 12:31:21 INFO - 'LANGUAGE': 'en_US:en', 12:31:21 INFO - 'LOGNAME': 'cltbld', 12:31:21 INFO - 'MAIL': '/var/mail/cltbld', 12:31:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:21 INFO - 'MOZ_NO_REMOTE': '1', 12:31:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:21 INFO - 'NO_EM_RESTART': '1', 12:31:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:21 INFO - 'PWD': '/builds/slave/test', 12:31:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:21 INFO - 'SHELL': '/bin/bash', 12:31:21 INFO - 'SHLVL': '1', 12:31:21 INFO - 'TERM': 'linux', 12:31:21 INFO - 'TMOUT': '86400', 12:31:21 INFO - 'USER': 'cltbld', 12:31:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411', 12:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:21 INFO - '_': '/tools/buildbot/bin/python'} 12:31:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:31:21 INFO - mozversion application_buildid: 20160929093015 12:31:21 INFO - mozversion application_changeset: 2027e4ba3584e9bb84ca452ed4d50d180b3cae62 12:31:21 INFO - mozversion application_display_name: Nightly 12:31:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:21 INFO - mozversion application_name: Firefox 12:31:21 INFO - mozversion application_remotingname: firefox 12:31:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:31:21 INFO - mozversion application_vendor: Mozilla 12:31:21 INFO - mozversion application_version: 52.0a1 12:31:21 INFO - mozversion platform_buildid: 20160929093015 12:31:21 INFO - mozversion platform_changeset: 2027e4ba3584e9bb84ca452ed4d50d180b3cae62 12:31:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:31:21 INFO - mozversion platform_version: 52.0a1 12:31:21 INFO - using testdate: 1475177481 12:31:21 INFO - actual date: 1475177481 12:31:21 INFO - starting webserver on 'localhost:39108' 12:31:21 INFO - SUITE-START | Running 2 tests 12:31:21 INFO - TEST-START | dromaeo_css 12:31:21 INFO - operating with platform_type : linux_ 12:31:21 INFO - Initialising browser for dromaeo_css test... 12:31:21 INFO - TEST-INFO | started process 21232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpccF6QP/profile http://localhost:39108/getInfo.html) 12:31:26 INFO - PROCESS | 21232 | __metrics Screen width/height:1600/1200 12:31:26 INFO - PROCESS | 21232 | colorDepth:24 12:31:26 INFO - PROCESS | 21232 | Browser inner width/height: 1024/697 12:31:26 INFO - PROCESS | 21232 | __metrics 12:31:26 ERROR - PROCESS | 21232 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 12:31:27 INFO - TEST-INFO | 21232: exit 0 12:31:27 INFO - Browser initialized. 12:31:27 INFO - Running cycle 1/1 for dromaeo_css test... 12:31:27 INFO - TEST-INFO | started process 21353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpccF6QP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:31:39 INFO - PROCESS | 21353 | RSS: Main: 185688064 12:31:39 INFO - PROCESS | 21353 | 12:32:29 INFO - PROCESS | 21353 | 1475177549211 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] 12:34:39 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:39108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39108/tests/dromaeo/cssquery-ext.html) 12:34:40 INFO - PROCESS | 21353 | RSS: Main: 200642560 12:34:40 INFO - PROCESS | 21353 | 12:37:42 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:39108/tests/dromaeo/cssquery-ext.html (next: http://localhost:39108/tests/dromaeo/cssquery-jquery.html) 12:37:43 INFO - PROCESS | 21353 | RSS: Main: 197742592 12:37:43 INFO - PROCESS | 21353 | 12:40:45 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:39108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39108/tests/dromaeo/cssquery-mootools.html) 12:40:45 INFO - PROCESS | 21353 | RSS: Main: 198397952 12:40:45 INFO - PROCESS | 21353 | 12:43:47 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:39108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39108/tests/dromaeo/cssquery-prototype.html) 12:43:48 INFO - PROCESS | 21353 | RSS: Main: 195137536 12:43:48 INFO - PROCESS | 21353 | 12:46:50 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:39108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39108/tests/dromaeo/cssquery-yui.html) 12:46:51 INFO - PROCESS | 21353 | RSS: Main: 198397952 12:46:51 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:39108/tests/dromaeo/cssquery-yui.html (next: http://localhost:39108/tests/dromaeo/cssquery-dojo.html) 12:49:54 INFO - PROCESS | 21353 | RSS: Main: 199041024 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | __start_tp_report 12:49:54 INFO - PROCESS | 21353 | _x_x_mozilla_page_load 12:49:54 INFO - PROCESS | 21353 | _x_x_mozilla_page_load_details 12:49:54 INFO - PROCESS | 21353 | |i|pagename|runs| 12:49:54 INFO - PROCESS | 21353 | |0;dojo.html;3034.3021105145817;3043.300040990572;3047.6647568767444;3072.846357682116;3080.9075727728164;5312.1766126250495;5367.1144261196905;5424.864378390542;5459.808906688267;5483.725813709313;5377.704226267554;5408.2698835657175;5435.755391007404;5470.5623550116;5487.259220005298;4872.171730805762;4949.925751113737;4981.402231732197;5015.473375295596;5040.294358789754;4934.185859333224;4955.529224723664;5018.04657115147;5021.297018417425;5031.195008798593;4849.903001939977;4855.393075865517;4899.583535399495;4977.701337919736;5045;4898.657094003421;4908.435529914034;4921;4979.278004689299;4991.775370108354;4841.661083724141;4861.829835955725;4883.615470097841;4933.654644174909;4939.506049395068;5298.682079075268;5325.786968521294;5400.243965844785;5402.594805389612;5415.539679127279;5719.342275638313;5737.741801618896;5762.9135562966585;5778.3066032076;5785.450382213683;5768.625039372428;5779.797707080274;5872.383399743008;5883.735231914531;5899.174115623816;5400.702961337164;5458.399576046631;5459.235707001063;5459.645123067067;5474.343078830526;5931.08068249422;5934.37689042653;5958.314793798682;5972.313183983811;6060.969695151496;5728.598998070095;5747.6838773867;5753.769849205984;5757.280339957505;5774.82675519735;5665.631733937281;5717.142428635655;5748.48263656273;5812.157237200667;5833.79581714638;5763.9135412968835;5767.106098554731;5787.2476578045425;5790.044642633919;5811.360750317462;5741.052726300197;5771.422857714279;5776.913346299809;5797.333306669702;5802.33273173582;4367.126574685076;4403.273459879084;4421.027373977719;4440.888977775581;4495.651304608605;3905.082305658168;3936.4292177634084;3978;4001.09975255571;4002.9799851000557;5476.26070480488;5501.064818980783;5518.365387980353;5523.8066667666435;5524.309461317335;5595.300587426572;5808.332041815161;5840.912386314209;5846.795362162304;5860.501857342088;5392.865178370572;5474.151506516497;5491.615586908958;5506.394296627368;5576.97211513948;5059.06407314648;5060.620453465931;5080.949190508121;5084.9745751271;5124.5131712487255;6105.786297479567;6119.44924956756;6124.35694252106;6132.17215675878;6134.263888333339;5717.085266357529;5750.367459579526;5787.768489260551;5899.233099697012;5910.290765108214;6030.4572588467245;6087.07709373271;6097.76666567467;6108.342071131425;6128.387161283836;5622.803201887914;5681.431856814285;5708.857278568069;5717.256756621613;5823.563232757476;5826.970865145647;5837.211976383134;5841.18223448709;5884.529237660891;5925.259342582177;5603.35561410443;5672.03575392176;5734.08254679266;5746.454086861741;5768.077107662753;5680.7443665036;5718.828435146952;5733.512651424676;5740;5821.09772985188;5637.661740295595;5654.830355089354;5668.688222147822;5671.149327600893;5707.971460142673;5697.515711164431;5774.624649397776;5776.42235776419;5778;5831.329397119385;5512.779488820403;5569.0254205513065;5571.8885622288135;5649.915251271152;5663.207150998781 12:49:54 INFO - PROCESS | 21353 | |1;ext.html;564.8418442836007;571.6484362117297;584.4214227914365;590.3683059126736;593.5785592229516;42017.78991105044;43587.564124358745;43684.56315436849;47175.76412117943;47522.287165692454;43843.56156438435;44137;44187.116257674825;44396.77801610996;44640.3303950441;8979.685711000116;9074.228690561311;9107.453552786821;9117.45295282282;9120.908790912072;8770.122987701243;8882.289416846668;8888.422252553595;8892.155245251723;8932.464052156858;8757.430767000156;8803.64785408583;8852.690155844546;8871.822563548725;8906.198442140207;8827.911720882774;8889.199972002518;8922.375433719642;8933.19601235892;8935.195832375117;8869.600867960957;8951;8975.640974361018;9015.639374425014;9029.548522573845;42286.36570451446;42522;42599.36100958488;42801;42831.357529637084;3322.2358857462677;3417.641147679483;3563.2873425314783;3729.664330210267;3987.601239876018;31487.527687084712;32163.51754723681;32257.51613725796;32261.83869080663;32337;4315;4361.510343522466;4379.978100109511;4393.121375724868;4475.485319188302;319695;321599;322467;322552;323200;56678.7166064167;56862.7156864213;57012.71493642505;57019;57103;36309.455358169645;58454.154584541204;58458.707706461195;58531.41468585345;58654.706726466095;15144.924275378773;15850.920745396199;15889;15891.920540397225;15928.362865485251;11979.820302695467;12036.75926481483;12051.096167787451;12064.215825971283;12080.275183489019;18850.905745471184;18923.243070277036;19017;19063.714044289347;19081.90459047696;6842.213145488333;6892.207396149407;7044.154701435758;7146.701215866097;7188.856222875514;921.3320342751585;986.3095832916987;1058.7564860082225;1091.1816137896578;1097.4703308873125;29565.408691826044;30545.541816872767;30607.234819129255;30769;30830.69169308323;939.7321763297427;1060.989390106089;1069.5561342042965;1096.331237944853;1135.693362792058;15170.131616437739;15842.44551440694;15909.920450397905;16087.276072576762;16143.515694529184;504659;506342.96084832464;510062;510569;512289.5084196665;56376;57268.42731572631;57456.42543574594;57459.70161193505;57491.13763293554;1250.5435516036582;1315.6908126590245;1317.7166909114587;1325.350578216667;1326;29257;30524.84737576298;30679;31074;31507.527387088754;48376.51623483861;48822.755886220344;49039;49168.75415622899;49178.50821491739;441558;444071;446800;447787;447861;27763.861180693966;27889.442211155256;28069.157925262276;28106;28281.29296767515;46037.166097559275;47003;47402.52597473981;48113.51886481231;48152;39601.603983960944;39914.2017159661;40283.3957490632;40814.1837163261;41294.58705413028;39120.21759564736;39211.2157756849;40445.59554404418;40578.1884362317;40857.38713919234;35344.29311413809;35667.286654267285;39728.60271397365;39928.2014359717;41025.56410525617;31074;36128.819355903055;36373.636263637025;37208.62791372051;37357.25285494329;27942.3014424641;27971.16086517408;28059.43881122407;28105.297367565974;28223.294417639725 12:49:54 INFO - PROCESS | 21353 | |2;jquery.html;390.7089218532194;397.79513550521466;400.833654033576;403.4694376894384;417.40936574746735;15077.849221507782;18168.818311816878;19345.51636209092;19737;19786.802131978693;19188.23247070119;19579;20159.19363225473;20230.595388092228;20274.89862550689;5474.616776825634;5903.557233207505;5907.320658124328;5924.407559244084;5933.376995415462;5681.545476361881;5842.707864606774;5897.557683173758;5899.970500147515;5905.616134951214;5782.479576838084;5799.3620701722775;5823.505002074808;5825.83483303341;5876.236089308384;5611.130274807411;5802.303723553179;5805.854853628651;5818.3308919474375;5826.9708651456685;5221.947780522184;5223.895522089575;5225.764840582183;5226.268322434862;5242;23071.423214419607;23318.65022024671;23551.079938872284;24062.63906041411;24325.513489730285;2337.555864385761;2384;2391.8206134539805;2404.362843846382;2430.987845060781;9632.543701356179;9787.804243915152;10326.845097323547;10442.895571044268;14334.569962901025;1835.972460413095;1932.420273917819;1946.4647222013919;1965.8230759231594;1981.4253866378733;74324.62837685777;84299.57850210709;84939.57530212309;85360.14639853584;85658.57170714106;10669.57321707123;11185.552577896793;11250.156238282161;11289.943550282196;11343.773124537463;12620.936895315464;13322;15872.761908571381;15895.205239737967;15975.920120399323;7669.693212271447;7704.614769261514;7708.768736937901;7999.600019998977;8036.598170091589;7595.708424740004;7675.577843218565;7898.605069746604;7902.644381002869;7928.801779955547;4040.5353384360587;4105.199486100182;4132.483439570054;4239.088595951824;4253.255680255943;1928.3154480159342;2006.3679940818595;2014.1842553765748;2024.7570291565107;2044.2027609232412;881.8985816631041;949.539473355422;954.4034978138664;964.3779762053576;1063.3301020357126;18382.35661751859;20078.799212007983;20151.899240503702;20228.292009779587;20445.897770511052;927.9072092790667;933.4679232837218;963.3545524498603;1000.8090372456753;1035.2804800663466;10763;11041.116710663127;11090.833637495443;11191;11203.887961120448;410568;421533;422053;422150;427924;60263.698681506314;93305.5334723322;97179;98612;99879;939.7603611079131;971.3928794503436;994.4294000010055;999.4253304350028;1004.3321191407778;17088.487345379657;17397.63259122847;17990.190441429906;18024.36914707979;18042.548936276697;42701.35947960845;43530.34704479372;43863.56136438595;44078.89802754828;44542.3318650227;58493;58531.12203317039;58966.70516647389;59175.70412147912;61002.38997610145;6843.418309443753;8624.655013799378;8637.654493820177;8748.300135988979;8949.32880033987;11857;13078.28069456189;13312.667183320107;13755.862441375459;13801.102928309629;11432.771344573228;11605.30368177912;11665.650030499099;11998.820017699567;12247.387630618612;11747.941260293645;11970.401479925795;12276.693082673004;12408.689782755142;12622.87377126217;12350.764923507577;12354.75290494203;12428.13003089775;12428.56500022495;12549.309787961749;8618;8904.86642700373;9060.365774395992;9126.726198214064;9290.16388525036;11915.940420297842;12188.75622487563;12234.143609947218;12248.38758062111;12294.938525307316 12:49:54 INFO - PROCESS | 21353 | |3;mootools.html;1478.5268714011513;1489.2777003153471;1605.983940160598;1697.1938329293596;1719.8624110071196;7918.841623167533;8207.507549547032;8735.781605459866;9213.815723685531;9219.262459003272;8515.701950431736;8825.602847871845;8855.291576673866;9165.312601554877;9177.954110229457;2345.695059642244;2358.009635952895;2371.691680081587;2382.6664267002634;2392.868392238426;2320.7351993163766;2346.988265058681;2401.5076909233567;2411.46947671512;2413.215704895907;2363.5863723848342;2371.1819422299277;2383.6305372667266;2387.0690430731943;2388.486475407787;2315.3748487908338;2349.859008459498;2357.6227803551437;2363.066588697455;2364.2316247219637;2235.7317121945307;2249.80876625487;2272.8522646027955;2276.089564174327;2279.8290128240283;8607.354448416394;8670.219680228747;8670.739877803677;8672.739817805475;8708.69519566812;5195.610329225286;5343.278657381282;5471.644343117685;5473.75368108436;5473.945260547383;3503.562054743157;3672.155404257009;3723.385641369171;3771.8868433947027;3775.754575952554;1191.3090407563593;1237.969050773729;1258.6853286678331;1271.7265787855656;1279.539365828301;12536.874631253753;12550.18423802459;12674.493020279086;12677.17598356104;12690.74618507634;4729.976350118296;4798.832040878552;4829.396325459317;4954.752262386866;4966.950330496721;10547.208959328082;10569.365838049742;10602.098821600097;10631.468426578795;10642.787144257072;5295.391030031596;5298.788048478018;5366.060939335601;5377.516023557899;5394.8921021579345;4273.1026484438;4416.315471101984;4849.393825771778;4900.166971614834;4962.627802914796;4035.6569691575955;4036.6165214305183;4148.315527937917;4162.334026555797;4166.500019997619;1301.5054279373778;1315.8749918757703;1348.730253949214;1353.6886516101156;1364.2905689041643;892.2014796756866;925.8935222449504;943.3255222515934;958.5399008475971;981.3032746749744;5704.401037891044;5962.2249107615735;6051.788187413419;6103.664298463627;6305.558610897193;462.4935695413517;467.08451435186737;467.1777671298471;479.8896253861631;481.5834303327666;4187.958120418757;4188.371744238389;4224.894377640584;4228.91542169161;4247.957520424818;10769.892301076889;10997.780044399227;11086.390248536247;11100.278481898651;11116.944415277872;10841.67474975752;10873.728156795985;10875;10908.50911708975;11027.724306892393;7445.739399121113;7644.273793989562;7665.080190377191;7739.61301934901;7808.102068262109;6068.393160684073;6151.692415379123;6232.283287422005;6284.24589049317;6285.717142728679;9987.900120998696;10307.381557106597;10332.070113689804;10425.582976680847;10464.843027354444;10289.74275643085;10454.268201225841;10455.16358691318;10467.267291289536;10498.895011049792;7007.054047703495;7113.893291600527;7231.63841807918;7280.526765760209;7464.029676142067;8400.705975290835;8713.738587842376;8743.475391476532;8745.737627871174;8745.825083498166;7632.580208088609;7754.961225193838;7893.486923349964;7981.3614910808155;8025.398095143005;7569.5079819811535;7694.461387702807;7741.7677469676;7814.57019863913;7891.487053341514;6918.481113916376;7034.226235114031;7034.718611255493;7051.435885129074;7075.6815943281645;5202.24567437727;5310.893782124259;5417.83746487606;5509.201165830852;5523.4200408956485;5212.687238765535;5272.6836389816735;5391.649542779707;5395.4604539545735;5476.342838859203 12:49:54 INFO - PROCESS | 21353 | |4;prototype.html;330.8874982505949;332.28227029616016;340.3329474230508;342.8902751119642;348.6583148514457;5302.92045619316;5327.200919862023;5431.158170483576;5466.890662186759;5495.505404513593;5180.606702609787;5316.49493298137;5323.0152421801995;5344.812931547397;5378.650387724795;4241.427407300013;4262.488501379838;4266.274733295331;4271.252530807112;4291.935620965688;4170.91658166838;4233.851815186469;4246.4691913510815;4252.427960513169;4257.3613957906255;4194.559571245021;4195.391668208108;4205.474315710536;4216.367544868263;4216.5572614875455;4186.958130418688;4214.494260688706;4217.34631132175;4217.797927590653;4260.190563792869;3553.7157027437743;3664.8900532984053;3683.3922402803505;3692.2061756722164;3797.1646237827636;5313.654612450178;5316.049592476174;5320.866978325535;5340.225667278261;5346.599005074596;4831.25115607078;4839.758012099416;4843.39457567804;4846.200376937836;4858.78135483904;5467.753951072212;5596.524295434893;5616.269884914976;5654.9717251413895;5696.518905084667;4044.8584299549375;4057.8173982170874;4066.471358723347;4074.2666320062376;4092.4270602115726;5855.795047173328;5868.765249390062;5872.7357268923;5888.467958777724;5889.203792843181;4091.97954010234;4133.731307465066;4151.584841515824;4161.375793630979;4180.811863466151;4206.663466922639;4220.915581688349;4223.324268117087;4224.662027037891;4225.366195070764;4865.391826021747;4867.221244600847;4868.634852386085;4877.975610121997;4885.6335774817035;5657.6039677223025;5677.943220567824;5713.457221563945;5717.685527295956;5809.477147056785;1399.8600139986124;1436.2459708652832;1437.216716889277;1446.5081872163514;1451.5790420778067;913.57975331347;924.7734305095295;927.4945154890601;950.6197520991659;952.3524003677566;4789.150455478984;4827.3449602718365;4847.854564363075;4859.757012149378;4925.359703238556;5094.917574867152;5176.9741151294;5186.5332120108615;5191.662541934762;5203.349581302337;4831;4867.3915760529935;4880.829170978998;4911.582515486152;5323.296545105606;3083.676213997498;3123.87504499822;3126.577911981899;3133.4673105572106;3135.843207839599;6057.515908602332;6132.037747920712;6143.293521245114;6158.998325544216;6170.691465426711;5720.914186287209;5985.910211346833;5992.250968628921;6000.529870181746;6022.2171117754415;6105.8168254952425;6127.662978536045;6130.6628135452975;6150.907736383869;6151.784687536005;5591.832245032656;5845.532357411312;5886.117082437669;5899.852503687443;5959.612625179349;5824.912626310694;5853.2976042875125;5860.736266868086;5860.941390586039;5865.824025279248;6120;6124.356942520971;6125.571210015256;6147.354527774519;6169.784057557964;3974;4125.422440858342;4152.563980781974;4166.33338665812;4185.895352616209;5682.943170568242;5841.240638716939;5843.422275985545;5848.122781582797;5859.384764599656;5697.088465845445;5740.282464691913;5760.6255593386295;5762.4525670061275;5787.450192231731;5687.345955215038;5702.089799916908;5728.226689396878;5749.9712501437225;5758.654480731169;5578.832635020955;5662.800517707482;5665.263515742927;5685.289338832646;5685.829425117253;5658.236138121301;5684.232628595087;5777.6822274775295;5779;5790.623609465371;5474.753636086306;5650.9263239984275;5676.631018983753;5682.204491371129;5686.971565142313 12:49:54 INFO - PROCESS | 21353 | |5;yui.html;691.2810676896029;723.6707298179329;758.8027112950631;778.2684276779827;857.9914200857992;16036.358545658175;16324.510264692048;16804.91597542012;16809.747853782188;17107.144642767875;14922.403103875831;15305.158216298127;15322.846771532282;15372.308246128923;15388.923055384708;792.8216151365954;795.936325093994;811.3914564076942;812.0499016151117;812.2770734046703;817.7955511122219;825.2078005115096;827.3877330775243;827.4910929778173;828.7803732011022;864.4726716702806;864.6973559254274;865.0786911938765;865.247234905633;865.4980111535294;846.5851732650988;848.0290067872313;852.258535074483;852.5098068610574;854.1373213054828;629.8960671489199;633.0662273147117;633.0757094641782;633.1673848888743;634.0046127579702;15765.92117039419;15959.840401595951;15997.360105595762;16004.599885002852;16044.35822567096;14875.181864997421;15024.624384390369;15051.548453546411;15170.924145379313;15228.162451065187;11611.419429028514;11754;11856.22934509254;12077.033837292995;12878.742425151444;3773.3019391412677;3815.6565909068318;3907.159960608483;3981;3996.220736956295;82612;85031.574842126;85154.57422712847;85835;86284.56857715733;11144.498497567629;11217.66347009591;11331.546738130382;11391.487383067783;11467.77064458706;21793.891030544746;21889.890550547145;21983.2305869297;22119.889400553217;22144.66782998256;8109.270165684999;8200.630971606291;8311.95844020776;8367.874481882776;8384.8742268866;4472.753998530047;4636.605888499448;4649.883752906205;4684.414448193976;4708.882277943078;3689.8339574719203;3811.9047023824073;3819.6371344722206;3888.3972984187494;4088.1823635273063;715.1239731329184;720.1250480666016;727.3708242370417;729.9927000730031;730.1238513783481;710.8222944263935;721.156247190788;738.3723834740535;748.9662965166581;766.4213518793387;9569.28230382724;9651.469169195761;9712.805743885083;9937.65218217359;10178;574.6810520161267;630.9589876658002;649.4382359259207;703.4442790195689;783.8393129408457;4389.319655453346;4528.9094218116115;4602;4735.857924262277;4856.805727770849;63377.68311158507;64071.67964160149;108533;110102.44948775205;111528;90678;93313.5334323324;94129.5293523528;95127.52436237775;96458.51770741242;84824.57587712022;85523.57238213769;86167;86451.99999999875;86884;9226.584803683716;9358.766030849283;9416.152546270869;9520.857187142337;9599.856002159833;48021.75989120032;48245;48885.75557122334;49158.77103072452;51215;65212;72293.27706722866;72990.27009730047;73077;75901.62049189719;11796.469158888041;11876.064555122048;12084.335361554848;12239.481463509019;12470.563530276397;13399.598012059654;13670.453181873012;13794.862051379358;14046.367913443715;14076.366563504462;12108.152429329863;12313.56902508408;12354.196977196454;12587.496500139892;13105.082644214814;12235;12747.936260318638;12997.675058123623;13152.539661111816;13587.932060339635;12327.69180770488;12328.81506777417;12616;12882.871171288167;13293.069485135948;10267.794644106927;10431.76929817553;10630.681079567625;10724;10812.135029197803;9761.609535618496;10516.737081573021;10673.733156671145;10696.251262411557;10730.61985474573 12:49:54 INFO - PROCESS | 21353 | __end_tp_report 12:49:54 INFO - PROCESS | 21353 | __start_cc_report 12:49:54 INFO - PROCESS | 21353 | _x_x_mozilla_cycle_collect,296 12:49:54 INFO - PROCESS | 21353 | __end_cc_report 12:49:54 INFO - PROCESS | 21353 | __startTimestamp1475178594317__endTimestamp 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | ------- Summary: start ------- 12:49:54 INFO - PROCESS | 21353 | Number of tests: 6 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | [#0] dojo.html Cycles:165 Average:5406.58 Median:5649.92 stddev:630.18 (11.2%) stddev-sans-first:604.00 12:49:54 INFO - PROCESS | 21353 | Values: 3034.3 3043.3 3047.7 3072.8 3080.9 5312.2 5367.1 5424.9 5459.8 5483.7 5377.7 5408.3 5435.8 5470.6 5487.3 4872.2 4949.9 4981.4 5015.5 5040.3 4934.2 4955.5 5018.0 5021.3 5031.2 4849.9 4855.4 4899.6 4977.7 5045.0 4898.7 4908.4 4921.0 4979.3 4991.8 4841.7 4861.8 4883.6 4933.7 4939.5 5298.7 5325.8 5400.2 5402.6 5415.5 5719.3 5737.7 5762.9 5778.3 5785.5 5768.6 5779.8 5872.4 5883.7 5899.2 5400.7 5458.4 5459.2 5459.6 5474.3 5931.1 5934.4 5958.3 5972.3 6061.0 5728.6 5747.7 5753.8 5757.3 5774.8 5665.6 5717.1 5748.5 5812.2 5833.8 5763.9 5767.1 5787.2 5790.0 5811.4 5741.1 5771.4 5776.9 5797.3 5802.3 4367.1 4403.3 4421.0 4440.9 4495.7 3905.1 3936.4 3978.0 4001.1 4003.0 5476.3 5501.1 5518.4 5523.8 5524.3 5595.3 5808.3 5840.9 5846.8 5860.5 5392.9 5474.2 5491.6 5506.4 5577.0 5059.1 5060.6 5080.9 5085.0 5124.5 6105.8 6119.4 6124.4 6132.2 6134.3 5717.1 5750.4 5787.8 5899.2 5910.3 6030.5 6087.1 6097.8 6108.3 6128.4 5622.8 5681.4 5708.9 5717.3 5823.6 5827.0 5837.2 5841.2 5884.5 5925.3 5603.4 5672.0 5734.1 5746.5 5768.1 5680.7 5718.8 5733.5 5740.0 5821.1 5637.7 5654.8 5668.7 5671.1 5708.0 5697.5 5774.6 5776.4 5778.0 5831.3 5512.8 5569.0 5571.9 5649.9 5663.2 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | [#1] ext.html Cycles:180 Average:58398.23 Median:42560.68 stddev:114601.54 (269.3%) stddev-sans-first:114840.76 12:49:54 INFO - PROCESS | 21353 | Values: 564.8 571.6 584.4 590.4 593.6 42017.8 43587.6 43684.6 47175.8 47522.3 43843.6 44137.0 44187.1 44396.8 44640.3 8979.7 9074.2 9107.5 9117.5 9120.9 8770.1 8882.3 8888.4 8892.2 8932.5 8757.4 8803.6 8852.7 8871.8 8906.2 8827.9 8889.2 8922.4 8933.2 8935.2 8869.6 8951.0 8975.6 9015.6 9029.5 42286.4 42522.0 42599.4 42801.0 42831.4 3322.2 3417.6 3563.3 3729.7 3987.6 31487.5 32163.5 32257.5 32261.8 32337.0 4315.0 4361.5 4380.0 4393.1 4475.5 319695.0 321599.0 322467.0 322552.0 323200.0 56678.7 56862.7 57012.7 57019.0 57103.0 36309.5 58454.2 58458.7 58531.4 58654.7 15144.9 15850.9 15889.0 15891.9 15928.4 11979.8 12036.8 12051.1 12064.2 12080.3 18850.9 18923.2 19017.0 19063.7 19081.9 6842.2 6892.2 7044.2 7146.7 7188.9 921.3 986.3 1058.8 1091.2 1097.5 29565.4 30545.5 30607.2 30769.0 30830.7 939.7 1061.0 1069.6 1096.3 1135.7 15170.1 15842.4 15909.9 16087.3 16143.5 504659.0 506343.0 510062.0 510569.0 512289.5 56376.0 57268.4 57456.4 57459.7 57491.1 1250.5 1315.7 1317.7 1325.4 1326.0 29257.0 30524.8 30679.0 31074.0 31507.5 48376.5 48822.8 49039.0 49168.8 49178.5 441558.0 444071.0 446800.0 447787.0 447861.0 27763.9 27889.4 28069.2 28106.0 28281.3 46037.2 47003.0 47402.5 48113.5 48152.0 39601.6 39914.2 40283.4 40814.2 41294.6 39120.2 39211.2 40445.6 40578.2 40857.4 35344.3 35667.3 39728.6 39928.2 41025.6 31074.0 36128.8 36373.6 37208.6 37357.3 27942.3 27971.2 28059.4 28105.3 28223.3 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | [#2] jquery.html Cycles:180 Average:27250.32 Median:2222.00 stddev:69886.80 (3145.2%) stddev-sans-first:70053.75 12:49:54 INFO - PROCESS | 21353 | Values: 390.7 397.8 400.8 403.5 417.4 15077.8 18168.8 19345.5 19737.0 19786.8 19188.2 19579.0 20159.2 20230.6 20274.9 5474.6 5903.6 5907.3 5924.4 5933.4 5681.5 5842.7 5897.6 5900.0 5905.6 5782.5 5799.4 5823.5 5825.8 5876.2 5611.1 5802.3 5805.9 5818.3 5827.0 5221.9 5223.9 5225.8 5226.3 5242.0 23071.4 23318.7 23551.1 24062.6 24325.5 2337.6 2384.0 2391.8 2404.4 2431.0 9632.5 9787.8 10326.8 10442.9 14334.6 1836.0 1932.4 1946.5 1965.8 1981.4 74324.6 84299.6 84939.6 85360.1 85658.6 10669.6 11185.6 11250.2 11289.9 11343.8 12620.9 13322.0 15872.8 15895.2 15975.9 7669.7 7704.6 7708.8 7999.6 8036.6 7595.7 7675.6 7898.6 7902.6 7928.8 4040.5 4105.2 4132.5 4239.1 4253.3 1928.3 2006.4 2014.2 2024.8 2044.2 881.9 949.5 954.4 964.4 1063.3 18382.4 20078.8 20151.9 20228.3 20445.9 927.9 933.5 963.4 1000.8 1035.3 10763.0 11041.1 11090.8 11191.0 11203.9 410568.0 421533.0 422053.0 422150.0 427924.0 60263.7 93305.5 97179.0 98612.0 99879.0 939.8 971.4 994.4 999.4 1004.3 17088.5 17397.6 17990.2 18024.4 18042.5 42701.4 43530.3 43863.6 44078.9 44542.3 58493.0 58531.1 58966.7 59175.7 61002.4 6843.4 8624.7 8637.7 8748.3 8949.3 11857.0 13078.3 13312.7 13755.9 13801.1 11432.8 11605.3 11665.7 11998.8 12247.4 11747.9 11970.4 12276.7 12408.7 12622.9 12350.8 12354.8 12428.1 12428.6 12549.3 8618.0 8904.9 9060.4 9126.7 9290.2 11915.9 12188.8 12234.1 12248.4 12294.9 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | [#3] mootools.html Cycles:180 Average:5857.88 Median:2639.36 stddev:3331.19 (126.2%) stddev-sans-first:3324.27 12:49:54 INFO - PROCESS | 21353 | Values: 1478.5 1489.3 1606.0 1697.2 1719.9 7918.8 8207.5 8735.8 9213.8 9219.3 8515.7 8825.6 8855.3 9165.3 9178.0 2345.7 2358.0 2371.7 2382.7 2392.9 2320.7 2347.0 2401.5 2411.5 2413.2 2363.6 2371.2 2383.6 2387.1 2388.5 2315.4 2349.9 2357.6 2363.1 2364.2 2235.7 2249.8 2272.9 2276.1 2279.8 8607.4 8670.2 8670.7 8672.7 8708.7 5195.6 5343.3 5471.6 5473.8 5473.9 3503.6 3672.2 3723.4 3771.9 3775.8 1191.3 1238.0 1258.7 1271.7 1279.5 12536.9 12550.2 12674.5 12677.2 12690.7 4730.0 4798.8 4829.4 4954.8 4967.0 10547.2 10569.4 10602.1 10631.5 10642.8 5295.4 5298.8 5366.1 5377.5 5394.9 4273.1 4416.3 4849.4 4900.2 4962.6 4035.7 4036.6 4148.3 4162.3 4166.5 1301.5 1315.9 1348.7 1353.7 1364.3 892.2 925.9 943.3 958.5 981.3 5704.4 5962.2 6051.8 6103.7 6305.6 462.5 467.1 467.2 479.9 481.6 4188.0 4188.4 4224.9 4228.9 4248.0 10769.9 10997.8 11086.4 11100.3 11116.9 10841.7 10873.7 10875.0 10908.5 11027.7 7445.7 7644.3 7665.1 7739.6 7808.1 6068.4 6151.7 6232.3 6284.2 6285.7 9987.9 10307.4 10332.1 10425.6 10464.8 10289.7 10454.3 10455.2 10467.3 10498.9 7007.1 7113.9 7231.6 7280.5 7464.0 8400.7 8713.7 8743.5 8745.7 8745.8 7632.6 7755.0 7893.5 7981.4 8025.4 7569.5 7694.5 7741.8 7814.6 7891.5 6918.5 7034.2 7034.7 7051.4 7075.7 5202.2 5310.9 5417.8 5509.2 5523.4 5212.7 5272.7 5391.6 5395.5 5476.3 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | [#4] prototype.html Cycles:180 Average:4757.64 Median:5323.16 stddev:1408.51 (26.5%) stddev-sans-first:1372.72 12:49:54 INFO - PROCESS | 21353 | Values: 330.9 332.3 340.3 342.9 348.7 5302.9 5327.2 5431.2 5466.9 5495.5 5180.6 5316.5 5323.0 5344.8 5378.7 4241.4 4262.5 4266.3 4271.3 4291.9 4170.9 4233.9 4246.5 4252.4 4257.4 4194.6 4195.4 4205.5 4216.4 4216.6 4187.0 4214.5 4217.3 4217.8 4260.2 3553.7 3664.9 3683.4 3692.2 3797.2 5313.7 5316.0 5320.9 5340.2 5346.6 4831.3 4839.8 4843.4 4846.2 4858.8 5467.8 5596.5 5616.3 5655.0 5696.5 4044.9 4057.8 4066.5 4074.3 4092.4 5855.8 5868.8 5872.7 5888.5 5889.2 4092.0 4133.7 4151.6 4161.4 4180.8 4206.7 4220.9 4223.3 4224.7 4225.4 4865.4 4867.2 4868.6 4878.0 4885.6 5657.6 5677.9 5713.5 5717.7 5809.5 1399.9 1436.2 1437.2 1446.5 1451.6 913.6 924.8 927.5 950.6 952.4 4789.2 4827.3 4847.9 4859.8 4925.4 5094.9 5177.0 5186.5 5191.7 5203.3 4831.0 4867.4 4880.8 4911.6 5323.3 3083.7 3123.9 3126.6 3133.5 3135.8 6057.5 6132.0 6143.3 6159.0 6170.7 5720.9 5985.9 5992.3 6000.5 6022.2 6105.8 6127.7 6130.7 6150.9 6151.8 5591.8 5845.5 5886.1 5899.9 5959.6 5824.9 5853.3 5860.7 5860.9 5865.8 6120.0 6124.4 6125.6 6147.4 6169.8 3974.0 4125.4 4152.6 4166.3 4185.9 5682.9 5841.2 5843.4 5848.1 5859.4 5697.1 5740.3 5760.6 5762.5 5787.5 5687.3 5702.1 5728.2 5750.0 5758.7 5578.8 5662.8 5665.3 5685.3 5685.8 5658.2 5684.2 5777.7 5779.0 5790.6 5474.8 5650.9 5676.6 5682.2 5687.0 12:49:54 INFO - PROCESS | 21353 | 12:49:54 INFO - PROCESS | 21353 | [#5] yui.html Cycles:180 Average:20058.57 Median:4722.37 stddev:28249.14 (598.2%) stddev-sans-first:28290.95 12:49:54 INFO - PROCESS | 21353 | Values: 691.3 723.7 758.8 778.3 858.0 16036.4 16324.5 16804.9 16809.7 17107.1 14922.4 15305.2 15322.8 15372.3 15388.9 792.8 795.9 811.4 812.0 812.3 817.8 825.2 827.4 827.5 828.8 864.5 864.7 865.1 865.2 865.5 846.6 848.0 852.3 852.5 854.1 629.9 633.1 633.1 633.2 634.0 15765.9 15959.8 15997.4 16004.6 16044.4 14875.2 15024.6 15051.5 15170.9 15228.2 11611.4 11754.0 11856.2 12077.0 12878.7 3773.3 3815.7 3907.2 3981.0 3996.2 82612.0 85031.6 85154.6 85835.0 86284.6 11144.5 11217.7 11331.5 11391.5 11467.8 21793.9 21889.9 21983.2 22119.9 22144.7 8109.3 8200.6 8312.0 8367.9 8384.9 4472.8 4636.6 4649.9 4684.4 4708.9 3689.8 3811.9 3819.6 3888.4 4088.2 715.1 720.1 727.4 730.0 730.1 710.8 721.2 738.4 749.0 766.4 9569.3 9651.5 9712.8 9937.7 10178.0 574.7 631.0 649.4 703.4 783.8 4389.3 4528.9 4602.0 4735.9 4856.8 63377.7 64071.7 108533.0 110102.4 111528.0 90678.0 93313.5 94129.5 95127.5 96458.5 84824.6 85523.6 86167.0 86452.0 86884.0 9226.6 9358.8 9416.2 9520.9 9599.9 48021.8 48245.0 48885.8 49158.8 51215.0 65212.0 72293.3 72990.3 73077.0 75901.6 11796.5 11876.1 12084.3 12239.5 12470.6 13399.6 13670.5 13794.9 14046.4 14076.4 12108.2 12313.6 12354.2 12587.5 13105.1 12235.0 12747.9 12997.7 13152.5 13587.9 12327.7 12328.8 12616.0 12882.9 13293.1 10267.8 10431.8 10630.7 10724.0 10812.1 9761.6 10516.7 10673.7 10696.3 10730.6 12:49:54 INFO - PROCESS | 21353 | -------- Summary: end -------- 12:49:54 INFO - PROCESS | 21353 | 12:49:55 INFO - TEST-INFO | 21353: exit 0 12:49:55 INFO - TEST-OK | dromaeo_css | took 1113802ms 12:49:55 INFO - TEST-START | kraken 12:49:55 INFO - operating with platform_type : linux_ 12:49:55 INFO - Initialising browser for kraken test... 12:49:55 INFO - TEST-INFO | started process 21714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS511ob/profile http://localhost:39108/getInfo.html) 12:49:59 INFO - PROCESS | 21714 | __metrics Screen width/height:1600/1200 12:49:59 INFO - PROCESS | 21714 | colorDepth:24 12:49:59 INFO - PROCESS | 21714 | Browser inner width/height: 1024/697 12:49:59 INFO - PROCESS | 21714 | __metrics 12:50:00 ERROR - PROCESS | 21714 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 12:50:01 INFO - TEST-INFO | 21714: exit 0 12:50:01 INFO - Browser initialized. 12:50:01 INFO - Running cycle 1/1 for kraken test... 12:50:01 INFO - TEST-INFO | started process 21840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS511ob/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:13 INFO - PROCESS | 21840 | RSS: Main: 185479168 12:50:13 INFO - PROCESS | 21840 | 12:50:16 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39108/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:16 INFO - PROCESS | 21840 | RSS: Main: 194846720 12:50:16 INFO - PROCESS | 21840 | 12:50:19 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39108/tests/kraken/driver.html?testName=audio-dft) 12:50:20 INFO - PROCESS | 21840 | RSS: Main: 196595712 12:50:20 INFO - PROCESS | 21840 | 12:50:23 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39108/tests/kraken/driver.html?testName=audio-fft) 12:50:23 INFO - PROCESS | 21840 | RSS: Main: 192094208 12:50:23 INFO - PROCESS | 21840 | 12:50:25 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39108/tests/kraken/driver.html?testName=audio-oscillator) 12:50:26 INFO - PROCESS | 21840 | RSS: Main: 192602112 12:50:26 INFO - PROCESS | 21840 | 12:50:28 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:50:29 INFO - PROCESS | 21840 | RSS: Main: 193339392 12:50:29 INFO - PROCESS | 21840 | 12:50:32 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39108/tests/kraken/driver.html?testName=imaging-darkroom) 12:50:32 INFO - PROCESS | 21840 | RSS: Main: 193236992 12:50:32 INFO - PROCESS | 21840 | 12:50:36 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39108/tests/kraken/driver.html?testName=imaging-desaturate) 12:50:36 INFO - PROCESS | 21840 | RSS: Main: 191463424 12:50:36 INFO - PROCESS | 21840 | 12:50:39 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39108/tests/kraken/driver.html?testName=json-parse-financial) 12:50:40 INFO - PROCESS | 21840 | RSS: Main: 193249280 12:50:40 INFO - PROCESS | 21840 | 12:50:41 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:50:42 INFO - PROCESS | 21840 | RSS: Main: 193253376 12:50:42 INFO - PROCESS | 21840 | 12:50:44 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:50:44 INFO - PROCESS | 21840 | RSS: Main: 193552384 12:50:44 INFO - PROCESS | 21840 | 12:50:46 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:50:47 INFO - PROCESS | 21840 | RSS: Main: 193687552 12:50:47 INFO - PROCESS | 21840 | 12:50:50 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:50:50 INFO - PROCESS | 21840 | RSS: Main: 193785856 12:50:50 INFO - PROCESS | 21840 | 12:50:53 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:50:54 INFO - PROCESS | 21840 | RSS: Main: 194318336 12:50:54 INFO - PROCESS | 21840 | 12:50:55 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:39108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39108/tests/kraken/driver.html?testName=ai-astar) 12:50:56 INFO - PROCESS | 21840 | RSS: Main: 195788800 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | __start_tp_report 12:50:56 INFO - PROCESS | 21840 | _x_x_mozilla_page_load 12:50:56 INFO - PROCESS | 21840 | _x_x_mozilla_page_load_details 12:50:56 INFO - PROCESS | 21840 | |i|pagename|runs| 12:50:56 INFO - PROCESS | 21840 | |0;ai-astar;109;110;111;112;112;111;112;112;112;112 12:50:56 INFO - PROCESS | 21840 | |1;audio-beat-detection;157;123;122;160;120;124;120;120;149;120 12:50:56 INFO - PROCESS | 21840 | |2;audio-dft;162;163;164;166;173;164;162;164;161;162 12:50:56 INFO - PROCESS | 21840 | |3;audio-fft;75;80;76;111;80;77;82;78;104;75 12:50:56 INFO - PROCESS | 21840 | |4;audio-oscillator;82;83;111;83;83;82;100;82;82;115 12:50:56 INFO - PROCESS | 21840 | |5;imaging-gaussian-blur;117;119;118;117;117;119;118;118;117;118 12:50:56 INFO - PROCESS | 21840 | |6;imaging-darkroom;147;148;148;147;148;147;146;146;147;147 12:50:56 INFO - PROCESS | 21840 | |7;imaging-desaturate;96;96;96;97;96;95;95;96;96;96 12:50:56 INFO - PROCESS | 21840 | |8;json-parse-financial;54;50;51;54;53;55;53;52;53;53 12:50:56 INFO - PROCESS | 21840 | |9;json-stringify-tinderbox;61;60;60;60;62;60;60;60;60;60 12:50:56 INFO - PROCESS | 21840 | |10;stanford-crypto-aes;80;83;80;80;80;86;85;80;80;82 12:50:56 INFO - PROCESS | 21840 | |11;stanford-crypto-ccm;132;129;134;127;132;134;133;133;158;127 12:50:56 INFO - PROCESS | 21840 | |12;stanford-crypto-pbkdf2;163;163;168;161;173;163;162;162;163;162 12:50:56 INFO - PROCESS | 21840 | |13;stanford-crypto-sha256-iterative;67;65;64;64;68;65;65;63;64;68 12:50:56 INFO - PROCESS | 21840 | __end_tp_report 12:50:56 INFO - PROCESS | 21840 | __start_cc_report 12:50:56 INFO - PROCESS | 21840 | _x_x_mozilla_cycle_collect,760 12:50:56 INFO - PROCESS | 21840 | __end_cc_report 12:50:56 INFO - PROCESS | 21840 | __startTimestamp1475178656243__endTimestamp 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | ------- Summary: start ------- 12:50:56 INFO - PROCESS | 21840 | Number of tests: 14 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.06 (0.9%) stddev-sans-first:0.73 12:50:56 INFO - PROCESS | 21840 | Values: 109.0 110.0 111.0 112.0 112.0 111.0 112.0 112.0 112.0 112.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:123.50 stddev:16.72 (13.5%) stddev-sans-first:14.97 12:50:56 INFO - PROCESS | 21840 | Values: 157.0 123.0 122.0 160.0 120.0 124.0 120.0 120.0 149.0 120.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.45 (2.1%) stddev-sans-first:3.57 12:50:56 INFO - PROCESS | 21840 | Values: 162.0 163.0 164.0 166.0 173.0 164.0 162.0 164.0 161.0 162.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.50 stddev:12.80 (16.5%) stddev-sans-first:13.18 12:50:56 INFO - PROCESS | 21840 | Values: 75.0 80.0 76.0 111.0 80.0 77.0 82.0 78.0 104.0 75.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.20 (16.1%) stddev-sans-first:13.65 12:50:56 INFO - PROCESS | 21840 | Values: 82.0 83.0 111.0 83.0 83.0 82.0 100.0 82.0 82.0 115.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 12:50:56 INFO - PROCESS | 21840 | Values: 117.0 119.0 118.0 117.0 117.0 119.0 118.0 118.0 117.0 118.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 12:50:56 INFO - PROCESS | 21840 | Values: 147.0 148.0 148.0 147.0 148.0 147.0 146.0 146.0 147.0 147.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:50:56 INFO - PROCESS | 21840 | Values: 96.0 96.0 96.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.48 (2.8%) stddev-sans-first:1.50 12:50:56 INFO - PROCESS | 21840 | Values: 54.0 50.0 51.0 54.0 53.0 55.0 53.0 52.0 53.0 53.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 12:50:56 INFO - PROCESS | 21840 | Values: 61.0 60.0 60.0 60.0 62.0 60.0 60.0 60.0 60.0 60.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:2.32 (2.9%) stddev-sans-first:2.39 12:50:56 INFO - PROCESS | 21840 | Values: 80.0 83.0 80.0 80.0 80.0 86.0 85.0 80.0 80.0 82.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:133.00 stddev:8.88 (6.7%) stddev-sans-first:9.39 12:50:56 INFO - PROCESS | 21840 | Values: 132.0 129.0 134.0 127.0 132.0 134.0 133.0 133.0 158.0 127.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:163.00 stddev:3.68 (2.3%) stddev-sans-first:3.89 12:50:56 INFO - PROCESS | 21840 | Values: 163.0 163.0 168.0 161.0 173.0 163.0 162.0 162.0 163.0 162.0 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:1.76 12:50:56 INFO - PROCESS | 21840 | Values: 67.0 65.0 64.0 64.0 68.0 65.0 65.0 63.0 64.0 68.0 12:50:56 INFO - PROCESS | 21840 | -------- Summary: end -------- 12:50:56 INFO - PROCESS | 21840 | 12:50:56 INFO - PROCESS | 21840 | [Parent 21840] WARNING: pipe error (77): Connection reset by peer: file /builds/slave/fx-team-l64-pgo-00000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 323 12:50:57 INFO - TEST-INFO | 21840: exit 0 12:50:57 INFO - TEST-OK | kraken | took 62082ms 12:50:57 INFO - SUITE-END | took 1175s 12:50:57 INFO - Completed test suite (00:19:35) 12:50:57 INFO - javascript benchmark 12:50:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7254.343929231668, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.3021105145817, 3043.300040990572, 3047.6647568767444, 3072.846357682116, 3080.9075727728164, 5312.1766126250495, 5367.1144261196905, 5424.864378390542, 5459.808906688267, 5483.725813709313, 5377.704226267554, 5408.2698835657175, 5435.755391007404, 5470.5623550116, 5487.259220005298, 4872.171730805762, 4949.925751113737, 4981.402231732197, 5015.473375295596, 5040.294358789754, 4934.185859333224, 4955.529224723664, 5018.04657115147, 5021.297018417425, 5031.195008798593, 4849.903001939977, 4855.393075865517, 4899.583535399495, 4977.701337919736, 5045.0, 4898.657094003421, 4908.435529914034, 4921.0, 4979.278004689299, 4991.775370108354, 4841.661083724141, 4861.829835955725, 4883.615470097841, 4933.654644174909, 4939.506049395068, 5298.682079075268, 5325.786968521294, 5400.243965844785, 5402.594805389612, 5415.539679127279, 5719.342275638313, 5737.741801618896, 5762.9135562966585, 5778.3066032076, 5785.450382213683, 5768.625039372428, 5779.797707080274, 5872.383399743008, 5883.735231914531, 5899.174115623816, 5400.702961337164, 5458.399576046631, 5459.235707001063, 5459.645123067067, 5474.343078830526, 5931.08068249422, 5934.37689042653, 5958.314793798682, 5972.313183983811, 6060.969695151496, 5728.598998070095, 5747.6838773867, 5753.769849205984, 5757.280339957505, 5774.82675519735, 5665.631733937281, 5717.142428635655, 5748.48263656273, 5812.157237200667, 5833.79581714638, 5763.9135412968835, 5767.106098554731, 5787.2476578045425, 5790.044642633919, 5811.360750317462, 5741.052726300197, 5771.422857714279, 5776.913346299809, 5797.333306669702, 5802.33273173582, 4367.126574685076, 4403.273459879084, 4421.027373977719, 4440.888977775581, 4495.651304608605, 3905.082305658168, 3936.4292177634084, 3978.0, 4001.09975255571, 4002.9799851000557, 5476.26070480488, 5501.064818980783, 5518.365387980353, 5523.8066667666435, 5524.309461317335, 5595.300587426572, 5808.332041815161, 5840.912386314209, 5846.795362162304, 5860.501857342088, 5392.865178370572, 5474.151506516497, 5491.615586908958, 5506.394296627368, 5576.97211513948, 5059.06407314648, 5060.620453465931, 5080.949190508121, 5084.9745751271, 5124.5131712487255, 6105.786297479567, 6119.44924956756, 6124.35694252106, 6132.17215675878, 6134.263888333339, 5717.085266357529, 5750.367459579526, 5787.768489260551, 5899.233099697012, 5910.290765108214, 6030.4572588467245, 6087.07709373271, 6097.76666567467, 6108.342071131425, 6128.387161283836, 5622.803201887914, 5681.431856814285, 5708.857278568069, 5717.256756621613, 5823.563232757476, 5826.970865145647, 5837.211976383134, 5841.18223448709, 5884.529237660891, 5925.259342582177, 5603.35561410443, 5672.03575392176, 5734.08254679266, 5746.454086861741, 5768.077107662753, 5680.7443665036, 5718.828435146952, 5733.512651424676, 5740.0, 5821.09772985188, 5637.661740295595, 5654.830355089354, 5668.688222147822, 5671.149327600893, 5707.971460142673, 5697.515711164431, 5774.624649397776, 5776.42235776419, 5778.0, 5831.329397119385, 5512.779488820403, 5569.0254205513065, 5571.8885622288135, 5649.915251271152, 5663.207150998781], "value": 5362.343070176616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.8418442836007, 571.6484362117297, 584.4214227914365, 590.3683059126736, 593.5785592229516, 42017.78991105044, 43587.564124358745, 43684.56315436849, 47175.76412117943, 47522.287165692454, 43843.56156438435, 44137.0, 44187.116257674825, 44396.77801610996, 44640.3303950441, 8979.685711000116, 9074.228690561311, 9107.453552786821, 9117.45295282282, 9120.908790912072, 8770.122987701243, 8882.289416846668, 8888.422252553595, 8892.155245251723, 8932.464052156858, 8757.430767000156, 8803.64785408583, 8852.690155844546, 8871.822563548725, 8906.198442140207, 8827.911720882774, 8889.199972002518, 8922.375433719642, 8933.19601235892, 8935.195832375117, 8869.600867960957, 8951.0, 8975.640974361018, 9015.639374425014, 9029.548522573845, 42286.36570451446, 42522.0, 42599.36100958488, 42801.0, 42831.357529637084, 3322.2358857462677, 3417.641147679483, 3563.2873425314783, 3729.664330210267, 3987.601239876018, 31487.527687084712, 32163.51754723681, 32257.51613725796, 32261.83869080663, 32337.0, 4315.0, 4361.510343522466, 4379.978100109511, 4393.121375724868, 4475.485319188302, 319695.0, 321599.0, 322467.0, 322552.0, 323200.0, 56678.7166064167, 56862.7156864213, 57012.71493642505, 57019.0, 57103.0, 36309.455358169645, 58454.154584541204, 58458.707706461195, 58531.41468585345, 58654.706726466095, 15144.924275378773, 15850.920745396199, 15889.0, 15891.920540397225, 15928.362865485251, 11979.820302695467, 12036.75926481483, 12051.096167787451, 12064.215825971283, 12080.275183489019, 18850.905745471184, 18923.243070277036, 19017.0, 19063.714044289347, 19081.90459047696, 6842.213145488333, 6892.207396149407, 7044.154701435758, 7146.701215866097, 7188.856222875514, 921.3320342751585, 986.3095832916987, 1058.7564860082225, 1091.1816137896578, 1097.4703308873125, 29565.408691826044, 30545.541816872767, 30607.234819129255, 30769.0, 30830.69169308323, 939.7321763297427, 1060.989390106089, 1069.5561342042965, 1096.331237944853, 1135.693362792058, 15170.131616437739, 15842.44551440694, 15909.920450397905, 16087.276072576762, 16143.515694529184, 504659.0, 506342.96084832464, 510062.0, 510569.0, 512289.5084196665, 56376.0, 57268.42731572631, 57456.42543574594, 57459.70161193505, 57491.13763293554, 1250.5435516036582, 1315.6908126590245, 1317.7166909114587, 1325.350578216667, 1326.0, 29257.0, 30524.84737576298, 30679.0, 31074.0, 31507.527387088754, 48376.51623483861, 48822.755886220344, 49039.0, 49168.75415622899, 49178.50821491739, 441558.0, 444071.0, 446800.0, 447787.0, 447861.0, 27763.861180693966, 27889.442211155256, 28069.157925262276, 28106.0, 28281.29296767515, 46037.166097559275, 47003.0, 47402.52597473981, 48113.51886481231, 48152.0, 39601.603983960944, 39914.2017159661, 40283.3957490632, 40814.1837163261, 41294.58705413028, 39120.21759564736, 39211.2157756849, 40445.59554404418, 40578.1884362317, 40857.38713919234, 35344.29311413809, 35667.286654267285, 39728.60271397365, 39928.2014359717, 41025.56410525617, 31074.0, 36128.819355903055, 36373.636263637025, 37208.62791372051, 37357.25285494329, 27942.3014424641, 27971.16086517408, 28059.43881122407, 28105.297367565974, 28223.294417639725], "value": 19690.354252527944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.7089218532194, 397.79513550521466, 400.833654033576, 403.4694376894384, 417.40936574746735, 15077.849221507782, 18168.818311816878, 19345.51636209092, 19737.0, 19786.802131978693, 19188.23247070119, 19579.0, 20159.19363225473, 20230.595388092228, 20274.89862550689, 5474.616776825634, 5903.557233207505, 5907.320658124328, 5924.407559244084, 5933.376995415462, 5681.545476361881, 5842.707864606774, 5897.557683173758, 5899.970500147515, 5905.616134951214, 5782.479576838084, 5799.3620701722775, 5823.505002074808, 5825.83483303341, 5876.236089308384, 5611.130274807411, 5802.303723553179, 5805.854853628651, 5818.3308919474375, 5826.9708651456685, 5221.947780522184, 5223.895522089575, 5225.764840582183, 5226.268322434862, 5242.0, 23071.423214419607, 23318.65022024671, 23551.079938872284, 24062.63906041411, 24325.513489730285, 2337.555864385761, 2384.0, 2391.8206134539805, 2404.362843846382, 2430.987845060781, 9632.543701356179, 9787.804243915152, 10326.845097323547, 10442.895571044268, 14334.569962901025, 1835.972460413095, 1932.420273917819, 1946.4647222013919, 1965.8230759231594, 1981.4253866378733, 74324.62837685777, 84299.57850210709, 84939.57530212309, 85360.14639853584, 85658.57170714106, 10669.57321707123, 11185.552577896793, 11250.156238282161, 11289.943550282196, 11343.773124537463, 12620.936895315464, 13322.0, 15872.761908571381, 15895.205239737967, 15975.920120399323, 7669.693212271447, 7704.614769261514, 7708.768736937901, 7999.600019998977, 8036.598170091589, 7595.708424740004, 7675.577843218565, 7898.605069746604, 7902.644381002869, 7928.801779955547, 4040.5353384360587, 4105.199486100182, 4132.483439570054, 4239.088595951824, 4253.255680255943, 1928.3154480159342, 2006.3679940818595, 2014.1842553765748, 2024.7570291565107, 2044.2027609232412, 881.8985816631041, 949.539473355422, 954.4034978138664, 964.3779762053576, 1063.3301020357126, 18382.35661751859, 20078.799212007983, 20151.899240503702, 20228.292009779587, 20445.897770511052, 927.9072092790667, 933.4679232837218, 963.3545524498603, 1000.8090372456753, 1035.2804800663466, 10763.0, 11041.116710663127, 11090.833637495443, 11191.0, 11203.887961120448, 410568.0, 421533.0, 422053.0, 422150.0, 427924.0, 60263.698681506314, 93305.5334723322, 97179.0, 98612.0, 99879.0, 939.7603611079131, 971.3928794503436, 994.4294000010055, 999.4253304350028, 1004.3321191407778, 17088.487345379657, 17397.63259122847, 17990.190441429906, 18024.36914707979, 18042.548936276697, 42701.35947960845, 43530.34704479372, 43863.56136438595, 44078.89802754828, 44542.3318650227, 58493.0, 58531.12203317039, 58966.70516647389, 59175.70412147912, 61002.38997610145, 6843.418309443753, 8624.655013799378, 8637.654493820177, 8748.300135988979, 8949.32880033987, 11857.0, 13078.28069456189, 13312.667183320107, 13755.862441375459, 13801.102928309629, 11432.771344573228, 11605.30368177912, 11665.650030499099, 11998.820017699567, 12247.387630618612, 11747.941260293645, 11970.401479925795, 12276.693082673004, 12408.689782755142, 12622.87377126217, 12350.764923507577, 12354.75290494203, 12428.13003089775, 12428.56500022495, 12549.309787961749, 8618.0, 8904.86642700373, 9060.365774395992, 9126.726198214064, 9290.16388525036, 11915.940420297842, 12188.75622487563, 12234.143609947218, 12248.38758062111, 12294.938525307316], "value": 9226.808219176544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.5268714011513, 1489.2777003153471, 1605.983940160598, 1697.1938329293596, 1719.8624110071196, 7918.841623167533, 8207.507549547032, 8735.781605459866, 9213.815723685531, 9219.262459003272, 8515.701950431736, 8825.602847871845, 8855.291576673866, 9165.312601554877, 9177.954110229457, 2345.695059642244, 2358.009635952895, 2371.691680081587, 2382.6664267002634, 2392.868392238426, 2320.7351993163766, 2346.988265058681, 2401.5076909233567, 2411.46947671512, 2413.215704895907, 2363.5863723848342, 2371.1819422299277, 2383.6305372667266, 2387.0690430731943, 2388.486475407787, 2315.3748487908338, 2349.859008459498, 2357.6227803551437, 2363.066588697455, 2364.2316247219637, 2235.7317121945307, 2249.80876625487, 2272.8522646027955, 2276.089564174327, 2279.8290128240283, 8607.354448416394, 8670.219680228747, 8670.739877803677, 8672.739817805475, 8708.69519566812, 5195.610329225286, 5343.278657381282, 5471.644343117685, 5473.75368108436, 5473.945260547383, 3503.562054743157, 3672.155404257009, 3723.385641369171, 3771.8868433947027, 3775.754575952554, 1191.3090407563593, 1237.969050773729, 1258.6853286678331, 1271.7265787855656, 1279.539365828301, 12536.874631253753, 12550.18423802459, 12674.493020279086, 12677.17598356104, 12690.74618507634, 4729.976350118296, 4798.832040878552, 4829.396325459317, 4954.752262386866, 4966.950330496721, 10547.208959328082, 10569.365838049742, 10602.098821600097, 10631.468426578795, 10642.787144257072, 5295.391030031596, 5298.788048478018, 5366.060939335601, 5377.516023557899, 5394.8921021579345, 4273.1026484438, 4416.315471101984, 4849.393825771778, 4900.166971614834, 4962.627802914796, 4035.6569691575955, 4036.6165214305183, 4148.315527937917, 4162.334026555797, 4166.500019997619, 1301.5054279373778, 1315.8749918757703, 1348.730253949214, 1353.6886516101156, 1364.2905689041643, 892.2014796756866, 925.8935222449504, 943.3255222515934, 958.5399008475971, 981.3032746749744, 5704.401037891044, 5962.2249107615735, 6051.788187413419, 6103.664298463627, 6305.558610897193, 462.4935695413517, 467.08451435186737, 467.1777671298471, 479.8896253861631, 481.5834303327666, 4187.958120418757, 4188.371744238389, 4224.894377640584, 4228.91542169161, 4247.957520424818, 10769.892301076889, 10997.780044399227, 11086.390248536247, 11100.278481898651, 11116.944415277872, 10841.67474975752, 10873.728156795985, 10875.0, 10908.50911708975, 11027.724306892393, 7445.739399121113, 7644.273793989562, 7665.080190377191, 7739.61301934901, 7808.102068262109, 6068.393160684073, 6151.692415379123, 6232.283287422005, 6284.24589049317, 6285.717142728679, 9987.900120998696, 10307.381557106597, 10332.070113689804, 10425.582976680847, 10464.843027354444, 10289.74275643085, 10454.268201225841, 10455.16358691318, 10467.267291289536, 10498.895011049792, 7007.054047703495, 7113.893291600527, 7231.63841807918, 7280.526765760209, 7464.029676142067, 8400.705975290835, 8713.738587842376, 8743.475391476532, 8745.737627871174, 8745.825083498166, 7632.580208088609, 7754.961225193838, 7893.486923349964, 7981.3614910808155, 8025.398095143005, 7569.5079819811535, 7694.461387702807, 7741.7677469676, 7814.57019863913, 7891.487053341514, 6918.481113916376, 7034.226235114031, 7034.718611255493, 7051.435885129074, 7075.6815943281645, 5202.24567437727, 5310.893782124259, 5417.83746487606, 5509.201165830852, 5523.4200408956485, 5212.687238765535, 5272.6836389816735, 5391.649542779707, 5395.4604539545735, 5476.342838859203], "value": 4628.653689709984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.8874982505949, 332.28227029616016, 340.3329474230508, 342.8902751119642, 348.6583148514457, 5302.92045619316, 5327.200919862023, 5431.158170483576, 5466.890662186759, 5495.505404513593, 5180.606702609787, 5316.49493298137, 5323.0152421801995, 5344.812931547397, 5378.650387724795, 4241.427407300013, 4262.488501379838, 4266.274733295331, 4271.252530807112, 4291.935620965688, 4170.91658166838, 4233.851815186469, 4246.4691913510815, 4252.427960513169, 4257.3613957906255, 4194.559571245021, 4195.391668208108, 4205.474315710536, 4216.367544868263, 4216.5572614875455, 4186.958130418688, 4214.494260688706, 4217.34631132175, 4217.797927590653, 4260.190563792869, 3553.7157027437743, 3664.8900532984053, 3683.3922402803505, 3692.2061756722164, 3797.1646237827636, 5313.654612450178, 5316.049592476174, 5320.866978325535, 5340.225667278261, 5346.599005074596, 4831.25115607078, 4839.758012099416, 4843.39457567804, 4846.200376937836, 4858.78135483904, 5467.753951072212, 5596.524295434893, 5616.269884914976, 5654.9717251413895, 5696.518905084667, 4044.8584299549375, 4057.8173982170874, 4066.471358723347, 4074.2666320062376, 4092.4270602115726, 5855.795047173328, 5868.765249390062, 5872.7357268923, 5888.467958777724, 5889.203792843181, 4091.97954010234, 4133.731307465066, 4151.584841515824, 4161.375793630979, 4180.811863466151, 4206.663466922639, 4220.915581688349, 4223.324268117087, 4224.662027037891, 4225.366195070764, 4865.391826021747, 4867.221244600847, 4868.634852386085, 4877.975610121997, 4885.6335774817035, 5657.6039677223025, 5677.943220567824, 5713.457221563945, 5717.685527295956, 5809.477147056785, 1399.8600139986124, 1436.2459708652832, 1437.216716889277, 1446.5081872163514, 1451.5790420778067, 913.57975331347, 924.7734305095295, 927.4945154890601, 950.6197520991659, 952.3524003677566, 4789.150455478984, 4827.3449602718365, 4847.854564363075, 4859.757012149378, 4925.359703238556, 5094.917574867152, 5176.9741151294, 5186.5332120108615, 5191.662541934762, 5203.349581302337, 4831.0, 4867.3915760529935, 4880.829170978998, 4911.582515486152, 5323.296545105606, 3083.676213997498, 3123.87504499822, 3126.577911981899, 3133.4673105572106, 3135.843207839599, 6057.515908602332, 6132.037747920712, 6143.293521245114, 6158.998325544216, 6170.691465426711, 5720.914186287209, 5985.910211346833, 5992.250968628921, 6000.529870181746, 6022.2171117754415, 6105.8168254952425, 6127.662978536045, 6130.6628135452975, 6150.907736383869, 6151.784687536005, 5591.832245032656, 5845.532357411312, 5886.117082437669, 5899.852503687443, 5959.612625179349, 5824.912626310694, 5853.2976042875125, 5860.736266868086, 5860.941390586039, 5865.824025279248, 6120.0, 6124.356942520971, 6125.571210015256, 6147.354527774519, 6169.784057557964, 3974.0, 4125.422440858342, 4152.563980781974, 4166.33338665812, 4185.895352616209, 5682.943170568242, 5841.240638716939, 5843.422275985545, 5848.122781582797, 5859.384764599656, 5697.088465845445, 5740.282464691913, 5760.6255593386295, 5762.4525670061275, 5787.450192231731, 5687.345955215038, 5702.089799916908, 5728.226689396878, 5749.9712501437225, 5758.654480731169, 5578.832635020955, 5662.800517707482, 5665.263515742927, 5685.289338832646, 5685.829425117253, 5658.236138121301, 5684.232628595087, 5777.6822274775295, 5779.0, 5790.623609465371, 5474.753636086306, 5650.9263239984275, 5676.631018983753, 5682.204491371129, 5686.971565142313], "value": 4307.768109419233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.2810676896029, 723.6707298179329, 758.8027112950631, 778.2684276779827, 857.9914200857992, 16036.358545658175, 16324.510264692048, 16804.91597542012, 16809.747853782188, 17107.144642767875, 14922.403103875831, 15305.158216298127, 15322.846771532282, 15372.308246128923, 15388.923055384708, 792.8216151365954, 795.936325093994, 811.3914564076942, 812.0499016151117, 812.2770734046703, 817.7955511122219, 825.2078005115096, 827.3877330775243, 827.4910929778173, 828.7803732011022, 864.4726716702806, 864.6973559254274, 865.0786911938765, 865.247234905633, 865.4980111535294, 846.5851732650988, 848.0290067872313, 852.258535074483, 852.5098068610574, 854.1373213054828, 629.8960671489199, 633.0662273147117, 633.0757094641782, 633.1673848888743, 634.0046127579702, 15765.92117039419, 15959.840401595951, 15997.360105595762, 16004.599885002852, 16044.35822567096, 14875.181864997421, 15024.624384390369, 15051.548453546411, 15170.924145379313, 15228.162451065187, 11611.419429028514, 11754.0, 11856.22934509254, 12077.033837292995, 12878.742425151444, 3773.3019391412677, 3815.6565909068318, 3907.159960608483, 3981.0, 3996.220736956295, 82612.0, 85031.574842126, 85154.57422712847, 85835.0, 86284.56857715733, 11144.498497567629, 11217.66347009591, 11331.546738130382, 11391.487383067783, 11467.77064458706, 21793.891030544746, 21889.890550547145, 21983.2305869297, 22119.889400553217, 22144.66782998256, 8109.270165684999, 8200.630971606291, 8311.95844020776, 8367.874481882776, 8384.8742268866, 4472.753998530047, 4636.605888499448, 4649.883752906205, 4684.414448193976, 4708.882277943078, 3689.8339574719203, 3811.9047023824073, 3819.6371344722206, 3888.3972984187494, 4088.1823635273063, 715.1239731329184, 720.1250480666016, 727.3708242370417, 729.9927000730031, 730.1238513783481, 710.8222944263935, 721.156247190788, 738.3723834740535, 748.9662965166581, 766.4213518793387, 9569.28230382724, 9651.469169195761, 9712.805743885083, 9937.65218217359, 10178.0, 574.6810520161267, 630.9589876658002, 649.4382359259207, 703.4442790195689, 783.8393129408457, 4389.319655453346, 4528.9094218116115, 4602.0, 4735.857924262277, 4856.805727770849, 63377.68311158507, 64071.67964160149, 108533.0, 110102.44948775205, 111528.0, 90678.0, 93313.5334323324, 94129.5293523528, 95127.52436237775, 96458.51770741242, 84824.57587712022, 85523.57238213769, 86167.0, 86451.99999999875, 86884.0, 9226.584803683716, 9358.766030849283, 9416.152546270869, 9520.857187142337, 9599.856002159833, 48021.75989120032, 48245.0, 48885.75557122334, 49158.77103072452, 51215.0, 65212.0, 72293.27706722866, 72990.27009730047, 73077.0, 75901.62049189719, 11796.469158888041, 11876.064555122048, 12084.335361554848, 12239.481463509019, 12470.563530276397, 13399.598012059654, 13670.453181873012, 13794.862051379358, 14046.367913443715, 14076.366563504462, 12108.152429329863, 12313.56902508408, 12354.196977196454, 12587.496500139892, 13105.082644214814, 12235.0, 12747.936260318638, 12997.675058123623, 13152.539661111816, 13587.932060339635, 12327.69180770488, 12328.81506777417, 12616.0, 12882.871171288167, 13293.069485135948, 10267.794644106927, 10431.76929817553, 10630.681079567625, 10724.0, 10812.135029197803, 9761.609535618496, 10516.737081573021, 10673.733156671145, 10696.251262411557, 10730.61985474573], "value": 7502.029871211662, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 112.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 122.0, 160.0, 120.0, 124.0, 120.0, 120.0, 149.0, 120.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 166.0, 173.0, 164.0, 162.0, 164.0, 161.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 76.0, 111.0, 80.0, 77.0, 82.0, 78.0, 104.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 111.0, 83.0, 83.0, 82.0, 100.0, 82.0, 82.0, 115.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 51.0, 54.0, 53.0, 55.0, 53.0, 52.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 62.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 80.0, 80.0, 80.0, 86.0, 85.0, 80.0, 80.0, 82.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 134.0, 127.0, 132.0, 134.0, 133.0, 133.0, 158.0, 127.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 168.0, 161.0, 173.0, 163.0, 162.0, 162.0, 163.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 64.0, 68.0, 65.0, 65.0, 63.0, 64.0, 68.0], "value": 65.3, "unit": "score"}]}]} 12:50:57 INFO - Return code: 0 12:50:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:50:57 ERROR - # TBPL SUCCESS # 12:50:57 INFO - Running post-action listener: _resource_record_post_action 12:50:57 INFO - [mozharness: 2016-09-29 19:50:57.533254Z] Finished run-tests step (success) 12:50:57 INFO - Running post-run listener: _resource_record_post_run 12:50:57 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 393781248; Read time: 0; Write time: 269740 12:50:57 INFO - TinderboxPrint: CPU usage
13.4% 12:50:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:50:57 INFO - TinderboxPrint: I/O write bytes / time
393,781,248 / 269,740 12:50:57 INFO - TinderboxPrint: CPU idle
8,240.0 (86.6%) 12:50:57 INFO - TinderboxPrint: CPU user
1,213.0 (12.7%) 12:50:57 INFO - TinderboxPrint: Swap in / out
0 / 0 12:50:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105431040; Read time: 0; Write time: 83916 12:50:57 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288350208; Read time: 0; Write time: 185824 12:50:58 INFO - Running post-run listener: _upload_blobber_files 12:50:58 INFO - Blob upload gear active. 12:50:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:50:58 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 12:50:58 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:50:58 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:50:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:50:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:50:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:50:59 INFO - (blobuploader) - INFO - Done attempting. 12:50:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:50:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:50:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:51:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:00 INFO - (blobuploader) - INFO - Done attempting. 12:51:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:51:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:03 INFO - (blobuploader) - INFO - Done attempting. 12:51:03 INFO - (blobuploader) - INFO - Iteration through files over. 12:51:03 INFO - Return code: 0 12:51:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:51:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:51:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50137ba9c7bd39a3ad81ed8207103dd440491c02a80ac8eb053f25d1609ed30ffc4f9e2b3724cb158d9a061e61648ce8b2e0076e0f987e8f03e3789be0f16c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10f7cedd1de3069868e8313cbc1a884749c33c4e8fb502b22d1601c0e499e9b92ba4576fb5b55f842ffc6510716ceb71be9c095d83c789c59d231e15b4ad36de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa5dad3ec88a604fa1004407308f3d6da1a598adb13171cd6bab42ff2e862c86527274dbf2a274fe5302d44bdffba8011ce2977151e39605ddb7e2f905819ec3"} 12:51:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:51:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:51:03 INFO - Contents: 12:51:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50137ba9c7bd39a3ad81ed8207103dd440491c02a80ac8eb053f25d1609ed30ffc4f9e2b3724cb158d9a061e61648ce8b2e0076e0f987e8f03e3789be0f16c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10f7cedd1de3069868e8313cbc1a884749c33c4e8fb502b22d1601c0e499e9b92ba4576fb5b55f842ffc6510716ceb71be9c095d83c789c59d231e15b4ad36de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa5dad3ec88a604fa1004407308f3d6da1a598adb13171cd6bab42ff2e862c86527274dbf2a274fe5302d44bdffba8011ce2977151e39605ddb7e2f905819ec3"} 12:51:03 INFO - Running post-run listener: copy_logs_to_upload_dir 12:51:03 INFO - Copying logs to upload dir... 12:51:03 INFO - mkdir: /builds/slave/test/build/upload/logs 12:51:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.695302 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-29 12:51:03.350291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:51:03.356084) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50137ba9c7bd39a3ad81ed8207103dd440491c02a80ac8eb053f25d1609ed30ffc4f9e2b3724cb158d9a061e61648ce8b2e0076e0f987e8f03e3789be0f16c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10f7cedd1de3069868e8313cbc1a884749c33c4e8fb502b22d1601c0e499e9b92ba4576fb5b55f842ffc6510716ceb71be9c095d83c789c59d231e15b4ad36de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa5dad3ec88a604fa1004407308f3d6da1a598adb13171cd6bab42ff2e862c86527274dbf2a274fe5302d44bdffba8011ce2977151e39605ddb7e2f905819ec3"} build_url:https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/XzPsarVBR5Ce_uWPWn1yxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50137ba9c7bd39a3ad81ed8207103dd440491c02a80ac8eb053f25d1609ed30ffc4f9e2b3724cb158d9a061e61648ce8b2e0076e0f987e8f03e3789be0f16c36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10f7cedd1de3069868e8313cbc1a884749c33c4e8fb502b22d1601c0e499e9b92ba4576fb5b55f842ffc6510716ceb71be9c095d83c789c59d231e15b4ad36de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa5dad3ec88a604fa1004407308f3d6da1a598adb13171cd6bab42ff2e862c86527274dbf2a274fe5302d44bdffba8011ce2977151e39605ddb7e2f905819ec3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:51:03.381510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:51:03.381861) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475177424.169831-888070411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:51:03.466655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:51:03.467015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:51:03.467364) ========= ========= Total master_lag: 0.17 =========