builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1479836520.12 results: success (0) buildid: 20161122080251 builduid: d817ad58cc1c4735b4649929257b8e0a revision: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.125027) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.125482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.125759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.140576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.140950) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-22 09:42:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.5M=0s 2016-11-22 09:42:01 (66.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.231543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.231865) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014768 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:00.281249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 09:42:00.281623) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ba0440fe03102f644bbe3f5c00923caa935d5e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ba0440fe03102f644bbe3f5c00923caa935d5e5 --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=337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-22 09:42:01,233 truncating revision to first 12 chars 2016-11-22 09:42:01,234 Setting DEBUG logging. 2016-11-22 09:42:01,234 attempt 1/10 2016-11-22 09:42:01,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ba0440fe031?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 09:42:02,474 unpacking tar archive at: mozilla-aurora-7ba0440fe031/testing/mozharness/ program finished with exit code 0 elapsedTime=1.548087 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 09:42:01.843425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:01.843775) ========= script_repo_revision: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:01.844179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:01.844464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 09:42:01.855517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-22 09:42:01.856191) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:02 INFO - MultiFileLogger online at 20161122 09:42:02 in /builds/slave/test 09:42:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:42:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:02 INFO - {'append_to_log': False, 09:42:02 INFO - 'base_work_dir': '/builds/slave/test', 09:42:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:42:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:02 INFO - 'branch': 'Mozilla-Aurora', 09:42:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:02 INFO - 'config_files': ('talos/linux_config.py',), 09:42:02 INFO - 'default_actions': ('clobber', 09:42:02 INFO - 'read-buildbot-config', 09:42:02 INFO - 'download-and-extract', 09:42:02 INFO - 'populate-webroot', 09:42:02 INFO - 'create-virtualenv', 09:42:02 INFO - 'install', 09:42:02 INFO - 'run-tests'), 09:42:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:02 INFO - 'download_minidump_stackwalk': True, 09:42:02 INFO - 'download_symbols': 'ondemand', 09:42:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:02 INFO - 'installer_path': 'installer.exe', 09:42:02 INFO - 'log_level': 'info', 09:42:02 INFO - 'log_name': 'talos', 09:42:02 INFO - 'log_to_console': True, 09:42:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:02 INFO - 'opt_config_files': (), 09:42:02 INFO - 'pip_index': False, 09:42:02 INFO - 'sps_profile': False, 09:42:02 INFO - 'sps_profile_interval': 0, 09:42:02 INFO - 'suite': 'dromaeojs', 09:42:02 INFO - 'system_bits': '32', 09:42:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:02 INFO - 'title': 'talos-linux64-ix-060', 09:42:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:02 INFO - 'use_talos_json': True, 09:42:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:02 INFO - 'work_dir': 'build'} 09:42:02 INFO - [mozharness: 2016-11-22 17:42:02.905421Z] Running clobber step. 09:42:02 INFO - Running pre-action listener: _resource_record_pre_action 09:42:02 INFO - Running main action method: clobber 09:42:02 INFO - rmtree: /builds/slave/test/build 09:42:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:03 INFO - Running post-action listener: _resource_record_post_action 09:42:03 INFO - [mozharness: 2016-11-22 17:42:03.366850Z] Finished clobber step (success) 09:42:03 INFO - [mozharness: 2016-11-22 17:42:03.366978Z] Running read-buildbot-config step. 09:42:03 INFO - Running pre-action listener: _resource_record_pre_action 09:42:03 INFO - Running main action method: read_buildbot_config 09:42:03 INFO - Using buildbot properties: 09:42:03 INFO - { 09:42:03 INFO - "project": "", 09:42:03 INFO - "product": "firefox", 09:42:03 INFO - "script_repo_revision": "production", 09:42:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:42:03 INFO - "repository": "", 09:42:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:42:03 INFO - "buildid": "20161122080251", 09:42:03 INFO - "pgo_build": "True", 09:42:03 INFO - "basedir": "/builds/slave/test", 09:42:03 INFO - "buildnumber": 632, 09:42:03 INFO - "slavename": "talos-linux64-ix-060", 09:42:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:42:03 INFO - "platform": "ubuntu64_hw", 09:42:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:42:03 INFO - "branch": "mozilla-aurora", 09:42:03 INFO - "repo_path": "releases/mozilla-aurora", 09:42:03 INFO - "revision": "7ba0440fe03102f644bbe3f5c00923caa935d5e5", 09:42:03 INFO - "stage_platform": "linux64-pgo", 09:42:03 INFO - "builduid": "d817ad58cc1c4735b4649929257b8e0a", 09:42:03 INFO - "slavebuilddir": "test" 09:42:03 INFO - } 09:42:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:42:03 INFO - Running post-action listener: _resource_record_post_action 09:42:03 INFO - [mozharness: 2016-11-22 17:42:03.369448Z] Finished read-buildbot-config step (success) 09:42:03 INFO - [mozharness: 2016-11-22 17:42:03.369537Z] Running download-and-extract step. 09:42:03 INFO - Running pre-action listener: _resource_record_pre_action 09:42:03 INFO - Running main action method: download_and_extract 09:42:03 INFO - mkdir: /builds/slave/test/build/tests 09:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:03 INFO - trying https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:42:03 INFO - Downloading https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:42:03 INFO - Downloaded 1361 bytes. 09:42:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:42:03 INFO - Using the following test package requirements: 09:42:03 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:42:03 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:42:03 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:42:03 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'jsshell-linux-x86_64.zip'], 09:42:03 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:42:03 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:42:03 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:42:03 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:42:03 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:42:03 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:42:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:42:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:42:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:42:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:03 INFO - Fetch https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:42:04 INFO - Http code: 200 09:42:04 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 09:42:04 INFO - x-amz-cf-id: VL0b_yOXfvel71NOuvfSFi-rWLKZBSf-vCAjlujcDJC5UWGou0IYwg== 09:42:04 INFO - x-amz-version-id: WFgKIOAm.3qsJtik1fNLK7kNG8jcsvPa 09:42:04 INFO - Expected file size: 21948138 09:42:04 INFO - Obtained file size: 21948138 09:42:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:42:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:42:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:08 INFO - Fetch https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:42:09 INFO - Http code: 200 09:42:09 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 09:42:09 INFO - x-amz-cf-id: 2ysXy5DSsArqpnEmDaC8XzuD9-dC8hSM97tn_x2EyLnc4QnNwhk-HA== 09:42:09 INFO - x-amz-version-id: WFgKIOAm.3qsJtik1fNLK7kNG8jcsvPa 09:42:09 INFO - Expected file size: 21948138 09:42:09 INFO - Obtained file size: 21948138 09:42:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:42:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:42:14 INFO - Fetch https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:42:14 INFO - Http code: 200 09:42:14 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 09:42:14 INFO - x-amz-cf-id: 4XKSxstFX_Rz-olzf6yfeSHn_V7t8VMfGJPTmf6rdwINUc76ioy7aw== 09:42:14 INFO - x-amz-version-id: Jqrj70KKthCsFXuEHTIoBEJw4Ya0O3OC 09:42:14 INFO - Expected file size: 14409038 09:42:14 INFO - Obtained file size: 14409038 09:42: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')]} 09:42:14 INFO - trying https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:42:14 INFO - Downloading https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:42:16 INFO - Downloaded 63951471 bytes. 09:42:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:42:16 INFO - mkdir: /builds/slave/test/properties 09:42:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:16 INFO - Contents: 09:42:16 INFO - build_url:https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:42:16 INFO - Running post-action listener: _resource_record_post_action 09:42:16 INFO - Running post-action listener: set_extra_try_arguments 09:42:16 INFO - [mozharness: 2016-11-22 17:42:16.788700Z] Finished download-and-extract step (success) 09:42:16 INFO - [mozharness: 2016-11-22 17:42:16.788926Z] Running populate-webroot step. 09:42:16 INFO - Running pre-action listener: _resource_record_pre_action 09:42:16 INFO - Running main action method: populate_webroot 09:42:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:16 INFO - '--tppagecycles', 09:42:16 INFO - '7'], 09:42:16 INFO - 'tests': ['tsvgm']}}, 09:42:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:42:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['damp', 'tps']}, 09:42:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'tests': ['damp', 'tps']}, 09:42:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['dromaeo_dom']}, 09:42:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['basic_compositor_video']}, 09:42:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:42:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['a11yr', 09:42:16 INFO - 'ts_paint', 09:42:16 INFO - 'tpaint', 09:42:16 INFO - 'sessionrestore', 09:42:16 INFO - 'sessionrestore_no_auto_restore', 09:42:16 INFO - 'tabpaint']}, 09:42:16 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:16 INFO - 'ts_paint', 09:42:16 INFO - 'tpaint', 09:42:16 INFO - 'sessionrestore', 09:42:16 INFO - 'sessionrestore_no_auto_restore', 09:42:16 INFO - 'tabpaint']}, 09:42:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:16 INFO - 'ts_paint', 09:42:16 INFO - 'tpaint', 09:42:16 INFO - 'sessionrestore', 09:42:16 INFO - 'sessionrestore_no_auto_restore', 09:42:16 INFO - 'tabpaint']}, 09:42:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:16 INFO - 'ts_paint', 09:42:16 INFO - 'tpaint', 09:42:16 INFO - 'sessionrestore', 09:42:16 INFO - 'sessionrestore_no_auto_restore', 09:42:16 INFO - 'tabpaint']}, 09:42:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['a11yr', 09:42:16 INFO - 'ts_paint', 09:42:16 INFO - 'tpaint', 09:42:16 INFO - 'sessionrestore', 09:42:16 INFO - 'sessionrestore_no_auto_restore', 09:42:16 INFO - 'tabpaint']}, 09:42:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['a11yr', 09:42:16 INFO - 'ts_paint', 09:42:16 INFO - 'tpaint', 09:42:16 INFO - 'sessionrestore', 09:42:16 INFO - 'sessionrestore_no_auto_restore', 09:42:16 INFO - 'tabpaint']}, 09:42:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['tsvgx', 09:42:16 INFO - 'tsvgr_opacity', 09:42:16 INFO - 'tart', 09:42:16 INFO - 'tscrollx', 09:42:16 INFO - 'cart']}, 09:42:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:16 INFO - 'tsvgr_opacity', 09:42:16 INFO - 'tart', 09:42:16 INFO - 'tscrollx', 09:42:16 INFO - 'cart']}, 09:42:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'talos_options': ['--disable-e10s'], 09:42:16 INFO - 'tests': ['tp5o']}, 09:42:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'tests': ['tp5o']}, 09:42:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'talos_options': ['--disable-e10s', 09:42:16 INFO - '--xperf_path', 09:42:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:16 INFO - 'tests': ['tp5n']}, 09:42:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:16 INFO - 'talos_options': ['--xperf_path', 09:42:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:16 INFO - 'tests': ['tp5n']}}, 09:42:16 INFO - 'talos.zip': {'path': '', 09:42:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:16 INFO - Running post-action listener: _resource_record_post_action 09:42:16 INFO - [mozharness: 2016-11-22 17:42:16.806069Z] Finished populate-webroot step (success) 09:42:16 INFO - [mozharness: 2016-11-22 17:42:16.806158Z] Running create-virtualenv step. 09:42:16 INFO - Running pre-action listener: _resource_record_pre_action 09:42:16 INFO - Running main action method: create_virtualenv 09:42:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:42:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:16 INFO - Using real prefix '/usr' 09:42:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:19 INFO - Installing pip.................done. 09:42:19 INFO - Return code: 0 09:42:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:42:19 INFO - Reading from file tmpfile_stdout 09:42:19 INFO - Output received: 09:42:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:42:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:19 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:42:19 INFO - Using env: {'DISPLAY': ':0', 09:42:19 INFO - 'HOME': '/home/cltbld', 09:42:19 INFO - 'LANG': 'en_US.UTF-8', 09:42:19 INFO - 'LANGUAGE': 'en_US:en', 09:42:19 INFO - 'LOGNAME': 'cltbld', 09:42:19 INFO - 'MAIL': '/var/mail/cltbld', 09:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:19 INFO - 'MOZ_NO_REMOTE': '1', 09:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:19 INFO - 'NO_EM_RESTART': '1', 09:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:19 INFO - 'PWD': '/builds/slave/test', 09:42:19 INFO - 'SHELL': '/bin/bash', 09:42:19 INFO - 'SHLVL': '1', 09:42:19 INFO - 'TERM': 'linux', 09:42:19 INFO - 'TMOUT': '86400', 09:42:19 INFO - 'USER': 'cltbld', 09:42:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:19 INFO - '_': '/tools/buildbot/bin/python'} 09:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:42:19 INFO - Cleaning up... 09:42:19 INFO - Return code: 0 09:42:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:19 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:42:19 INFO - Using env: {'DISPLAY': ':0', 09:42:19 INFO - 'HOME': '/home/cltbld', 09:42:19 INFO - 'LANG': 'en_US.UTF-8', 09:42:19 INFO - 'LANGUAGE': 'en_US:en', 09:42:19 INFO - 'LOGNAME': 'cltbld', 09:42:19 INFO - 'MAIL': '/var/mail/cltbld', 09:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:19 INFO - 'MOZ_NO_REMOTE': '1', 09:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:19 INFO - 'NO_EM_RESTART': '1', 09:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:19 INFO - 'PWD': '/builds/slave/test', 09:42:19 INFO - 'SHELL': '/bin/bash', 09:42:19 INFO - 'SHLVL': '1', 09:42:19 INFO - 'TERM': 'linux', 09:42:19 INFO - 'TMOUT': '86400', 09:42:19 INFO - 'USER': 'cltbld', 09:42:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:19 INFO - '_': '/tools/buildbot/bin/python'} 09:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:20 INFO - Downloading/unpacking psutil>=3.1.1 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:22 INFO - Installing collected packages: psutil 09:42:22 INFO - Running setup.py install for psutil 09:42:22 INFO - building 'psutil._psutil_linux' extension 09:42:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:42:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:42:22 INFO - building 'psutil._psutil_posix' extension 09:42:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:42:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:42:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:22 INFO - Successfully installed psutil 09:42:22 INFO - Cleaning up... 09:42:22 INFO - Return code: 0 09:42:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:42:22 INFO - Using env: {'DISPLAY': ':0', 09:42:22 INFO - 'HOME': '/home/cltbld', 09:42:22 INFO - 'LANG': 'en_US.UTF-8', 09:42:22 INFO - 'LANGUAGE': 'en_US:en', 09:42:22 INFO - 'LOGNAME': 'cltbld', 09:42:22 INFO - 'MAIL': '/var/mail/cltbld', 09:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:22 INFO - 'MOZ_NO_REMOTE': '1', 09:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:22 INFO - 'NO_EM_RESTART': '1', 09:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:22 INFO - 'PWD': '/builds/slave/test', 09:42:22 INFO - 'SHELL': '/bin/bash', 09:42:22 INFO - 'SHLVL': '1', 09:42:22 INFO - 'TERM': 'linux', 09:42:22 INFO - 'TMOUT': '86400', 09:42:22 INFO - 'USER': 'cltbld', 09:42:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:22 INFO - '_': '/tools/buildbot/bin/python'} 09:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:42:24 INFO - Installing collected packages: mozsystemmonitor 09:42:24 INFO - Running setup.py install for mozsystemmonitor 09:42:24 INFO - Successfully installed mozsystemmonitor 09:42:24 INFO - Cleaning up... 09:42:25 INFO - Return code: 0 09:42:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:42:25 INFO - Using env: {'DISPLAY': ':0', 09:42:25 INFO - 'HOME': '/home/cltbld', 09:42:25 INFO - 'LANG': 'en_US.UTF-8', 09:42:25 INFO - 'LANGUAGE': 'en_US:en', 09:42:25 INFO - 'LOGNAME': 'cltbld', 09:42:25 INFO - 'MAIL': '/var/mail/cltbld', 09:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:25 INFO - 'MOZ_NO_REMOTE': '1', 09:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:25 INFO - 'NO_EM_RESTART': '1', 09:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:25 INFO - 'PWD': '/builds/slave/test', 09:42:25 INFO - 'SHELL': '/bin/bash', 09:42:25 INFO - 'SHLVL': '1', 09:42:25 INFO - 'TERM': 'linux', 09:42:25 INFO - 'TMOUT': '86400', 09:42:25 INFO - 'USER': 'cltbld', 09:42:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:25 INFO - '_': '/tools/buildbot/bin/python'} 09:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:27 INFO - warning: no files found matching '*.txt' 09:42:27 INFO - no previously-included directories found matching 'build' 09:42:27 INFO - no previously-included directories found matching 'dist' 09:42:27 INFO - no previously-included directories found matching '.git*' 09:42:27 INFO - Installing collected packages: jsonschema, functools32 09:42:27 INFO - Running setup.py install for functools32 09:42:27 INFO - warning: no files found matching '*.txt' 09:42:27 INFO - no previously-included directories found matching 'build' 09:42:27 INFO - no previously-included directories found matching 'dist' 09:42:27 INFO - no previously-included directories found matching '.git*' 09:42:27 INFO - Successfully installed jsonschema functools32 09:42:27 INFO - Cleaning up... 09:42:27 INFO - Return code: 0 09:42:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:27 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:42:27 INFO - Using env: {'DISPLAY': ':0', 09:42:27 INFO - 'HOME': '/home/cltbld', 09:42:27 INFO - 'LANG': 'en_US.UTF-8', 09:42:27 INFO - 'LANGUAGE': 'en_US:en', 09:42:27 INFO - 'LOGNAME': 'cltbld', 09:42:27 INFO - 'MAIL': '/var/mail/cltbld', 09:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:27 INFO - 'MOZ_NO_REMOTE': '1', 09:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:27 INFO - 'NO_EM_RESTART': '1', 09:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:27 INFO - 'PWD': '/builds/slave/test', 09:42:27 INFO - 'SHELL': '/bin/bash', 09:42:27 INFO - 'SHLVL': '1', 09:42:27 INFO - 'TERM': 'linux', 09:42:27 INFO - 'TMOUT': '86400', 09:42:27 INFO - 'USER': 'cltbld', 09:42:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:27 INFO - '_': '/tools/buildbot/bin/python'} 09:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:42:27 INFO - Cleaning up... 09:42:27 INFO - Return code: 0 09:42:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:27 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:42:27 INFO - Using env: {'DISPLAY': ':0', 09:42:27 INFO - 'HOME': '/home/cltbld', 09:42:27 INFO - 'LANG': 'en_US.UTF-8', 09:42:27 INFO - 'LANGUAGE': 'en_US:en', 09:42:27 INFO - 'LOGNAME': 'cltbld', 09:42:27 INFO - 'MAIL': '/var/mail/cltbld', 09:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:27 INFO - 'MOZ_NO_REMOTE': '1', 09:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:27 INFO - 'NO_EM_RESTART': '1', 09:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:27 INFO - 'PWD': '/builds/slave/test', 09:42:27 INFO - 'SHELL': '/bin/bash', 09:42:27 INFO - 'SHLVL': '1', 09:42:27 INFO - 'TERM': 'linux', 09:42:27 INFO - 'TMOUT': '86400', 09:42:27 INFO - 'USER': 'cltbld', 09:42:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:27 INFO - '_': '/tools/buildbot/bin/python'} 09:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:30 INFO - Downloading docopt-0.6.1.tar.gz 09:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:30 INFO - Running setup.py install for blobuploader 09:42:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:30 INFO - Running setup.py install for requests 09:42:31 INFO - Running setup.py install for docopt 09:42:31 INFO - Successfully installed blobuploader requests docopt 09:42:31 INFO - Cleaning up... 09:42:31 INFO - Return code: 0 09:42:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:31 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:42:31 INFO - Using env: {'DISPLAY': ':0', 09:42:31 INFO - 'HOME': '/home/cltbld', 09:42:31 INFO - 'LANG': 'en_US.UTF-8', 09:42:31 INFO - 'LANGUAGE': 'en_US:en', 09:42:31 INFO - 'LOGNAME': 'cltbld', 09:42:31 INFO - 'MAIL': '/var/mail/cltbld', 09:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:31 INFO - 'MOZ_NO_REMOTE': '1', 09:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:31 INFO - 'NO_EM_RESTART': '1', 09:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:31 INFO - 'PWD': '/builds/slave/test', 09:42:31 INFO - 'SHELL': '/bin/bash', 09:42:31 INFO - 'SHLVL': '1', 09:42:31 INFO - 'TERM': 'linux', 09:42:31 INFO - 'TMOUT': '86400', 09:42:31 INFO - 'USER': 'cltbld', 09:42:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:31 INFO - '_': '/tools/buildbot/bin/python'} 09:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:31 INFO - Running setup.py (path:/tmp/pip-Ox9lA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:31 INFO - Running setup.py (path:/tmp/pip-VVhQt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:31 INFO - Running setup.py (path:/tmp/pip-mAq3_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:31 INFO - Running setup.py (path:/tmp/pip-RIthxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:31 INFO - Running setup.py (path:/tmp/pip-ZLvrLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:31 INFO - Running setup.py (path:/tmp/pip-pNe3Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:32 INFO - Running setup.py (path:/tmp/pip-Jyx_RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:32 INFO - Running setup.py (path:/tmp/pip-6LXIkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:32 INFO - Running setup.py (path:/tmp/pip-Yh4ubg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:32 INFO - Running setup.py (path:/tmp/pip-XSM0yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:32 INFO - Running setup.py (path:/tmp/pip-P6hjEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:32 INFO - Running setup.py (path:/tmp/pip-xSVW77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:32 INFO - Running setup.py (path:/tmp/pip-BPjzOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:32 INFO - Running setup.py (path:/tmp/pip-GFka1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:32 INFO - Running setup.py (path:/tmp/pip-i8i0Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:32 INFO - Running setup.py (path:/tmp/pip-GAdEzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:32 INFO - Running setup.py (path:/tmp/pip-I8jXnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:32 INFO - Running setup.py install for manifestparser 09:42:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:32 INFO - Running setup.py install for mozcrash 09:42:33 INFO - Running setup.py install for mozdebug 09:42:33 INFO - Running setup.py install for mozdevice 09:42:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Running setup.py install for mozfile 09:42:33 INFO - Running setup.py install for mozhttpd 09:42:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Running setup.py install for mozinfo 09:42:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Running setup.py install for mozInstall 09:42:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Running setup.py install for mozleak 09:42:33 INFO - Running setup.py install for mozlog 09:42:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Running setup.py install for moznetwork 09:42:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:33 INFO - Running setup.py install for mozprocess 09:42:34 INFO - Running setup.py install for mozprofile 09:42:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:34 INFO - Running setup.py install for mozrunner 09:42:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:34 INFO - Running setup.py install for mozscreenshot 09:42:34 INFO - Running setup.py install for moztest 09:42:34 INFO - Running setup.py install for mozversion 09:42:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:34 INFO - Cleaning up... 09:42:34 INFO - Return code: 0 09:42:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:34 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:42:34 INFO - Using env: {'DISPLAY': ':0', 09:42:34 INFO - 'HOME': '/home/cltbld', 09:42:34 INFO - 'LANG': 'en_US.UTF-8', 09:42:34 INFO - 'LANGUAGE': 'en_US:en', 09:42:34 INFO - 'LOGNAME': 'cltbld', 09:42:34 INFO - 'MAIL': '/var/mail/cltbld', 09:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:34 INFO - 'MOZ_NO_REMOTE': '1', 09:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:34 INFO - 'NO_EM_RESTART': '1', 09:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:34 INFO - 'PWD': '/builds/slave/test', 09:42:34 INFO - 'SHELL': '/bin/bash', 09:42:34 INFO - 'SHLVL': '1', 09:42:34 INFO - 'TERM': 'linux', 09:42:34 INFO - 'TMOUT': '86400', 09:42:34 INFO - 'USER': 'cltbld', 09:42:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:34 INFO - '_': '/tools/buildbot/bin/python'} 09:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:34 INFO - Running setup.py (path:/tmp/pip-qp7NTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:34 INFO - Running setup.py (path:/tmp/pip-RmlLBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:35 INFO - Running setup.py (path:/tmp/pip-7CEkSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:35 INFO - Running setup.py (path:/tmp/pip-X1Eqiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:35 INFO - Running setup.py (path:/tmp/pip-uZRBtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:35 INFO - Running setup.py (path:/tmp/pip-Yb0XL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:35 INFO - Running setup.py (path:/tmp/pip-e1D7Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:35 INFO - Running setup.py (path:/tmp/pip-ESpsyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:35 INFO - Running setup.py (path:/tmp/pip-vK5Z7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:35 INFO - Running setup.py (path:/tmp/pip-Rbs6IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:35 INFO - Running setup.py (path:/tmp/pip-IcJAHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:35 INFO - Running setup.py (path:/tmp/pip-ucRd99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:35 INFO - Running setup.py (path:/tmp/pip-KTp5tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:35 INFO - Running setup.py (path:/tmp/pip-BuWM8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:35 INFO - Running setup.py (path:/tmp/pip-8nGGIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:35 INFO - Running setup.py (path:/tmp/pip-cwIvur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:36 INFO - Running setup.py (path:/tmp/pip-6dt0SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:42:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:38 INFO - Downloading blessings-1.6.tar.gz 09:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:38 INFO - Installing collected packages: blessings 09:42:38 INFO - Running setup.py install for blessings 09:42:38 INFO - Successfully installed blessings 09:42:38 INFO - Cleaning up... 09:42:38 INFO - Return code: 0 09:42:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:38 INFO - Reading from file tmpfile_stdout 09:42:38 INFO - Current package versions: 09:42:38 INFO - argparse == 1.2.1 09:42:38 INFO - blessings == 1.6 09:42:38 INFO - blobuploader == 1.2.4 09:42:38 INFO - docopt == 0.6.1 09:42:38 INFO - functools32 == 3.2.3-2 09:42:38 INFO - jsonschema == 2.5.1 09:42:38 INFO - manifestparser == 1.1 09:42:38 INFO - mozInstall == 1.12 09:42:38 INFO - mozcrash == 1.0 09:42:38 INFO - mozdebug == 0.1 09:42:38 INFO - mozdevice == 0.48 09:42:38 INFO - mozfile == 1.2 09:42:38 INFO - mozhttpd == 0.7 09:42:38 INFO - mozinfo == 0.9 09:42:38 INFO - mozleak == 0.1 09:42:38 INFO - mozlog == 3.4 09:42:38 INFO - moznetwork == 0.27 09:42:38 INFO - mozprocess == 0.23 09:42:38 INFO - mozprofile == 0.28 09:42:38 INFO - mozrunner == 6.13 09:42:38 INFO - mozscreenshot == 0.1 09:42:38 INFO - mozsystemmonitor == 0.3 09:42:38 INFO - moztest == 0.7 09:42:38 INFO - mozversion == 1.4 09:42:38 INFO - psutil == 3.1.1 09:42:38 INFO - requests == 1.2.3 09:42:38 INFO - wsgiref == 0.1.2 09:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:42:38 INFO - Using env: {'DISPLAY': ':0', 09:42:38 INFO - 'HOME': '/home/cltbld', 09:42:38 INFO - 'LANG': 'en_US.UTF-8', 09:42:38 INFO - 'LANGUAGE': 'en_US:en', 09:42:38 INFO - 'LOGNAME': 'cltbld', 09:42:38 INFO - 'MAIL': '/var/mail/cltbld', 09:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:38 INFO - 'MOZ_NO_REMOTE': '1', 09:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:38 INFO - 'NO_EM_RESTART': '1', 09:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:38 INFO - 'PWD': '/builds/slave/test', 09:42:38 INFO - 'SHELL': '/bin/bash', 09:42:38 INFO - 'SHLVL': '1', 09:42:38 INFO - 'TERM': 'linux', 09:42:38 INFO - 'TMOUT': '86400', 09:42:38 INFO - 'USER': 'cltbld', 09:42:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:38 INFO - '_': '/tools/buildbot/bin/python'} 09:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:42:38 INFO - Cleaning up... 09:42:38 INFO - Return code: 0 09:42:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:38 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 0x7f3f7ab04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:42:38 INFO - Using env: {'DISPLAY': ':0', 09:42:38 INFO - 'HOME': '/home/cltbld', 09:42:38 INFO - 'LANG': 'en_US.UTF-8', 09:42:38 INFO - 'LANGUAGE': 'en_US:en', 09:42:38 INFO - 'LOGNAME': 'cltbld', 09:42:38 INFO - 'MAIL': '/var/mail/cltbld', 09:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:38 INFO - 'MOZ_NO_REMOTE': '1', 09:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:38 INFO - 'NO_EM_RESTART': '1', 09:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:38 INFO - 'PWD': '/builds/slave/test', 09:42:38 INFO - 'SHELL': '/bin/bash', 09:42:38 INFO - 'SHLVL': '1', 09:42:38 INFO - 'TERM': 'linux', 09:42:38 INFO - 'TMOUT': '86400', 09:42:38 INFO - 'USER': 'cltbld', 09:42:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:38 INFO - '_': '/tools/buildbot/bin/python'} 09:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:42:39 INFO - Cleaning up... 09:42:39 INFO - Return code: 0 09:42:39 INFO - Running post-action listener: _resource_record_post_action 09:42:39 INFO - Running post-action listener: _start_resource_monitoring 09:42:39 INFO - Starting resource monitoring. 09:42:39 INFO - [mozharness: 2016-11-22 17:42:39.058617Z] Finished create-virtualenv step (success) 09:42:39 INFO - [mozharness: 2016-11-22 17:42:39.059154Z] Running install step. 09:42:39 INFO - Running pre-action listener: _resource_record_pre_action 09:42:39 INFO - Running main action method: install 09:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:39 INFO - Reading from file tmpfile_stdout 09:42:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:42:39 INFO - Reading from file tmpfile_stdout 09:42:39 INFO - Output received: 09:42:39 INFO - Usage: mozinstall [options] installer 09:42:39 INFO - Options: 09:42:39 INFO - -h, --help show this help message and exit 09:42:39 INFO - -d DEST, --destination=DEST 09:42:39 INFO - Directory to install application into. [default: 09:42:39 INFO - "/builds/slave/test"] 09:42:39 INFO - --app=APP Application being installed. [default: firefox] 09:42:39 INFO - mkdir: /builds/slave/test/build/application 09:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:42:55 INFO - Reading from file tmpfile_stdout 09:42:55 INFO - Output received: 09:42:55 INFO - /builds/slave/test/build/application/firefox/firefox 09:42:55 INFO - Running post-action listener: _resource_record_post_action 09:42:55 INFO - [mozharness: 2016-11-22 17:42:55.269054Z] Finished install step (success) 09:42:55 INFO - [mozharness: 2016-11-22 17:42:55.269296Z] Running run-tests step. 09:42:55 INFO - Running pre-action listener: _resource_record_pre_action 09:42:55 INFO - Running main action method: run_tests 09:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:42:55 INFO - Python 2.7.3 09:42:55 INFO - Return code: 0 09:42:55 INFO - grabbing minidump binary from tooltool 09:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:55 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 0x169df60>, '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 0x169ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x169f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:42:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:42:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:42:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:42:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:42:55 INFO - Return code: 0 09:42:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:42:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:42:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:42:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:42:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:42:55 INFO - Using env: {'DISPLAY': ':0', 09:42:55 INFO - 'HOME': '/home/cltbld', 09:42:55 INFO - 'LANG': 'en_US.UTF-8', 09:42:55 INFO - 'LANGUAGE': 'en_US:en', 09:42:55 INFO - 'LOGNAME': 'cltbld', 09:42:55 INFO - 'MAIL': '/var/mail/cltbld', 09:42:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:42:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:55 INFO - 'MOZ_NO_REMOTE': '1', 09:42:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:55 INFO - 'NO_EM_RESTART': '1', 09:42:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:55 INFO - 'PWD': '/builds/slave/test', 09:42:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:42:55 INFO - 'SHELL': '/bin/bash', 09:42:55 INFO - 'SHLVL': '1', 09:42:55 INFO - 'TERM': 'linux', 09:42:55 INFO - 'TMOUT': '86400', 09:42:55 INFO - 'USER': 'cltbld', 09:42:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268', 09:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:55 INFO - '_': '/tools/buildbot/bin/python'} 09:42:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:42:55 INFO - mozversion application_buildid: 20161122080251 09:42:55 INFO - mozversion application_changeset: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 09:42:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:42:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:42:55 INFO - mozversion application_name: Firefox 09:42:55 INFO - mozversion application_remotingname: firefox-dev 09:42:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:42:55 INFO - mozversion application_vendor: Mozilla 09:42:55 INFO - mozversion application_version: 52.0a2 09:42:55 INFO - mozversion platform_buildid: 20161122080251 09:42:55 INFO - mozversion platform_changeset: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 09:42:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:42:55 INFO - mozversion platform_version: 52.0a2 09:42:55 INFO - using testdate: 1479836575 09:42:55 INFO - actual date: 1479836575 09:42:55 INFO - starting webserver on 'localhost:36079' 09:42:55 INFO - SUITE-START | Running 2 tests 09:42:55 INFO - TEST-START | dromaeo_css 09:42:55 INFO - operating with platform_type : linux_ 09:42:55 INFO - Initialising browser for dromaeo_css test... 09:42:55 INFO - TEST-INFO | started process 20873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXebfC/profile http://localhost:36079/getInfo.html) 09:42:58 ERROR - PROCESS | 20873 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 09:42:59 INFO - PROCESS | 20873 | __metrics Screen width/height:1600/1200 09:42:59 INFO - PROCESS | 20873 | colorDepth:24 09:42:59 INFO - PROCESS | 20873 | Browser inner width/height: 1024/697 09:42:59 INFO - PROCESS | 20873 | __metrics 09:43:00 INFO - PROCESS | 20873 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:43:00 INFO - PROCESS | 20873 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:43:00 INFO - PROCESS | 20873 | console.error: PushService: 09:43:00 INFO - PROCESS | 20873 | stateChangeProcessEnqueue: Error transitioning state 09:43:00 INFO - PROCESS | 20873 | UnknownError 09:43:01 INFO - TEST-INFO | 20873: exit 0 09:43:01 INFO - Browser initialized. 09:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:01 INFO - TEST-INFO | started process 20965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXebfC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:13 INFO - PROCESS | 20965 | RSS: Main: 144293888 09:43:13 INFO - PROCESS | 20965 | 09:44:04 INFO - PROCESS | 20965 | 1479836644817 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] 09:46:15 INFO - PROCESS | 20965 | Cycle 1(1): loaded http://localhost:36079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36079/tests/dromaeo/cssquery-ext.html) 09:46:16 INFO - PROCESS | 20965 | RSS: Main: 249597952 09:46:16 INFO - PROCESS | 20965 | 09:49:18 INFO - PROCESS | 20965 | Cycle 1(1): loaded http://localhost:36079/tests/dromaeo/cssquery-ext.html (next: http://localhost:36079/tests/dromaeo/cssquery-jquery.html) 09:49:19 INFO - PROCESS | 20965 | RSS: Main: 229687296 09:49:19 INFO - PROCESS | 20965 | 09:52:21 INFO - PROCESS | 20965 | Cycle 1(1): loaded http://localhost:36079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36079/tests/dromaeo/cssquery-mootools.html) 09:52:21 INFO - PROCESS | 20965 | RSS: Main: 174219264 09:52:21 INFO - PROCESS | 20965 | 09:55:23 INFO - PROCESS | 20965 | Cycle 1(1): loaded http://localhost:36079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36079/tests/dromaeo/cssquery-prototype.html) 09:55:24 INFO - PROCESS | 20965 | RSS: Main: 214753280 09:55:24 INFO - PROCESS | 20965 | 09:58:27 INFO - PROCESS | 20965 | Cycle 1(1): loaded http://localhost:36079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36079/tests/dromaeo/cssquery-yui.html) 09:58:27 INFO - PROCESS | 20965 | RSS: Main: 175808512 09:58:27 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | Cycle 1(1): loaded http://localhost:36079/tests/dromaeo/cssquery-yui.html (next: http://localhost:36079/tests/dromaeo/cssquery-dojo.html) 10:01:30 INFO - PROCESS | 20965 | RSS: Main: 269049856 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | __start_tp_report 10:01:30 INFO - PROCESS | 20965 | _x_x_mozilla_page_load 10:01:30 INFO - PROCESS | 20965 | _x_x_mozilla_page_load_details 10:01:30 INFO - PROCESS | 20965 | |i|pagename|runs| 10:01:30 INFO - PROCESS | 20965 | |0;dojo.html;3250.902472925812;3294.8187849668275;3303.2402547414094;3321.186309354209;3341.5655964724583;5647;5739.3399759027725;5740.253767010293;5749.453801888824;5754.223179870716;5673.290838645169;5694.715264236792;5698.0883058710615;5702.971485142579;5725.627834190775;5141.665791723544;5143.048536020848;5149.562287205583;5171.482851714817;5221.973890130563;5089.109405853961;5112.8977420451565;5237.764300606482;5238.973805130969;5270.631055826094;5105.3873535175835;5118;5151.896962060775;5155.664881782691;5188.584913206953;5221.71280579568;5232.686038837663;5297;5298.894022119574;5305.628605997582;4873.780679869415;4969.130402179604;5161.096808058574;5181.989512045153;5265.842024739226;5514.751836167382;5519.282493275889;5551.9722401388135;5589.469000444951;5633.549316054747;5924.911126333109;6010.459058684695;6057.545684073712;6057.697115144269;6065.909011364833;5928.7332070056955;5987.700614969234;6047.15339852421;6056.182415373913;6076.665783381913;5710.2862142232225;5746.741396637161;5749.252597162342;5778.393268706767;5799.565032622486;6252.124702541648;6262.405071518289;6271.247450305992;6280.120783090371;6293.559450838489;5821;5876.970615146897;6018.819435416857;6022.066579680157;6032.366601506778;6052.364501727343;6080.14877917092;6084.5436592255755;6125.6017461851925;6132.948755694992;6105;6115.052166914135;6118.938810611926;6131.448169664752;6131.724072416752;5870.383609720918;6015.789447369321;6083.787067452707;6094.481969032593;6098.786542471081;4308.418363520885;4320.373545835836;4339.414179085846;4358.411614432011;4373.037931655031;3985.04358953849;3998.540167880673;3998.9400158997637;4012.598740125964;4019.457373254632;5783.59514833966;5796.5072968797285;5804.303483581997;5809.070548712186;5858.707064646751;5946.762129514771;6017.308009578867;6023.427774361428;6047.485963693048;6089.421504957022;5815.098659707752;5820.534357251495;5821.15593238978;5833.241678581757;5857.092150716646;5164.974175129176;5206.193040078794;5207.1668533034535;5209;5217.087009773274;6125.20492926512;6176.258848938156;6209.720562574786;6290;6345.650989195547;6028.8794224116145;6115.4190351916495;6118.265808103056;6127.908081378694;6134.9079763804475;6271.466925311217;6335.081413194969;6338.841528961812;6340.048992651139;6346.619202847844;5883.35283118848;5888.352281248974;5983.95280825845;5988.311344195473;5992.2809262886985;6136.723847426787;6155.446009859134;6197;6208.627482350893;6212.782552610637;6036.3058248302;6041.909371359346;6043.456088952015;6045.758169673164;6068.969655151696;5696.1455781633085;5969.492593129633;5976.312724036791;5981.312149102909;5982.611130276518;5799.159121927381;5839.299284085767;5872.823815285548;5890.145928840208;5941.405859414024;5999.970000149971;6012;6014.428629280212;6022.66875321844;6026.397360263939;5639.802606908903;5690.743916523684;5692.459216374438;5852.18069470266;5866.530677545701 10:01:30 INFO - PROCESS | 20965 | |1;ext.html;572.2074926227174;629.1852051593188;638.6423602782443;671.120831710459;671.9697613607387;34452.82773586132;44378;45526.31710524345;45613.77193114038;48571.27143092848;44830.77584612081;45135;45241.321380179244;45303.77348113263;45315.320270195974;8209.835803283931;8802.735917922457;8941;8944.910550894505;8958.417702849294;8338.332933365316;10524.210684198677;10754.408507532082;10772.138228941665;11072.557097716082;10554.366737995706;10600.681979540588;10610.257281990263;10612.575496980111;10617.256792024522;10585.047345738882;10633.680989570325;10648.946755266214;10652.520636571373;10656.147508199325;10563.788724225473;10622.787544249071;10635.57457701691;10648.414337211529;10653.84019239712;42156.578434215575;42360.15279694389;42557;42576.78711606453;42610.57389426097;3415.299863527971;3603.2433189030335;3629.6370362963494;3746.606606306326;4332.761698106603;32030.679693203;32114.518282225785;32306.515402268986;32322;32445.67554324474;4279.358096285551;4486.192485352635;4526.818927242906;4527.660425468103;4590.586847183769;349926;353346;354994;355733;356852.21573892224;40483.39274910879;61647.691761540904;62064;62146;62222;41175.588244117775;41318.793406032775;41495.75512734563;41513.792431037655;41540.58459415428;16368.83631163673;16492.752608710878;16508.17459127039;16512.174391280387;16515.17424128789;11696.590619328283;11927.642170734893;13362.131461454974;13746.450141994408;13898.444062237397;9262.90737092634;9475.668351607661;9478.857817132748;9551.665691700757;9564.95217523922;3584.928301434009;3600.6759391654355;3604.6575575320303;3621.239539696693;3693.796841173761;1028.4908970059869;1086.6088208245026;1139.9829002564802;1146.7305183281921;1149.6321177223208;32136.83931580374;32450.513242301386;32519.674803251666;32833.50749738756;33611;1112.2158877990996;1167.4921409187032;1186.2170967161805;1187.3232257613079;1239.9956035611183;17432.302707891795;17483.300667973137;17583.29666813313;17597.560060998578;17605.486179738124;537318;541708;541807;542880;543119;60717.39282607118;61630.383696163364;61779.38220617826;61945;62174;1300.258852454111;1337.164272329794;1340.1891855427325;1407.7677183264648;1429.27821450167;27138.32154196161;33716.83141584276;34496.310073798886;36973;37053.629463705016;58088.70955645195;58257.70871145617;58504.4149558516;58680;58893;475520;476221;476879;478398;480138;27035.1889443317;27072.72927270781;27705;30791.69208307978;31398.215044624067;42973.785131074146;47884.74184484769;48991.26513102378;49072.50927490679;49647.751761240965;40279.798601006805;41151.325163864254;41853.162936741704;41981.580184197766;43518.78240608777;41370.37944430776;41747;41754.16491670089;41885.37171942362;43604.78197609119;42450.363244551976;42703.78648106739;42735.7863210682;42798.78600606977;43470;35234.47148292726;37254;37777.433338499395;37992.430113547765;38019.42970855495;28924.566131507625;28994.565081524215;29077;29179;29242.41515169727 10:01:30 INFO - PROCESS | 20965 | |2;jquery.html;409.4288467587715;413.10562631901934;418.7320115126318;421.73852211628775;421.85446021122704;19092.140853661585;20164.294249701245;20678.172873085077;20867.373978780663;21050.26324078654;19969.800301996976;20264.59470810583;20295;20326.593468130664;20473.692894606593;5604.8318550443555;5832.650040997532;5890.204822348992;5893.263342082239;5898.380670029649;5604.187392828037;5742.138679198133;5748.770049198048;5781.219535362714;5848.561357898154;5730.283714535683;5735.283089613798;5742.138679198112;5743.712814359286;5749.080147176453;5660.2075709400715;5751.453611906883;5778.971105144489;5815.767369305223;5818.912716309259;5259.710715910624;5262.578993680497;5264.8683782905355;5265.499777521168;5270.7628156733035;23695.170669026502;23707.644385334235;23758.76241237583;24036;24125.155619553232;2413.625887987347;2420.697412823397;2562.6540417043648;2670.8130430869846;3036.952251473238;15106.697866042727;15299.082055076731;15336.846631533654;15361.615959600987;15574.14342211178;1988.2146552111979;1995.4811748945378;2000.2399088346335;2010.577778666467;2102.6845973104005;84134.15865841325;85100.57449712773;85400;85684;87427.56286218528;11108.888911110947;11335.546578136948;11388.259763115371;11608.361540115206;11621.128415368881;16655;16685.49943501697;16700.248488818033;16705.749413758804;16714;8365.03421695901;8471.407001509959;8504.44721093127;8594.14058594148;8844;8248.8350232995;8378.329733621418;8459.280961118375;8666.480011199223;8680.913190868137;6942.056224257216;7160.82097947545;7201.855962880713;7210.315020073084;7236.457265705093;1986.7913869043832;1990.2735501541833;2000.7699114602008;2050.5693804300968;2077.5637116205767;952.3952290295712;1024.5235965276183;1052.3843551522293;1080.287010573018;1119.1270808769173;20516.07677654509;20673;21060.789392106188;21096.367108986757;21271.149154033974;1013.99493002536;1061.3631820907394;1077.4612693653173;1077.7844431113808;1096.1395304685784;11134.610288639858;11839.467223974942;12022.158448908493;12028.766387490841;12150.33173175466;376051;380709;382067;519117;521658;73316.63341683257;80188.59905700434;103276;110334;112672;993.3146129170993;1063.2344711807486;1072.265498133781;1073.3881687438086;1094.8357746338113;18454.446366609023;18776.24895004239;19163.233470661016;19215.135318910405;19555;43090.78454607707;44366;44508.332375015045;50040.24939625982;50150.49849501458;64701.35298646953;64755;64801.67599161974;65956.6702166486;66057.66971165114;8799.296056315607;8996.55017249122;9215.539223038955;9270.72187834366;9353.766155845886;13882.375293111632;14033.719325613227;14077.366518506487;14186.3616137272;14270.357833897708;12091.69770755703;12313.199642023239;12407.441665125272;12683.11218214716;12742.171758835646;11134.220604557604;11210.43947802623;11737.237079589799;11805.23265987708;12009.339486328336;12172.452239649414;12392.194507356993;12438.440270188044;12458.003359731381;12582.24506529611;8764.1674040966;9136.49749263797;9316.255844973684;9512.191463725385;9580.760480987752;11749.588764393548;12099.637010889688;12121;12139.939300303442;12546.874531254936 10:01:30 INFO - PROCESS | 20965 | |3;mootools.html;1450.1951416963589;1474.6313421644588;1582.1377349344607;1732.896026238425;1766.8851524650897;8380.161983801625;8982.371234013606;8983.685571005017;8986.460812351255;8988.325875559327;7802.453828232026;7971.322437592797;8047.718329858456;8252.711155109557;8778.122187781235;2403.158894386959;2439.6462512935614;2441.438469152096;2443.462438263588;2449.8040156787415;2455.4229756007326;2479.1075212923333;2501.374656335916;2505.3110394641526;2505.8621775802326;2428.259380888828;2428.7449817769143;2455.533448644761;2465.050955382173;2467.062516243825;2404.326788499223;2408.4942162145794;2410.4576470294132;2424.139430502164;2452.16626347042;2396.7363590005084;2416.347586151747;2420.140849998243;2420.189236605739;2422.2491027781443;8680.262177714902;8685.348598855111;8729.60716767747;8749.606267717969;8763;5122.897542049175;5195.19474481456;5247.449017853147;5274.208868669692;5276.15581506957;3456.3778519866414;3504.8598056077726;3574.392353299945;3602.6397360264027;3614.765040272374;983.5623147699276;1007.5214273220236;1213.5145941623332;1233.9814902776466;2165.404513758713;11861.169718119734;12374.62876113718;12381.62855114357;12400.255984640951;12402.75194496114;4753.429588449409;4763.118823017753;4799.928001079987;4849.806007759721;4855.902881942341;9628.277879159092;9637.807243855224;9757.560909759079;9770.218382529381;9784.706458806248;5524.806631767869;5527.977324195037;5533.08704063833;5534;5536.972315138399;4340.370646256275;4877.146499362598;5050.747462626854;5104.285400043997;5149.871253218699;3924.9215015699524;4010.979945100256;4074.409210664437;4097.955021469506;4128.401381799622;1233.7285797124619;1261.7224210673637;1263.3746295583562;1283.5507572349602;1286.0676009892752;923.3075193604797;931.3108299858056;956.1585804492141;963.7638778499313;995.0149352141473;5774.913376299359;5861.589688721834;5962.612430192024;5984.760609575568;6132.325444201134;930.7440453875239;949.6866034208695;954.1984732824461;961.4183419031385;970.9271804614682;3885.339492286318;4006.819693113817;4009.859654912064;4010.6189911958318;4069.2471892699355;10581.31221470602;10914.454277286104;10942.726431839268;10953.671389858317;10956.616518421817;10301.9484902575;10791.40647264408;10910;10926.890731092588;10927.836082458769;7748.806279842936;8304.875426868603;8315.95842020798;8406.159384061668;8434.957825210957;5670.744816483186;5678.176664383559;5770.653760774367;5788.305403351625;5789.218455508452;9634.662786802428;9667.806643867223;9743.658971936231;9773.07155820196;9774.924758276726;9730.659426920023;9748;9818;9826.5086745661;9842.409455432697;7145.4998150128995;7322.853542929005;7335.083114610674;7486.588237646982;7586.810329741801;7849.097353804385;7948.523088614702;8127;8266.751997439846;8383.790405239917;7528.811779705551;7532.7740167795055;7561.962190189014;7590.468667193243;7795.649195786316;7435.7025718970635;7442.367398771165;7442.813929651802;7529.924700753141;7569.432292577969;6559.540832141895;6672.733090676318;6684.331566843277;6695.799126026227;6695.966520167368;5173.198154286091;5209.218617207449;5217.295665085165;5226;5377.27406800077;5162.5095615916425;5173.560247379015;5182.689038657692;5200.193969934666;5367.302250707383 10:01:30 INFO - PROCESS | 20965 | |4;prototype.html;356.91077230692326;359.10403543159816;366.4027634955023;368.30758174631694;372.92541491701667;5383.815560576677;5448.37343705474;5468.179773034042;5475.260839786628;5491.313585801775;5168.61235407345;5205.401378841434;5228.581713462923;5285.4450282720245;5402.9464254470395;4283.0363168287195;4298.570142985708;4300.741955482681;4300.806463709125;4303.031817840992;4314.676399270052;4340.500842403117;4351.021020270446;4351.717138385995;4359.629431498326;4174.478190226222;4240.957590424087;4260.531341552442;4277.673921084458;4315.784210789448;4260.829566817323;4264.808083636244;4267.14657068586;4270.530241673413;4271.842719426685;3770.0763312988493;3776.7356285060055;3776.9055773605605;3781.2248489059675;3810.7523011004196;5166.689998600058;5229.189475631283;5248.241838983945;5293.75596734767;5311.760970756325;4837.467878533358;4845.9757701211265;4851.781669824866;4852.8544143675745;4856.781444834991;5580.386157522669;5582.804601838916;5613.775448982035;5615.634983726086;5627.43725627434;3919.2749341371937;4095.9590404096175;4125.009997600554;4127.33962565988;4141.585841415865;5883.911476376884;5920.5559583031445;5925.555583331225;5926.318473375531;5936.753281810825;4196.202721482909;4203.32746760523;4207.179599978036;4257.212415703105;4269.249607660906;4193.496780386373;4284.693168583612;4318.805653745589;4319.352097185448;4320.589543993316;4860.756962151878;4861.4895435978715;4874.832018624096;4884.3650325457465;4898.926516102261;5710;5710.400407957188;5713.200151978726;5718.342390625048;5725.5133313667975;1349.9325033748273;1386.729587730383;1431.2843578210895;1440.3950340856866;1451.4121780678843;942.1191186240886;949.0983565612696;956.7225504603726;992;1008.6167256442504;5351.9464805351445;5369.7583608737705;5385.553245922612;5404.91892621611;5408.945910540923;5552.333719953632;5589.804356847572;5598;5620.5503559715125;5624.971875140598;5243.239730239094;5584.4136365681015;5593.524550413179;5616.5787565932715;5618.719064046863;2965.54034124711;2982.7166419190144;2985.5820185174093;2994.520876659724;3021.9546706799415;5708.31500219968;5858.443447872445;5870;5904.704764761831;5910.8817823643285;5665.773369065274;5690.317161940511;5704.942950570524;5742.076404404488;5751.5398768099285;5830.3586605473365;5867.442592953833;5889.234399528034;5891.823245302733;5905.899402813471;5374.435684253097;5595.328560572757;5606.570324567209;5612.831615051555;5620;5534.723263836711;5544.223808666709;5564.657928388792;5611.298587676541;5622.718864056699;5711.228984087261;5766.971165144148;5830.708464576669;5866.823995280149;6117.541184411098;4251.978740106403;4276.251655960256;4278.550752170977;4294.269974104473;4295.799629276209;5892.234009578728;5897.5576831736935;5909.438603332676;5916.556258280732;5954.21907088993;5625.128105143709;5700.771969121189;5720.2849643794525;5751.798687045934;5758.568107392046;5674.943250567607;5675.2543321407675;5680.488756011813;5705.4009329019855;5705.800296989585;5427.674339539641;5497.4162143792355;5596.496315331477;5692.288463942007;5697.3448053474385;5730.656160630376;5739.110437882135;5744.42555744439;5755.798547051;5757.798477053283;5434.945650543444;5601.935632229864;5623;5629.690367029689;5642.689652069175 10:01:30 INFO - PROCESS | 20965 | |5;yui.html;673.3300366135695;747.9401647868171;766.2720415605173;792.3423558446489;809.9878501822474;14504.564863054098;15515.844841551581;15534.223288835541;15547.689046219082;15561.066336019832;14215.786763198534;14958.850411495881;15389.76915346268;15457.072575645469;16131.596710082255;728;744.4639859301294;831.9084900660922;833.0877688930626;854.6880388658158;821.4126899267023;837.8910741603582;838.1911455445494;838.6980686952692;838.7609531283586;877.7761670773975;879.7536689726886;880.1902249930048;880.8238352329528;881.5195718333524;756.4213376766751;770.3375097416217;847.7117779954783;877.3814460805118;879.1735768377737;629.109809619388;644.9871002579922;645.6416688737748;645.9031145328238;646.1148226929137;15503.922480387526;15820;15906;15918.522444326689;15948.441804536786;14018.158910465405;14388.712225755531;14512.056716313406;14558.272086395744;14650.413983440649;13428.778363147456;13499.797503037462;13503.527376541871;13616.93191534036;13781.655458613615;4505.2791553351635;4553.112143132091;4588.518205588399;4604.585587297126;4616.422947131608;69830;70432;70567.2943270571;71257.28742712506;72866;11064.612738554273;11264.887351126385;11349.489272982735;11437.256578322382;11461.828072578917;20191.49521261951;20210.898945505473;20218.19127234894;20230.595388092155;20744.58510829775;8010.759677209693;8244.258016778518;8261.958690206631;8288.378371622153;8540.957295213608;4698.7415692137265;4726.7636618169645;4769.713817170981;4847.660663753503;4942.5057494251005;3289.9835500822824;3379.9155021124175;3387.0346951118813;3416.3167366526295;3432.485127230935;596.3946594206883;596.6360520082746;612.773273888664;616.981490555284;621.9036049412258;458.28049961560697;543.9728013599304;558.109814845321;558.109814845321;571.828451464559;7946.9602651987525;8071.4753541019645;8162.7143049992965;8478;8503.14968503157;542.9321334833146;594.8810237952426;631.8136149835809;634;634.514596333805;4086.427900093989;4144.461220041436;4198.223328684203;4201.663866890642;4323.567643235651;92573;93525.53237233906;93672.53163734138;97458.512707436;97614;81356;84899.81141557771;85215.57392212999;85968.57015715007;87313;72534.63732681303;73645.6317718408;74369;75700.24299757152;76042.23957760351;7618;7836.255555722198;7934.365250780039;8089.110197878111;8097.554634494923;50131.49868501268;50274.49725502698;50845;50922;51620.22569661383;61880.69059654673;67141;67659;68311;71055;10264.486775661038;10343.431111288952;10871.619493317696;10877.12982961377;10915.727106822076;11946.402679866145;11952.163348565517;12122.212056216318;12377.133600647869;12397.93801030989;11622.476988535705;11628.592999245324;11707.2975621463;11867;11917.34454605005;11648.650540483799;11950.223235489666;12116.697082573006;12211.389430528261;12305.446254918372;11475.885241147816;11545.653630391102;11829.76340473203;12000.879991199976;12178.147529672839;10044.347117437343;10299.948500257451;10393;10485.318454300446;10490.737731556772;9448.196903263299;10049.648262311077;10071.395716257048;10164.949175254076;10185.541650625592 10:01:30 INFO - PROCESS | 20965 | __end_tp_report 10:01:30 INFO - PROCESS | 20965 | __start_cc_report 10:01:30 INFO - PROCESS | 20965 | _x_x_mozilla_cycle_collect,1015 10:01:30 INFO - PROCESS | 20965 | __end_cc_report 10:01:30 INFO - PROCESS | 20965 | __startTimestamp1479837690342__endTimestamp 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | ------- Summary: start ------- 10:01:30 INFO - PROCESS | 20965 | Number of tests: 6 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | [#0] dojo.html Cycles:165 Average:5637.06 Median:5858.71 stddev:670.23 (11.4%) stddev-sans-first:645.62 10:01:30 INFO - PROCESS | 20965 | Values: 3250.9 3294.8 3303.2 3321.2 3341.6 5647.0 5739.3 5740.3 5749.5 5754.2 5673.3 5694.7 5698.1 5703.0 5725.6 5141.7 5143.0 5149.6 5171.5 5222.0 5089.1 5112.9 5237.8 5239.0 5270.6 5105.4 5118.0 5151.9 5155.7 5188.6 5221.7 5232.7 5297.0 5298.9 5305.6 4873.8 4969.1 5161.1 5182.0 5265.8 5514.8 5519.3 5552.0 5589.5 5633.5 5924.9 6010.5 6057.5 6057.7 6065.9 5928.7 5987.7 6047.2 6056.2 6076.7 5710.3 5746.7 5749.3 5778.4 5799.6 6252.1 6262.4 6271.2 6280.1 6293.6 5821.0 5877.0 6018.8 6022.1 6032.4 6052.4 6080.1 6084.5 6125.6 6132.9 6105.0 6115.1 6118.9 6131.4 6131.7 5870.4 6015.8 6083.8 6094.5 6098.8 4308.4 4320.4 4339.4 4358.4 4373.0 3985.0 3998.5 3998.9 4012.6 4019.5 5783.6 5796.5 5804.3 5809.1 5858.7 5946.8 6017.3 6023.4 6047.5 6089.4 5815.1 5820.5 5821.2 5833.2 5857.1 5165.0 5206.2 5207.2 5209.0 5217.1 6125.2 6176.3 6209.7 6290.0 6345.7 6028.9 6115.4 6118.3 6127.9 6134.9 6271.5 6335.1 6338.8 6340.0 6346.6 5883.4 5888.4 5984.0 5988.3 5992.3 6136.7 6155.4 6197.0 6208.6 6212.8 6036.3 6041.9 6043.5 6045.8 6069.0 5696.1 5969.5 5976.3 5981.3 5982.6 5799.2 5839.3 5872.8 5890.1 5941.4 6000.0 6012.0 6014.4 6022.7 6026.4 5639.8 5690.7 5692.5 5852.2 5866.5 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | [#1] ext.html Cycles:180 Average:61537.96 Median:20762.02 stddev:123229.15 (593.5%) stddev-sans-first:123489.83 10:01:30 INFO - PROCESS | 20965 | Values: 572.2 629.2 638.6 671.1 672.0 34452.8 44378.0 45526.3 45613.8 48571.3 44830.8 45135.0 45241.3 45303.8 45315.3 8209.8 8802.7 8941.0 8944.9 8958.4 8338.3 10524.2 10754.4 10772.1 11072.6 10554.4 10600.7 10610.3 10612.6 10617.3 10585.0 10633.7 10648.9 10652.5 10656.1 10563.8 10622.8 10635.6 10648.4 10653.8 42156.6 42360.2 42557.0 42576.8 42610.6 3415.3 3603.2 3629.6 3746.6 4332.8 32030.7 32114.5 32306.5 32322.0 32445.7 4279.4 4486.2 4526.8 4527.7 4590.6 349926.0 353346.0 354994.0 355733.0 356852.2 40483.4 61647.7 62064.0 62146.0 62222.0 41175.6 41318.8 41495.8 41513.8 41540.6 16368.8 16492.8 16508.2 16512.2 16515.2 11696.6 11927.6 13362.1 13746.5 13898.4 9262.9 9475.7 9478.9 9551.7 9565.0 3584.9 3600.7 3604.7 3621.2 3693.8 1028.5 1086.6 1140.0 1146.7 1149.6 32136.8 32450.5 32519.7 32833.5 33611.0 1112.2 1167.5 1186.2 1187.3 1240.0 17432.3 17483.3 17583.3 17597.6 17605.5 537318.0 541708.0 541807.0 542880.0 543119.0 60717.4 61630.4 61779.4 61945.0 62174.0 1300.3 1337.2 1340.2 1407.8 1429.3 27138.3 33716.8 34496.3 36973.0 37053.6 58088.7 58257.7 58504.4 58680.0 58893.0 475520.0 476221.0 476879.0 478398.0 480138.0 27035.2 27072.7 27705.0 30791.7 31398.2 42973.8 47884.7 48991.3 49072.5 49647.8 40279.8 41151.3 41853.2 41981.6 43518.8 41370.4 41747.0 41754.2 41885.4 43604.8 42450.4 42703.8 42735.8 42798.8 43470.0 35234.5 37254.0 37777.4 37992.4 38019.4 28924.6 28994.6 29077.0 29179.0 29242.4 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | [#2] jquery.html Cycles:180 Average:28685.33 Median:22483.16 stddev:73365.04 (326.3%) stddev-sans-first:73540.13 10:01:30 INFO - PROCESS | 20965 | Values: 409.4 413.1 418.7 421.7 421.9 19092.1 20164.3 20678.2 20867.4 21050.3 19969.8 20264.6 20295.0 20326.6 20473.7 5604.8 5832.7 5890.2 5893.3 5898.4 5604.2 5742.1 5748.8 5781.2 5848.6 5730.3 5735.3 5742.1 5743.7 5749.1 5660.2 5751.5 5779.0 5815.8 5818.9 5259.7 5262.6 5264.9 5265.5 5270.8 23695.2 23707.6 23758.8 24036.0 24125.2 2413.6 2420.7 2562.7 2670.8 3037.0 15106.7 15299.1 15336.8 15361.6 15574.1 1988.2 1995.5 2000.2 2010.6 2102.7 84134.2 85100.6 85400.0 85684.0 87427.6 11108.9 11335.5 11388.3 11608.4 11621.1 16655.0 16685.5 16700.2 16705.7 16714.0 8365.0 8471.4 8504.4 8594.1 8844.0 8248.8 8378.3 8459.3 8666.5 8680.9 6942.1 7160.8 7201.9 7210.3 7236.5 1986.8 1990.3 2000.8 2050.6 2077.6 952.4 1024.5 1052.4 1080.3 1119.1 20516.1 20673.0 21060.8 21096.4 21271.1 1014.0 1061.4 1077.5 1077.8 1096.1 11134.6 11839.5 12022.2 12028.8 12150.3 376051.0 380709.0 382067.0 519117.0 521658.0 73316.6 80188.6 103276.0 110334.0 112672.0 993.3 1063.2 1072.3 1073.4 1094.8 18454.4 18776.2 19163.2 19215.1 19555.0 43090.8 44366.0 44508.3 50040.2 50150.5 64701.4 64755.0 64801.7 65956.7 66057.7 8799.3 8996.6 9215.5 9270.7 9353.8 13882.4 14033.7 14077.4 14186.4 14270.4 12091.7 12313.2 12407.4 12683.1 12742.2 11134.2 11210.4 11737.2 11805.2 12009.3 12172.5 12392.2 12438.4 12458.0 12582.2 8764.2 9136.5 9316.3 9512.2 9580.8 11749.6 12099.6 12121.0 12139.9 12546.9 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | [#3] mootools.html Cycles:180 Average:5747.00 Median:5275.18 stddev:3170.38 (60.1%) stddev-sans-first:3162.83 10:01:30 INFO - PROCESS | 20965 | Values: 1450.2 1474.6 1582.1 1732.9 1766.9 8380.2 8982.4 8983.7 8986.5 8988.3 7802.5 7971.3 8047.7 8252.7 8778.1 2403.2 2439.6 2441.4 2443.5 2449.8 2455.4 2479.1 2501.4 2505.3 2505.9 2428.3 2428.7 2455.5 2465.1 2467.1 2404.3 2408.5 2410.5 2424.1 2452.2 2396.7 2416.3 2420.1 2420.2 2422.2 8680.3 8685.3 8729.6 8749.6 8763.0 5122.9 5195.2 5247.4 5274.2 5276.2 3456.4 3504.9 3574.4 3602.6 3614.8 983.6 1007.5 1213.5 1234.0 2165.4 11861.2 12374.6 12381.6 12400.3 12402.8 4753.4 4763.1 4799.9 4849.8 4855.9 9628.3 9637.8 9757.6 9770.2 9784.7 5524.8 5528.0 5533.1 5534.0 5537.0 4340.4 4877.1 5050.7 5104.3 5149.9 3924.9 4011.0 4074.4 4098.0 4128.4 1233.7 1261.7 1263.4 1283.6 1286.1 923.3 931.3 956.2 963.8 995.0 5774.9 5861.6 5962.6 5984.8 6132.3 930.7 949.7 954.2 961.4 970.9 3885.3 4006.8 4009.9 4010.6 4069.2 10581.3 10914.5 10942.7 10953.7 10956.6 10301.9 10791.4 10910.0 10926.9 10927.8 7748.8 8304.9 8316.0 8406.2 8435.0 5670.7 5678.2 5770.7 5788.3 5789.2 9634.7 9667.8 9743.7 9773.1 9774.9 9730.7 9748.0 9818.0 9826.5 9842.4 7145.5 7322.9 7335.1 7486.6 7586.8 7849.1 7948.5 8127.0 8266.8 8383.8 7528.8 7532.8 7562.0 7590.5 7795.6 7435.7 7442.4 7442.8 7529.9 7569.4 6559.5 6672.7 6684.3 6695.8 6696.0 5173.2 5209.2 5217.3 5226.0 5377.3 5162.5 5173.6 5182.7 5200.2 5367.3 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | [#4] prototype.html Cycles:180 Average:4768.23 Median:5441.66 stddev:1379.21 (25.3%) stddev-sans-first:1342.74 10:01:30 INFO - PROCESS | 20965 | Values: 356.9 359.1 366.4 368.3 372.9 5383.8 5448.4 5468.2 5475.3 5491.3 5168.6 5205.4 5228.6 5285.4 5402.9 4283.0 4298.6 4300.7 4300.8 4303.0 4314.7 4340.5 4351.0 4351.7 4359.6 4174.5 4241.0 4260.5 4277.7 4315.8 4260.8 4264.8 4267.1 4270.5 4271.8 3770.1 3776.7 3776.9 3781.2 3810.8 5166.7 5229.2 5248.2 5293.8 5311.8 4837.5 4846.0 4851.8 4852.9 4856.8 5580.4 5582.8 5613.8 5615.6 5627.4 3919.3 4096.0 4125.0 4127.3 4141.6 5883.9 5920.6 5925.6 5926.3 5936.8 4196.2 4203.3 4207.2 4257.2 4269.2 4193.5 4284.7 4318.8 4319.4 4320.6 4860.8 4861.5 4874.8 4884.4 4898.9 5710.0 5710.4 5713.2 5718.3 5725.5 1349.9 1386.7 1431.3 1440.4 1451.4 942.1 949.1 956.7 992.0 1008.6 5351.9 5369.8 5385.6 5404.9 5408.9 5552.3 5589.8 5598.0 5620.6 5625.0 5243.2 5584.4 5593.5 5616.6 5618.7 2965.5 2982.7 2985.6 2994.5 3022.0 5708.3 5858.4 5870.0 5904.7 5910.9 5665.8 5690.3 5704.9 5742.1 5751.5 5830.4 5867.4 5889.2 5891.8 5905.9 5374.4 5595.3 5606.6 5612.8 5620.0 5534.7 5544.2 5564.7 5611.3 5622.7 5711.2 5767.0 5830.7 5866.8 6117.5 4252.0 4276.3 4278.6 4294.3 4295.8 5892.2 5897.6 5909.4 5916.6 5954.2 5625.1 5700.8 5720.3 5751.8 5758.6 5674.9 5675.3 5680.5 5705.4 5705.8 5427.7 5497.4 5596.5 5692.3 5697.3 5730.7 5739.1 5744.4 5755.8 5757.8 5434.9 5601.9 5623.0 5629.7 5642.7 10:01:30 INFO - PROCESS | 20965 | 10:01:30 INFO - PROCESS | 20965 | [#5] yui.html Cycles:180 Average:18776.13 Median:50203.00 stddev:25924.50 (51.6%) stddev-sans-first:25961.58 10:01:30 INFO - PROCESS | 20965 | Values: 673.3 747.9 766.3 792.3 810.0 14504.6 15515.8 15534.2 15547.7 15561.1 14215.8 14958.9 15389.8 15457.1 16131.6 728.0 744.5 831.9 833.1 854.7 821.4 837.9 838.2 838.7 838.8 877.8 879.8 880.2 880.8 881.5 756.4 770.3 847.7 877.4 879.2 629.1 645.0 645.6 645.9 646.1 15503.9 15820.0 15906.0 15918.5 15948.4 14018.2 14388.7 14512.1 14558.3 14650.4 13428.8 13499.8 13503.5 13616.9 13781.7 4505.3 4553.1 4588.5 4604.6 4616.4 69830.0 70432.0 70567.3 71257.3 72866.0 11064.6 11264.9 11349.5 11437.3 11461.8 20191.5 20210.9 20218.2 20230.6 20744.6 8010.8 8244.3 8262.0 8288.4 8541.0 4698.7 4726.8 4769.7 4847.7 4942.5 3290.0 3379.9 3387.0 3416.3 3432.5 596.4 596.6 612.8 617.0 621.9 458.3 544.0 558.1 558.1 571.8 7947.0 8071.5 8162.7 8478.0 8503.1 542.9 594.9 631.8 634.0 634.5 4086.4 4144.5 4198.2 4201.7 4323.6 92573.0 93525.5 93672.5 97458.5 97614.0 81356.0 84899.8 85215.6 85968.6 87313.0 72534.6 73645.6 74369.0 75700.2 76042.2 7618.0 7836.3 7934.4 8089.1 8097.6 50131.5 50274.5 50845.0 50922.0 51620.2 61880.7 67141.0 67659.0 68311.0 71055.0 10264.5 10343.4 10871.6 10877.1 10915.7 11946.4 11952.2 12122.2 12377.1 12397.9 11622.5 11628.6 11707.3 11867.0 11917.3 11648.7 11950.2 12116.7 12211.4 12305.4 11475.9 11545.7 11829.8 12000.9 12178.1 10044.3 10299.9 10393.0 10485.3 10490.7 9448.2 10049.6 10071.4 10164.9 10185.5 10:01:30 INFO - PROCESS | 20965 | -------- Summary: end -------- 10:01:30 INFO - PROCESS | 20965 | 10:01:31 INFO - TEST-INFO | 20965: exit 0 10:01:31 INFO - TEST-OK | dromaeo_css | took 1115568ms 10:01:31 INFO - TEST-START | kraken 10:01:31 INFO - operating with platform_type : linux_ 10:01:31 INFO - Initialising browser for kraken test... 10:01:31 INFO - TEST-INFO | started process 21283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVX_NYG/profile http://localhost:36079/getInfo.html) 10:01:34 ERROR - PROCESS | 21283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 10:01:34 INFO - PROCESS | 21283 | __metrics Screen width/height:1600/1200 10:01:34 INFO - PROCESS | 21283 | colorDepth:24 10:01:34 INFO - PROCESS | 21283 | Browser inner width/height: 1024/697 10:01:34 INFO - PROCESS | 21283 | __metrics 10:01:35 INFO - PROCESS | 21283 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:01:35 INFO - PROCESS | 21283 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:36 INFO - PROCESS | 21283 | console.error: PushService: 10:01:36 INFO - PROCESS | 21283 | stateChangeProcessEnqueue: Error transitioning state 10:01:36 INFO - PROCESS | 21283 | UnknownError 10:01:36 INFO - TEST-INFO | 21283: exit 0 10:01:36 INFO - Browser initialized. 10:01:36 INFO - Running cycle 1/1 for kraken test... 10:01:36 INFO - TEST-INFO | started process 21380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVX_NYG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:48 INFO - PROCESS | 21380 | RSS: Main: 144982016 10:01:48 INFO - PROCESS | 21380 | 10:01:50 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36079/tests/kraken/driver.html?testName=audio-beat-detection) 10:01:51 INFO - PROCESS | 21380 | RSS: Main: 186191872 10:01:51 INFO - PROCESS | 21380 | 10:01:54 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36079/tests/kraken/driver.html?testName=audio-dft) 10:01:54 INFO - PROCESS | 21380 | RSS: Main: 176070656 10:01:54 INFO - PROCESS | 21380 | 10:01:57 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36079/tests/kraken/driver.html?testName=audio-fft) 10:01:58 INFO - PROCESS | 21380 | RSS: Main: 267112448 10:01:58 INFO - PROCESS | 21380 | 10:02:00 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36079/tests/kraken/driver.html?testName=audio-oscillator) 10:02:00 INFO - PROCESS | 21380 | RSS: Main: 173244416 10:02:00 INFO - PROCESS | 21380 | 10:02:03 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:03 INFO - PROCESS | 21380 | RSS: Main: 175419392 10:02:03 INFO - PROCESS | 21380 | 10:02:06 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36079/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:07 INFO - PROCESS | 21380 | RSS: Main: 214306816 10:02:07 INFO - PROCESS | 21380 | 10:02:10 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36079/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:11 INFO - PROCESS | 21380 | RSS: Main: 213188608 10:02:11 INFO - PROCESS | 21380 | 10:02:13 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36079/tests/kraken/driver.html?testName=json-parse-financial) 10:02:14 INFO - PROCESS | 21380 | RSS: Main: 212307968 10:02:14 INFO - PROCESS | 21380 | 10:02:15 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:16 INFO - PROCESS | 21380 | RSS: Main: 174305280 10:02:16 INFO - PROCESS | 21380 | 10:02:18 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:18 INFO - PROCESS | 21380 | RSS: Main: 181604352 10:02:18 INFO - PROCESS | 21380 | 10:02:20 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:21 INFO - PROCESS | 21380 | RSS: Main: 190550016 10:02:21 INFO - PROCESS | 21380 | 10:02:23 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:24 INFO - PROCESS | 21380 | RSS: Main: 198905856 10:02:24 INFO - PROCESS | 21380 | 10:02:27 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:27 INFO - PROCESS | 21380 | RSS: Main: 195108864 10:02:27 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | Cycle 1(1): loaded http://localhost:36079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36079/tests/kraken/driver.html?testName=ai-astar) 10:02:29 INFO - PROCESS | 21380 | RSS: Main: 246763520 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | __start_tp_report 10:02:29 INFO - PROCESS | 21380 | _x_x_mozilla_page_load 10:02:29 INFO - PROCESS | 21380 | _x_x_mozilla_page_load_details 10:02:29 INFO - PROCESS | 21380 | |i|pagename|runs| 10:02:29 INFO - PROCESS | 21380 | |0;ai-astar;103;113;110;110;110;111;110;110;111;110 10:02:29 INFO - PROCESS | 21380 | |1;audio-beat-detection;156;125;121;156;125;125;123;121;149;126 10:02:29 INFO - PROCESS | 21380 | |2;audio-dft;162;160;162;161;161;161;160;160;160;161 10:02:29 INFO - PROCESS | 21380 | |3;audio-fft;77;75;76;113;75;75;75;75;97;75 10:02:29 INFO - PROCESS | 21380 | |4;audio-oscillator;81;82;107;81;81;82;104;82;82;107 10:02:29 INFO - PROCESS | 21380 | |5;imaging-gaussian-blur;117;117;118;117;116;117;117;117;117;117 10:02:29 INFO - PROCESS | 21380 | |6;imaging-darkroom;146;147;146;146;146;146;146;147;147;147 10:02:29 INFO - PROCESS | 21380 | |7;imaging-desaturate;85;85;84;85;85;85;84;85;84;84 10:02:29 INFO - PROCESS | 21380 | |8;json-parse-financial;50;50;49;51;49;50;52;50;50;51 10:02:29 INFO - PROCESS | 21380 | |9;json-stringify-tinderbox;61;60;60;62;60;60;60;59;61;60 10:02:29 INFO - PROCESS | 21380 | |10;stanford-crypto-aes;76;75;78;76;83;75;75;76;78;75 10:02:29 INFO - PROCESS | 21380 | |11;stanford-crypto-ccm;127;135;127;126;124;132;124;136;162;133 10:02:29 INFO - PROCESS | 21380 | |12;stanford-crypto-pbkdf2;155;158;163;162;157;157;158;156;155;157 10:02:29 INFO - PROCESS | 21380 | |13;stanford-crypto-sha256-iterative;62;65;62;60;61;61;61;63;60;64 10:02:29 INFO - PROCESS | 21380 | __end_tp_report 10:02:29 INFO - PROCESS | 21380 | __start_cc_report 10:02:29 INFO - PROCESS | 21380 | _x_x_mozilla_cycle_collect,1619 10:02:29 INFO - PROCESS | 21380 | __end_cc_report 10:02:29 INFO - PROCESS | 21380 | __startTimestamp1479837749781__endTimestamp 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | ------- Summary: start ------- 10:02:29 INFO - PROCESS | 21380 | Number of tests: 14 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:2.57 (2.3%) stddev-sans-first:1.01 10:02:29 INFO - PROCESS | 21380 | Values: 103.0 113.0 110.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:125.50 stddev:14.69 (11.7%) stddev-sans-first:12.94 10:02:29 INFO - PROCESS | 21380 | Values: 156.0 125.0 121.0 156.0 125.0 125.0 123.0 121.0 149.0 126.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 10:02:29 INFO - PROCESS | 21380 | Values: 162.0 160.0 162.0 161.0 161.0 161.0 160.0 160.0 160.0 161.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:13.06 (17.4%) stddev-sans-first:13.76 10:02:29 INFO - PROCESS | 21380 | Values: 77.0 75.0 76.0 113.0 75.0 75.0 75.0 75.0 97.0 75.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:81.50 stddev:11.84 (14.5%) stddev-sans-first:12.20 10:02:29 INFO - PROCESS | 21380 | Values: 81.0 82.0 107.0 81.0 81.0 82.0 104.0 82.0 82.0 107.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:02:29 INFO - PROCESS | 21380 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:02:29 INFO - PROCESS | 21380 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 10:02:29 INFO - PROCESS | 21380 | Values: 85.0 85.0 84.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:0.92 (1.8%) stddev-sans-first:0.97 10:02:29 INFO - PROCESS | 21380 | Values: 50.0 50.0 49.0 51.0 49.0 50.0 52.0 50.0 50.0 51.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 10:02:29 INFO - PROCESS | 21380 | Values: 61.0 60.0 60.0 62.0 60.0 60.0 60.0 59.0 61.0 60.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.50 (3.3%) stddev-sans-first:2.64 10:02:29 INFO - PROCESS | 21380 | Values: 76.0 75.0 78.0 76.0 83.0 75.0 75.0 76.0 78.0 75.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.50 stddev:11.24 (8.5%) stddev-sans-first:11.73 10:02:29 INFO - PROCESS | 21380 | Values: 127.0 135.0 127.0 126.0 124.0 132.0 124.0 136.0 162.0 133.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:157.50 stddev:2.70 (1.7%) stddev-sans-first:2.67 10:02:29 INFO - PROCESS | 21380 | Values: 155.0 158.0 163.0 162.0 157.0 157.0 158.0 156.0 155.0 157.0 10:02:29 INFO - PROCESS | 21380 | 10:02:29 INFO - PROCESS | 21380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.66 (2.7%) stddev-sans-first:1.76 10:02:29 INFO - PROCESS | 21380 | Values: 62.0 65.0 62.0 60.0 61.0 61.0 61.0 63.0 60.0 64.0 10:02:29 INFO - PROCESS | 21380 | -------- Summary: end -------- 10:02:29 INFO - PROCESS | 21380 | 10:02:30 INFO - TEST-INFO | 21380: exit 0 10:02:30 INFO - TEST-OK | kraken | took 59841ms 10:02:30 INFO - SUITE-END | took 1175s 10:02:31 INFO - Completed test suite (00:19:35) 10:02:31 INFO - javascript benchmark 10:02:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.902472925812, 3294.8187849668275, 3303.2402547414094, 3321.186309354209, 3341.5655964724583, 5647.0, 5739.3399759027725, 5740.253767010293, 5749.453801888824, 5754.223179870716, 5673.290838645169, 5694.715264236792, 5698.0883058710615, 5702.971485142579, 5725.627834190775, 5141.665791723544, 5143.048536020848, 5149.562287205583, 5171.482851714817, 5221.973890130563, 5089.109405853961, 5112.8977420451565, 5237.764300606482, 5238.973805130969, 5270.631055826094, 5105.3873535175835, 5118.0, 5151.896962060775, 5155.664881782691, 5188.584913206953, 5221.71280579568, 5232.686038837663, 5297.0, 5298.894022119574, 5305.628605997582, 4873.780679869415, 4969.130402179604, 5161.096808058574, 5181.989512045153, 5265.842024739226, 5514.751836167382, 5519.282493275889, 5551.9722401388135, 5589.469000444951, 5633.549316054747, 5924.911126333109, 6010.459058684695, 6057.545684073712, 6057.697115144269, 6065.909011364833, 5928.7332070056955, 5987.700614969234, 6047.15339852421, 6056.182415373913, 6076.665783381913, 5710.2862142232225, 5746.741396637161, 5749.252597162342, 5778.393268706767, 5799.565032622486, 6252.124702541648, 6262.405071518289, 6271.247450305992, 6280.120783090371, 6293.559450838489, 5821.0, 5876.970615146897, 6018.819435416857, 6022.066579680157, 6032.366601506778, 6052.364501727343, 6080.14877917092, 6084.5436592255755, 6125.6017461851925, 6132.948755694992, 6105.0, 6115.052166914135, 6118.938810611926, 6131.448169664752, 6131.724072416752, 5870.383609720918, 6015.789447369321, 6083.787067452707, 6094.481969032593, 6098.786542471081, 4308.418363520885, 4320.373545835836, 4339.414179085846, 4358.411614432011, 4373.037931655031, 3985.04358953849, 3998.540167880673, 3998.9400158997637, 4012.598740125964, 4019.457373254632, 5783.59514833966, 5796.5072968797285, 5804.303483581997, 5809.070548712186, 5858.707064646751, 5946.762129514771, 6017.308009578867, 6023.427774361428, 6047.485963693048, 6089.421504957022, 5815.098659707752, 5820.534357251495, 5821.15593238978, 5833.241678581757, 5857.092150716646, 5164.974175129176, 5206.193040078794, 5207.1668533034535, 5209.0, 5217.087009773274, 6125.20492926512, 6176.258848938156, 6209.720562574786, 6290.0, 6345.650989195547, 6028.8794224116145, 6115.4190351916495, 6118.265808103056, 6127.908081378694, 6134.9079763804475, 6271.466925311217, 6335.081413194969, 6338.841528961812, 6340.048992651139, 6346.619202847844, 5883.35283118848, 5888.352281248974, 5983.95280825845, 5988.311344195473, 5992.2809262886985, 6136.723847426787, 6155.446009859134, 6197.0, 6208.627482350893, 6212.782552610637, 6036.3058248302, 6041.909371359346, 6043.456088952015, 6045.758169673164, 6068.969655151696, 5696.1455781633085, 5969.492593129633, 5976.312724036791, 5981.312149102909, 5982.611130276518, 5799.159121927381, 5839.299284085767, 5872.823815285548, 5890.145928840208, 5941.405859414024, 5999.970000149971, 6012.0, 6014.428629280212, 6022.66875321844, 6026.397360263939, 5639.802606908903, 5690.743916523684, 5692.459216374438, 5852.18069470266, 5866.530677545701], "value": 5589.672564384916, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.2074926227174, 629.1852051593188, 638.6423602782443, 671.120831710459, 671.9697613607387, 34452.82773586132, 44378.0, 45526.31710524345, 45613.77193114038, 48571.27143092848, 44830.77584612081, 45135.0, 45241.321380179244, 45303.77348113263, 45315.320270195974, 8209.835803283931, 8802.735917922457, 8941.0, 8944.910550894505, 8958.417702849294, 8338.332933365316, 10524.210684198677, 10754.408507532082, 10772.138228941665, 11072.557097716082, 10554.366737995706, 10600.681979540588, 10610.257281990263, 10612.575496980111, 10617.256792024522, 10585.047345738882, 10633.680989570325, 10648.946755266214, 10652.520636571373, 10656.147508199325, 10563.788724225473, 10622.787544249071, 10635.57457701691, 10648.414337211529, 10653.84019239712, 42156.578434215575, 42360.15279694389, 42557.0, 42576.78711606453, 42610.57389426097, 3415.299863527971, 3603.2433189030335, 3629.6370362963494, 3746.606606306326, 4332.761698106603, 32030.679693203, 32114.518282225785, 32306.515402268986, 32322.0, 32445.67554324474, 4279.358096285551, 4486.192485352635, 4526.818927242906, 4527.660425468103, 4590.586847183769, 349926.0, 353346.0, 354994.0, 355733.0, 356852.21573892224, 40483.39274910879, 61647.691761540904, 62064.0, 62146.0, 62222.0, 41175.588244117775, 41318.793406032775, 41495.75512734563, 41513.792431037655, 41540.58459415428, 16368.83631163673, 16492.752608710878, 16508.17459127039, 16512.174391280387, 16515.17424128789, 11696.590619328283, 11927.642170734893, 13362.131461454974, 13746.450141994408, 13898.444062237397, 9262.90737092634, 9475.668351607661, 9478.857817132748, 9551.665691700757, 9564.95217523922, 3584.928301434009, 3600.6759391654355, 3604.6575575320303, 3621.239539696693, 3693.796841173761, 1028.4908970059869, 1086.6088208245026, 1139.9829002564802, 1146.7305183281921, 1149.6321177223208, 32136.83931580374, 32450.513242301386, 32519.674803251666, 32833.50749738756, 33611.0, 1112.2158877990996, 1167.4921409187032, 1186.2170967161805, 1187.3232257613079, 1239.9956035611183, 17432.302707891795, 17483.300667973137, 17583.29666813313, 17597.560060998578, 17605.486179738124, 537318.0, 541708.0, 541807.0, 542880.0, 543119.0, 60717.39282607118, 61630.383696163364, 61779.38220617826, 61945.0, 62174.0, 1300.258852454111, 1337.164272329794, 1340.1891855427325, 1407.7677183264648, 1429.27821450167, 27138.32154196161, 33716.83141584276, 34496.310073798886, 36973.0, 37053.629463705016, 58088.70955645195, 58257.70871145617, 58504.4149558516, 58680.0, 58893.0, 475520.0, 476221.0, 476879.0, 478398.0, 480138.0, 27035.1889443317, 27072.72927270781, 27705.0, 30791.69208307978, 31398.215044624067, 42973.785131074146, 47884.74184484769, 48991.26513102378, 49072.50927490679, 49647.751761240965, 40279.798601006805, 41151.325163864254, 41853.162936741704, 41981.580184197766, 43518.78240608777, 41370.37944430776, 41747.0, 41754.16491670089, 41885.37171942362, 43604.78197609119, 42450.363244551976, 42703.78648106739, 42735.7863210682, 42798.78600606977, 43470.0, 35234.47148292726, 37254.0, 37777.433338499395, 37992.430113547765, 38019.42970855495, 28924.566131507625, 28994.565081524215, 29077.0, 29179.0, 29242.41515169727], "value": 20011.4686163469, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.4288467587715, 413.10562631901934, 418.7320115126318, 421.73852211628775, 421.85446021122704, 19092.140853661585, 20164.294249701245, 20678.172873085077, 20867.373978780663, 21050.26324078654, 19969.800301996976, 20264.59470810583, 20295.0, 20326.593468130664, 20473.692894606593, 5604.8318550443555, 5832.650040997532, 5890.204822348992, 5893.263342082239, 5898.380670029649, 5604.187392828037, 5742.138679198133, 5748.770049198048, 5781.219535362714, 5848.561357898154, 5730.283714535683, 5735.283089613798, 5742.138679198112, 5743.712814359286, 5749.080147176453, 5660.2075709400715, 5751.453611906883, 5778.971105144489, 5815.767369305223, 5818.912716309259, 5259.710715910624, 5262.578993680497, 5264.8683782905355, 5265.499777521168, 5270.7628156733035, 23695.170669026502, 23707.644385334235, 23758.76241237583, 24036.0, 24125.155619553232, 2413.625887987347, 2420.697412823397, 2562.6540417043648, 2670.8130430869846, 3036.952251473238, 15106.697866042727, 15299.082055076731, 15336.846631533654, 15361.615959600987, 15574.14342211178, 1988.2146552111979, 1995.4811748945378, 2000.2399088346335, 2010.577778666467, 2102.6845973104005, 84134.15865841325, 85100.57449712773, 85400.0, 85684.0, 87427.56286218528, 11108.888911110947, 11335.546578136948, 11388.259763115371, 11608.361540115206, 11621.128415368881, 16655.0, 16685.49943501697, 16700.248488818033, 16705.749413758804, 16714.0, 8365.03421695901, 8471.407001509959, 8504.44721093127, 8594.14058594148, 8844.0, 8248.8350232995, 8378.329733621418, 8459.280961118375, 8666.480011199223, 8680.913190868137, 6942.056224257216, 7160.82097947545, 7201.855962880713, 7210.315020073084, 7236.457265705093, 1986.7913869043832, 1990.2735501541833, 2000.7699114602008, 2050.5693804300968, 2077.5637116205767, 952.3952290295712, 1024.5235965276183, 1052.3843551522293, 1080.287010573018, 1119.1270808769173, 20516.07677654509, 20673.0, 21060.789392106188, 21096.367108986757, 21271.149154033974, 1013.99493002536, 1061.3631820907394, 1077.4612693653173, 1077.7844431113808, 1096.1395304685784, 11134.610288639858, 11839.467223974942, 12022.158448908493, 12028.766387490841, 12150.33173175466, 376051.0, 380709.0, 382067.0, 519117.0, 521658.0, 73316.63341683257, 80188.59905700434, 103276.0, 110334.0, 112672.0, 993.3146129170993, 1063.2344711807486, 1072.265498133781, 1073.3881687438086, 1094.8357746338113, 18454.446366609023, 18776.24895004239, 19163.233470661016, 19215.135318910405, 19555.0, 43090.78454607707, 44366.0, 44508.332375015045, 50040.24939625982, 50150.49849501458, 64701.35298646953, 64755.0, 64801.67599161974, 65956.6702166486, 66057.66971165114, 8799.296056315607, 8996.55017249122, 9215.539223038955, 9270.72187834366, 9353.766155845886, 13882.375293111632, 14033.719325613227, 14077.366518506487, 14186.3616137272, 14270.357833897708, 12091.69770755703, 12313.199642023239, 12407.441665125272, 12683.11218214716, 12742.171758835646, 11134.220604557604, 11210.43947802623, 11737.237079589799, 11805.23265987708, 12009.339486328336, 12172.452239649414, 12392.194507356993, 12438.440270188044, 12458.003359731381, 12582.24506529611, 8764.1674040966, 9136.49749263797, 9316.255844973684, 9512.191463725385, 9580.760480987752, 11749.588764393548, 12099.637010889688, 12121.0, 12139.939300303442, 12546.874531254936], "value": 9863.14866460645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.1951416963589, 1474.6313421644588, 1582.1377349344607, 1732.896026238425, 1766.8851524650897, 8380.161983801625, 8982.371234013606, 8983.685571005017, 8986.460812351255, 8988.325875559327, 7802.453828232026, 7971.322437592797, 8047.718329858456, 8252.711155109557, 8778.122187781235, 2403.158894386959, 2439.6462512935614, 2441.438469152096, 2443.462438263588, 2449.8040156787415, 2455.4229756007326, 2479.1075212923333, 2501.374656335916, 2505.3110394641526, 2505.8621775802326, 2428.259380888828, 2428.7449817769143, 2455.533448644761, 2465.050955382173, 2467.062516243825, 2404.326788499223, 2408.4942162145794, 2410.4576470294132, 2424.139430502164, 2452.16626347042, 2396.7363590005084, 2416.347586151747, 2420.140849998243, 2420.189236605739, 2422.2491027781443, 8680.262177714902, 8685.348598855111, 8729.60716767747, 8749.606267717969, 8763.0, 5122.897542049175, 5195.19474481456, 5247.449017853147, 5274.208868669692, 5276.15581506957, 3456.3778519866414, 3504.8598056077726, 3574.392353299945, 3602.6397360264027, 3614.765040272374, 983.5623147699276, 1007.5214273220236, 1213.5145941623332, 1233.9814902776466, 2165.404513758713, 11861.169718119734, 12374.62876113718, 12381.62855114357, 12400.255984640951, 12402.75194496114, 4753.429588449409, 4763.118823017753, 4799.928001079987, 4849.806007759721, 4855.902881942341, 9628.277879159092, 9637.807243855224, 9757.560909759079, 9770.218382529381, 9784.706458806248, 5524.806631767869, 5527.977324195037, 5533.08704063833, 5534.0, 5536.972315138399, 4340.370646256275, 4877.146499362598, 5050.747462626854, 5104.285400043997, 5149.871253218699, 3924.9215015699524, 4010.979945100256, 4074.409210664437, 4097.955021469506, 4128.401381799622, 1233.7285797124619, 1261.7224210673637, 1263.3746295583562, 1283.5507572349602, 1286.0676009892752, 923.3075193604797, 931.3108299858056, 956.1585804492141, 963.7638778499313, 995.0149352141473, 5774.913376299359, 5861.589688721834, 5962.612430192024, 5984.760609575568, 6132.325444201134, 930.7440453875239, 949.6866034208695, 954.1984732824461, 961.4183419031385, 970.9271804614682, 3885.339492286318, 4006.819693113817, 4009.859654912064, 4010.6189911958318, 4069.2471892699355, 10581.31221470602, 10914.454277286104, 10942.726431839268, 10953.671389858317, 10956.616518421817, 10301.9484902575, 10791.40647264408, 10910.0, 10926.890731092588, 10927.836082458769, 7748.806279842936, 8304.875426868603, 8315.95842020798, 8406.159384061668, 8434.957825210957, 5670.744816483186, 5678.176664383559, 5770.653760774367, 5788.305403351625, 5789.218455508452, 9634.662786802428, 9667.806643867223, 9743.658971936231, 9773.07155820196, 9774.924758276726, 9730.659426920023, 9748.0, 9818.0, 9826.5086745661, 9842.409455432697, 7145.4998150128995, 7322.853542929005, 7335.083114610674, 7486.588237646982, 7586.810329741801, 7849.097353804385, 7948.523088614702, 8127.0, 8266.751997439846, 8383.790405239917, 7528.811779705551, 7532.7740167795055, 7561.962190189014, 7590.468667193243, 7795.649195786316, 7435.7025718970635, 7442.367398771165, 7442.813929651802, 7529.924700753141, 7569.432292577969, 6559.540832141895, 6672.733090676318, 6684.331566843277, 6695.799126026227, 6695.966520167368, 5173.198154286091, 5209.218617207449, 5217.295665085165, 5226.0, 5377.27406800077, 5162.5095615916425, 5173.560247379015, 5182.689038657692, 5200.193969934666, 5367.302250707383], "value": 4666.56809462139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.91077230692326, 359.10403543159816, 366.4027634955023, 368.30758174631694, 372.92541491701667, 5383.815560576677, 5448.37343705474, 5468.179773034042, 5475.260839786628, 5491.313585801775, 5168.61235407345, 5205.401378841434, 5228.581713462923, 5285.4450282720245, 5402.9464254470395, 4283.0363168287195, 4298.570142985708, 4300.741955482681, 4300.806463709125, 4303.031817840992, 4314.676399270052, 4340.500842403117, 4351.021020270446, 4351.717138385995, 4359.629431498326, 4174.478190226222, 4240.957590424087, 4260.531341552442, 4277.673921084458, 4315.784210789448, 4260.829566817323, 4264.808083636244, 4267.14657068586, 4270.530241673413, 4271.842719426685, 3770.0763312988493, 3776.7356285060055, 3776.9055773605605, 3781.2248489059675, 3810.7523011004196, 5166.689998600058, 5229.189475631283, 5248.241838983945, 5293.75596734767, 5311.760970756325, 4837.467878533358, 4845.9757701211265, 4851.781669824866, 4852.8544143675745, 4856.781444834991, 5580.386157522669, 5582.804601838916, 5613.775448982035, 5615.634983726086, 5627.43725627434, 3919.2749341371937, 4095.9590404096175, 4125.009997600554, 4127.33962565988, 4141.585841415865, 5883.911476376884, 5920.5559583031445, 5925.555583331225, 5926.318473375531, 5936.753281810825, 4196.202721482909, 4203.32746760523, 4207.179599978036, 4257.212415703105, 4269.249607660906, 4193.496780386373, 4284.693168583612, 4318.805653745589, 4319.352097185448, 4320.589543993316, 4860.756962151878, 4861.4895435978715, 4874.832018624096, 4884.3650325457465, 4898.926516102261, 5710.0, 5710.400407957188, 5713.200151978726, 5718.342390625048, 5725.5133313667975, 1349.9325033748273, 1386.729587730383, 1431.2843578210895, 1440.3950340856866, 1451.4121780678843, 942.1191186240886, 949.0983565612696, 956.7225504603726, 992.0, 1008.6167256442504, 5351.9464805351445, 5369.7583608737705, 5385.553245922612, 5404.91892621611, 5408.945910540923, 5552.333719953632, 5589.804356847572, 5598.0, 5620.5503559715125, 5624.971875140598, 5243.239730239094, 5584.4136365681015, 5593.524550413179, 5616.5787565932715, 5618.719064046863, 2965.54034124711, 2982.7166419190144, 2985.5820185174093, 2994.520876659724, 3021.9546706799415, 5708.31500219968, 5858.443447872445, 5870.0, 5904.704764761831, 5910.8817823643285, 5665.773369065274, 5690.317161940511, 5704.942950570524, 5742.076404404488, 5751.5398768099285, 5830.3586605473365, 5867.442592953833, 5889.234399528034, 5891.823245302733, 5905.899402813471, 5374.435684253097, 5595.328560572757, 5606.570324567209, 5612.831615051555, 5620.0, 5534.723263836711, 5544.223808666709, 5564.657928388792, 5611.298587676541, 5622.718864056699, 5711.228984087261, 5766.971165144148, 5830.708464576669, 5866.823995280149, 6117.541184411098, 4251.978740106403, 4276.251655960256, 4278.550752170977, 4294.269974104473, 4295.799629276209, 5892.234009578728, 5897.5576831736935, 5909.438603332676, 5916.556258280732, 5954.21907088993, 5625.128105143709, 5700.771969121189, 5720.2849643794525, 5751.798687045934, 5758.568107392046, 5674.943250567607, 5675.2543321407675, 5680.488756011813, 5705.4009329019855, 5705.800296989585, 5427.674339539641, 5497.4162143792355, 5596.496315331477, 5692.288463942007, 5697.3448053474385, 5730.656160630376, 5739.110437882135, 5744.42555744439, 5755.798547051, 5757.798477053283, 5434.945650543444, 5601.935632229864, 5623.0, 5629.690367029689, 5642.689652069175], "value": 4332.846953617285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.3300366135695, 747.9401647868171, 766.2720415605173, 792.3423558446489, 809.9878501822474, 14504.564863054098, 15515.844841551581, 15534.223288835541, 15547.689046219082, 15561.066336019832, 14215.786763198534, 14958.850411495881, 15389.76915346268, 15457.072575645469, 16131.596710082255, 728.0, 744.4639859301294, 831.9084900660922, 833.0877688930626, 854.6880388658158, 821.4126899267023, 837.8910741603582, 838.1911455445494, 838.6980686952692, 838.7609531283586, 877.7761670773975, 879.7536689726886, 880.1902249930048, 880.8238352329528, 881.5195718333524, 756.4213376766751, 770.3375097416217, 847.7117779954783, 877.3814460805118, 879.1735768377737, 629.109809619388, 644.9871002579922, 645.6416688737748, 645.9031145328238, 646.1148226929137, 15503.922480387526, 15820.0, 15906.0, 15918.522444326689, 15948.441804536786, 14018.158910465405, 14388.712225755531, 14512.056716313406, 14558.272086395744, 14650.413983440649, 13428.778363147456, 13499.797503037462, 13503.527376541871, 13616.93191534036, 13781.655458613615, 4505.2791553351635, 4553.112143132091, 4588.518205588399, 4604.585587297126, 4616.422947131608, 69830.0, 70432.0, 70567.2943270571, 71257.28742712506, 72866.0, 11064.612738554273, 11264.887351126385, 11349.489272982735, 11437.256578322382, 11461.828072578917, 20191.49521261951, 20210.898945505473, 20218.19127234894, 20230.595388092155, 20744.58510829775, 8010.759677209693, 8244.258016778518, 8261.958690206631, 8288.378371622153, 8540.957295213608, 4698.7415692137265, 4726.7636618169645, 4769.713817170981, 4847.660663753503, 4942.5057494251005, 3289.9835500822824, 3379.9155021124175, 3387.0346951118813, 3416.3167366526295, 3432.485127230935, 596.3946594206883, 596.6360520082746, 612.773273888664, 616.981490555284, 621.9036049412258, 458.28049961560697, 543.9728013599304, 558.109814845321, 558.109814845321, 571.828451464559, 7946.9602651987525, 8071.4753541019645, 8162.7143049992965, 8478.0, 8503.14968503157, 542.9321334833146, 594.8810237952426, 631.8136149835809, 634.0, 634.514596333805, 4086.427900093989, 4144.461220041436, 4198.223328684203, 4201.663866890642, 4323.567643235651, 92573.0, 93525.53237233906, 93672.53163734138, 97458.512707436, 97614.0, 81356.0, 84899.81141557771, 85215.57392212999, 85968.57015715007, 87313.0, 72534.63732681303, 73645.6317718408, 74369.0, 75700.24299757152, 76042.23957760351, 7618.0, 7836.255555722198, 7934.365250780039, 8089.110197878111, 8097.554634494923, 50131.49868501268, 50274.49725502698, 50845.0, 50922.0, 51620.22569661383, 61880.69059654673, 67141.0, 67659.0, 68311.0, 71055.0, 10264.486775661038, 10343.431111288952, 10871.619493317696, 10877.12982961377, 10915.727106822076, 11946.402679866145, 11952.163348565517, 12122.212056216318, 12377.133600647869, 12397.93801030989, 11622.476988535705, 11628.592999245324, 11707.2975621463, 11867.0, 11917.34454605005, 11648.650540483799, 11950.223235489666, 12116.697082573006, 12211.389430528261, 12305.446254918372, 11475.885241147816, 11545.653630391102, 11829.76340473203, 12000.879991199976, 12178.147529672839, 10044.347117437343, 10299.948500257451, 10393.0, 10485.318454300446, 10490.737731556772, 9448.196903263299, 10049.648262311077, 10071.395716257048, 10164.949175254076, 10185.541650625592], "value": 7094.5456913426215, "unit": "score"}], "name": "dromaeo_css", "value": 7354.785572190547, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 121.0, 156.0, 125.0, 125.0, 123.0, 121.0, 149.0, 126.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 113.0, 75.0, 75.0, 75.0, 75.0, 97.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 107.0, 81.0, 81.0, 82.0, 104.0, 82.0, 82.0, 107.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 49.0, 51.0, 49.0, 50.0, 52.0, 50.0, 50.0, 51.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 62.0, 60.0, 60.0, 60.0, 59.0, 61.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 76.0, 83.0, 75.0, 75.0, 76.0, 78.0, 75.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 135.0, 127.0, 126.0, 124.0, 132.0, 124.0, 136.0, 162.0, 133.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 163.0, 162.0, 157.0, 157.0, 158.0, 156.0, 155.0, 157.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 60.0, 61.0, 61.0, 61.0, 63.0, 60.0, 64.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1461.0, "alertThreshold": 2.0}]} 10:02:31 INFO - Return code: 0 10:02:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:02:31 ERROR - # TBPL SUCCESS # 10:02:31 INFO - Running post-action listener: _resource_record_post_action 10:02:31 INFO - [mozharness: 2016-11-22 18:02:31.570587Z] Finished run-tests step (success) 10:02:31 INFO - Running post-run listener: _resource_record_post_run 10:02:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360943616; Read time: 16; Write time: 213012 10:02:31 INFO - TinderboxPrint: CPU usage
13.0% 10:02:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:02:31 INFO - TinderboxPrint: I/O write bytes / time
360,943,616 / 213,012 10:02:31 INFO - TinderboxPrint: CPU idle
8,279.5 (87.0%) 10:02:31 INFO - TinderboxPrint: CPU user
1,190.1 (12.5%) 10:02:31 INFO - TinderboxPrint: Swap in / out
0 / 0 10:02:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111505408; Read time: 0; Write time: 86856 10:02:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 248954880; Read time: 0; Write time: 126156 10:02:32 INFO - Running post-run listener: _upload_blobber_files 10:02:32 INFO - Blob upload gear active. 10:02:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:02:32 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:33 INFO - (blobuploader) - INFO - Done attempting. 10:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:34 INFO - (blobuploader) - INFO - Done attempting. 10:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:38 INFO - (blobuploader) - INFO - Done attempting. 10:02:38 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:38 INFO - Return code: 0 10:02:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51c1f5f940dc5ed95e98492ceb109782d65010b8e97fa21f96357316dd09fda0e5a521e283b3d0f73841df3126b845f7f10ded6ec99c169be7d2938b12c372ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b909c037bb448dd55d89fa693c52e128793692f32d5ecac893b073f283b355c37979c06312577b85db821d0c29e5ed1d1108c8ce92f3cb0dd2ba5d9149e082b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/addc65ed40653f6dce8ee648517c45e3801bdab311b96ad0ec542d21c89a109f68d13140a205632c595d4b895a9b991e4dcf7f5b3e46834b9c734d30a312f919"} 10:02:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:38 INFO - Contents: 10:02:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51c1f5f940dc5ed95e98492ceb109782d65010b8e97fa21f96357316dd09fda0e5a521e283b3d0f73841df3126b845f7f10ded6ec99c169be7d2938b12c372ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b909c037bb448dd55d89fa693c52e128793692f32d5ecac893b073f283b355c37979c06312577b85db821d0c29e5ed1d1108c8ce92f3cb0dd2ba5d9149e082b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/addc65ed40653f6dce8ee648517c45e3801bdab311b96ad0ec542d21c89a109f68d13140a205632c595d4b895a9b991e4dcf7f5b3e46834b9c734d30a312f919"} 10:02:38 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:38 INFO - Copying logs to upload dir... 10:02:38 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.408102 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-22 10:02:37.278283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 10:02:37.281810) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51c1f5f940dc5ed95e98492ceb109782d65010b8e97fa21f96357316dd09fda0e5a521e283b3d0f73841df3126b845f7f10ded6ec99c169be7d2938b12c372ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b909c037bb448dd55d89fa693c52e128793692f32d5ecac893b073f283b355c37979c06312577b85db821d0c29e5ed1d1108c8ce92f3cb0dd2ba5d9149e082b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/addc65ed40653f6dce8ee648517c45e3801bdab311b96ad0ec542d21c89a109f68d13140a205632c595d4b895a9b991e4dcf7f5b3e46834b9c734d30a312f919"} build_url:https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011713 build_url: 'https://queue.taskcluster.net/v1/task/SFVroAdhTG-innVOGkp-TQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51c1f5f940dc5ed95e98492ceb109782d65010b8e97fa21f96357316dd09fda0e5a521e283b3d0f73841df3126b845f7f10ded6ec99c169be7d2938b12c372ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b909c037bb448dd55d89fa693c52e128793692f32d5ecac893b073f283b355c37979c06312577b85db821d0c29e5ed1d1108c8ce92f3cb0dd2ba5d9149e082b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/addc65ed40653f6dce8ee648517c45e3801bdab311b96ad0ec542d21c89a109f68d13140a205632c595d4b895a9b991e4dcf7f5b3e46834b9c734d30a312f919"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 10:02:37.308004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:02:37.308385) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479836520.218811-448219268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:02:37.484546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 10:02:37.484873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 10:02:37.485243) ========= ========= Total master_lag: 0.26 =========