builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1476969764.62 results: success (0) buildid: 20161020033007 builduid: a27c517f0b1c4a26875e2a28b2202a36 revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.625061) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.625573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.625905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.664301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.664683) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 06:22:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-10-20 06:22:44 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117232 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.906620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.906992) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.058088 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.977483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:44.977876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99a239e1866a57f987b08dad796528e4ea30e622 --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 99a239e1866a57f987b08dad796528e4ea30e622 --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=516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 06:22:45,083 truncating revision to first 12 chars 2016-10-20 06:22:45,083 Setting DEBUG logging. 2016-10-20 06:22:45,083 attempt 1/10 2016-10-20 06:22:45,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99a239e1866a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 06:22:45,400 unpacking tar archive at: fx-team-99a239e1866a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:45.690148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:45.690532) ========= script_repo_revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:45.691004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:45.691311) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:22:45.702401) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-20 06:22:45.702762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:22:46 INFO - MultiFileLogger online at 20161020 06:22:46 in /builds/slave/test 06:22:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:22:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:22:46 INFO - {'append_to_log': False, 06:22:46 INFO - 'base_work_dir': '/builds/slave/test', 06:22:46 INFO - 'blob_upload_branch': 'Fx-Team', 06:22:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:22:46 INFO - 'branch': 'Fx-Team', 06:22:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:22:46 INFO - 'config_files': ('talos/linux_config.py',), 06:22:46 INFO - 'default_actions': ('clobber', 06:22:46 INFO - 'read-buildbot-config', 06:22:46 INFO - 'download-and-extract', 06:22:46 INFO - 'populate-webroot', 06:22:46 INFO - 'create-virtualenv', 06:22:46 INFO - 'install', 06:22:46 INFO - 'run-tests'), 06:22:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:22:46 INFO - 'download_minidump_stackwalk': True, 06:22:46 INFO - 'download_symbols': 'ondemand', 06:22:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:22:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:22:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:22:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:22:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:22:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:22:46 INFO - 'installer_path': 'installer.exe', 06:22:46 INFO - 'log_level': 'info', 06:22:46 INFO - 'log_name': 'talos', 06:22:46 INFO - 'log_to_console': True, 06:22:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:22:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:22:46 INFO - 'opt_config_files': (), 06:22:46 INFO - 'pip_index': False, 06:22:46 INFO - 'sps_profile': False, 06:22:46 INFO - 'sps_profile_interval': 0, 06:22:46 INFO - 'suite': 'dromaeojs', 06:22:46 INFO - 'system_bits': '32', 06:22:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:22:46 INFO - 'title': 'talos-linux64-ix-061', 06:22:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:22:46 INFO - 'use_talos_json': True, 06:22:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:22:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:22:46 INFO - 'work_dir': 'build'} 06:22:46 INFO - [mozharness: 2016-10-20 13:22:46.044777Z] Running clobber step. 06:22:46 INFO - Running pre-action listener: _resource_record_pre_action 06:22:46 INFO - Running main action method: clobber 06:22:46 INFO - rmtree: /builds/slave/test/build 06:22:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:22:50 INFO - Running post-action listener: _resource_record_post_action 06:22:50 INFO - [mozharness: 2016-10-20 13:22:50.158860Z] Finished clobber step (success) 06:22:50 INFO - [mozharness: 2016-10-20 13:22:50.159026Z] Running read-buildbot-config step. 06:22:50 INFO - Running pre-action listener: _resource_record_pre_action 06:22:50 INFO - Running main action method: read_buildbot_config 06:22:50 INFO - Using buildbot properties: 06:22:50 INFO - { 06:22:50 INFO - "project": "", 06:22:50 INFO - "product": "firefox", 06:22:50 INFO - "script_repo_revision": "production", 06:22:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:22:50 INFO - "repository": "", 06:22:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:22:50 INFO - "buildid": "20161020033007", 06:22:50 INFO - "pgo_build": "True", 06:22:50 INFO - "basedir": "/builds/slave/test", 06:22:50 INFO - "buildnumber": 1647, 06:22:50 INFO - "slavename": "talos-linux64-ix-061", 06:22:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:22:50 INFO - "platform": "ubuntu64_hw", 06:22:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:22:50 INFO - "branch": "fx-team", 06:22:50 INFO - "repo_path": "integration/fx-team", 06:22:50 INFO - "revision": "99a239e1866a57f987b08dad796528e4ea30e622", 06:22:50 INFO - "stage_platform": "linux64-pgo", 06:22:50 INFO - "builduid": "a27c517f0b1c4a26875e2a28b2202a36", 06:22:50 INFO - "slavebuilddir": "test" 06:22:50 INFO - } 06:22:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:22:50 INFO - Running post-action listener: _resource_record_post_action 06:22:50 INFO - [mozharness: 2016-10-20 13:22:50.163156Z] Finished read-buildbot-config step (success) 06:22:50 INFO - [mozharness: 2016-10-20 13:22:50.163304Z] Running download-and-extract step. 06:22:50 INFO - Running pre-action listener: _resource_record_pre_action 06:22:50 INFO - Running main action method: download_and_extract 06:22:50 INFO - mkdir: /builds/slave/test/build/tests 06:22: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')]} 06:22:50 INFO - trying https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:22:50 INFO - Downloading https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/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 06:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/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 06:22:50 INFO - Downloaded 1361 bytes. 06:22:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:22:50 INFO - Using the following test package requirements: 06:22:50 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:22:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:22:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:22:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'jsshell-linux-x86_64.zip'], 06:22:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:22:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:22:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:22:50 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:22:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:22:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:22:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:22:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:22:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:50 INFO - Fetch https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:22:51 INFO - Http code: 200 06:22:51 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 06:22:51 INFO - x-amz-cf-id: vPI0be_ZQzqQsaT5clwo9ATQ3mbJqGGoCUu0kyQVkfKYCrMEbTkmlg== 06:22:51 INFO - x-amz-version-id: 3s_D9qfpsaahG802asFHlJJIPZsT5u1J 06:22:51 INFO - Expected file size: 22116251 06:22:51 INFO - Obtained file size: 22116251 06:22:55 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 06:22:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:22:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:55 INFO - Fetch https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:22:56 INFO - Http code: 200 06:22:56 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 06:22:56 INFO - x-amz-cf-id: 43zoz2DOvFkm6suFe_wtE8uL1zrN5rYMYV32YNkMJyUVst-KIUqfxw== 06:22:56 INFO - x-amz-version-id: 3s_D9qfpsaahG802asFHlJJIPZsT5u1J 06:22:56 INFO - Expected file size: 22116251 06:22:56 INFO - Obtained file size: 22116251 06:23:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:23:01 INFO - Fetch https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:23:01 INFO - Http code: 200 06:23:01 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 06:23:01 INFO - x-amz-cf-id: 4A6VPb4HMlwyIHC3ek1-bR7jIHOlKj5K545kcVzbWkeFwtGz62ny8Q== 06:23:01 INFO - x-amz-version-id: kJSgoR6AaW4y_tk0wzd4K7.C22B279TC 06:23:01 INFO - Expected file size: 14409028 06:23:01 INFO - Obtained file size: 14409028 06:23:02 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')]} 06:23:02 INFO - trying https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:02 INFO - Downloading https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/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 06:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/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 06:23:04 INFO - Downloaded 59472912 bytes. 06:23:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:04 INFO - mkdir: /builds/slave/test/properties 06:23:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:23:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:23:04 INFO - Contents: 06:23:04 INFO - build_url:https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:04 INFO - Running post-action listener: _resource_record_post_action 06:23:04 INFO - Running post-action listener: set_extra_try_arguments 06:23:04 INFO - [mozharness: 2016-10-20 13:23:04.747478Z] Finished download-and-extract step (success) 06:23:04 INFO - [mozharness: 2016-10-20 13:23:04.747780Z] Running populate-webroot step. 06:23:04 INFO - Running pre-action listener: _resource_record_pre_action 06:23:04 INFO - Running main action method: populate_webroot 06:23:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:23:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:23:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:23:04 INFO - '--tppagecycles', 06:23:04 INFO - '7'], 06:23:04 INFO - 'tests': ['tsvgm']}}, 06:23:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:23:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:23:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:23:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:23:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['damp', 'tps']}, 06:23:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'tests': ['damp', 'tps']}, 06:23:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['dromaeo_dom']}, 06:23:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:23:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['basic_compositor_video']}, 06:23:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:23:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['a11yr', 06:23:04 INFO - 'ts_paint', 06:23:04 INFO - 'tpaint', 06:23:04 INFO - 'sessionrestore', 06:23:04 INFO - 'sessionrestore_no_auto_restore', 06:23:04 INFO - 'tabpaint']}, 06:23:04 INFO - 'other-e10s': {'tests': ['a11yr', 06:23:04 INFO - 'ts_paint', 06:23:04 INFO - 'tpaint', 06:23:04 INFO - 'sessionrestore', 06:23:04 INFO - 'sessionrestore_no_auto_restore', 06:23:04 INFO - 'tabpaint']}, 06:23:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:23:04 INFO - 'ts_paint', 06:23:04 INFO - 'tpaint', 06:23:04 INFO - 'sessionrestore', 06:23:04 INFO - 'sessionrestore_no_auto_restore', 06:23:04 INFO - 'tabpaint']}, 06:23:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:23:04 INFO - 'ts_paint', 06:23:04 INFO - 'tpaint', 06:23:04 INFO - 'sessionrestore', 06:23:04 INFO - 'sessionrestore_no_auto_restore', 06:23:04 INFO - 'tabpaint']}, 06:23:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['a11yr', 06:23:04 INFO - 'ts_paint', 06:23:04 INFO - 'tpaint', 06:23:04 INFO - 'sessionrestore', 06:23:04 INFO - 'sessionrestore_no_auto_restore', 06:23:04 INFO - 'tabpaint']}, 06:23:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['a11yr', 06:23:04 INFO - 'ts_paint', 06:23:04 INFO - 'tpaint', 06:23:04 INFO - 'sessionrestore', 06:23:04 INFO - 'sessionrestore_no_auto_restore', 06:23:04 INFO - 'tabpaint']}, 06:23:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['tsvgx', 06:23:04 INFO - 'tsvgr_opacity', 06:23:04 INFO - 'tart', 06:23:04 INFO - 'tscrollx', 06:23:04 INFO - 'cart']}, 06:23:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:23:04 INFO - 'tsvgr_opacity', 06:23:04 INFO - 'tart', 06:23:04 INFO - 'tscrollx', 06:23:04 INFO - 'cart']}, 06:23:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'talos_options': ['--disable-e10s'], 06:23:04 INFO - 'tests': ['tp5o']}, 06:23:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'tests': ['tp5o']}, 06:23:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'talos_options': ['--disable-e10s', 06:23:04 INFO - '--xperf_path', 06:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:04 INFO - 'tests': ['tp5n']}, 06:23:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:04 INFO - 'talos_options': ['--xperf_path', 06:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:04 INFO - 'tests': ['tp5n']}}, 06:23:04 INFO - 'talos.zip': {'path': '', 06:23:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:23:04 INFO - Running post-action listener: _resource_record_post_action 06:23:04 INFO - [mozharness: 2016-10-20 13:23:04.764500Z] Finished populate-webroot step (success) 06:23:04 INFO - [mozharness: 2016-10-20 13:23:04.764589Z] Running create-virtualenv step. 06:23:04 INFO - Running pre-action listener: _resource_record_pre_action 06:23:04 INFO - Running main action method: create_virtualenv 06:23:04 INFO - Creating virtualenv /builds/slave/test/build/venv 06:23:04 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 06:23:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:23:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:23:04 INFO - Using real prefix '/usr' 06:23:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:23:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:23:07 INFO - Installing pip.................done. 06:23:07 INFO - Return code: 0 06:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:23:08 INFO - Reading from file tmpfile_stdout 06:23:08 INFO - Output received: 06:23:08 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) 06:23:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:08 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:08 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 06:23:08 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 06:23:08 INFO - Using env: {'DISPLAY': ':0', 06:23:08 INFO - 'HOME': '/home/cltbld', 06:23:08 INFO - 'LANG': 'en_US.UTF-8', 06:23:08 INFO - 'LANGUAGE': 'en_US:en', 06:23:08 INFO - 'LOGNAME': 'cltbld', 06:23:08 INFO - 'MAIL': '/var/mail/cltbld', 06:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:08 INFO - 'MOZ_NO_REMOTE': '1', 06:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:08 INFO - 'NO_EM_RESTART': '1', 06:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:08 INFO - 'PWD': '/builds/slave/test', 06:23:08 INFO - 'SHELL': '/bin/bash', 06:23:08 INFO - 'SHLVL': '1', 06:23:08 INFO - 'TERM': 'linux', 06:23:08 INFO - 'TMOUT': '86400', 06:23:08 INFO - 'USER': 'cltbld', 06:23:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:08 INFO - '_': '/tools/buildbot/bin/python'} 06:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:08 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 06:23:08 INFO - Cleaning up... 06:23:08 INFO - Return code: 0 06:23:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:08 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:08 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 06:23:08 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 06:23:08 INFO - Using env: {'DISPLAY': ':0', 06:23:08 INFO - 'HOME': '/home/cltbld', 06:23:08 INFO - 'LANG': 'en_US.UTF-8', 06:23:08 INFO - 'LANGUAGE': 'en_US:en', 06:23:08 INFO - 'LOGNAME': 'cltbld', 06:23:08 INFO - 'MAIL': '/var/mail/cltbld', 06:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:08 INFO - 'MOZ_NO_REMOTE': '1', 06:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:08 INFO - 'NO_EM_RESTART': '1', 06:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:08 INFO - 'PWD': '/builds/slave/test', 06:23:08 INFO - 'SHELL': '/bin/bash', 06:23:08 INFO - 'SHLVL': '1', 06:23:08 INFO - 'TERM': 'linux', 06:23:08 INFO - 'TMOUT': '86400', 06:23:08 INFO - 'USER': 'cltbld', 06:23:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:08 INFO - '_': '/tools/buildbot/bin/python'} 06:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:08 INFO - Downloading/unpacking psutil>=3.1.1 06:23:08 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 06:23:08 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 06:23:08 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 06:23:08 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 06:23:08 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 06:23:08 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 06:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:10 INFO - Installing collected packages: psutil 06:23:10 INFO - Running setup.py install for psutil 06:23:10 INFO - building 'psutil._psutil_linux' extension 06:23:10 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 06:23:11 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 06:23:11 INFO - building 'psutil._psutil_posix' extension 06:23:11 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 06:23:11 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 06:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:12 INFO - Successfully installed psutil 06:23:12 INFO - Cleaning up... 06:23:12 INFO - Return code: 0 06:23:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:23:12 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')]} 06:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:12 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')]} 06:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:12 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:12 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 06:23:12 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 06:23:12 INFO - Using env: {'DISPLAY': ':0', 06:23:12 INFO - 'HOME': '/home/cltbld', 06:23:12 INFO - 'LANG': 'en_US.UTF-8', 06:23:12 INFO - 'LANGUAGE': 'en_US:en', 06:23:12 INFO - 'LOGNAME': 'cltbld', 06:23:12 INFO - 'MAIL': '/var/mail/cltbld', 06:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:12 INFO - 'MOZ_NO_REMOTE': '1', 06:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:12 INFO - 'NO_EM_RESTART': '1', 06:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:12 INFO - 'PWD': '/builds/slave/test', 06:23:12 INFO - 'SHELL': '/bin/bash', 06:23:12 INFO - 'SHLVL': '1', 06:23:12 INFO - 'TERM': 'linux', 06:23:12 INFO - 'TMOUT': '86400', 06:23:12 INFO - 'USER': 'cltbld', 06:23:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:12 INFO - '_': '/tools/buildbot/bin/python'} 06:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:23:12 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 06:23:12 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 06:23:12 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 06:23:12 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 06:23:12 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 06:23:12 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 06:23:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:23:14 INFO - Installing collected packages: mozsystemmonitor 06:23:14 INFO - Running setup.py install for mozsystemmonitor 06:23:14 INFO - Successfully installed mozsystemmonitor 06:23:14 INFO - Cleaning up... 06:23:14 INFO - Return code: 0 06:23:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:23:14 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')]} 06:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:14 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')]} 06:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:14 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:14 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 06:23:14 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 06:23:14 INFO - Using env: {'DISPLAY': ':0', 06:23:14 INFO - 'HOME': '/home/cltbld', 06:23:14 INFO - 'LANG': 'en_US.UTF-8', 06:23:14 INFO - 'LANGUAGE': 'en_US:en', 06:23:14 INFO - 'LOGNAME': 'cltbld', 06:23:14 INFO - 'MAIL': '/var/mail/cltbld', 06:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:14 INFO - 'MOZ_NO_REMOTE': '1', 06:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:14 INFO - 'NO_EM_RESTART': '1', 06:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:14 INFO - 'PWD': '/builds/slave/test', 06:23:14 INFO - 'SHELL': '/bin/bash', 06:23:14 INFO - 'SHLVL': '1', 06:23:14 INFO - 'TERM': 'linux', 06:23:14 INFO - 'TMOUT': '86400', 06:23:14 INFO - 'USER': 'cltbld', 06:23:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:14 INFO - '_': '/tools/buildbot/bin/python'} 06:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:14 INFO - Downloading/unpacking jsonschema==2.5.1 06:23:14 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 06:23:14 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 06:23:14 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 06:23:14 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 06:23:14 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 06:23:14 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 06:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:23:16 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 06:23:16 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 06:23:16 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 06:23:16 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 06:23:16 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 06:23:16 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 06:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:23:16 INFO - warning: no files found matching '*.txt' 06:23:16 INFO - no previously-included directories found matching 'build' 06:23:16 INFO - no previously-included directories found matching 'dist' 06:23:16 INFO - no previously-included directories found matching '.git*' 06:23:16 INFO - Installing collected packages: jsonschema, functools32 06:23:16 INFO - Running setup.py install for functools32 06:23:17 INFO - warning: no files found matching '*.txt' 06:23:17 INFO - no previously-included directories found matching 'build' 06:23:17 INFO - no previously-included directories found matching 'dist' 06:23:17 INFO - no previously-included directories found matching '.git*' 06:23:17 INFO - Successfully installed jsonschema functools32 06:23:17 INFO - Cleaning up... 06:23:17 INFO - Return code: 0 06:23:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:23:17 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')]} 06:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:17 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')]} 06:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:17 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:17 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 06:23:17 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 06:23:17 INFO - Using env: {'DISPLAY': ':0', 06:23:17 INFO - 'HOME': '/home/cltbld', 06:23:17 INFO - 'LANG': 'en_US.UTF-8', 06:23:17 INFO - 'LANGUAGE': 'en_US:en', 06:23:17 INFO - 'LOGNAME': 'cltbld', 06:23:17 INFO - 'MAIL': '/var/mail/cltbld', 06:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:17 INFO - 'MOZ_NO_REMOTE': '1', 06:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:17 INFO - 'NO_EM_RESTART': '1', 06:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:17 INFO - 'PWD': '/builds/slave/test', 06:23:17 INFO - 'SHELL': '/bin/bash', 06:23:17 INFO - 'SHLVL': '1', 06:23:17 INFO - 'TERM': 'linux', 06:23:17 INFO - 'TMOUT': '86400', 06:23:17 INFO - 'USER': 'cltbld', 06:23:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:17 INFO - '_': '/tools/buildbot/bin/python'} 06:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:23:17 INFO - Cleaning up... 06:23:17 INFO - Return code: 0 06:23:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:23:17 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')]} 06:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:17 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')]} 06:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:17 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:17 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 06:23:17 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 06:23:17 INFO - Using env: {'DISPLAY': ':0', 06:23:17 INFO - 'HOME': '/home/cltbld', 06:23:17 INFO - 'LANG': 'en_US.UTF-8', 06:23:17 INFO - 'LANGUAGE': 'en_US:en', 06:23:17 INFO - 'LOGNAME': 'cltbld', 06:23:17 INFO - 'MAIL': '/var/mail/cltbld', 06:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:17 INFO - 'MOZ_NO_REMOTE': '1', 06:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:17 INFO - 'NO_EM_RESTART': '1', 06:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:17 INFO - 'PWD': '/builds/slave/test', 06:23:17 INFO - 'SHELL': '/bin/bash', 06:23:17 INFO - 'SHLVL': '1', 06:23:17 INFO - 'TERM': 'linux', 06:23:17 INFO - 'TMOUT': '86400', 06:23:17 INFO - 'USER': 'cltbld', 06:23:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:17 INFO - '_': '/tools/buildbot/bin/python'} 06:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 06:23:17 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 06:23:17 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 06:23:17 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 06:23:17 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 06:23:17 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 06:23:17 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 06:23:19 INFO - Downloading blobuploader-1.2.4.tar.gz 06:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:23:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:23:19 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 06:23:19 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 06:23:19 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 06:23:19 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 06:23:19 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 06:23:19 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 06:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:23:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:23:20 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 06:23:20 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 06:23:20 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 06:23:20 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 06:23:20 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 06:23:20 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 06:23:20 INFO - Downloading docopt-0.6.1.tar.gz 06:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 06:23:20 INFO - Running setup.py install for blobuploader 06:23:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:23:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:23:20 INFO - Running setup.py install for requests 06:23:20 INFO - Running setup.py install for docopt 06:23:20 INFO - Successfully installed blobuploader requests docopt 06:23:20 INFO - Cleaning up... 06:23:20 INFO - Return code: 0 06:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:20 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:20 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 06:23:20 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 06:23:20 INFO - Using env: {'DISPLAY': ':0', 06:23:20 INFO - 'HOME': '/home/cltbld', 06:23:20 INFO - 'LANG': 'en_US.UTF-8', 06:23:20 INFO - 'LANGUAGE': 'en_US:en', 06:23:20 INFO - 'LOGNAME': 'cltbld', 06:23:20 INFO - 'MAIL': '/var/mail/cltbld', 06:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:20 INFO - 'MOZ_NO_REMOTE': '1', 06:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:20 INFO - 'NO_EM_RESTART': '1', 06:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:20 INFO - 'PWD': '/builds/slave/test', 06:23:20 INFO - 'SHELL': '/bin/bash', 06:23:20 INFO - 'SHLVL': '1', 06:23:20 INFO - 'TERM': 'linux', 06:23:20 INFO - 'TMOUT': '86400', 06:23:20 INFO - 'USER': 'cltbld', 06:23:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:20 INFO - '_': '/tools/buildbot/bin/python'} 06:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:21 INFO - Running setup.py (path:/tmp/pip-AdTyXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:21 INFO - Running setup.py (path:/tmp/pip-a0MMI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:21 INFO - Running setup.py (path:/tmp/pip-eU8wWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:21 INFO - Running setup.py (path:/tmp/pip-mmNKUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:21 INFO - Running setup.py (path:/tmp/pip-2N_11B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:21 INFO - Running setup.py (path:/tmp/pip-8hGNHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:21 INFO - Running setup.py (path:/tmp/pip-CNcUSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:21 INFO - Running setup.py (path:/tmp/pip-OrFG_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:21 INFO - Running setup.py (path:/tmp/pip-ZSwkgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:21 INFO - Running setup.py (path:/tmp/pip-oXc0_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:21 INFO - Running setup.py (path:/tmp/pip-SK13Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:21 INFO - Running setup.py (path:/tmp/pip-DYPfTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:21 INFO - Running setup.py (path:/tmp/pip-D7tB7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:22 INFO - Running setup.py (path:/tmp/pip-Crlg1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:22 INFO - Running setup.py (path:/tmp/pip-kH8k4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:22 INFO - Running setup.py (path:/tmp/pip-0VyF5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:22 INFO - Running setup.py (path:/tmp/pip-A4tupv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:22 INFO - Running setup.py install for manifestparser 06:23:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:22 INFO - Running setup.py install for mozcrash 06:23:22 INFO - Running setup.py install for mozdebug 06:23:22 INFO - Running setup.py install for mozdevice 06:23:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:22 INFO - Running setup.py install for mozfile 06:23:22 INFO - Running setup.py install for mozhttpd 06:23:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:23:22 INFO - Running setup.py install for mozinfo 06:23:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Running setup.py install for mozInstall 06:23:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Running setup.py install for mozleak 06:23:23 INFO - Running setup.py install for mozlog 06:23:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Running setup.py install for moznetwork 06:23:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Running setup.py install for mozprocess 06:23:23 INFO - Running setup.py install for mozprofile 06:23:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Running setup.py install for mozrunner 06:23:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:23:23 INFO - Running setup.py install for mozscreenshot 06:23:23 INFO - Running setup.py install for moztest 06:23:24 INFO - Running setup.py install for mozversion 06:23:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:23:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:23:24 INFO - Cleaning up... 06:23:24 INFO - Return code: 0 06:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:24 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:24 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 06:23:24 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 06:23:24 INFO - Using env: {'DISPLAY': ':0', 06:23:24 INFO - 'HOME': '/home/cltbld', 06:23:24 INFO - 'LANG': 'en_US.UTF-8', 06:23:24 INFO - 'LANGUAGE': 'en_US:en', 06:23:24 INFO - 'LOGNAME': 'cltbld', 06:23:24 INFO - 'MAIL': '/var/mail/cltbld', 06:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:24 INFO - 'MOZ_NO_REMOTE': '1', 06:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:24 INFO - 'NO_EM_RESTART': '1', 06:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:24 INFO - 'PWD': '/builds/slave/test', 06:23:24 INFO - 'SHELL': '/bin/bash', 06:23:24 INFO - 'SHLVL': '1', 06:23:24 INFO - 'TERM': 'linux', 06:23:24 INFO - 'TMOUT': '86400', 06:23:24 INFO - 'USER': 'cltbld', 06:23:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:24 INFO - '_': '/tools/buildbot/bin/python'} 06:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:24 INFO - Running setup.py (path:/tmp/pip-li_fOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:24 INFO - Running setup.py (path:/tmp/pip-RluLMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:24 INFO - Running setup.py (path:/tmp/pip-W2eEAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:24 INFO - Running setup.py (path:/tmp/pip-hcDRUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:24 INFO - Running setup.py (path:/tmp/pip-NODhja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:24 INFO - Running setup.py (path:/tmp/pip-x2N3wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:24 INFO - Running setup.py (path:/tmp/pip-qK8X8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:24 INFO - Running setup.py (path:/tmp/pip-XpyX3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:24 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)) 06:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:24 INFO - Running setup.py (path:/tmp/pip-p7KYvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:25 INFO - Running setup.py (path:/tmp/pip-BBoaLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:25 INFO - Running setup.py (path:/tmp/pip-RZwh6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:25 INFO - Running setup.py (path:/tmp/pip-0ZM8FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:25 INFO - Running setup.py (path:/tmp/pip-oROXiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:25 INFO - Running setup.py (path:/tmp/pip-FzyBW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:25 INFO - Running setup.py (path:/tmp/pip-Se2dMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:25 INFO - Running setup.py (path:/tmp/pip-a3yaD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:25 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)) 06:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:25 INFO - Running setup.py (path:/tmp/pip-tjM2Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:25 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)) 06:23:25 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)) 06:23:25 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)) 06:23:25 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)) 06:23:25 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)) 06:23:25 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)) 06:23:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:27 INFO - Downloading blessings-1.6.tar.gz 06:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:23:27 INFO - Installing collected packages: blessings 06:23:27 INFO - Running setup.py install for blessings 06:23:27 INFO - Successfully installed blessings 06:23:27 INFO - Cleaning up... 06:23:27 INFO - Return code: 0 06:23:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:28 INFO - Reading from file tmpfile_stdout 06:23:28 INFO - Current package versions: 06:23:28 INFO - argparse == 1.2.1 06:23:28 INFO - blessings == 1.6 06:23:28 INFO - blobuploader == 1.2.4 06:23:28 INFO - docopt == 0.6.1 06:23:28 INFO - functools32 == 3.2.3-2 06:23:28 INFO - jsonschema == 2.5.1 06:23:28 INFO - manifestparser == 1.1 06:23:28 INFO - mozInstall == 1.12 06:23:28 INFO - mozcrash == 0.17 06:23:28 INFO - mozdebug == 0.1 06:23:28 INFO - mozdevice == 0.48 06:23:28 INFO - mozfile == 1.2 06:23:28 INFO - mozhttpd == 0.7 06:23:28 INFO - mozinfo == 0.9 06:23:28 INFO - mozleak == 0.1 06:23:28 INFO - mozlog == 3.4 06:23:28 INFO - moznetwork == 0.27 06:23:28 INFO - mozprocess == 0.23 06:23:28 INFO - mozprofile == 0.28 06:23:28 INFO - mozrunner == 6.12 06:23:28 INFO - mozscreenshot == 0.1 06:23:28 INFO - mozsystemmonitor == 0.3 06:23:28 INFO - moztest == 0.7 06:23:28 INFO - mozversion == 1.4 06:23:28 INFO - psutil == 3.1.1 06:23:28 INFO - requests == 1.2.3 06:23:28 INFO - wsgiref == 0.1.2 06:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:28 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 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:28 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 06:23:28 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 06:23:28 INFO - Using env: {'DISPLAY': ':0', 06:23:28 INFO - 'HOME': '/home/cltbld', 06:23:28 INFO - 'LANG': 'en_US.UTF-8', 06:23:28 INFO - 'LANGUAGE': 'en_US:en', 06:23:28 INFO - 'LOGNAME': 'cltbld', 06:23:28 INFO - 'MAIL': '/var/mail/cltbld', 06:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:28 INFO - 'MOZ_NO_REMOTE': '1', 06:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:28 INFO - 'NO_EM_RESTART': '1', 06:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:28 INFO - 'PWD': '/builds/slave/test', 06:23:28 INFO - 'SHELL': '/bin/bash', 06:23:28 INFO - 'SHLVL': '1', 06:23:28 INFO - 'TERM': 'linux', 06:23:28 INFO - 'TMOUT': '86400', 06:23:28 INFO - 'USER': 'cltbld', 06:23:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:28 INFO - '_': '/tools/buildbot/bin/python'} 06:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 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)) 06:23:28 INFO - Cleaning up... 06:23:28 INFO - Return code: 0 06:23:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3f7147f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', '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 06:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:23:28 INFO - Using env: {'DISPLAY': ':0', 06:23:28 INFO - 'HOME': '/home/cltbld', 06:23:28 INFO - 'LANG': 'en_US.UTF-8', 06:23:28 INFO - 'LANGUAGE': 'en_US:en', 06:23:28 INFO - 'LOGNAME': 'cltbld', 06:23:28 INFO - 'MAIL': '/var/mail/cltbld', 06:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:28 INFO - 'MOZ_NO_REMOTE': '1', 06:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:28 INFO - 'NO_EM_RESTART': '1', 06:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:28 INFO - 'PWD': '/builds/slave/test', 06:23:28 INFO - 'SHELL': '/bin/bash', 06:23:28 INFO - 'SHLVL': '1', 06:23:28 INFO - 'TERM': 'linux', 06:23:28 INFO - 'TMOUT': '86400', 06:23:28 INFO - 'USER': 'cltbld', 06:23:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:28 INFO - '_': '/tools/buildbot/bin/python'} 06:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:23:28 INFO - Cleaning up... 06:23:28 INFO - Return code: 0 06:23:28 INFO - Running post-action listener: _resource_record_post_action 06:23:28 INFO - Running post-action listener: _start_resource_monitoring 06:23:28 INFO - Starting resource monitoring. 06:23:28 INFO - [mozharness: 2016-10-20 13:23:28.577827Z] Finished create-virtualenv step (success) 06:23:28 INFO - [mozharness: 2016-10-20 13:23:28.578323Z] Running install step. 06:23:28 INFO - Running pre-action listener: _resource_record_pre_action 06:23:28 INFO - Running main action method: install 06:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:28 INFO - Reading from file tmpfile_stdout 06:23:28 INFO - Detecting whether we're running mozinstall >=1.0... 06:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:23:28 INFO - Reading from file tmpfile_stdout 06:23:28 INFO - Output received: 06:23:28 INFO - Usage: mozinstall [options] installer 06:23:28 INFO - Options: 06:23:28 INFO - -h, --help show this help message and exit 06:23:28 INFO - -d DEST, --destination=DEST 06:23:28 INFO - Directory to install application into. [default: 06:23:28 INFO - "/builds/slave/test"] 06:23:28 INFO - --app=APP Application being installed. [default: firefox] 06:23:28 INFO - mkdir: /builds/slave/test/build/application 06:23:28 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'] 06:23:28 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 06:23:45 INFO - Reading from file tmpfile_stdout 06:23:45 INFO - Output received: 06:23:45 INFO - /builds/slave/test/build/application/firefox/firefox 06:23:45 INFO - Running post-action listener: _resource_record_post_action 06:23:45 INFO - [mozharness: 2016-10-20 13:23:45.803957Z] Finished install step (success) 06:23:45 INFO - [mozharness: 2016-10-20 13:23:45.804204Z] Running run-tests step. 06:23:45 INFO - Running pre-action listener: _resource_record_pre_action 06:23:45 INFO - Running main action method: run_tests 06:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:23:45 INFO - Python 2.7.3 06:23:45 INFO - Return code: 0 06:23:45 INFO - grabbing minidump binary from tooltool 06:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:45 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 0x1041930>, '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 0x1042830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:23:45 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 06:23:45 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 06:23:45 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 06:23:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:23:45 INFO - Return code: 0 06:23:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:23:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:23:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:23:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:23:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:23:45 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:23:45 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:23:45 INFO - Using env: {'DISPLAY': ':0', 06:23:45 INFO - 'HOME': '/home/cltbld', 06:23:45 INFO - 'LANG': 'en_US.UTF-8', 06:23:45 INFO - 'LANGUAGE': 'en_US:en', 06:23:45 INFO - 'LOGNAME': 'cltbld', 06:23:45 INFO - 'MAIL': '/var/mail/cltbld', 06:23:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:23:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:45 INFO - 'MOZ_NO_REMOTE': '1', 06:23:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:45 INFO - 'NO_EM_RESTART': '1', 06:23:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:45 INFO - 'PWD': '/builds/slave/test', 06:23:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:23:45 INFO - 'SHELL': '/bin/bash', 06:23:45 INFO - 'SHLVL': '1', 06:23:45 INFO - 'TERM': 'linux', 06:23:45 INFO - 'TMOUT': '86400', 06:23:45 INFO - 'USER': 'cltbld', 06:23:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637', 06:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:45 INFO - '_': '/tools/buildbot/bin/python'} 06:23:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:23:46 INFO - mozversion application_buildid: 20161020033007 06:23:46 INFO - mozversion application_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 06:23:46 INFO - mozversion application_display_name: Nightly 06:23:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:23:46 INFO - mozversion application_name: Firefox 06:23:46 INFO - mozversion application_remotingname: firefox 06:23:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:23:46 INFO - mozversion application_vendor: Mozilla 06:23:46 INFO - mozversion application_version: 52.0a1 06:23:46 INFO - mozversion platform_buildid: 20161020033007 06:23:46 INFO - mozversion platform_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 06:23:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:23:46 INFO - mozversion platform_version: 52.0a1 06:23:46 INFO - using testdate: 1476969826 06:23:46 INFO - actual date: 1476969826 06:23:46 INFO - starting webserver on 'localhost:42623' 06:23:46 INFO - SUITE-START | Running 2 tests 06:23:46 INFO - TEST-START | dromaeo_css 06:23:46 INFO - operating with platform_type : linux_ 06:23:46 INFO - Initialising browser for dromaeo_css test... 06:23:46 INFO - TEST-INFO | started process 3344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL99Kg7/profile http://localhost:42623/getInfo.html) 06:23:51 INFO - PROCESS | 3344 | __metrics Screen width/height:1600/1200 06:23:51 INFO - PROCESS | 3344 | colorDepth:24 06:23:51 INFO - PROCESS | 3344 | Browser inner width/height: 1024/697 06:23:51 INFO - PROCESS | 3344 | __metrics 06:23:52 INFO - PROCESS | 3344 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:23:52 INFO - PROCESS | 3344 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:23:53 INFO - PROCESS | 3344 | console.error: PushService: 06:23:53 INFO - PROCESS | 3344 | stateChangeProcessEnqueue: Error transitioning state 06:23:53 INFO - PROCESS | 3344 | UnknownError 06:23:53 INFO - TEST-INFO | 3344: exit 0 06:23:53 INFO - Browser initialized. 06:23:53 INFO - Running cycle 1/1 for dromaeo_css test... 06:23:53 INFO - TEST-INFO | started process 3430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL99Kg7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:05 INFO - PROCESS | 3430 | RSS: Main: 171843584 06:24:05 INFO - PROCESS | 3430 | 06:24:56 INFO - PROCESS | 3430 | 1476969896623 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] 06:27:07 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:42623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42623/tests/dromaeo/cssquery-ext.html) 06:27:10 INFO - PROCESS | 3430 | RSS: Main: 415203328 06:27:10 INFO - PROCESS | 3430 | 06:30:12 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:42623/tests/dromaeo/cssquery-ext.html (next: http://localhost:42623/tests/dromaeo/cssquery-jquery.html) 06:30:13 INFO - PROCESS | 3430 | RSS: Main: 283996160 06:30:13 INFO - PROCESS | 3430 | 06:33:15 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:42623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42623/tests/dromaeo/cssquery-mootools.html) 06:33:16 INFO - PROCESS | 3430 | RSS: Main: 219402240 06:33:16 INFO - PROCESS | 3430 | 06:36:18 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:42623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42623/tests/dromaeo/cssquery-prototype.html) 06:36:18 INFO - PROCESS | 3430 | RSS: Main: 219648000 06:36:18 INFO - PROCESS | 3430 | 06:39:21 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:42623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42623/tests/dromaeo/cssquery-yui.html) 06:39:22 INFO - PROCESS | 3430 | RSS: Main: 220258304 06:39:22 INFO - PROCESS | 3430 | 06:42:24 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:42623/tests/dromaeo/cssquery-yui.html (next: http://localhost:42623/tests/dromaeo/cssquery-dojo.html) 06:42:25 INFO - PROCESS | 3430 | RSS: Main: 318451712 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | __start_tp_report 06:42:25 INFO - PROCESS | 3430 | _x_x_mozilla_page_load 06:42:25 INFO - PROCESS | 3430 | _x_x_mozilla_page_load_details 06:42:25 INFO - PROCESS | 3430 | |i|pagename|runs| 06:42:25 INFO - PROCESS | 3430 | |0;dojo.html;2980.9105726828175;3018.7735919806005;3022.6070610820575;3030.181850900257;3070.9692903070977;5134.2812006319145;5193.1171700810855;5219.373675158981;5237.685738855671;5311.973440132803;5207.557357624597;5219.608529360304;5223.425423203454;5226.24219488174;5233.685978841272;4691.085238378518;4695.906081878352;4746.620270378361;4766.952330476703;4867.829625963092;4786.282057691356;4788.0423915216925;4797.0405918816205;4843.782029808667;4858.927116093261;4214.36784482327;4779.737114458703;4845.370101886768;4847.369841920546;4889.3399391082285;4810.494898035691;4812.831550895702;4845.563899249085;4862.44081930579;4883.487233840467;4639.652026098022;4674.228752255874;4680.087382960324;4686.343911852344;4741.834035808764;5068.543831055223;5078.822241221539;5132.076226279269;5172.922406163911;5221.895562088775;5463.235147079412;5496.642718223303;5511.366192887829;5535.806246781343;5551.472610102034;5447.264619276387;5448.182772584105;5494.423085575997;5553.111502159675;5559.499645031967;5160.122779127557;5163.896722065538;5168.483151684839;5170.276161337416;5223.608229382773;5601.719914004283;5613.887722245532;5623.212750214973;5631.859203519863;5694;5325.760340784674;5357.8392648220615;5377.139657654757;5384.6499977501335;5475.808346707846;5573.247611572467;5576.637518561281;5599.328080630269;5631.971840140773;5632.746526406321;5538.280023596906;5540.113581826889;5549.833504994856;5553.250311208016;5611.691356975405;5381.569474442035;5520.751566179451;5536.667799932017;5537.944620553823;5538.806141785099;4242.236397448489;4254.106637606075;4265.637420819203;4266.232078225949;4289.806958686867;3723.832427540767;3748.475213470116;3791.7914514701406;3814.504114465102;3843.9807800960816;5237.554807841376;5246.580273578104;5255.842324730264;5272.736363181825;5286.444923283077;5451.918221226685;5490.670559766347;5498.092814685612;5503.394626591072;5537.335519737658;5281.445448227958;5295.443978382292;5297.867553311121;5363.088274993261;5365.54392876602;4791.664583479123;4809.639277054235;4817.0365926814775;4817.78319975602;4878.219484882402;5570.387257401763;5620.775168993195;5675.318961724702;5737.225474560964;5738.713064346766;5502.80740174092;5561.694106824001;5562.860928476821;5564.054110801093;5632.605717599728;5650.463205995424;5691.630044047124;5696.487316141402;5698.743556540048;5708.743106560298;5311.734413279243;5352.785888564414;5434.10337294342;5455.672659640434;5459.836204913859;5424.267723857229;5495.258140151029;5496.367917689357;5497.230387745799;5503.889922201613;5366.785328586813;5369.704666243238;5373.570114390917;5373.596980226421;5376.838694839161;5351.277577526984;5354.196870469305;5358.785648574013;5361.892762144813;5365.409804921377;5322.733863306897;5348.679079255257;5368.57051435892;5384.219288203267;5387.138057910715;5330.9733451332495;5356.223347614497;5356.464353564768;5357.383900851296;5361.410244872983;5231.55531779803;5260.921086183634;5302.973485132549;5383.219433182088;5405.918911216257 06:42:25 INFO - PROCESS | 3430 | |1;ext.html;602.5270162922105;616.054356562676;638.9456896163825;640.80135158101;642.1587720086684;31903.840480797593;43252.567474325246;43988.78005609976;43995.56004439955;47393.7630311848;45217.547824521745;45641.31538026932;45674.54325456744;45680.771596141974;45714.77142614282;8747.650093996233;8908.109189081104;8911.108889111101;8911.598978045971;8912.465252084863;7976.680932762712;8162.224588664068;10453.268271220979;10698.572057117706;10704;10793.946030269877;10876.836847447295;10891.455427228646;10895.237333386665;10898.182636302308;10710.732231694192;10721.249512534127;10727.141828653688;10739.516721747501;10814.134869210444;10459.738506537322;10517.263791534595;10518.579256829718;10518.894811051869;10520.105791007774;41145;41432.58567414317;41445.79277103595;41447;41454;3095.1178914009397;3348.68187522185;3448.2413868948793;3492.9301413971834;3518.6629080949074;30883.22791930197;30886.845565772026;30995.380092398027;31010.689893101007;31218.37563248745;4134.1731653669085;4194.559571245037;4201.411802347674;4202.180574787918;4238.7032907696475;216793;218130;218243;218309;218826;33758.83120584382;56739.43260567424;56776.71611641916;56954.145687813885;57039.714801425725;34683;36015.4597681035;36322.81838590843;36475.635243647754;36562;13884.652883677989;13949.58151255464;13960.720785584232;13990.510332138327;14076.648083797987;10460.52927618259;10790.73023174427;11586.536538538532;11664.066874650178;11678.357690326944;7816;7868.409869259828;7950.522968621901;8277;8299.170082991774;3115.7781206465365;3166.8733250669716;3181.5227715842807;3206.470932296145;3253.967460325414;959.5729900194486;990.4156547636928;1055.767731099157;1068.278911734576;1073.592035026685;31534.842325788683;32006.679933200834;32094.83952580222;32094.83952580269;32350.514742278883;1046.6493724602344;1094.7372630568607;1106.3527836215742;1123.6179698902413;1187.352892673495;16299.266533005806;17004.319827206775;17042.74435883463;17089.91455042717;17090.48728538146;475347;475527;477742;478090;478714.6064269656;57376;57997.420025799205;58088;58109.4189058104;58154.7092264536;1289.509986205236;1309.3780454284329;1326.588757485202;1327.5220920468623;1341.2891167681144;30115.69884301129;30973;31413.685863141076;31863.330153957544;32017.67982320147;49658.75170624124;50112.49887501078;50128.498715012385;50357;50509.49490505195;382210;382778;383173;383693;385013;27153.321166970985;27559.86220068887;27737.306567335978;27748.86125569359;27756;46350.7682461599;46385.30422043739;47359;47378.76310618425;47748;39054.02364940899;39274;39850.402243965786;40169.59830401659;41196.38205426981;39063.609363906;39636.405453917636;40056.198876021735;40866.79566602148;41181.794091030555;40190.397144042276;40759.388609170295;40877.38683919684;41083.1783364337;41450.79274603607;32712.50931236081;35647;35668.094898039446;35819.64180358163;35948.64051359453;27380.589291161046;27755.44489110247;27987.300317492227;28046.859765701858;28060.29849253785 06:42:25 INFO - PROCESS | 3430 | |2;jquery.html;355.1334743226529;372.73908264215055;377.3396556026952;388.0899291162225;396.8610986154844;14205.857941420583;18008.369707060272;18124.36564720235;18427.907860460713;19477.707834382494;17869.553261168476;18281.54296142597;18331.266749330043;18444.354447594338;19223.173798489155;5100.642954993143;5366.624336296461;5373.113436283028;5374.48942350476;5383.838484845461;3853.9401664542197;3881.4565960765517;5248.501392367719;5383.81156659517;5396.082665946798;5818.767249310023;5869.178315035899;5888.205092312547;5929.525637948954;5932.317783454893;5537.58468114893;5852.736626851802;5878.853028674296;5879.853003674921;5884.794032208873;5750.913736293959;5753.108268218432;5760.74076666551;5772.538196944234;5783.624064435799;13439.328033598282;20915;22671.886640566856;22926.312210633707;22937.197198098154;2254.2448279826276;2261.8416710830247;2294.865774829408;2302.26327575176;2431.234161239204;9207;9529.809403811954;10008.849867251924;10269.640562580349;11339.546418143347;1808.2043900683789;1862.37610400516;1893.7632795900513;1913.8468922486306;1973.891435971021;79702.08192746983;84275.5786221071;84795.5760221201;85612.57193713992;86532.56733716291;10234.948825255975;10578.894211057945;10774;10926.125909927347;11060.281081729823;15201.543953681406;15228.771568426482;15237.161956092521;15265;15274;7529.698812047566;7584.62076896153;7755.185705500954;7819.0617125945255;7846.607669616496;6661.367170118831;6856.588604683635;6900.551464154914;6912;6943.756968506179;4533.750643714561;4548.5224051474115;4614.215583350771;4702.482726900038;4719.834805781781;1784.12577836859;1943.9611207775765;1966.8131527504863;1974.131382191831;2007.9899600502197;843.9957800211082;905.3300557587338;950.8684665248333;952.1002652493465;1058.5924419098549;18167.90916045438;19268.518287042654;19320;19540.224156919765;19540.90229548843;954.355809828363;957.090763774417;957.1385752822515;979.0698836105728;1007.2121983479236;10000.199984001263;10346.53440595175;10673.573057077785;10687.519061642244;10688.412137332365;413190;417245;422270;424903;427584;89923;90489.54755226182;91556;91596.54201728948;91782;942.2697409507549;975.5024937282037;1003.2626019875386;1007.4761124215366;1011.8785745710414;16194;16478.75281870749;16685.91657041707;16708.33166673368;17016.978981261163;38746.41880371853;40671.38992915049;41067.589324106375;41078.58921410747;43029.35455968101;56178;56654.43345566656;56675.71662141663;56890;56978.715106424206;7994.1606131355375;8321.209485098905;8428.241458268785;8447.831043379221;8574.699885503978;11706.824397633873;12423.503059877503;13046.673833154247;13114.934425327812;13167.60497185086;10780;10862.782744345226;11150.330980141218;11158.944205278922;11242.156838237328;11313.321200727984;11356.375399352784;11556;11622.418879055844;11638;11771.47028383742;11870.169088163746;11881.227720198505;12182.512699492276;12358.62924112278;7411.370033547209;7435.4795164337975;7631.427642926914;7822;8452.281556067803;10529.526171322155;11718.94140529326;11827.940860295643;11862.466189021343;12378.75242495163 06:42:25 INFO - PROCESS | 3430 | |3;mootools.html;1339.7043273547074;1413.731391035703;1452.0489079652828;1545.4281915691197;1733.852622527085;7453.217412171718;7992.840143197132;8185.795355116117;8262.173782621734;8440.957795211016;8190.590470476483;8256.25693687568;8263.876041859361;8264.214899584545;8273.29676977456;2194.9780502194935;2222.055626358791;2224.7219097612797;2225.643896976476;2227.7549469558335;2157.7194964654573;2199.659052846803;2202.042111681416;2205.7683943185975;2209.304069218191;2203.6474164133742;2217.168561789329;2224.8998795054263;2226.209695558078;2240.955180896381;2168.967465488019;2169.609470295346;2169.902354394056;2171.5873983943;2177.1835561664375;2080.750309962799;2153.0311359887955;2167.1764729402726;2169.5010147666126;2170.6201414752513;8210.261076503084;8223.095459499451;8297.170282971714;8301.169883011711;8307.418480706354;4973.5523802857915;5170.560502357304;5184.377874655028;5190.948090519122;5192.3769147702515;3194.984025079883;3358.177246574605;3396.1679388549715;3408.2672225471397;3409.352223077632;1077.4343469678404;1133.9716507087305;1134.4157758754247;1150.384544268812;1153.2446247707765;11138.108951283877;11155.888441115567;11174.161937854693;11175.552977880876;11260.943695281552;4170.52039015511;4232.957670423257;4451.154280686659;4461.598456138898;4480.910381792346;9154.771130721652;9166.954165229132;9168.083191680911;9172.587233574504;9176;5114.462981386975;5115.283860259567;5117.667351622133;5122.078025955364;5122.718250496184;4029.5366032906004;4212.705110642226;4394.560543945579;4824.710517368969;4830.468648448667;3347.43093674076;3651.653092956165;3706.0734816295926;3723.590405055442;3736.4768932349493;1085.3379438542484;1121.994390028061;1128.6097082349665;1131.9943400283112;1139.5726602524053;790.9881351779728;937.4188003437775;950.8906475755376;953.9379940303858;983.4148681534475;5596.832095037155;5699.544036477072;5740.56945729072;5782.132680097935;5837.88324233513;427.06259759826884;444.16718652526515;444.66205683680636;446.87040758180416;447.7000409725492;4088.2436749201493;4092.3656833190903;4113.85601503946;4132.297509423405;4150.688698347576;9732.318737688294;9914.30599858003;9953.004699530135;9954.900450995543;9979.650712225037;9803.16673082796;9832;9871.40771553709;9885.901140988643;9889.505524723734;7297.963510182415;7501.549907005598;7512.060992375953;7534.321911028033;7716.614169291401;5815.505682017076;5871.4715675589405;5905.675187864708;5970.194023806731;5983.581149319506;9350.485723285285;9373.343865929319;9431.104045115702;9523.619055237712;9561.665341713007;8786.121387861163;9314.860277095984;9536.380135291183;9537.189338905993;9711.077447642463;6826.180858297036;6972.163340399185;6977.232504424611;7010.4041156500225;7179.246179151114;7524.887126692995;7830.2169783021245;7939.603019848869;7995.920550725577;7997.800054998672;7093.538919970186;7142.357187853118;7204.639768011683;7232.783016509513;7430.517016393917;7149.285071492809;7151.60666163366;7264.091988501437;7265.564066156047;7301.196868344584;6556.8360790978695;6716.361945615159;6731.629760363227;6738.35985581369;6741.52809303344;4926.926096108633;4988.825391111439;5053.317802096817;5079.212722028092;5146.073706732824;4980.800767969386;5011.148104822262;5101.107306221471;5123;5250.579953603779 06:42:25 INFO - PROCESS | 3430 | |4;prototype.html;303.78127748021416;307.1813616711464;313.9121046107091;322.88537569162946;326.7500362222899;5336.546393556548;5400.24396584478;5407.567394608432;5414.242006119146;5420.159875219342;5326.121190003654;5328.415718376585;5335.733213339327;5350.545203657684;5354.518093371596;4169.249535083683;4175.853845115422;4176.1230141670285;4187.7487350758975;4187.874363769077;3940.2710498557717;4157.106222162234;4176.352665336878;4198.244316023115;4199.517055538607;4127.525334586516;4134.937975930364;4140.37894315852;4152.128053108836;4157.667386609064;3888.5333759948985;4001.559828418872;4112.820205291186;4134.958650413488;4139.234241665302;3518.683318501347;3580.6777390034763;3584.713222942158;3589.264200838848;3621.474886141521;5069.935313584152;5104.719240441774;5113.2330150477355;5118.6416950813455;5147.897042059175;4529.5243999380245;4616.69991450558;4641.605463535603;4734;4763.523647635244;5487.917681234785;5494.642848214853;5512.972435137799;5513.807016754395;5528.7055871813145;3972.8410863565423;3978.1844721832244;3982.2433737589763;3983.641472267481;3984.9240705009483;5621.634593751393;5640.971795141039;5715.056745775887;5722.227499287585;5776.624519406268;4029.2143032108456;4034;4037.858674946363;4043.5147782265726;4056.7768772717195;4096.303628383182;4096.365063415175;4102.077032667626;4104.240715467648;4107.609777071173;4451.821927122879;4668.813247470063;4673.906521869543;4704.88237794051;4712.222483290218;5566.387697353369;5567.079357621614;5568.248286481273;5570.554355651539;5634.4647258511195;1400.6483743187669;1417.0222546443129;1417.8723914847508;1421.5024741340449;1425.7291114688176;858.4591707224408;907.4101833808078;920.7467946314817;925.7222833150028;935.1116439382614;4728.777474586938;4769.73766442842;4775.355327030876;4796.544328288807;4850.5149485051215;4928.48250933654;4938.629602779806;4957.925631115536;4972.303877457159;4998.625103117281;4721.386219791405;4764.309175169581;4776.47458779534;4826.7827947742435;5037.571806396424;2903.6225290712073;2961.1708721557998;2967.1840243933093;2997.010986374491;3024.9848750756105;5823.854403639858;5825.475707186373;5832.387599302097;5832.783542254001;5855.765769369263;5567.276254086943;5689.459501347365;5773.336066352424;5822.359540450547;5825.7378417971295;5767.769289228468;5776.306843178845;5779.248697669276;5791.739371728282;5817.3019237690905;5594.916076258941;5633.690147041952;5706.058500347563;5716.456936591017;5717.599768016199;5406.513413792777;5614.550835933034;5637.746301416364;5646.689432081275;5673.716314184192;5820.70896455184;5862.706864656835;5884.823455296348;5908.615939963888;5908.675022873783;4034.899127521718;4040.676745860383;4042.130941847517;4053.6622914437576;4069.7761623111014;5504.22940788298;5717.256756621613;5740.942590574208;5774.509166720708;5789.710514474344;5576.553875689854;5614.354349249888;5615.494605485526;5638.407967163389;5666.291713535808;5499.450054994469;5554.1946417770005;5560.749766260447;5633.126865335879;5672.688002159921;5568.858384031183;5581.860453488695;5583.325002499315;5584.748686309044;5595.07681232592;5616.129499927518;5617.859553511195;5619.747111380079;5657.886842263214;5691.800786972602;5399.326208875261;5419.783208671609;5437.211604317273;5499.2576002240785;5517.586181036358 06:42:25 INFO - PROCESS | 3430 | |5;yui.html;717.8636059148764;730.7734602273295;735.7351353512735;767.4857845243686;813.6989313953836;15479.61300967475;16026.118563479004;16152.919235403835;16187.514374568753;16214.432494862682;15021.896934429189;15285.388584456608;15412.229388530584;15423.614409639764;15450.5364839055;788.0936922539097;811.2941740685583;812.8008637883727;813.1137060603941;813.5281536708695;796.9163237860029;800.3597122302135;800.4196957206037;800.4676889868231;800.9959950200241;841.6170642357713;844.472204871955;844.5481667307992;844.67902197165;845.3026253341018;837.3803385494751;839.0225387423644;839.1943734015322;839.2195258409677;840.2185967050641;622.1880446017944;622.5704264057786;622.9439350458481;623.2271982741413;623.2676604989119;13015.609531714064;13075.346232688327;13094.476220951246;13122.540711075162;13123.343832808321;12723.936380318039;12838.293893835835;12942;13057.934710326483;13262.403191856292;10905.890941090567;11252.324860508314;11274.774504509864;11777.411129443579;11963.282203067844;3699.4635777812337;3727.07307234524;3829;3945.210957808421;3949.763014219156;76554.23445765582;77077.61461192714;77286;82128.58935705283;82209.58895205485;9417.670381536613;9488.146066853878;9624.566894489764;9738.415695058318;10225.693229203136;20439.284625038053;20439.59120817605;20470;20472.18111275562;20527.794722052888;8129.1464396238725;8429.283510901641;8508.446950948168;8510.702125425703;8519.233269005696;4754.78603462845;4846.273059041101;4862.124817532807;4909.7790599423115;4991.07665081961;3092.304231547884;3474.8262586870555;3600.297941901304;3602.603713591503;3811.5426148862316;622.0668996505242;633.2243002322118;633.8383712153371;636.8789929913302;637.8150336402391;671.6473851228144;705.5837056136904;712.9362632991966;725.793148952546;737.6533029476137;8855.87459009833;9017.188453039258;9219;9409.576569054409;9749.463779492055;608.0696534302524;612.7487730030755;625.8657976300883;658.6871236162784;679.4598294355999;4303.569643035734;4444.73331600105;4635.95364046362;4719.716816990992;4785.688930219525;67864;68209;89052;111317;118992;103499;103748;105829;107035.46482267539;109818;88841.55579222192;89622.55188724014;91306;93304;93855.061449386;8876;8924.196822286025;9077.183053525214;9158.129977652112;9190.770230744285;52495;54087.45912540824;54805.23116301373;54929;55368.44631553633;45513;63983.6800815993;75451.35920242766;75959.24040759522;76572;12773.87226127764;12876.420561074587;13188.868111318763;13421.798673019717;13426.597202083953;13970.790438143233;14509.709805803614;14920.104793712411;15078.321475533847;15251.542453726406;12744.49022039108;13279.933600331937;13383.665408364868;13649.318432519372;13802.17186968785;13804.240766757925;13857.72284554283;14607.123572585679;14856.628584285047;15195.240237988277;12448.31534265624;12474;12510.56213032576;12903.41934612926;12942.288174150512;10528.578856845641;10741.698150725915;10957.83563246536;11106;11287.830682539605;10025.498725063571;10292;10535.63125290611;11466.885331146581;11806.571073501567 06:42:25 INFO - PROCESS | 3430 | __end_tp_report 06:42:25 INFO - PROCESS | 3430 | __start_cc_report 06:42:25 INFO - PROCESS | 3430 | _x_x_mozilla_cycle_collect,2510 06:42:25 INFO - PROCESS | 3430 | __end_cc_report 06:42:25 INFO - PROCESS | 3430 | __startTimestamp1476970945198__endTimestamp 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | ------- Summary: start ------- 06:42:25 INFO - PROCESS | 3430 | Number of tests: 6 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | [#0] dojo.html Cycles:165 Average:5145.51 Median:5352.79 stddev:565.24 (10.6%) stddev-sans-first:540.87 06:42:25 INFO - PROCESS | 3430 | Values: 2980.9 3018.8 3022.6 3030.2 3071.0 5134.3 5193.1 5219.4 5237.7 5312.0 5207.6 5219.6 5223.4 5226.2 5233.7 4691.1 4695.9 4746.6 4767.0 4867.8 4786.3 4788.0 4797.0 4843.8 4858.9 4214.4 4779.7 4845.4 4847.4 4889.3 4810.5 4812.8 4845.6 4862.4 4883.5 4639.7 4674.2 4680.1 4686.3 4741.8 5068.5 5078.8 5132.1 5172.9 5221.9 5463.2 5496.6 5511.4 5535.8 5551.5 5447.3 5448.2 5494.4 5553.1 5559.5 5160.1 5163.9 5168.5 5170.3 5223.6 5601.7 5613.9 5623.2 5631.9 5694.0 5325.8 5357.8 5377.1 5384.6 5475.8 5573.2 5576.6 5599.3 5632.0 5632.7 5538.3 5540.1 5549.8 5553.3 5611.7 5381.6 5520.8 5536.7 5537.9 5538.8 4242.2 4254.1 4265.6 4266.2 4289.8 3723.8 3748.5 3791.8 3814.5 3844.0 5237.6 5246.6 5255.8 5272.7 5286.4 5451.9 5490.7 5498.1 5503.4 5537.3 5281.4 5295.4 5297.9 5363.1 5365.5 4791.7 4809.6 4817.0 4817.8 4878.2 5570.4 5620.8 5675.3 5737.2 5738.7 5502.8 5561.7 5562.9 5564.1 5632.6 5650.5 5691.6 5696.5 5698.7 5708.7 5311.7 5352.8 5434.1 5455.7 5459.8 5424.3 5495.3 5496.4 5497.2 5503.9 5366.8 5369.7 5373.6 5373.6 5376.8 5351.3 5354.2 5358.8 5361.9 5365.4 5322.7 5348.7 5368.6 5384.2 5387.1 5331.0 5356.2 5356.5 5357.4 5361.4 5231.6 5260.9 5303.0 5383.2 5405.9 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | [#1] ext.html Cycles:180 Average:52012.10 Median:35657.55 stddev:99494.49 (279.0%) stddev-sans-first:99698.73 06:42:25 INFO - PROCESS | 3430 | Values: 602.5 616.1 638.9 640.8 642.2 31903.8 43252.6 43988.8 43995.6 47393.8 45217.5 45641.3 45674.5 45680.8 45714.8 8747.7 8908.1 8911.1 8911.6 8912.5 7976.7 8162.2 10453.3 10698.6 10704.0 10793.9 10876.8 10891.5 10895.2 10898.2 10710.7 10721.2 10727.1 10739.5 10814.1 10459.7 10517.3 10518.6 10518.9 10520.1 41145.0 41432.6 41445.8 41447.0 41454.0 3095.1 3348.7 3448.2 3492.9 3518.7 30883.2 30886.8 30995.4 31010.7 31218.4 4134.2 4194.6 4201.4 4202.2 4238.7 216793.0 218130.0 218243.0 218309.0 218826.0 33758.8 56739.4 56776.7 56954.1 57039.7 34683.0 36015.5 36322.8 36475.6 36562.0 13884.7 13949.6 13960.7 13990.5 14076.6 10460.5 10790.7 11586.5 11664.1 11678.4 7816.0 7868.4 7950.5 8277.0 8299.2 3115.8 3166.9 3181.5 3206.5 3254.0 959.6 990.4 1055.8 1068.3 1073.6 31534.8 32006.7 32094.8 32094.8 32350.5 1046.6 1094.7 1106.4 1123.6 1187.4 16299.3 17004.3 17042.7 17089.9 17090.5 475347.0 475527.0 477742.0 478090.0 478714.6 57376.0 57997.4 58088.0 58109.4 58154.7 1289.5 1309.4 1326.6 1327.5 1341.3 30115.7 30973.0 31413.7 31863.3 32017.7 49658.8 50112.5 50128.5 50357.0 50509.5 382210.0 382778.0 383173.0 383693.0 385013.0 27153.3 27559.9 27737.3 27748.9 27756.0 46350.8 46385.3 47359.0 47378.8 47748.0 39054.0 39274.0 39850.4 40169.6 41196.4 39063.6 39636.4 40056.2 40866.8 41181.8 40190.4 40759.4 40877.4 41083.2 41450.8 32712.5 35647.0 35668.1 35819.6 35948.6 27380.6 27755.4 27987.3 28046.9 28060.3 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | [#2] jquery.html Cycles:180 Average:26776.99 Median:2115.64 stddev:69952.13 (3306.4%) stddev-sans-first:70120.23 06:42:25 INFO - PROCESS | 3430 | Values: 355.1 372.7 377.3 388.1 396.9 14205.9 18008.4 18124.4 18427.9 19477.7 17869.6 18281.5 18331.3 18444.4 19223.2 5100.6 5366.6 5373.1 5374.5 5383.8 3853.9 3881.5 5248.5 5383.8 5396.1 5818.8 5869.2 5888.2 5929.5 5932.3 5537.6 5852.7 5878.9 5879.9 5884.8 5750.9 5753.1 5760.7 5772.5 5783.6 13439.3 20915.0 22671.9 22926.3 22937.2 2254.2 2261.8 2294.9 2302.3 2431.2 9207.0 9529.8 10008.8 10269.6 11339.5 1808.2 1862.4 1893.8 1913.8 1973.9 79702.1 84275.6 84795.6 85612.6 86532.6 10234.9 10578.9 10774.0 10926.1 11060.3 15201.5 15228.8 15237.2 15265.0 15274.0 7529.7 7584.6 7755.2 7819.1 7846.6 6661.4 6856.6 6900.6 6912.0 6943.8 4533.8 4548.5 4614.2 4702.5 4719.8 1784.1 1944.0 1966.8 1974.1 2008.0 844.0 905.3 950.9 952.1 1058.6 18167.9 19268.5 19320.0 19540.2 19540.9 954.4 957.1 957.1 979.1 1007.2 10000.2 10346.5 10673.6 10687.5 10688.4 413190.0 417245.0 422270.0 424903.0 427584.0 89923.0 90489.5 91556.0 91596.5 91782.0 942.3 975.5 1003.3 1007.5 1011.9 16194.0 16478.8 16685.9 16708.3 17017.0 38746.4 40671.4 41067.6 41078.6 43029.4 56178.0 56654.4 56675.7 56890.0 56978.7 7994.2 8321.2 8428.2 8447.8 8574.7 11706.8 12423.5 13046.7 13114.9 13167.6 10780.0 10862.8 11150.3 11158.9 11242.2 11313.3 11356.4 11556.0 11622.4 11638.0 11771.5 11870.2 11881.2 12182.5 12358.6 7411.4 7435.5 7631.4 7822.0 8452.3 10529.5 11718.9 11827.9 11862.5 12378.8 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | [#3] mootools.html Cycles:180 Average:5418.12 Median:5177.47 stddev:3012.49 (58.2%) stddev-sans-first:3005.35 06:42:25 INFO - PROCESS | 3430 | Values: 1339.7 1413.7 1452.0 1545.4 1733.9 7453.2 7992.8 8185.8 8262.2 8441.0 8190.6 8256.3 8263.9 8264.2 8273.3 2195.0 2222.1 2224.7 2225.6 2227.8 2157.7 2199.7 2202.0 2205.8 2209.3 2203.6 2217.2 2224.9 2226.2 2241.0 2169.0 2169.6 2169.9 2171.6 2177.2 2080.8 2153.0 2167.2 2169.5 2170.6 8210.3 8223.1 8297.2 8301.2 8307.4 4973.6 5170.6 5184.4 5190.9 5192.4 3195.0 3358.2 3396.2 3408.3 3409.4 1077.4 1134.0 1134.4 1150.4 1153.2 11138.1 11155.9 11174.2 11175.6 11260.9 4170.5 4233.0 4451.2 4461.6 4480.9 9154.8 9167.0 9168.1 9172.6 9176.0 5114.5 5115.3 5117.7 5122.1 5122.7 4029.5 4212.7 4394.6 4824.7 4830.5 3347.4 3651.7 3706.1 3723.6 3736.5 1085.3 1122.0 1128.6 1132.0 1139.6 791.0 937.4 950.9 953.9 983.4 5596.8 5699.5 5740.6 5782.1 5837.9 427.1 444.2 444.7 446.9 447.7 4088.2 4092.4 4113.9 4132.3 4150.7 9732.3 9914.3 9953.0 9954.9 9979.7 9803.2 9832.0 9871.4 9885.9 9889.5 7298.0 7501.5 7512.1 7534.3 7716.6 5815.5 5871.5 5905.7 5970.2 5983.6 9350.5 9373.3 9431.1 9523.6 9561.7 8786.1 9314.9 9536.4 9537.2 9711.1 6826.2 6972.2 6977.2 7010.4 7179.2 7524.9 7830.2 7939.6 7995.9 7997.8 7093.5 7142.4 7204.6 7232.8 7430.5 7149.3 7151.6 7264.1 7265.6 7301.2 6556.8 6716.4 6731.6 6738.4 6741.5 4926.9 4988.8 5053.3 5079.2 5146.1 4980.8 5011.1 5101.1 5123.0 5250.6 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | [#4] prototype.html Cycles:180 Average:4623.97 Median:5327.27 stddev:1364.96 (25.6%) stddev-sans-first:1329.72 06:42:25 INFO - PROCESS | 3430 | Values: 303.8 307.2 313.9 322.9 326.8 5336.5 5400.2 5407.6 5414.2 5420.2 5326.1 5328.4 5335.7 5350.5 5354.5 4169.2 4175.9 4176.1 4187.7 4187.9 3940.3 4157.1 4176.4 4198.2 4199.5 4127.5 4134.9 4140.4 4152.1 4157.7 3888.5 4001.6 4112.8 4135.0 4139.2 3518.7 3580.7 3584.7 3589.3 3621.5 5069.9 5104.7 5113.2 5118.6 5147.9 4529.5 4616.7 4641.6 4734.0 4763.5 5487.9 5494.6 5513.0 5513.8 5528.7 3972.8 3978.2 3982.2 3983.6 3984.9 5621.6 5641.0 5715.1 5722.2 5776.6 4029.2 4034.0 4037.9 4043.5 4056.8 4096.3 4096.4 4102.1 4104.2 4107.6 4451.8 4668.8 4673.9 4704.9 4712.2 5566.4 5567.1 5568.2 5570.6 5634.5 1400.6 1417.0 1417.9 1421.5 1425.7 858.5 907.4 920.7 925.7 935.1 4728.8 4769.7 4775.4 4796.5 4850.5 4928.5 4938.6 4957.9 4972.3 4998.6 4721.4 4764.3 4776.5 4826.8 5037.6 2903.6 2961.2 2967.2 2997.0 3025.0 5823.9 5825.5 5832.4 5832.8 5855.8 5567.3 5689.5 5773.3 5822.4 5825.7 5767.8 5776.3 5779.2 5791.7 5817.3 5594.9 5633.7 5706.1 5716.5 5717.6 5406.5 5614.6 5637.7 5646.7 5673.7 5820.7 5862.7 5884.8 5908.6 5908.7 4034.9 4040.7 4042.1 4053.7 4069.8 5504.2 5717.3 5740.9 5774.5 5789.7 5576.6 5614.4 5615.5 5638.4 5666.3 5499.5 5554.2 5560.7 5633.1 5672.7 5568.9 5581.9 5583.3 5584.7 5595.1 5616.1 5617.9 5619.7 5657.9 5691.8 5399.3 5419.8 5437.2 5499.3 5517.6 06:42:25 INFO - PROCESS | 3430 | 06:42:25 INFO - PROCESS | 3430 | [#5] yui.html Cycles:180 Average:20239.23 Median:4854.20 stddev:29173.04 (601.0%) stddev-sans-first:29218.06 06:42:25 INFO - PROCESS | 3430 | Values: 717.9 730.8 735.7 767.5 813.7 15479.6 16026.1 16152.9 16187.5 16214.4 15021.9 15285.4 15412.2 15423.6 15450.5 788.1 811.3 812.8 813.1 813.5 796.9 800.4 800.4 800.5 801.0 841.6 844.5 844.5 844.7 845.3 837.4 839.0 839.2 839.2 840.2 622.2 622.6 622.9 623.2 623.3 13015.6 13075.3 13094.5 13122.5 13123.3 12723.9 12838.3 12942.0 13057.9 13262.4 10905.9 11252.3 11274.8 11777.4 11963.3 3699.5 3727.1 3829.0 3945.2 3949.8 76554.2 77077.6 77286.0 82128.6 82209.6 9417.7 9488.1 9624.6 9738.4 10225.7 20439.3 20439.6 20470.0 20472.2 20527.8 8129.1 8429.3 8508.4 8510.7 8519.2 4754.8 4846.3 4862.1 4909.8 4991.1 3092.3 3474.8 3600.3 3602.6 3811.5 622.1 633.2 633.8 636.9 637.8 671.6 705.6 712.9 725.8 737.7 8855.9 9017.2 9219.0 9409.6 9749.5 608.1 612.7 625.9 658.7 679.5 4303.6 4444.7 4636.0 4719.7 4785.7 67864.0 68209.0 89052.0 111317.0 118992.0 103499.0 103748.0 105829.0 107035.5 109818.0 88841.6 89622.6 91306.0 93304.0 93855.1 8876.0 8924.2 9077.2 9158.1 9190.8 52495.0 54087.5 54805.2 54929.0 55368.4 45513.0 63983.7 75451.4 75959.2 76572.0 12773.9 12876.4 13188.9 13421.8 13426.6 13970.8 14509.7 14920.1 15078.3 15251.5 12744.5 13279.9 13383.7 13649.3 13802.2 13804.2 13857.7 14607.1 14856.6 15195.2 12448.3 12474.0 12510.6 12903.4 12942.3 10528.6 10741.7 10957.8 11106.0 11287.8 10025.5 10292.0 10535.6 11466.9 11806.6 06:42:25 INFO - PROCESS | 3430 | -------- Summary: end -------- 06:42:25 INFO - PROCESS | 3430 | 06:42:26 INFO - TEST-INFO | 3430: exit 0 06:42:26 INFO - TEST-OK | dromaeo_css | took 1119800ms 06:42:26 INFO - TEST-START | kraken 06:42:26 INFO - operating with platform_type : linux_ 06:42:26 INFO - Initialising browser for kraken test... 06:42:26 INFO - TEST-INFO | started process 3741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUpV8MQ/profile http://localhost:42623/getInfo.html) 06:42:29 INFO - PROCESS | 3741 | __metrics Screen width/height:1600/1200 06:42:29 INFO - PROCESS | 3741 | colorDepth:24 06:42:29 INFO - PROCESS | 3741 | Browser inner width/height: 1024/697 06:42:29 INFO - PROCESS | 3741 | __metrics 06:42:30 INFO - PROCESS | 3741 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:42:30 INFO - PROCESS | 3741 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:42:31 INFO - PROCESS | 3741 | console.error: PushService: 06:42:31 INFO - PROCESS | 3741 | stateChangeProcessEnqueue: Error transitioning state 06:42:31 INFO - PROCESS | 3741 | UnknownError 06:42:31 INFO - TEST-INFO | 3741: exit 0 06:42:31 INFO - Browser initialized. 06:42:31 INFO - Running cycle 1/1 for kraken test... 06:42:31 INFO - TEST-INFO | started process 3827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUpV8MQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:44 INFO - PROCESS | 3827 | RSS: Main: 172105728 06:42:44 INFO - PROCESS | 3827 | 06:42:46 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42623/tests/kraken/driver.html?testName=audio-beat-detection) 06:42:47 INFO - PROCESS | 3827 | RSS: Main: 229171200 06:42:47 INFO - PROCESS | 3827 | 06:42:50 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42623/tests/kraken/driver.html?testName=audio-dft) 06:42:50 INFO - PROCESS | 3827 | RSS: Main: 215814144 06:42:50 INFO - PROCESS | 3827 | 06:42:53 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42623/tests/kraken/driver.html?testName=audio-fft) 06:42:54 INFO - PROCESS | 3827 | RSS: Main: 297816064 06:42:54 INFO - PROCESS | 3827 | 06:42:56 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42623/tests/kraken/driver.html?testName=audio-oscillator) 06:42:57 INFO - PROCESS | 3827 | RSS: Main: 209436672 06:42:57 INFO - PROCESS | 3827 | 06:42:59 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:42:59 INFO - PROCESS | 3827 | RSS: Main: 211869696 06:42:59 INFO - PROCESS | 3827 | 06:43:02 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42623/tests/kraken/driver.html?testName=imaging-darkroom) 06:43:03 INFO - PROCESS | 3827 | RSS: Main: 247615488 06:43:03 INFO - PROCESS | 3827 | 06:43:06 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42623/tests/kraken/driver.html?testName=imaging-desaturate) 06:43:07 INFO - PROCESS | 3827 | RSS: Main: 246628352 06:43:07 INFO - PROCESS | 3827 | 06:43:09 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42623/tests/kraken/driver.html?testName=json-parse-financial) 06:43:10 INFO - PROCESS | 3827 | RSS: Main: 246116352 06:43:10 INFO - PROCESS | 3827 | 06:43:12 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:43:12 INFO - PROCESS | 3827 | RSS: Main: 208654336 06:43:12 INFO - PROCESS | 3827 | 06:43:14 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:43:15 INFO - PROCESS | 3827 | RSS: Main: 215601152 06:43:15 INFO - PROCESS | 3827 | 06:43:17 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:43:18 INFO - PROCESS | 3827 | RSS: Main: 225128448 06:43:18 INFO - PROCESS | 3827 | 06:43:20 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:21 INFO - PROCESS | 3827 | RSS: Main: 233644032 06:43:21 INFO - PROCESS | 3827 | 06:43:24 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:24 INFO - PROCESS | 3827 | RSS: Main: 231051264 06:43:24 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:42623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42623/tests/kraken/driver.html?testName=ai-astar) 06:43:26 INFO - PROCESS | 3827 | RSS: Main: 281759744 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | __start_tp_report 06:43:26 INFO - PROCESS | 3827 | _x_x_mozilla_page_load 06:43:26 INFO - PROCESS | 3827 | _x_x_mozilla_page_load_details 06:43:26 INFO - PROCESS | 3827 | |i|pagename|runs| 06:43:26 INFO - PROCESS | 3827 | |0;ai-astar;103;112;114;112;113;112;112;111;111;110 06:43:26 INFO - PROCESS | 3827 | |1;audio-beat-detection;147;124;122;172;123;128;120;123;159;124 06:43:26 INFO - PROCESS | 3827 | |2;audio-dft;160;161;160;161;159;161;161;162;160;163 06:43:26 INFO - PROCESS | 3827 | |3;audio-fft;76;75;77;106;76;76;76;77;97;76 06:43:26 INFO - PROCESS | 3827 | |4;audio-oscillator;82;83;120;84;83;83;104;84;84;120 06:43:26 INFO - PROCESS | 3827 | |5;imaging-gaussian-blur;117;118;116;116;117;118;117;117;117;120 06:43:26 INFO - PROCESS | 3827 | |6;imaging-darkroom;146;147;146;146;146;146;146;145;145;146 06:43:26 INFO - PROCESS | 3827 | |7;imaging-desaturate;84;84;84;84;85;85;84;85;84;85 06:43:26 INFO - PROCESS | 3827 | |8;json-parse-financial;55;53;52;54;57;54;54;56;54;56 06:43:26 INFO - PROCESS | 3827 | |9;json-stringify-tinderbox;60;60;59;59;70;60;59;59;59;60 06:43:26 INFO - PROCESS | 3827 | |10;stanford-crypto-aes;81;80;82;81;81;95;82;80;80;81 06:43:26 INFO - PROCESS | 3827 | |11;stanford-crypto-ccm;135;139;130;136;129;142;134;132;184;136 06:43:26 INFO - PROCESS | 3827 | |12;stanford-crypto-pbkdf2;169;166;171;167;168;164;166;167;167;167 06:43:26 INFO - PROCESS | 3827 | |13;stanford-crypto-sha256-iterative;71;67;66;65;65;66;68;67;64;65 06:43:26 INFO - PROCESS | 3827 | __end_tp_report 06:43:26 INFO - PROCESS | 3827 | __start_cc_report 06:43:26 INFO - PROCESS | 3827 | _x_x_mozilla_cycle_collect,1675 06:43:26 INFO - PROCESS | 3827 | __end_cc_report 06:43:26 INFO - PROCESS | 3827 | __startTimestamp1476971006763__endTimestamp 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | ------- Summary: start ------- 06:43:26 INFO - PROCESS | 3827 | Number of tests: 14 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.02 (2.7%) stddev-sans-first:1.17 06:43:26 INFO - PROCESS | 3827 | Values: 103.0 112.0 114.0 112.0 113.0 112.0 112.0 111.0 111.0 110.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:126.00 stddev:18.43 (14.6%) stddev-sans-first:18.95 06:43:26 INFO - PROCESS | 3827 | Values: 147.0 124.0 122.0 172.0 123.0 128.0 120.0 123.0 159.0 124.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 06:43:26 INFO - PROCESS | 3827 | Values: 160.0 161.0 160.0 161.0 159.0 161.0 161.0 162.0 160.0 163.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:10.92 (14.4%) stddev-sans-first:11.42 06:43:26 INFO - PROCESS | 3827 | Values: 76.0 75.0 77.0 106.0 76.0 76.0 76.0 77.0 97.0 76.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:83.00 stddev:15.78 (19.0%) stddev-sans-first:16.26 06:43:26 INFO - PROCESS | 3827 | Values: 82.0 83.0 120.0 84.0 83.0 83.0 104.0 84.0 84.0 120.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 06:43:26 INFO - PROCESS | 3827 | Values: 117.0 118.0 116.0 116.0 117.0 118.0 117.0 117.0 117.0 120.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:43:26 INFO - PROCESS | 3827 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 06:43:26 INFO - PROCESS | 3827 | Values: 84.0 84.0 84.0 84.0 85.0 85.0 84.0 85.0 84.0 85.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.51 (2.8%) stddev-sans-first:1.59 06:43:26 INFO - PROCESS | 3827 | Values: 55.0 53.0 52.0 54.0 57.0 54.0 54.0 56.0 54.0 56.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:3.37 (5.6%) stddev-sans-first:3.57 06:43:26 INFO - PROCESS | 3827 | Values: 60.0 60.0 59.0 59.0 70.0 60.0 59.0 59.0 59.0 60.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:4.52 (5.6%) stddev-sans-first:4.77 06:43:26 INFO - PROCESS | 3827 | Values: 81.0 80.0 82.0 81.0 81.0 95.0 82.0 80.0 80.0 81.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:136.00 stddev:16.05 (11.8%) stddev-sans-first:16.93 06:43:26 INFO - PROCESS | 3827 | Values: 135.0 139.0 130.0 136.0 129.0 142.0 134.0 132.0 184.0 136.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.00 stddev:1.87 (1.1%) stddev-sans-first:1.87 06:43:26 INFO - PROCESS | 3827 | Values: 169.0 166.0 171.0 167.0 168.0 164.0 166.0 167.0 167.0 167.0 06:43:26 INFO - PROCESS | 3827 | 06:43:26 INFO - PROCESS | 3827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:2.01 (3.0%) stddev-sans-first:1.27 06:43:26 INFO - PROCESS | 3827 | Values: 71.0 67.0 66.0 65.0 65.0 66.0 68.0 67.0 64.0 65.0 06:43:26 INFO - PROCESS | 3827 | -------- Summary: end -------- 06:43:26 INFO - PROCESS | 3827 | 06:43:27 INFO - TEST-INFO | 3827: exit 0 06:43:27 INFO - TEST-OK | kraken | took 61784ms 06:43:27 INFO - SUITE-END | took 1181s 06:43:28 INFO - Completed test suite (00:19:42) 06:43:28 INFO - javascript benchmark 06:43:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2980.9105726828175, 3018.7735919806005, 3022.6070610820575, 3030.181850900257, 3070.9692903070977, 5134.2812006319145, 5193.1171700810855, 5219.373675158981, 5237.685738855671, 5311.973440132803, 5207.557357624597, 5219.608529360304, 5223.425423203454, 5226.24219488174, 5233.685978841272, 4691.085238378518, 4695.906081878352, 4746.620270378361, 4766.952330476703, 4867.829625963092, 4786.282057691356, 4788.0423915216925, 4797.0405918816205, 4843.782029808667, 4858.927116093261, 4214.36784482327, 4779.737114458703, 4845.370101886768, 4847.369841920546, 4889.3399391082285, 4810.494898035691, 4812.831550895702, 4845.563899249085, 4862.44081930579, 4883.487233840467, 4639.652026098022, 4674.228752255874, 4680.087382960324, 4686.343911852344, 4741.834035808764, 5068.543831055223, 5078.822241221539, 5132.076226279269, 5172.922406163911, 5221.895562088775, 5463.235147079412, 5496.642718223303, 5511.366192887829, 5535.806246781343, 5551.472610102034, 5447.264619276387, 5448.182772584105, 5494.423085575997, 5553.111502159675, 5559.499645031967, 5160.122779127557, 5163.896722065538, 5168.483151684839, 5170.276161337416, 5223.608229382773, 5601.719914004283, 5613.887722245532, 5623.212750214973, 5631.859203519863, 5694.0, 5325.760340784674, 5357.8392648220615, 5377.139657654757, 5384.6499977501335, 5475.808346707846, 5573.247611572467, 5576.637518561281, 5599.328080630269, 5631.971840140773, 5632.746526406321, 5538.280023596906, 5540.113581826889, 5549.833504994856, 5553.250311208016, 5611.691356975405, 5381.569474442035, 5520.751566179451, 5536.667799932017, 5537.944620553823, 5538.806141785099, 4242.236397448489, 4254.106637606075, 4265.637420819203, 4266.232078225949, 4289.806958686867, 3723.832427540767, 3748.475213470116, 3791.7914514701406, 3814.504114465102, 3843.9807800960816, 5237.554807841376, 5246.580273578104, 5255.842324730264, 5272.736363181825, 5286.444923283077, 5451.918221226685, 5490.670559766347, 5498.092814685612, 5503.394626591072, 5537.335519737658, 5281.445448227958, 5295.443978382292, 5297.867553311121, 5363.088274993261, 5365.54392876602, 4791.664583479123, 4809.639277054235, 4817.0365926814775, 4817.78319975602, 4878.219484882402, 5570.387257401763, 5620.775168993195, 5675.318961724702, 5737.225474560964, 5738.713064346766, 5502.80740174092, 5561.694106824001, 5562.860928476821, 5564.054110801093, 5632.605717599728, 5650.463205995424, 5691.630044047124, 5696.487316141402, 5698.743556540048, 5708.743106560298, 5311.734413279243, 5352.785888564414, 5434.10337294342, 5455.672659640434, 5459.836204913859, 5424.267723857229, 5495.258140151029, 5496.367917689357, 5497.230387745799, 5503.889922201613, 5366.785328586813, 5369.704666243238, 5373.570114390917, 5373.596980226421, 5376.838694839161, 5351.277577526984, 5354.196870469305, 5358.785648574013, 5361.892762144813, 5365.409804921377, 5322.733863306897, 5348.679079255257, 5368.57051435892, 5384.219288203267, 5387.138057910715, 5330.9733451332495, 5356.223347614497, 5356.464353564768, 5357.383900851296, 5361.410244872983, 5231.55531779803, 5260.921086183634, 5302.973485132549, 5383.219433182088, 5405.918911216257], "value": 5108.4993403071685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.5270162922105, 616.054356562676, 638.9456896163825, 640.80135158101, 642.1587720086684, 31903.840480797593, 43252.567474325246, 43988.78005609976, 43995.56004439955, 47393.7630311848, 45217.547824521745, 45641.31538026932, 45674.54325456744, 45680.771596141974, 45714.77142614282, 8747.650093996233, 8908.109189081104, 8911.108889111101, 8911.598978045971, 8912.465252084863, 7976.680932762712, 8162.224588664068, 10453.268271220979, 10698.572057117706, 10704.0, 10793.946030269877, 10876.836847447295, 10891.455427228646, 10895.237333386665, 10898.182636302308, 10710.732231694192, 10721.249512534127, 10727.141828653688, 10739.516721747501, 10814.134869210444, 10459.738506537322, 10517.263791534595, 10518.579256829718, 10518.894811051869, 10520.105791007774, 41145.0, 41432.58567414317, 41445.79277103595, 41447.0, 41454.0, 3095.1178914009397, 3348.68187522185, 3448.2413868948793, 3492.9301413971834, 3518.6629080949074, 30883.22791930197, 30886.845565772026, 30995.380092398027, 31010.689893101007, 31218.37563248745, 4134.1731653669085, 4194.559571245037, 4201.411802347674, 4202.180574787918, 4238.7032907696475, 216793.0, 218130.0, 218243.0, 218309.0, 218826.0, 33758.83120584382, 56739.43260567424, 56776.71611641916, 56954.145687813885, 57039.714801425725, 34683.0, 36015.4597681035, 36322.81838590843, 36475.635243647754, 36562.0, 13884.652883677989, 13949.58151255464, 13960.720785584232, 13990.510332138327, 14076.648083797987, 10460.52927618259, 10790.73023174427, 11586.536538538532, 11664.066874650178, 11678.357690326944, 7816.0, 7868.409869259828, 7950.522968621901, 8277.0, 8299.170082991774, 3115.7781206465365, 3166.8733250669716, 3181.5227715842807, 3206.470932296145, 3253.967460325414, 959.5729900194486, 990.4156547636928, 1055.767731099157, 1068.278911734576, 1073.592035026685, 31534.842325788683, 32006.679933200834, 32094.83952580222, 32094.83952580269, 32350.514742278883, 1046.6493724602344, 1094.7372630568607, 1106.3527836215742, 1123.6179698902413, 1187.352892673495, 16299.266533005806, 17004.319827206775, 17042.74435883463, 17089.91455042717, 17090.48728538146, 475347.0, 475527.0, 477742.0, 478090.0, 478714.6064269656, 57376.0, 57997.420025799205, 58088.0, 58109.4189058104, 58154.7092264536, 1289.509986205236, 1309.3780454284329, 1326.588757485202, 1327.5220920468623, 1341.2891167681144, 30115.69884301129, 30973.0, 31413.685863141076, 31863.330153957544, 32017.67982320147, 49658.75170624124, 50112.49887501078, 50128.498715012385, 50357.0, 50509.49490505195, 382210.0, 382778.0, 383173.0, 383693.0, 385013.0, 27153.321166970985, 27559.86220068887, 27737.306567335978, 27748.86125569359, 27756.0, 46350.7682461599, 46385.30422043739, 47359.0, 47378.76310618425, 47748.0, 39054.02364940899, 39274.0, 39850.402243965786, 40169.59830401659, 41196.38205426981, 39063.609363906, 39636.405453917636, 40056.198876021735, 40866.79566602148, 41181.794091030555, 40190.397144042276, 40759.388609170295, 40877.38683919684, 41083.1783364337, 41450.79274603607, 32712.50931236081, 35647.0, 35668.094898039446, 35819.64180358163, 35948.64051359453, 27380.589291161046, 27755.44489110247, 27987.300317492227, 28046.859765701858, 28060.29849253785], "value": 18517.838324891014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.1334743226529, 372.73908264215055, 377.3396556026952, 388.0899291162225, 396.8610986154844, 14205.857941420583, 18008.369707060272, 18124.36564720235, 18427.907860460713, 19477.707834382494, 17869.553261168476, 18281.54296142597, 18331.266749330043, 18444.354447594338, 19223.173798489155, 5100.642954993143, 5366.624336296461, 5373.113436283028, 5374.48942350476, 5383.838484845461, 3853.9401664542197, 3881.4565960765517, 5248.501392367719, 5383.81156659517, 5396.082665946798, 5818.767249310023, 5869.178315035899, 5888.205092312547, 5929.525637948954, 5932.317783454893, 5537.58468114893, 5852.736626851802, 5878.853028674296, 5879.853003674921, 5884.794032208873, 5750.913736293959, 5753.108268218432, 5760.74076666551, 5772.538196944234, 5783.624064435799, 13439.328033598282, 20915.0, 22671.886640566856, 22926.312210633707, 22937.197198098154, 2254.2448279826276, 2261.8416710830247, 2294.865774829408, 2302.26327575176, 2431.234161239204, 9207.0, 9529.809403811954, 10008.849867251924, 10269.640562580349, 11339.546418143347, 1808.2043900683789, 1862.37610400516, 1893.7632795900513, 1913.8468922486306, 1973.891435971021, 79702.08192746983, 84275.5786221071, 84795.5760221201, 85612.57193713992, 86532.56733716291, 10234.948825255975, 10578.894211057945, 10774.0, 10926.125909927347, 11060.281081729823, 15201.543953681406, 15228.771568426482, 15237.161956092521, 15265.0, 15274.0, 7529.698812047566, 7584.62076896153, 7755.185705500954, 7819.0617125945255, 7846.607669616496, 6661.367170118831, 6856.588604683635, 6900.551464154914, 6912.0, 6943.756968506179, 4533.750643714561, 4548.5224051474115, 4614.215583350771, 4702.482726900038, 4719.834805781781, 1784.12577836859, 1943.9611207775765, 1966.8131527504863, 1974.131382191831, 2007.9899600502197, 843.9957800211082, 905.3300557587338, 950.8684665248333, 952.1002652493465, 1058.5924419098549, 18167.90916045438, 19268.518287042654, 19320.0, 19540.224156919765, 19540.90229548843, 954.355809828363, 957.090763774417, 957.1385752822515, 979.0698836105728, 1007.2121983479236, 10000.199984001263, 10346.53440595175, 10673.573057077785, 10687.519061642244, 10688.412137332365, 413190.0, 417245.0, 422270.0, 424903.0, 427584.0, 89923.0, 90489.54755226182, 91556.0, 91596.54201728948, 91782.0, 942.2697409507549, 975.5024937282037, 1003.2626019875386, 1007.4761124215366, 1011.8785745710414, 16194.0, 16478.75281870749, 16685.91657041707, 16708.33166673368, 17016.978981261163, 38746.41880371853, 40671.38992915049, 41067.589324106375, 41078.58921410747, 43029.35455968101, 56178.0, 56654.43345566656, 56675.71662141663, 56890.0, 56978.715106424206, 7994.1606131355375, 8321.209485098905, 8428.241458268785, 8447.831043379221, 8574.699885503978, 11706.824397633873, 12423.503059877503, 13046.673833154247, 13114.934425327812, 13167.60497185086, 10780.0, 10862.782744345226, 11150.330980141218, 11158.944205278922, 11242.156838237328, 11313.321200727984, 11356.375399352784, 11556.0, 11622.418879055844, 11638.0, 11771.47028383742, 11870.169088163746, 11881.227720198505, 12182.512699492276, 12358.62924112278, 7411.370033547209, 7435.4795164337975, 7631.427642926914, 7822.0, 8452.281556067803, 10529.526171322155, 11718.94140529326, 11827.940860295643, 11862.466189021343, 12378.75242495163], "value": 8885.420362876148, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.7043273547074, 1413.731391035703, 1452.0489079652828, 1545.4281915691197, 1733.852622527085, 7453.217412171718, 7992.840143197132, 8185.795355116117, 8262.173782621734, 8440.957795211016, 8190.590470476483, 8256.25693687568, 8263.876041859361, 8264.214899584545, 8273.29676977456, 2194.9780502194935, 2222.055626358791, 2224.7219097612797, 2225.643896976476, 2227.7549469558335, 2157.7194964654573, 2199.659052846803, 2202.042111681416, 2205.7683943185975, 2209.304069218191, 2203.6474164133742, 2217.168561789329, 2224.8998795054263, 2226.209695558078, 2240.955180896381, 2168.967465488019, 2169.609470295346, 2169.902354394056, 2171.5873983943, 2177.1835561664375, 2080.750309962799, 2153.0311359887955, 2167.1764729402726, 2169.5010147666126, 2170.6201414752513, 8210.261076503084, 8223.095459499451, 8297.170282971714, 8301.169883011711, 8307.418480706354, 4973.5523802857915, 5170.560502357304, 5184.377874655028, 5190.948090519122, 5192.3769147702515, 3194.984025079883, 3358.177246574605, 3396.1679388549715, 3408.2672225471397, 3409.352223077632, 1077.4343469678404, 1133.9716507087305, 1134.4157758754247, 1150.384544268812, 1153.2446247707765, 11138.108951283877, 11155.888441115567, 11174.161937854693, 11175.552977880876, 11260.943695281552, 4170.52039015511, 4232.957670423257, 4451.154280686659, 4461.598456138898, 4480.910381792346, 9154.771130721652, 9166.954165229132, 9168.083191680911, 9172.587233574504, 9176.0, 5114.462981386975, 5115.283860259567, 5117.667351622133, 5122.078025955364, 5122.718250496184, 4029.5366032906004, 4212.705110642226, 4394.560543945579, 4824.710517368969, 4830.468648448667, 3347.43093674076, 3651.653092956165, 3706.0734816295926, 3723.590405055442, 3736.4768932349493, 1085.3379438542484, 1121.994390028061, 1128.6097082349665, 1131.9943400283112, 1139.5726602524053, 790.9881351779728, 937.4188003437775, 950.8906475755376, 953.9379940303858, 983.4148681534475, 5596.832095037155, 5699.544036477072, 5740.56945729072, 5782.132680097935, 5837.88324233513, 427.06259759826884, 444.16718652526515, 444.66205683680636, 446.87040758180416, 447.7000409725492, 4088.2436749201493, 4092.3656833190903, 4113.85601503946, 4132.297509423405, 4150.688698347576, 9732.318737688294, 9914.30599858003, 9953.004699530135, 9954.900450995543, 9979.650712225037, 9803.16673082796, 9832.0, 9871.40771553709, 9885.901140988643, 9889.505524723734, 7297.963510182415, 7501.549907005598, 7512.060992375953, 7534.321911028033, 7716.614169291401, 5815.505682017076, 5871.4715675589405, 5905.675187864708, 5970.194023806731, 5983.581149319506, 9350.485723285285, 9373.343865929319, 9431.104045115702, 9523.619055237712, 9561.665341713007, 8786.121387861163, 9314.860277095984, 9536.380135291183, 9537.189338905993, 9711.077447642463, 6826.180858297036, 6972.163340399185, 6977.232504424611, 7010.4041156500225, 7179.246179151114, 7524.887126692995, 7830.2169783021245, 7939.603019848869, 7995.920550725577, 7997.800054998672, 7093.538919970186, 7142.357187853118, 7204.639768011683, 7232.783016509513, 7430.517016393917, 7149.285071492809, 7151.60666163366, 7264.091988501437, 7265.564066156047, 7301.196868344584, 6556.8360790978695, 6716.361945615159, 6731.629760363227, 6738.35985581369, 6741.52809303344, 4926.926096108633, 4988.825391111439, 5053.317802096817, 5079.212722028092, 5146.073706732824, 4980.800767969386, 5011.148104822262, 5101.107306221471, 5123.0, 5250.579953603779], "value": 4295.789703935143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.78127748021416, 307.1813616711464, 313.9121046107091, 322.88537569162946, 326.7500362222899, 5336.546393556548, 5400.24396584478, 5407.567394608432, 5414.242006119146, 5420.159875219342, 5326.121190003654, 5328.415718376585, 5335.733213339327, 5350.545203657684, 5354.518093371596, 4169.249535083683, 4175.853845115422, 4176.1230141670285, 4187.7487350758975, 4187.874363769077, 3940.2710498557717, 4157.106222162234, 4176.352665336878, 4198.244316023115, 4199.517055538607, 4127.525334586516, 4134.937975930364, 4140.37894315852, 4152.128053108836, 4157.667386609064, 3888.5333759948985, 4001.559828418872, 4112.820205291186, 4134.958650413488, 4139.234241665302, 3518.683318501347, 3580.6777390034763, 3584.713222942158, 3589.264200838848, 3621.474886141521, 5069.935313584152, 5104.719240441774, 5113.2330150477355, 5118.6416950813455, 5147.897042059175, 4529.5243999380245, 4616.69991450558, 4641.605463535603, 4734.0, 4763.523647635244, 5487.917681234785, 5494.642848214853, 5512.972435137799, 5513.807016754395, 5528.7055871813145, 3972.8410863565423, 3978.1844721832244, 3982.2433737589763, 3983.641472267481, 3984.9240705009483, 5621.634593751393, 5640.971795141039, 5715.056745775887, 5722.227499287585, 5776.624519406268, 4029.2143032108456, 4034.0, 4037.858674946363, 4043.5147782265726, 4056.7768772717195, 4096.303628383182, 4096.365063415175, 4102.077032667626, 4104.240715467648, 4107.609777071173, 4451.821927122879, 4668.813247470063, 4673.906521869543, 4704.88237794051, 4712.222483290218, 5566.387697353369, 5567.079357621614, 5568.248286481273, 5570.554355651539, 5634.4647258511195, 1400.6483743187669, 1417.0222546443129, 1417.8723914847508, 1421.5024741340449, 1425.7291114688176, 858.4591707224408, 907.4101833808078, 920.7467946314817, 925.7222833150028, 935.1116439382614, 4728.777474586938, 4769.73766442842, 4775.355327030876, 4796.544328288807, 4850.5149485051215, 4928.48250933654, 4938.629602779806, 4957.925631115536, 4972.303877457159, 4998.625103117281, 4721.386219791405, 4764.309175169581, 4776.47458779534, 4826.7827947742435, 5037.571806396424, 2903.6225290712073, 2961.1708721557998, 2967.1840243933093, 2997.010986374491, 3024.9848750756105, 5823.854403639858, 5825.475707186373, 5832.387599302097, 5832.783542254001, 5855.765769369263, 5567.276254086943, 5689.459501347365, 5773.336066352424, 5822.359540450547, 5825.7378417971295, 5767.769289228468, 5776.306843178845, 5779.248697669276, 5791.739371728282, 5817.3019237690905, 5594.916076258941, 5633.690147041952, 5706.058500347563, 5716.456936591017, 5717.599768016199, 5406.513413792777, 5614.550835933034, 5637.746301416364, 5646.689432081275, 5673.716314184192, 5820.70896455184, 5862.706864656835, 5884.823455296348, 5908.615939963888, 5908.675022873783, 4034.899127521718, 4040.676745860383, 4042.130941847517, 4053.6622914437576, 4069.7761623111014, 5504.22940788298, 5717.256756621613, 5740.942590574208, 5774.509166720708, 5789.710514474344, 5576.553875689854, 5614.354349249888, 5615.494605485526, 5638.407967163389, 5666.291713535808, 5499.450054994469, 5554.1946417770005, 5560.749766260447, 5633.126865335879, 5672.688002159921, 5568.858384031183, 5581.860453488695, 5583.325002499315, 5584.748686309044, 5595.07681232592, 5616.129499927518, 5617.859553511195, 5619.747111380079, 5657.886842263214, 5691.800786972602, 5399.326208875261, 5419.783208671609, 5437.211604317273, 5499.2576002240785, 5517.586181036358], "value": 4183.743843602823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.8636059148764, 730.7734602273295, 735.7351353512735, 767.4857845243686, 813.6989313953836, 15479.61300967475, 16026.118563479004, 16152.919235403835, 16187.514374568753, 16214.432494862682, 15021.896934429189, 15285.388584456608, 15412.229388530584, 15423.614409639764, 15450.5364839055, 788.0936922539097, 811.2941740685583, 812.8008637883727, 813.1137060603941, 813.5281536708695, 796.9163237860029, 800.3597122302135, 800.4196957206037, 800.4676889868231, 800.9959950200241, 841.6170642357713, 844.472204871955, 844.5481667307992, 844.67902197165, 845.3026253341018, 837.3803385494751, 839.0225387423644, 839.1943734015322, 839.2195258409677, 840.2185967050641, 622.1880446017944, 622.5704264057786, 622.9439350458481, 623.2271982741413, 623.2676604989119, 13015.609531714064, 13075.346232688327, 13094.476220951246, 13122.540711075162, 13123.343832808321, 12723.936380318039, 12838.293893835835, 12942.0, 13057.934710326483, 13262.403191856292, 10905.890941090567, 11252.324860508314, 11274.774504509864, 11777.411129443579, 11963.282203067844, 3699.4635777812337, 3727.07307234524, 3829.0, 3945.210957808421, 3949.763014219156, 76554.23445765582, 77077.61461192714, 77286.0, 82128.58935705283, 82209.58895205485, 9417.670381536613, 9488.146066853878, 9624.566894489764, 9738.415695058318, 10225.693229203136, 20439.284625038053, 20439.59120817605, 20470.0, 20472.18111275562, 20527.794722052888, 8129.1464396238725, 8429.283510901641, 8508.446950948168, 8510.702125425703, 8519.233269005696, 4754.78603462845, 4846.273059041101, 4862.124817532807, 4909.7790599423115, 4991.07665081961, 3092.304231547884, 3474.8262586870555, 3600.297941901304, 3602.603713591503, 3811.5426148862316, 622.0668996505242, 633.2243002322118, 633.8383712153371, 636.8789929913302, 637.8150336402391, 671.6473851228144, 705.5837056136904, 712.9362632991966, 725.793148952546, 737.6533029476137, 8855.87459009833, 9017.188453039258, 9219.0, 9409.576569054409, 9749.463779492055, 608.0696534302524, 612.7487730030755, 625.8657976300883, 658.6871236162784, 679.4598294355999, 4303.569643035734, 4444.73331600105, 4635.95364046362, 4719.716816990992, 4785.688930219525, 67864.0, 68209.0, 89052.0, 111317.0, 118992.0, 103499.0, 103748.0, 105829.0, 107035.46482267539, 109818.0, 88841.55579222192, 89622.55188724014, 91306.0, 93304.0, 93855.061449386, 8876.0, 8924.196822286025, 9077.183053525214, 9158.129977652112, 9190.770230744285, 52495.0, 54087.45912540824, 54805.23116301373, 54929.0, 55368.44631553633, 45513.0, 63983.6800815993, 75451.35920242766, 75959.24040759522, 76572.0, 12773.87226127764, 12876.420561074587, 13188.868111318763, 13421.798673019717, 13426.597202083953, 13970.790438143233, 14509.709805803614, 14920.104793712411, 15078.321475533847, 15251.542453726406, 12744.49022039108, 13279.933600331937, 13383.665408364868, 13649.318432519372, 13802.17186968785, 13804.240766757925, 13857.72284554283, 14607.123572585679, 14856.628584285047, 15195.240237988277, 12448.31534265624, 12474.0, 12510.56213032576, 12903.41934612926, 12942.288174150512, 10528.578856845641, 10741.698150725915, 10957.83563246536, 11106.0, 11287.830682539605, 10025.498725063571, 10292.0, 10535.63125290611, 11466.885331146581, 11806.571073501567], "value": 7380.290403485852, "unit": "score"}], "name": "dromaeo_css", "value": 6937.688139258976, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 114.0, 112.0, 113.0, 112.0, 112.0, 111.0, 111.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 122.0, 172.0, 123.0, 128.0, 120.0, 123.0, 159.0, 124.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 159.0, 161.0, 161.0, 162.0, 160.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 106.0, 76.0, 76.0, 76.0, 77.0, 97.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 120.0, 84.0, 83.0, 83.0, 104.0, 84.0, 84.0, 120.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 120.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 54.0, 57.0, 54.0, 54.0, 56.0, 54.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 70.0, 60.0, 59.0, 59.0, 59.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 81.0, 81.0, 95.0, 82.0, 80.0, 80.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 130.0, 136.0, 129.0, 142.0, 134.0, 132.0, 184.0, 136.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 171.0, 167.0, 168.0, 164.0, 166.0, 167.0, 167.0, 167.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 66.0, 65.0, 65.0, 66.0, 68.0, 67.0, 64.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1498.1000000000001, "alertThreshold": 2.0}]} 06:43:28 INFO - Return code: 0 06:43:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:43:28 INFO - # TBPL SUCCESS # 06:43:28 INFO - Running post-action listener: _resource_record_post_action 06:43:28 INFO - [mozharness: 2016-10-20 13:43:28.562848Z] Finished run-tests step (success) 06:43:28 INFO - Running post-run listener: _resource_record_post_run 06:43:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7856128; Write bytes: 424505344; Read time: 2020; Write time: 435508 06:43:28 INFO - TinderboxPrint: CPU usage
13.1% 06:43:28 INFO - TinderboxPrint: I/O read bytes / time
7,856,128 / 2,020 06:43:28 INFO - TinderboxPrint: I/O write bytes / time
424,505,344 / 435,508 06:43:28 INFO - TinderboxPrint: CPU idle
8,314.5 (86.9%) 06:43:28 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 06:43:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:43:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 10084352; Read time: 0; Write time: 6200 06:43:28 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5636096; Write bytes: 338100224; Read time: 1496; Write time: 336944 06:43:29 INFO - Running post-run listener: _upload_blobber_files 06:43:29 INFO - Blob upload gear active. 06:43:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:43:29 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 06:43:29 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'] 06:43:29 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 06:43:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:30 INFO - (blobuploader) - INFO - Done attempting. 06:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:34 INFO - (blobuploader) - INFO - Done attempting. 06:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:35 INFO - (blobuploader) - INFO - Done attempting. 06:43:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:43:35 INFO - Return code: 0 06:43:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:43:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:43:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a5795b193cd2126c1dcc868233f60480c903336ed4817426b893384f2e67786a730a9c98dcd01aa6c985a2bc5616777148314eeb5532ec01658145a9eae0875", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7d9e6372d7988b52694217fb32f0b18bde4237cdc75cfde3a8acabf064fe620439e7dbe7fba8cceb4f586a35844f0862578c125ee7b32a17a0e8f031eb04352", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8445a59ad6d76d31577c91683aaeecd7533f7a36df8fd68d87a37a5e40a651814a72eb66cf049228ee33c465da2bc27f60b614b8ddefa48fe55c366dd12555c"} 06:43:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:43:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:43:35 INFO - Contents: 06:43:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a5795b193cd2126c1dcc868233f60480c903336ed4817426b893384f2e67786a730a9c98dcd01aa6c985a2bc5616777148314eeb5532ec01658145a9eae0875", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7d9e6372d7988b52694217fb32f0b18bde4237cdc75cfde3a8acabf064fe620439e7dbe7fba8cceb4f586a35844f0862578c125ee7b32a17a0e8f031eb04352", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8445a59ad6d76d31577c91683aaeecd7533f7a36df8fd68d87a37a5e40a651814a72eb66cf049228ee33c465da2bc27f60b614b8ddefa48fe55c366dd12555c"} 06:43:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:43:35 INFO - Copying logs to upload dir... 06:43:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:43:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.834689 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-20 06:43:35.540842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 06:43:35.544271) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a5795b193cd2126c1dcc868233f60480c903336ed4817426b893384f2e67786a730a9c98dcd01aa6c985a2bc5616777148314eeb5532ec01658145a9eae0875", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7d9e6372d7988b52694217fb32f0b18bde4237cdc75cfde3a8acabf064fe620439e7dbe7fba8cceb4f586a35844f0862578c125ee7b32a17a0e8f031eb04352", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8445a59ad6d76d31577c91683aaeecd7533f7a36df8fd68d87a37a5e40a651814a72eb66cf049228ee33c465da2bc27f60b614b8ddefa48fe55c366dd12555c"} build_url:https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/dNXfFl3wQva56xPzfFJLkg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a5795b193cd2126c1dcc868233f60480c903336ed4817426b893384f2e67786a730a9c98dcd01aa6c985a2bc5616777148314eeb5532ec01658145a9eae0875", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7d9e6372d7988b52694217fb32f0b18bde4237cdc75cfde3a8acabf064fe620439e7dbe7fba8cceb4f586a35844f0862578c125ee7b32a17a0e8f031eb04352", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8445a59ad6d76d31577c91683aaeecd7533f7a36df8fd68d87a37a5e40a651814a72eb66cf049228ee33c465da2bc27f60b614b8ddefa48fe55c366dd12555c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 06:43:35.570630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:43:35.571115) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476967501.280042-2060845637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:43:35.656023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 06:43:35.656370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 06:43:35.656714) ========= ========= Total master_lag: 0.25 =========