builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1487702338.01 results: success (0) buildid: 20170221085328 builduid: 271bc994a21945febda676952a620652 revision: 0316bb85a29c03cdc70f74598678bce3a0998c1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.011734) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.012135) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.012422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.029228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.029541) ========= 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=03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-21 10:38:58-- 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% 46.4M=0s 2017-02-21 10:38:58 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087505 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.130146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.130464) ========= 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=03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020407 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.180047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:58.182450) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0316bb85a29c03cdc70f74598678bce3a0998c1f --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-beta --rev 0316bb85a29c03cdc70f74598678bce3a0998c1f --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=03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-21 10:38:58,299 truncating revision to first 12 chars 2017-02-21 10:38:58,299 Setting DEBUG logging. 2017-02-21 10:38:58,300 attempt 1/10 2017-02-21 10:38:58,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0316bb85a29c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-21 10:38:58,940 unpacking tar archive at: mozilla-beta-0316bb85a29c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.967001 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:59.162084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:59.162586) ========= script_repo_revision: 0316bb85a29c03cdc70f74598678bce3a0998c1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:59.162970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:59.163227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 10:38:59.175145) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-21 10:38:59.175531) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:38:59 INFO - MultiFileLogger online at 20170221 10:38:59 in /builds/slave/test 10:38:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:38:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:38:59 INFO - {'append_to_log': False, 10:38:59 INFO - 'base_work_dir': '/builds/slave/test', 10:38:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:38:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:38:59 INFO - 'branch': 'Mozilla-Beta', 10:38:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:38:59 INFO - 'config_files': ('talos/linux_config.py',), 10:38:59 INFO - 'default_actions': ('clobber', 10:38:59 INFO - 'read-buildbot-config', 10:38:59 INFO - 'download-and-extract', 10:38:59 INFO - 'populate-webroot', 10:38:59 INFO - 'create-virtualenv', 10:38:59 INFO - 'install', 10:38:59 INFO - 'run-tests'), 10:38:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:38:59 INFO - 'download_minidump_stackwalk': True, 10:38:59 INFO - 'download_symbols': 'ondemand', 10:38:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:38:59 INFO - 'tooltool.py': '/tools/tooltool.py', 10:38:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:38:59 INFO - '/tools/misc-python/virtualenv.py')}, 10:38:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:38:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:38:59 INFO - 'installer_path': 'installer.exe', 10:38:59 INFO - 'log_level': 'info', 10:38:59 INFO - 'log_name': 'talos', 10:38:59 INFO - 'log_to_console': True, 10:38:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:38:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:38:59 INFO - 'opt_config_files': (), 10:38:59 INFO - 'pip_index': False, 10:38:59 INFO - 'sps_profile': False, 10:38:59 INFO - 'sps_profile_interval': 0, 10:38:59 INFO - 'suite': 'dromaeojs', 10:38:59 INFO - 'system_bits': '32', 10:38:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:38:59 INFO - 'title': 'talos-linux64-ix-047', 10:38:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:38:59 INFO - 'use_talos_json': True, 10:38:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:38:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:38:59 INFO - 'work_dir': 'build'} 10:38:59 INFO - [mozharness: 2017-02-21 18:38:59.387712Z] Running clobber step. 10:38:59 INFO - Running pre-action listener: _resource_record_pre_action 10:38:59 INFO - Running main action method: clobber 10:38:59 INFO - rmtree: /builds/slave/test/build 10:38:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:39:00 INFO - Running post-action listener: _resource_record_post_action 10:39:00 INFO - [mozharness: 2017-02-21 18:39:00.297756Z] Finished clobber step (success) 10:39:00 INFO - [mozharness: 2017-02-21 18:39:00.297855Z] Running read-buildbot-config step. 10:39:00 INFO - Running pre-action listener: _resource_record_pre_action 10:39:00 INFO - Running main action method: read_buildbot_config 10:39:00 INFO - Using buildbot properties: 10:39:00 INFO - { 10:39:00 INFO - "project": "", 10:39:00 INFO - "product": "firefox", 10:39:00 INFO - "script_repo_revision": "production", 10:39:00 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:39:00 INFO - "repository": "", 10:39:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:39:00 INFO - "buildid": "20170221085328", 10:39:00 INFO - "pgo_build": "True", 10:39:00 INFO - "basedir": "/builds/slave/test", 10:39:00 INFO - "buildnumber": 561, 10:39:00 INFO - "slavename": "talos-linux64-ix-047", 10:39:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:39:00 INFO - "platform": "ubuntu64_hw", 10:39:00 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:39:00 INFO - "branch": "mozilla-beta", 10:39:00 INFO - "repo_path": "releases/mozilla-beta", 10:39:00 INFO - "revision": "0316bb85a29c03cdc70f74598678bce3a0998c1f", 10:39:00 INFO - "stage_platform": "linux64-pgo", 10:39:00 INFO - "builduid": "271bc994a21945febda676952a620652", 10:39:00 INFO - "slavebuilddir": "test" 10:39:00 INFO - } 10:39:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 10:39:00 INFO - Running post-action listener: _resource_record_post_action 10:39:00 INFO - [mozharness: 2017-02-21 18:39:00.300279Z] Finished read-buildbot-config step (success) 10:39:00 INFO - [mozharness: 2017-02-21 18:39:00.300367Z] Running download-and-extract step. 10:39:00 INFO - Running pre-action listener: _resource_record_pre_action 10:39:00 INFO - Running main action method: download_and_extract 10:39:00 INFO - mkdir: /builds/slave/test/build/tests 10:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:00 INFO - trying https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 10:39:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 10:39:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:39:00 INFO - Downloaded 1327 bytes. 10:39:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 10:39:00 INFO - Using the following test package requirements: 10:39:00 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 10:39:00 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:39:00 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 10:39:00 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'jsshell-linux-x86_64.zip'], 10:39:00 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:39:00 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 10:39:00 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 10:39:00 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 10:39:00 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:39:00 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 10:39:00 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:39:00 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:39:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 10:39:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:39:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 10:39:01 INFO - Http code: 200 10:39:01 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 10:39:01 INFO - x-amz-cf-id: TChCEMqpIoWiYCc__Lu7HbQDWNC-pyh_78hH9jH5nIeeJPukiM9ldQ== 10:39:01 INFO - x-amz-version-id: 0XkqrpgWxlhKRhA12FTP8pWGzaj04Ytr 10:39:01 INFO - Expected file size: 21963945 10:39:01 INFO - Obtained file size: 21963945 10:39:05 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:39:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 10:39:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:39:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 10:39:06 INFO - Http code: 200 10:39:06 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 10:39:06 INFO - x-amz-cf-id: wdNkC0Le2_caKXdB83FOGk63L7SMOQnP-flMi5BmuXFJSh5Mx18UFA== 10:39:06 INFO - x-amz-version-id: 0XkqrpgWxlhKRhA12FTP8pWGzaj04Ytr 10:39:06 INFO - Expected file size: 21963945 10:39:06 INFO - Obtained file size: 21963945 10:39:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 10:39:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:39:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 10:39:11 INFO - Http code: 200 10:39:11 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 10:39:11 INFO - x-amz-cf-id: cclOIuTXltx6VsFHQVbO22I9EUSbTM4Vq1KapMiNT-XY8OmiHotkSg== 10:39:11 INFO - x-amz-version-id: xa14k2CNdH84eaih.jnkPSjFf1r8XfSK 10:39:11 INFO - Expected file size: 14403005 10:39:11 INFO - Obtained file size: 14403005 10:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:12 INFO - trying https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:39:13 INFO - Downloaded 57772329 bytes. 10:39:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:39:13 INFO - mkdir: /builds/slave/test/properties 10:39:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:39:13 INFO - Writing to file /builds/slave/test/properties/build_url 10:39:13 INFO - Contents: 10:39:13 INFO - build_url:https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:39:14 INFO - Running post-action listener: _resource_record_post_action 10:39:14 INFO - Running post-action listener: set_extra_try_arguments 10:39:14 INFO - [mozharness: 2017-02-21 18:39:14.059458Z] Finished download-and-extract step (success) 10:39:14 INFO - [mozharness: 2017-02-21 18:39:14.059684Z] Running populate-webroot step. 10:39:14 INFO - Running pre-action listener: _resource_record_pre_action 10:39:14 INFO - Running main action method: populate_webroot 10:39:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:39:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:39:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:39:14 INFO - '--tppagecycles', 10:39:14 INFO - '7'], 10:39:14 INFO - 'tests': ['tsvgm']}}, 10:39:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:39:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:39:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:39:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:39:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['damp', 'tps']}, 10:39:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'tests': ['damp', 'tps']}, 10:39:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['dromaeo_dom']}, 10:39:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:39:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['basic_compositor_video']}, 10:39:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:39:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['a11yr', 10:39:14 INFO - 'ts_paint', 10:39:14 INFO - 'tpaint', 10:39:14 INFO - 'sessionrestore', 10:39:14 INFO - 'sessionrestore_no_auto_restore', 10:39:14 INFO - 'tabpaint']}, 10:39:14 INFO - 'other-e10s': {'tests': ['a11yr', 10:39:14 INFO - 'ts_paint', 10:39:14 INFO - 'tpaint', 10:39:14 INFO - 'sessionrestore', 10:39:14 INFO - 'sessionrestore_no_auto_restore', 10:39:14 INFO - 'tabpaint']}, 10:39:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:39:14 INFO - 'ts_paint', 10:39:14 INFO - 'tpaint', 10:39:14 INFO - 'sessionrestore', 10:39:14 INFO - 'sessionrestore_no_auto_restore', 10:39:14 INFO - 'tabpaint']}, 10:39:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:39:14 INFO - 'ts_paint', 10:39:14 INFO - 'tpaint', 10:39:14 INFO - 'sessionrestore', 10:39:14 INFO - 'sessionrestore_no_auto_restore', 10:39:14 INFO - 'tabpaint']}, 10:39:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['a11yr', 10:39:14 INFO - 'ts_paint', 10:39:14 INFO - 'tpaint', 10:39:14 INFO - 'sessionrestore', 10:39:14 INFO - 'sessionrestore_no_auto_restore', 10:39:14 INFO - 'tabpaint']}, 10:39:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['a11yr', 10:39:14 INFO - 'ts_paint', 10:39:14 INFO - 'tpaint', 10:39:14 INFO - 'sessionrestore', 10:39:14 INFO - 'sessionrestore_no_auto_restore', 10:39:14 INFO - 'tabpaint']}, 10:39:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['tsvgx', 10:39:14 INFO - 'tsvgr_opacity', 10:39:14 INFO - 'tart', 10:39:14 INFO - 'tscrollx', 10:39:14 INFO - 'cart']}, 10:39:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:39:14 INFO - 'tsvgr_opacity', 10:39:14 INFO - 'tart', 10:39:14 INFO - 'tscrollx', 10:39:14 INFO - 'cart']}, 10:39:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'talos_options': ['--disable-e10s'], 10:39:14 INFO - 'tests': ['tp5o']}, 10:39:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'tests': ['tp5o']}, 10:39:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'talos_options': ['--disable-e10s', 10:39:14 INFO - '--xperf_path', 10:39:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:14 INFO - 'tests': ['tp5n']}, 10:39:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:14 INFO - 'talos_options': ['--xperf_path', 10:39:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:14 INFO - 'tests': ['tp5n']}}, 10:39:14 INFO - 'talos.zip': {'path': '', 10:39:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:39:14 INFO - Running post-action listener: _resource_record_post_action 10:39:14 INFO - [mozharness: 2017-02-21 18:39:14.080977Z] Finished populate-webroot step (success) 10:39:14 INFO - [mozharness: 2017-02-21 18:39:14.081064Z] Running create-virtualenv step. 10:39:14 INFO - Running pre-action listener: _resource_record_pre_action 10:39:14 INFO - Running main action method: create_virtualenv 10:39:14 INFO - Creating virtualenv /builds/slave/test/build/venv 10:39:14 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 10:39:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:39:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:39:14 INFO - Using real prefix '/usr' 10:39:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:39:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:39:16 INFO - Installing pip.................done. 10:39:16 INFO - Return code: 0 10:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:39:16 INFO - Reading from file tmpfile_stdout 10:39:16 INFO - Output received: 10:39:16 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) 10:39:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:39:16 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')]} 10:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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')]} 10:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:16 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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39:16 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 10:39:16 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 10:39:16 INFO - Using env: {'DISPLAY': ':0', 10:39:16 INFO - 'HOME': '/home/cltbld', 10:39:16 INFO - 'LANG': 'en_US.UTF-8', 10:39:16 INFO - 'LANGUAGE': 'en_US:en', 10:39:16 INFO - 'LOGNAME': 'cltbld', 10:39:16 INFO - 'MAIL': '/var/mail/cltbld', 10:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:16 INFO - 'MOZ_NO_REMOTE': '1', 10:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:16 INFO - 'NO_EM_RESTART': '1', 10:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:16 INFO - 'PWD': '/builds/slave/test', 10:39:16 INFO - 'SHELL': '/bin/bash', 10:39:16 INFO - 'SHLVL': '1', 10:39:16 INFO - 'TERM': 'linux', 10:39:16 INFO - 'TMOUT': '86400', 10:39:16 INFO - 'USER': 'cltbld', 10:39:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:16 INFO - '_': '/tools/buildbot/bin/python'} 10:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:17 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 10:39:17 INFO - Cleaning up... 10:39:17 INFO - Return code: 0 10:39:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:39:17 INFO - Using env: {'DISPLAY': ':0', 10:39:17 INFO - 'HOME': '/home/cltbld', 10:39:17 INFO - 'LANG': 'en_US.UTF-8', 10:39:17 INFO - 'LANGUAGE': 'en_US:en', 10:39:17 INFO - 'LOGNAME': 'cltbld', 10:39:17 INFO - 'MAIL': '/var/mail/cltbld', 10:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:17 INFO - 'MOZ_NO_REMOTE': '1', 10:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:17 INFO - 'NO_EM_RESTART': '1', 10:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:17 INFO - 'PWD': '/builds/slave/test', 10:39:17 INFO - 'SHELL': '/bin/bash', 10:39:17 INFO - 'SHLVL': '1', 10:39:17 INFO - 'TERM': 'linux', 10:39:17 INFO - 'TMOUT': '86400', 10:39:17 INFO - 'USER': 'cltbld', 10:39:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:17 INFO - '_': '/tools/buildbot/bin/python'} 10:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:17 INFO - Downloading/unpacking psutil>=3.1.1 10:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:39:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:19 INFO - Installing collected packages: psutil 10:39:19 INFO - Running setup.py install for psutil 10:39:19 INFO - building 'psutil._psutil_linux' extension 10:39:19 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 10:39:19 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 10:39:19 INFO - building 'psutil._psutil_posix' extension 10:39:19 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 10:39:20 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 10:39:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:20 INFO - Successfully installed psutil 10:39:20 INFO - Cleaning up... 10:39:20 INFO - Return code: 0 10:39:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:20 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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39:20 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 10:39:20 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 10:39:20 INFO - Using env: {'DISPLAY': ':0', 10:39:20 INFO - 'HOME': '/home/cltbld', 10:39:20 INFO - 'LANG': 'en_US.UTF-8', 10:39:20 INFO - 'LANGUAGE': 'en_US:en', 10:39:20 INFO - 'LOGNAME': 'cltbld', 10:39:20 INFO - 'MAIL': '/var/mail/cltbld', 10:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:20 INFO - 'MOZ_NO_REMOTE': '1', 10:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:20 INFO - 'NO_EM_RESTART': '1', 10:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:20 INFO - 'PWD': '/builds/slave/test', 10:39:20 INFO - 'SHELL': '/bin/bash', 10:39:20 INFO - 'SHLVL': '1', 10:39:20 INFO - 'TERM': 'linux', 10:39:20 INFO - 'TMOUT': '86400', 10:39:20 INFO - 'USER': 'cltbld', 10:39:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:20 INFO - '_': '/tools/buildbot/bin/python'} 10:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:39:22 INFO - Installing collected packages: mozsystemmonitor 10:39:22 INFO - Running setup.py install for mozsystemmonitor 10:39:22 INFO - Successfully installed mozsystemmonitor 10:39:22 INFO - Cleaning up... 10:39:22 INFO - Return code: 0 10:39:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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', '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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:39: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 jsonschema==2.5.1 10:39:22 INFO - Using env: {'DISPLAY': ':0', 10:39:22 INFO - 'HOME': '/home/cltbld', 10:39:22 INFO - 'LANG': 'en_US.UTF-8', 10:39:22 INFO - 'LANGUAGE': 'en_US:en', 10:39:22 INFO - 'LOGNAME': 'cltbld', 10:39:22 INFO - 'MAIL': '/var/mail/cltbld', 10:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:22 INFO - 'MOZ_NO_REMOTE': '1', 10:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:22 INFO - 'NO_EM_RESTART': '1', 10:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:22 INFO - 'PWD': '/builds/slave/test', 10:39:22 INFO - 'SHELL': '/bin/bash', 10:39:22 INFO - 'SHLVL': '1', 10:39:22 INFO - 'TERM': 'linux', 10:39:22 INFO - 'TMOUT': '86400', 10:39:22 INFO - 'USER': 'cltbld', 10:39:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:22 INFO - '_': '/tools/buildbot/bin/python'} 10:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:22 INFO - Downloading/unpacking jsonschema==2.5.1 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:39:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:39:24 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 10:39:24 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 10:39:24 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 10:39:24 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 10:39:24 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 10:39:24 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 10:39:25 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:25 INFO - warning: no files found matching '*.txt' 10:39:25 INFO - no previously-included directories found matching 'build' 10:39:25 INFO - no previously-included directories found matching 'dist' 10:39:25 INFO - no previously-included directories found matching '.git*' 10:39:25 INFO - Installing collected packages: jsonschema, functools32 10:39:25 INFO - Running setup.py install for functools32 10:39:25 INFO - warning: no files found matching '*.txt' 10:39:25 INFO - no previously-included directories found matching 'build' 10:39:25 INFO - no previously-included directories found matching 'dist' 10:39:25 INFO - no previously-included directories found matching '.git*' 10:39:25 INFO - Successfully installed jsonschema functools32 10:39:25 INFO - Cleaning up... 10:39:25 INFO - Return code: 0 10:39:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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', '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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:39: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 functools32==3.2.3-2 10:39:25 INFO - Using env: {'DISPLAY': ':0', 10:39:25 INFO - 'HOME': '/home/cltbld', 10:39:25 INFO - 'LANG': 'en_US.UTF-8', 10:39:25 INFO - 'LANGUAGE': 'en_US:en', 10:39:25 INFO - 'LOGNAME': 'cltbld', 10:39:25 INFO - 'MAIL': '/var/mail/cltbld', 10:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:25 INFO - 'MOZ_NO_REMOTE': '1', 10:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:25 INFO - 'NO_EM_RESTART': '1', 10:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:25 INFO - 'PWD': '/builds/slave/test', 10:39:25 INFO - 'SHELL': '/bin/bash', 10:39:25 INFO - 'SHLVL': '1', 10:39:25 INFO - 'TERM': 'linux', 10:39:25 INFO - 'TMOUT': '86400', 10:39:25 INFO - 'USER': 'cltbld', 10:39:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:25 INFO - '_': '/tools/buildbot/bin/python'} 10:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:39:25 INFO - Cleaning up... 10:39:25 INFO - Return code: 0 10:39:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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', '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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:39: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 blobuploader==1.2.4 10:39:25 INFO - Using env: {'DISPLAY': ':0', 10:39:25 INFO - 'HOME': '/home/cltbld', 10:39:25 INFO - 'LANG': 'en_US.UTF-8', 10:39:25 INFO - 'LANGUAGE': 'en_US:en', 10:39:25 INFO - 'LOGNAME': 'cltbld', 10:39:25 INFO - 'MAIL': '/var/mail/cltbld', 10:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:25 INFO - 'MOZ_NO_REMOTE': '1', 10:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:25 INFO - 'NO_EM_RESTART': '1', 10:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:25 INFO - 'PWD': '/builds/slave/test', 10:39:25 INFO - 'SHELL': '/bin/bash', 10:39:25 INFO - 'SHLVL': '1', 10:39:25 INFO - 'TERM': 'linux', 10:39:25 INFO - 'TMOUT': '86400', 10:39:25 INFO - 'USER': 'cltbld', 10:39:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:25 INFO - '_': '/tools/buildbot/bin/python'} 10:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39:27 INFO - Downloading blobuploader-1.2.4.tar.gz 10:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:39:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:39:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39: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 10:39:28 INFO - Downloading docopt-0.6.1.tar.gz 10:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:39:28 INFO - Installing collected packages: blobuploader, requests, docopt 10:39:28 INFO - Running setup.py install for blobuploader 10:39:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:39:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:39:28 INFO - Running setup.py install for requests 10:39:29 INFO - Running setup.py install for docopt 10:39:29 INFO - Successfully installed blobuploader requests docopt 10:39:29 INFO - Cleaning up... 10:39:29 INFO - Return code: 0 10:39:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:29 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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39:29 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 10:39:29 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 10:39:29 INFO - Using env: {'DISPLAY': ':0', 10:39:29 INFO - 'HOME': '/home/cltbld', 10:39:29 INFO - 'LANG': 'en_US.UTF-8', 10:39:29 INFO - 'LANGUAGE': 'en_US:en', 10:39:29 INFO - 'LOGNAME': 'cltbld', 10:39:29 INFO - 'MAIL': '/var/mail/cltbld', 10:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:29 INFO - 'MOZ_NO_REMOTE': '1', 10:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:29 INFO - 'NO_EM_RESTART': '1', 10:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:29 INFO - 'PWD': '/builds/slave/test', 10:39:29 INFO - 'SHELL': '/bin/bash', 10:39:29 INFO - 'SHLVL': '1', 10:39:29 INFO - 'TERM': 'linux', 10:39:29 INFO - 'TMOUT': '86400', 10:39:29 INFO - 'USER': 'cltbld', 10:39:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:29 INFO - '_': '/tools/buildbot/bin/python'} 10:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:29 INFO - Running setup.py (path:/tmp/pip-S2C2kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:29 INFO - Running setup.py (path:/tmp/pip-62WZNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:29 INFO - Running setup.py (path:/tmp/pip-FHIPkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:29 INFO - Running setup.py (path:/tmp/pip-Pcxmew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:29 INFO - Running setup.py (path:/tmp/pip-2TX72M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:29 INFO - Running setup.py (path:/tmp/pip-xyGPn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:29 INFO - Running setup.py (path:/tmp/pip-pwFdAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:29 INFO - Running setup.py (path:/tmp/pip-JEvDPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:30 INFO - Running setup.py (path:/tmp/pip-4RsCq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:30 INFO - Running setup.py (path:/tmp/pip-GW4YYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:30 INFO - Running setup.py (path:/tmp/pip-9M0t8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:30 INFO - Running setup.py (path:/tmp/pip-mrtjb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:30 INFO - Running setup.py (path:/tmp/pip-MICqFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:30 INFO - Running setup.py (path:/tmp/pip-XDVGyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:30 INFO - Running setup.py (path:/tmp/pip-gb73B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:30 INFO - Running setup.py (path:/tmp/pip-v1lX5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:30 INFO - Running setup.py (path:/tmp/pip-fguAHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:39:30 INFO - Running setup.py install for manifestparser 10:39:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:39:30 INFO - Running setup.py install for mozcrash 10:39:30 INFO - Running setup.py install for mozdebug 10:39:30 INFO - Running setup.py install for mozdevice 10:39:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Running setup.py install for mozfile 10:39:31 INFO - Running setup.py install for mozhttpd 10:39:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Running setup.py install for mozinfo 10:39:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Running setup.py install for mozInstall 10:39:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Running setup.py install for mozleak 10:39:31 INFO - Running setup.py install for mozlog 10:39:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Running setup.py install for moznetwork 10:39:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:39:31 INFO - Running setup.py install for mozprocess 10:39:31 INFO - Running setup.py install for mozprofile 10:39:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:39:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:39:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:39:32 INFO - Running setup.py install for mozrunner 10:39:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:39:32 INFO - Running setup.py install for mozscreenshot 10:39:32 INFO - Running setup.py install for moztest 10:39:32 INFO - Running setup.py install for mozversion 10:39:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:39:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:39:32 INFO - Cleaning up... 10:39:32 INFO - Return code: 0 10:39:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:32 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')]} 10:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:32 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')]} 10:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:32 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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39:32 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 10:39:32 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 10:39:32 INFO - Using env: {'DISPLAY': ':0', 10:39:32 INFO - 'HOME': '/home/cltbld', 10:39:32 INFO - 'LANG': 'en_US.UTF-8', 10:39:32 INFO - 'LANGUAGE': 'en_US:en', 10:39:32 INFO - 'LOGNAME': 'cltbld', 10:39:32 INFO - 'MAIL': '/var/mail/cltbld', 10:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:32 INFO - 'MOZ_NO_REMOTE': '1', 10:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:32 INFO - 'NO_EM_RESTART': '1', 10:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:32 INFO - 'PWD': '/builds/slave/test', 10:39:32 INFO - 'SHELL': '/bin/bash', 10:39:32 INFO - 'SHLVL': '1', 10:39:32 INFO - 'TERM': 'linux', 10:39:32 INFO - 'TMOUT': '86400', 10:39:32 INFO - 'USER': 'cltbld', 10:39:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:32 INFO - '_': '/tools/buildbot/bin/python'} 10:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:32 INFO - Running setup.py (path:/tmp/pip-b8YRBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:32 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)) 10:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:32 INFO - Running setup.py (path:/tmp/pip-AQUdvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:32 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)) 10:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:32 INFO - Running setup.py (path:/tmp/pip-cQl6vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:32 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)) 10:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:32 INFO - Running setup.py (path:/tmp/pip-g6lne9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:33 INFO - Running setup.py (path:/tmp/pip-Yoy914-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:33 INFO - Running setup.py (path:/tmp/pip-_EtN35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:33 INFO - Running setup.py (path:/tmp/pip-Rp6Og6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:33 INFO - Running setup.py (path:/tmp/pip-YnjkCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:33 INFO - Running setup.py (path:/tmp/pip-2jj3UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:33 INFO - Running setup.py (path:/tmp/pip-59bB3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:33 INFO - Running setup.py (path:/tmp/pip-GHRebN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:33 INFO - Running setup.py (path:/tmp/pip-ElIbyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:33 INFO - Running setup.py (path:/tmp/pip-jhcNHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:33 INFO - Running setup.py (path:/tmp/pip-sWA16V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:33 INFO - Running setup.py (path:/tmp/pip-nFLkbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:33 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:33 INFO - Running setup.py (path:/tmp/pip-EbYIiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 10:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:33 INFO - Running setup.py (path:/tmp/pip-Uk4GUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:33 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)) 10:39:33 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)) 10:39:33 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)) 10:39:33 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)) 10:39:33 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)) 10:39:33 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)) 10:39:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:35 INFO - Downloading blessings-1.6.tar.gz 10:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:39:36 INFO - Installing collected packages: blessings 10:39:36 INFO - Running setup.py install for blessings 10:39:36 INFO - Successfully installed blessings 10:39:36 INFO - Cleaning up... 10:39:36 INFO - Return code: 0 10:39:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:39:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:36 INFO - Reading from file tmpfile_stdout 10:39:36 INFO - Current package versions: 10:39:36 INFO - argparse == 1.2.1 10:39:36 INFO - blessings == 1.6 10:39:36 INFO - blobuploader == 1.2.4 10:39:36 INFO - docopt == 0.6.1 10:39:36 INFO - functools32 == 3.2.3-2 10:39:36 INFO - jsonschema == 2.5.1 10:39:36 INFO - manifestparser == 1.1 10:39:36 INFO - mozInstall == 1.12 10:39:36 INFO - mozcrash == 1.0 10:39:36 INFO - mozdebug == 0.1 10:39:36 INFO - mozdevice == 0.48 10:39:36 INFO - mozfile == 1.2 10:39:36 INFO - mozhttpd == 0.7 10:39:36 INFO - mozinfo == 0.9 10:39:36 INFO - mozleak == 0.1 10:39:36 INFO - mozlog == 3.4 10:39:36 INFO - moznetwork == 0.27 10:39:36 INFO - mozprocess == 0.23 10:39:36 INFO - mozprofile == 0.28 10:39:36 INFO - mozrunner == 6.13 10:39:36 INFO - mozscreenshot == 0.1 10:39:36 INFO - mozsystemmonitor == 0.3 10:39:36 INFO - moztest == 0.8 10:39:36 INFO - mozversion == 1.4 10:39:36 INFO - psutil == 3.1.1 10:39:36 INFO - requests == 1.2.3 10:39:36 INFO - wsgiref == 0.1.2 10:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:36 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')]} 10:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:36 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')]} 10:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:36 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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39:36 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 10:39:36 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 10:39:36 INFO - Using env: {'DISPLAY': ':0', 10:39:36 INFO - 'HOME': '/home/cltbld', 10:39:36 INFO - 'LANG': 'en_US.UTF-8', 10:39:36 INFO - 'LANGUAGE': 'en_US:en', 10:39:36 INFO - 'LOGNAME': 'cltbld', 10:39:36 INFO - 'MAIL': '/var/mail/cltbld', 10:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:36 INFO - 'MOZ_NO_REMOTE': '1', 10:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:36 INFO - 'NO_EM_RESTART': '1', 10:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:36 INFO - 'PWD': '/builds/slave/test', 10:39:36 INFO - 'SHELL': '/bin/bash', 10:39:36 INFO - 'SHLVL': '1', 10:39:36 INFO - 'TERM': 'linux', 10:39:36 INFO - 'TMOUT': '86400', 10:39:36 INFO - 'USER': 'cltbld', 10:39:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:36 INFO - '_': '/tools/buildbot/bin/python'} 10:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 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)) 10:39:36 INFO - Cleaning up... 10:39:36 INFO - Return code: 0 10:39:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:39:36 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')]} 10:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:36 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')]} 10:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:36 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 0x7f3f2fc4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25aeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', '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 10:39:36 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 10:39:36 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 10:39:36 INFO - Using env: {'DISPLAY': ':0', 10:39:36 INFO - 'HOME': '/home/cltbld', 10:39:36 INFO - 'LANG': 'en_US.UTF-8', 10:39:36 INFO - 'LANGUAGE': 'en_US:en', 10:39:36 INFO - 'LOGNAME': 'cltbld', 10:39:36 INFO - 'MAIL': '/var/mail/cltbld', 10:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:36 INFO - 'MOZ_NO_REMOTE': '1', 10:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:36 INFO - 'NO_EM_RESTART': '1', 10:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:36 INFO - 'PWD': '/builds/slave/test', 10:39:36 INFO - 'SHELL': '/bin/bash', 10:39:36 INFO - 'SHLVL': '1', 10:39:36 INFO - 'TERM': 'linux', 10:39:36 INFO - 'TMOUT': '86400', 10:39:36 INFO - 'USER': 'cltbld', 10:39:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:36 INFO - '_': '/tools/buildbot/bin/python'} 10:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:39:36 INFO - Cleaning up... 10:39:36 INFO - Return code: 0 10:39:36 INFO - Running post-action listener: _resource_record_post_action 10:39:36 INFO - Running post-action listener: _start_resource_monitoring 10:39:36 INFO - Starting resource monitoring. 10:39:36 INFO - [mozharness: 2017-02-21 18:39:36.949370Z] Finished create-virtualenv step (success) 10:39:36 INFO - [mozharness: 2017-02-21 18:39:36.949827Z] Running install step. 10:39:36 INFO - Running pre-action listener: _resource_record_pre_action 10:39:36 INFO - Running main action method: install 10:39:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:37 INFO - Reading from file tmpfile_stdout 10:39:37 INFO - Detecting whether we're running mozinstall >=1.0... 10:39:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:39:37 INFO - Reading from file tmpfile_stdout 10:39:37 INFO - Output received: 10:39:37 INFO - Usage: mozinstall [options] installer 10:39:37 INFO - Options: 10:39:37 INFO - -h, --help show this help message and exit 10:39:37 INFO - -d DEST, --destination=DEST 10:39:37 INFO - Directory to install application into. [default: 10:39:37 INFO - "/builds/slave/test"] 10:39:37 INFO - --app=APP Application being installed. [default: firefox] 10:39:37 INFO - mkdir: /builds/slave/test/build/application 10:39:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:39:50 INFO - Reading from file tmpfile_stdout 10:39:50 INFO - Output received: 10:39:50 INFO - /builds/slave/test/build/application/firefox/firefox 10:39:50 INFO - Running post-action listener: _resource_record_post_action 10:39:50 INFO - [mozharness: 2017-02-21 18:39:50.903108Z] Finished install step (success) 10:39:50 INFO - [mozharness: 2017-02-21 18:39:50.903350Z] Running run-tests step. 10:39:50 INFO - Running pre-action listener: _resource_record_pre_action 10:39:50 INFO - Running main action method: run_tests 10:39:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:39:50 INFO - Python 2.7.3 10:39:50 INFO - Return code: 0 10:39:50 INFO - grabbing minidump binary from tooltool 10:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:39:50 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 0x25abf60>, '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 0x25acd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ad1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:39:50 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 10:39:50 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 10:39:50 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 10:39:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:39:50 INFO - Return code: 0 10:39:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:39:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:39:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:39:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:39:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:39:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 10:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 10:39:50 INFO - Using env: {'DISPLAY': ':0', 10:39:50 INFO - 'HOME': '/home/cltbld', 10:39:50 INFO - 'LANG': 'en_US.UTF-8', 10:39:50 INFO - 'LANGUAGE': 'en_US:en', 10:39:50 INFO - 'LOGNAME': 'cltbld', 10:39:50 INFO - 'MAIL': '/var/mail/cltbld', 10:39:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:39:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:50 INFO - 'MOZ_NO_REMOTE': '1', 10:39:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:50 INFO - 'NO_EM_RESTART': '1', 10:39:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:50 INFO - 'PWD': '/builds/slave/test', 10:39:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:39:50 INFO - 'SHELL': '/bin/bash', 10:39:50 INFO - 'SHLVL': '1', 10:39:50 INFO - 'TERM': 'linux', 10:39:50 INFO - 'TMOUT': '86400', 10:39:50 INFO - 'USER': 'cltbld', 10:39:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957', 10:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:50 INFO - '_': '/tools/buildbot/bin/python'} 10:39:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 10:39:51 INFO - mozversion application_buildid: 20170221085328 10:39:51 INFO - mozversion application_changeset: 0316bb85a29c03cdc70f74598678bce3a0998c1f 10:39:51 INFO - mozversion application_display_name: Firefox 10:39:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:39:51 INFO - mozversion application_name: Firefox 10:39:51 INFO - mozversion application_remotingname: firefox 10:39:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:39:51 INFO - mozversion application_vendor: Mozilla 10:39:51 INFO - mozversion application_version: 52.0 10:39:51 INFO - mozversion platform_buildid: 20170221085328 10:39:51 INFO - mozversion platform_changeset: 0316bb85a29c03cdc70f74598678bce3a0998c1f 10:39:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:39:51 INFO - mozversion platform_version: 52.0 10:39:51 INFO - using testdate: 1487702391 10:39:51 INFO - actual date: 1487702391 10:39:51 INFO - starting webserver on 'localhost:46192' 10:39:51 INFO - SUITE-START | Running 2 tests 10:39:51 INFO - TEST-START | dromaeo_css 10:39:51 INFO - operating with platform_type : linux_ 10:39:51 INFO - Initialising browser for dromaeo_css test... 10:39:51 INFO - TEST-INFO | started process 11763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDBCZZv/profile http://localhost:46192/getInfo.html) 10:39:55 INFO - PROCESS | 11763 | __metrics Screen width/height:1600/1200 10:39:55 INFO - PROCESS | 11763 | colorDepth:24 10:39:55 INFO - PROCESS | 11763 | Browser inner width/height: 1024/697 10:39:55 INFO - PROCESS | 11763 | __metrics 10:39:56 INFO - PROCESS | 11763 | 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:39:56 INFO - PROCESS | 11763 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:39:56 INFO - PROCESS | 11763 | console.error: PushService: 10:39:56 INFO - PROCESS | 11763 | stateChangeProcessEnqueue: Error transitioning state 10:39:56 INFO - PROCESS | 11763 | UnknownError 10:39:57 INFO - TEST-INFO | 11763: exit 0 10:39:57 INFO - Browser initialized. 10:39:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:39:57 INFO - TEST-INFO | started process 11858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDBCZZv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:08 INFO - PROCESS | 11858 | RSS: Main: 142331904 10:40:08 INFO - PROCESS | 11858 | 10:43:09 INFO - PROCESS | 11858 | Cycle 1(1): loaded http://localhost:46192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46192/tests/dromaeo/cssquery-ext.html) 10:43:11 INFO - PROCESS | 11858 | RSS: Main: 243875840 10:43:11 INFO - PROCESS | 11858 | 10:46:13 INFO - PROCESS | 11858 | Cycle 1(1): loaded http://localhost:46192/tests/dromaeo/cssquery-ext.html (next: http://localhost:46192/tests/dromaeo/cssquery-jquery.html) 10:46:13 INFO - PROCESS | 11858 | RSS: Main: 235909120 10:46:13 INFO - PROCESS | 11858 | 10:49:15 INFO - PROCESS | 11858 | Cycle 1(1): loaded http://localhost:46192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46192/tests/dromaeo/cssquery-mootools.html) 10:49:16 INFO - PROCESS | 11858 | RSS: Main: 176283648 10:49:16 INFO - PROCESS | 11858 | 10:52:18 INFO - PROCESS | 11858 | Cycle 1(1): loaded http://localhost:46192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46192/tests/dromaeo/cssquery-prototype.html) 10:52:18 INFO - PROCESS | 11858 | RSS: Main: 205254656 10:52:18 INFO - PROCESS | 11858 | 10:55:21 INFO - PROCESS | 11858 | Cycle 1(1): loaded http://localhost:46192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46192/tests/dromaeo/cssquery-yui.html) 10:55:22 INFO - PROCESS | 11858 | RSS: Main: 175726592 10:55:22 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | Cycle 1(1): loaded http://localhost:46192/tests/dromaeo/cssquery-yui.html (next: http://localhost:46192/tests/dromaeo/cssquery-dojo.html) 10:58:24 INFO - PROCESS | 11858 | RSS: Main: 267866112 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | __start_tp_report 10:58:24 INFO - PROCESS | 11858 | _x_x_mozilla_page_load 10:58:24 INFO - PROCESS | 11858 | _x_x_mozilla_page_load_details 10:58:24 INFO - PROCESS | 11858 | |i|pagename|runs| 10:58:24 INFO - PROCESS | 11858 | |0;dojo.html;3146.622405311363;3158.1157275962723;3174.8888788892395;3199.58405407297;3221.420144374013;5373.81191658292;5430.56555475562;5431.321084864392;5455.263539422182;5461.344638643368;5452.945470545294;5476.945230547693;5489.835304940848;5505.064139096353;5510.448955104487;4972.627052971024;4987.625928055392;4991.725455099968;5050.671706339094;5058.14011618024;4850.175470170062;4874.512548745115;5004.949950500485;5065.797368105272;5085.898282034357;4922.778474968617;4944.975275123619;4959.752012399384;4966.5778408835295;5009.04828082665;5016.924746128811;5027.622928280375;5099.745012749348;5110.080185566597;5139.948600513984;4760.190767569521;4954.331165292675;4967.379077615298;5048.217526283432;5081.3140226069745;5240.711760853152;5314.654547454403;5329.2006199070065;5346.759395827158;5373.75818088183;5733.312002559678;5780.306363236438;5889.1460738193155;5889.263842019747;5892.086726557391;5610.046292130348;5897.203877476529;5907.734151963172;5912.822615321547;5917.585768996172;5295.338082739658;5423.267858839085;5437.700926449043;5477.233187353773;5509.696966666792;5976.193213916153;5997.730102145414;6009.248843894513;6019.789307374221;6020.428059334444;5622.212890195376;5771.913421298684;5774.04728219839;5785.652860828363;5790.10253410722;5745.597808153389;5763.135529670583;5785.739641716133;5802.941970580325;5873.148393482921;5799.594028418054;5806.361300256968;5809.593328466966;5814.011618024946;5834.941650583524;5770.971145144247;5824.592278540462;5825.24271844666;5829.009068458372;5852.063669812809;4415.735055896656;4487.842925497592;4520.864374068783;4542.3413605027745;4543.45478542577;4036.334004889219;4064.3700226464944;4072.837086516506;4084.346504559256;4105.753654780723;5539.667619942817;5539.723013849372;5548.667079975134;5549.250851135045;5583.637063590853;5674.432556744293;5728.283964504437;5738.655680659173;5770.971145144247;5857.560682948796;5532.6680399176175;5535.972320138454;5539.169124631338;5547.362053363834;5570.888582228333;4985.5762260208285;4991.051700176955;4993.850184494471;4995.550400463976;5025.120603894304;5849.795257165979;5880.970595146997;6025.126356678169;6129.540284478682;6136.8772624548155;5873.559483038704;5937.34689184198;5945.732442040205;5972.163897054503;5974.581779275582;6180.011198208265;6193.566450348612;6195.721192546436;6200.379962003944;6205.317415084427;5544.944550554443;5581.7767289309595;5763.682997435181;5824.592278540462;5829.358770535323;5800.622959507618;5845.09401042839;5861.560382971209;5928.644281343133;5961.970190149022;5762.510186634016;5801.158831969256;5807.593468457168;5816.738246778989;5818.9127163093435;5515.862103447446;5793.652380857162;5800.419958004335;5803.7388317524965;5806.593538452268;5482.451754824486;5611.5230205433;5623.409541998031;5659.943400566106;5769.105788602773;5727.513161381329;5767.942320576908;5784.305883293863;5788;5788.7395067222915;5426.945730542644;5491.121420572689;5492.340919089735;5648.378678345461;5661.490465858093 10:58:24 INFO - PROCESS | 11858 | |1;ext.html;568.6900639151662;626.9341719119493;649.7076315657954;660.2077506991608;671.0571646836197;32901.341973160525;43026.56973430265;44089.559104408945;44210.33684494735;44264;45172.77413612935;45439.77280113595;45632;45639;45689.31466028012;8292.460990035659;8771.91228087719;8900.465972041698;8914.197722205;8921.241694455946;8381.161883811632;10819.621313254038;11065.612703555376;11072;11341.886581134208;11193.888061119365;11246.437678116103;11253.099752019818;11257.155713321492;11261.042811361043;10821;10861.34831910088;10866.45667716611;10873;10887.401192934385;10858.077063449617;10904.073153781937;10928.180386471047;10938.945305273503;10939.671809845717;42572;43002;43025.78487107576;43048;43058.784706076585;3355.6308806031316;3541.1678255609913;3559.5906470755936;3694.11341278094;3938.980305098456;31507.684923150933;32387.676123238703;32391.838040809882;32396;32768;4235.174141042498;4297.828086876521;4384.649228061748;4387.4954380246045;4436.401085853401;325950;326096.36951815325;327773;327918;329155;60407.69796150991;60780.392196078355;60787.39212607906;60796.39203607996;60915.39084609186;39451.80274098611;40298.194036119115;40493.19013619711;42579;63012;16156.434524791812;16195.919020405057;16211.946223495435;16213.189340533163;16221.432249871434;11978.862008109216;12178.939105304595;13468.865311346957;13583.117097388638;13686.794698079537;19706.113224904915;20336.288229911883;20342;20541.89729051345;20558.69161962572;7037.19072306681;7343.302386273295;7383.372413344819;7397.334239918433;7438.44211684115;952.5237381309346;957.6169532187041;1067.1622776120864;1089.624079692505;1103.939283339408;28464.857675711904;29403.264918377212;30256.84871575672;30269.848650756605;30750.231244219074;1070.6573896353093;1135.9091272698165;1163.6567212672282;1211.4487908001838;1262.5896583610363;15387.149753148808;15419.691606168039;15446.845531544766;15491.380344786083;15552.766708499381;519554;526205;527016;527067;527326;59017.70491147603;59479.02604869739;59580.10629840556;59585.702071489366;59662;1299.1166007115253;1321.524251269523;1324.7814110671632;1400.292852109678;1406.1563062162825;30871.84564077165;32465.675343246265;32554.34891302208;35018.824905875306;35557;55444;56006.1599076006;56111.158332624225;56120.719396402754;56144.71927640335;464297;467317;467516;467739;468055.97916030604;28930.132096037152;30020.24949376283;30297.848510757307;30366;30409;46536.53463465322;47455.52544474511;47510.287345689154;47679.76160119177;48817.2677409832;39550.80224598858;40144.19711605693;40905.59094409018;43340;44862;39615.40576891291;40386.39420408638;40871;40894.182116358104;42178.7891060555;41013;41877.79061104675;42054.15891682088;42160.57839421566;42258.154836903705;34899.4765078519;36572.81713591415;36579.26841463103;36885.81557092197;37502.81248593739;27329.590056148776;27373.452530949668;27398;27398.72601273962;27462 10:58:24 INFO - PROCESS | 11858 | |2;jquery.html;427.9928380616808;430.8276689324271;430.93751406046107;431.9244132276852;443.39919409200553;18370.724439133424;18641.16114774835;19812.50468738282;20059.899700501515;20090.69863952042;17944.910275448638;18485.722714159263;19020.61958760824;19528.121234544444;19670.213191472325;5732.742026608813;5942.821715348547;5975.25309336333;5999.76000959961;6004.639721616695;5700.401457846929;5831.329397119343;5877.764889404419;5935.851603709899;5946.345901950782;5885.5585831062845;5890.263717035371;5892.351841297454;5895.616784908989;5897.174395584621;5780.161876527922;5811.331696854873;5851.151583020481;5874;5874.471297583216;5264.368275806889;5274.05067087924;5274.2879711238875;5278.1291086970605;5278.340207474066;23209;23474.765252347428;23599.410014749596;23640.29079127612;23859.64210536843;2205.63607004844;2458.569750293709;2470.345358480004;3001.8048826826184;3244.107870335653;14373.137611743328;14588.34352454142;14601.78097328541;14865.479708210161;15339.463118790789;1929.729837822706;1992.810682985114;2027.4221846773598;2049.938501844932;2056.3830850744716;58769;74620.25379746188;79775.20224797736;80815;82050;10809.891901081046;11248.156388270912;11273.21087523882;11287.661370158909;11662;15996.440124595583;16013.679726405406;16044;16052.197390130446;16084.43704470338;8401.68953537782;8608.354373422018;8678.522681252465;8830.42602230853;8855.64577416909;8202.712905048294;8265.173482651808;8270;8489.320854331761;8495.36284778644;6774.356436138559;6861.279565645636;6950.270221626757;6973;6981.616011119438;1802.8510886108222;1994.4814348269265;1996.830269427115;2059.742532183477;2094.916203351879;955.7610597350663;1025.2003437318904;1055.2718624149313;1071.23406764164;1100.8073587122221;19522;19666.410007699793;19907.900460497895;20075.498112547302;20080.49798755043;1002.0680766886719;1026.3892983674702;1030.6701855406197;1043.5877828257946;1045.985394167656;10767.300125491818;11464.25482343645;11490.597829076109;11493.540258389738;11514.884851151548;448538;461714;467130;469542;470018;88660;93813;93959;97801;98140.50929745306;1029.9073083422527;1038.953247103867;1073.5652060915343;1075.725689949058;1077.956881724738;17353.82646173522;17743.556411089827;18188.90905545464;18216.635667286315;18343.541411464288;40718;41962.580374195866;42359.15281694287;42452.787736061124;42593.78703106465;57999.4200057994;58259;58279.4172058274;58624.120638191314;58973.41026589679;8457.345948038728;8744.69393571222;8775.692850750193;8987.786648802328;9204.401713888576;12281.69295767613;12844.165129266568;13035.47858085666;13139.737205256033;13140.60578182656;10846.837297440386;10902.672919812418;11432.199746017699;11736.823947640964;12158.696032599255;10684.57261709554;11100.722481937693;11129;11138.665840024812;11647;10850.565977360817;11272.549098036316;11522.884771152181;11764.941175294069;11799.292042477478;8427.747167584983;8707.521086340312;8749.256313213447;8831.823363532822;8975.281977441658;10761.623343182951;11371.20401571882;11396.48715807774;11472.82790758156;11497 10:58:24 INFO - PROCESS | 11858 | |3;mootools.html;1511.365226604826;1537.2851623994843;1662.8835981481293;1758.7713597232357;1804.395527498288;8299.419040667155;8861.778455538606;8864.024957254713;8872.068432814558;8878.378513504058;7582.4313176511705;7797.7660670179985;8214.712485063024;8484.321254299657;8641.91358086419;2476.739942306054;2505.110685706575;2505.4112283613335;2519.496100779842;2521.042004038463;2434.7443518430578;2497.7502249775057;2498.8250822442437;2500.087468074149;2500.574902266619;2484.1057219401;2488.22864911877;2503.111395454615;2513.773760361567;2514.861682607465;2398.8560686358787;2400.699912510936;2426.2357357432443;2426.5146970605774;2429.963550546743;2460.778529932297;2461.2862269941875;2478.7025556933104;2494.1893884487613;2497.1010436242937;8503.10717374673;8578.39951203416;8587.613557389932;8601.61292741828;8638.784030399227;5395.21769343443;5562.638428502134;5564.972175139139;5569.916451253194;5569.944300556983;3559.626239244894;3619.7466177367332;3622.094476380905;3628.1655219299446;3708.5735140458655;1204.9879501204964;1241.9130660853743;1260.2249616485888;1275.3941877608063;1285.7428514297178;12166.087543434278;12184.451699673447;12201.572944946973;12208.694782630417;12215.572454964034;4731.485924504194;4914.483979182206;4970.751462426864;5025.120603894304;5034.521720436553;10059;10065.647702330383;10072.043155900177;10076.345037572535;10077.54651040705;5603.38362780102;5603.635763675348;5614.9719251403485;5615.932972735167;5619.915701264485;4436.578525040116;4456.331550267486;5093;5126.436092029874;5167.121589329748;4105.527864295645;4143.627073563393;4185.748855068706;4253.532111467736;4272.380504826782;1367.712780316125;1369.9246541440316;1369.9931500342634;1401.7967394727707;1424.622475044114;830.3274347778319;941.2940294778916;948.6584829461526;952.7332346942867;972.4894430424084;5655.118274547986;5692;5708.0581704019205;5713.74288157034;5786.363500014995;474.3927772451268;504.2839168380908;508.7941578459076;509.48796459557906;518.590313652218;3907.9804600976813;3939.763614183101;4001.3997900315185;4013.3177359848896;4065.2479291331197;10010.899891001143;10250.333728307785;10366.792664146826;10377.11794497461;10380.740481488023;10344.069033786995;10354.326968747007;10355.896441035644;10356.896431035593;10358.274920755626;7707.537547747153;7875.094364148082;7947.920520794718;7980.241877021674;7990.600469976478;5519.172124181405;5592.972035139798;5631.2960879890015;5715.8571035724435;5746.683932383759;9114.225290850352;9230.492322922035;9283.76790580241;9392.483413412328;9394.95302523483;9384.483853388128;9509.381890177116;9630.903690963281;9695.6121755129;9822.65620703272;6982.685779140053;7027.262137475492;7144;7624.58064806441;7777.766666999999;8019.318357939641;8177.550234737147;8218.178182181735;8220.972378452694;8226.588670566329;7108.751193708195;7237.095363079615;7240.022596949344;7462.4776265660885;7472.626368681435;7111.040009598638;7141;7202.747903823341;7328.083989501312;7442.218567050381;6780.457563394818;6908.205556361083;6916;6916.273791252047;6919.515633905578;4764.142454358249;4804;4859.392575928009;4864.440589332272;4926.162552366178;4834.129856625841;4892.461829198856;4986.501349864984;5026.070177017264;5071.0872043032605 10:58:24 INFO - PROCESS | 11858 | |4;prototype.html;350.7965380079554;355.91280136366584;363.2408266722549;366.790929170373;368.0761289164197;5335.733213339327;5346.155576326166;5348.304720386349;5375.354957405112;5390.676559406428;5068.5945124390055;5102.540771330579;5191.351081114861;5232.16285394337;5347.919781203285;4220.240356735786;4231.746095234295;4231.851885184019;4235.9788201058955;4257.659387249028;4229.915401691965;4238.512571054337;4243.215005224043;4247.362895565659;4254.170436764832;4122.196171746511;4149.381741120966;4173.979130104345;4201.537830838605;4206.831726730927;4172.603602657743;4173.770442625654;4184.769837658928;4195.55946625603;4212.831486740527;3748.11919198988;3765.7928813915223;3772.6981841452616;3773.9811300943593;3804.144067584799;5001.699898006132;5159;5180.274761533388;5209.739513024371;5210.114280572312;4819.036192761461;4825.782839772219;4827.489705353197;4828.348172996635;4841.9031619367415;5509.283793106871;5523.061079616475;5531.778728850841;5546.889062218774;5551.639143455663;3857.517810273716;3988.581198974124;4148.336266197424;4148.585141485827;4149.605787450188;5671.602987790856;5740.799072032501;5744.3394009689;5749.683767392792;5798.652080875118;4197.523461157932;4203.957960420418;4206.158768246363;4210;4212.620864122244;4209.26337890874;4269.210196113729;4269.807858646368;4283.828646854154;4284.785760711952;4777.61449179741;4790.808367665254;4808.27875818623;4824.614030877591;4826.348442960156;5564.4991950724625;5647.265855438766;5648.604597678123;5649.858753531194;5651.519620832275;1420.2259768426231;1421.6516953346497;1430;1443.2999995002415;1445.8288786083306;978.6721448314894;1000.3297790480395;1006.5571148694551;1006.7785087280787;1016.5425558498705;5091.7963281469065;5237.895242095136;5257.579393648575;5274.657147285414;5336.199570064444;5531.668099913937;5559.444055594408;5561;5569.162176481751;5569.860753481114;5061.620378471555;5229.47705229474;5251.579873610179;5273.868153296198;5280.603954703336;2877.956830647542;2923.9415211695646;2956.438276727415;2963.866626001835;2980.970190298069;5724.652892314131;5751.396103409165;5834.649921004753;5838.241028666246;5853.209816674695;5349;5601.019821531216;5623.325200975909;5664.374800127922;5680.346760122638;5706.429357064343;5720.856978575485;5798.9130163047585;5803.361630220672;5809.680467574324;5404.945950540601;5465.480779325958;5543.699364763578;5551.611387202857;5574.996500629763;5689.146628005667;5690;5728.942710573007;5730.885382292414;5738.799142030009;6029.9698501508965;6051.4553690168095;6059.454649081604;6061.181740465157;6086.269647642134;4151.315033019518;4197.391378250076;4228.70399072062;4244.702870799015;4247.768147237267;5519.779208831602;5610.831675049755;5655.943440565542;5764.394738552392;5765.221695071112;5612.494875461228;5664.745086471201;5677.892810902;5679.318481782213;5697.886042279214;5462.86168837635;5532.28080349552;5604.187392828098;5659;5664.405237450173;5515.889682206253;5534.695591742493;5555;5588.552915766648;5596.552275818006;5595.972020139873;5656.43435656431;5658.519025882846;5660.490555849993;5665.490105890325;5259.632495551108;5482.42434544383;5514.944850551443;5539.224508568723;5541.612087153861 10:58:24 INFO - PROCESS | 11858 | |5;yui.html;826.4132864899393;834.6661335465812;859.3554833874595;860.3203469259286;875.3434923807147;14437.422503099877;15282.465113721008;15367.077975321488;15388.23058847056;15424.228788560555;13411.664708382295;14267.215303158322;14294;14390.424383024667;14422.855771442282;866.4368160695551;881.0176653031855;882.748416701237;885.7032893980524;886.0961818944672;733.0323972356491;755.6523998960457;858.51064893011;873.930085593151;880.9779755506099;917.6283605139896;919.9862002069974;920.148862302371;920.1626519866923;921.1341339141186;911.4531281231275;914.154407173362;914.2777206007246;914.5290175559592;915.1306259053893;671.2616122265468;672.5057083043959;672.6603065451965;672.8385187555001;672.9327067293281;13999.930000350036;14184.57446276603;14268.857311426857;14283.428662853474;14978.10131392109;14380.137191768423;14623;14888.851111488855;15068;15204.16377099259;11160.944195279053;11209.887901121048;11323.850387554494;11410.030147437477;11824.290542567473;3739.775613463201;3771.8679846205528;3832;3855.248226595815;3900.161465284949;58376.70811645957;58419.202751820994;58685.70657146729;58817.41182588162;60762;10408.167346612252;10968.122550195965;11105.278156919774;11620.825687614693;11809.40952952349;20022.69965950512;20350.694739578918;20368.69446958297;20402.89798550998;20406.18375264973;7955.4431189817315;8062.637181326854;8119.147489513634;8273.544955027532;8415.326773858076;4226;4493.393391892053;4519.796609152596;4524.547545245449;4555.521670224579;3339.4322965095994;3447.896563103111;3448.103493091814;3451.378751824696;3454.0501362125615;590.164916642954;597.9222701048923;598.1595857819771;599.3377318063564;615.7013848283578;531.6172355903743;590.8079874040953;694.0560837261321;694.5346617766108;701.3442431326624;8208.343332533383;8571;8615.439996400213;8649.567521623894;8832.514211718417;654.2574178307655;654.6628486329544;669.9448368819129;692.715986445565;708.9113860767404;4215.936760948588;4293.613574778285;4357.607815296575;4414.779261036935;4464.330350447459;60001;84809.57595211985;86832.5658371704;87805.56097219473;89263.55368223117;45930.31104533435;65489.67255163789;66896;78263;78338.60830695924;69811.30188698048;72188.63905680439;72281.63859180776;73167;73546.26453735394;8271.379646526655;8280.130586288353;8284;8381.455205411628;8565.785855353666;47401;47950.520494794604;48398.75800621115;49113.263301049796;49177.26234106563;60842;61345;64565.35434645593;67904;68469;10043.347182433119;10116.797664046826;10131.949340253252;10252;10253.07722304996;11574.18980671345;11635.185537012328;11732.472038758448;11967.521299148284;12218.450169742206;10909.83635245456;10998.670039898816;11083.556657733923;11176.329420234812;11328.886711132784;11111.72220694489;11398.08815294791;11558.94220528892;11793.469293881624;12057.879421205676;10798.190135739695;10859.34843909368;11208.327500350006;11499.597514086967;11581.594644187413;8875.911240887508;9030.413023153475;9230.446173229628;9561.330706850455;9635.614575416905;9246.676366327147;9580.18568421692;9698.563564639468;9701.466419347003;9713.757156071155 10:58:24 INFO - PROCESS | 11858 | __end_tp_report 10:58:24 INFO - PROCESS | 11858 | __start_cc_report 10:58:24 INFO - PROCESS | 11858 | _x_x_mozilla_cycle_collect,1053 10:58:24 INFO - PROCESS | 11858 | __end_cc_report 10:58:24 INFO - PROCESS | 11858 | __startTimestamp1487703504857__endTimestamp 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | ------- Summary: start ------- 10:58:24 INFO - PROCESS | 11858 | Number of tests: 6 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | [#0] dojo.html Cycles:165 Average:5434.77 Median:5610.05 stddev:610.94 (10.9%) stddev-sans-first:585.85 10:58:24 INFO - PROCESS | 11858 | Values: 3146.6 3158.1 3174.9 3199.6 3221.4 5373.8 5430.6 5431.3 5455.3 5461.3 5452.9 5476.9 5489.8 5505.1 5510.4 4972.6 4987.6 4991.7 5050.7 5058.1 4850.2 4874.5 5004.9 5065.8 5085.9 4922.8 4945.0 4959.8 4966.6 5009.0 5016.9 5027.6 5099.7 5110.1 5139.9 4760.2 4954.3 4967.4 5048.2 5081.3 5240.7 5314.7 5329.2 5346.8 5373.8 5733.3 5780.3 5889.1 5889.3 5892.1 5610.0 5897.2 5907.7 5912.8 5917.6 5295.3 5423.3 5437.7 5477.2 5509.7 5976.2 5997.7 6009.2 6019.8 6020.4 5622.2 5771.9 5774.0 5785.7 5790.1 5745.6 5763.1 5785.7 5802.9 5873.1 5799.6 5806.4 5809.6 5814.0 5834.9 5771.0 5824.6 5825.2 5829.0 5852.1 4415.7 4487.8 4520.9 4542.3 4543.5 4036.3 4064.4 4072.8 4084.3 4105.8 5539.7 5539.7 5548.7 5549.3 5583.6 5674.4 5728.3 5738.7 5771.0 5857.6 5532.7 5536.0 5539.2 5547.4 5570.9 4985.6 4991.1 4993.9 4995.6 5025.1 5849.8 5881.0 6025.1 6129.5 6136.9 5873.6 5937.3 5945.7 5972.2 5974.6 6180.0 6193.6 6195.7 6200.4 6205.3 5544.9 5581.8 5763.7 5824.6 5829.4 5800.6 5845.1 5861.6 5928.6 5962.0 5762.5 5801.2 5807.6 5816.7 5818.9 5515.9 5793.7 5800.4 5803.7 5806.6 5482.5 5611.5 5623.4 5659.9 5769.1 5727.5 5767.9 5784.3 5788.0 5788.7 5426.9 5491.1 5492.3 5648.4 5661.5 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | [#1] ext.html Cycles:180 Average:60259.18 Median:20598.46 stddev:118646.88 (576.0%) stddev-sans-first:118895.07 10:58:24 INFO - PROCESS | 11858 | Values: 568.7 626.9 649.7 660.2 671.1 32901.3 43026.6 44089.6 44210.3 44264.0 45172.8 45439.8 45632.0 45639.0 45689.3 8292.5 8771.9 8900.5 8914.2 8921.2 8381.2 10819.6 11065.6 11072.0 11341.9 11193.9 11246.4 11253.1 11257.2 11261.0 10821.0 10861.3 10866.5 10873.0 10887.4 10858.1 10904.1 10928.2 10938.9 10939.7 42572.0 43002.0 43025.8 43048.0 43058.8 3355.6 3541.2 3559.6 3694.1 3939.0 31507.7 32387.7 32391.8 32396.0 32768.0 4235.2 4297.8 4384.6 4387.5 4436.4 325950.0 326096.4 327773.0 327918.0 329155.0 60407.7 60780.4 60787.4 60796.4 60915.4 39451.8 40298.2 40493.2 42579.0 63012.0 16156.4 16195.9 16211.9 16213.2 16221.4 11978.9 12178.9 13468.9 13583.1 13686.8 19706.1 20336.3 20342.0 20541.9 20558.7 7037.2 7343.3 7383.4 7397.3 7438.4 952.5 957.6 1067.2 1089.6 1103.9 28464.9 29403.3 30256.8 30269.8 30750.2 1070.7 1135.9 1163.7 1211.4 1262.6 15387.1 15419.7 15446.8 15491.4 15552.8 519554.0 526205.0 527016.0 527067.0 527326.0 59017.7 59479.0 59580.1 59585.7 59662.0 1299.1 1321.5 1324.8 1400.3 1406.2 30871.8 32465.7 32554.3 35018.8 35557.0 55444.0 56006.2 56111.2 56120.7 56144.7 464297.0 467317.0 467516.0 467739.0 468056.0 28930.1 30020.2 30297.8 30366.0 30409.0 46536.5 47455.5 47510.3 47679.8 48817.3 39550.8 40144.2 40905.6 43340.0 44862.0 39615.4 40386.4 40871.0 40894.2 42178.8 41013.0 41877.8 42054.2 42160.6 42258.2 34899.5 36572.8 36579.3 36885.8 37502.8 27329.6 27373.5 27398.0 27398.7 27462.0 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | [#2] jquery.html Cycles:180 Average:28481.35 Median:23341.88 stddev:76477.40 (327.6%) stddev-sans-first:76662.93 10:58:24 INFO - PROCESS | 11858 | Values: 428.0 430.8 430.9 431.9 443.4 18370.7 18641.2 19812.5 20059.9 20090.7 17944.9 18485.7 19020.6 19528.1 19670.2 5732.7 5942.8 5975.3 5999.8 6004.6 5700.4 5831.3 5877.8 5935.9 5946.3 5885.6 5890.3 5892.4 5895.6 5897.2 5780.2 5811.3 5851.2 5874.0 5874.5 5264.4 5274.1 5274.3 5278.1 5278.3 23209.0 23474.8 23599.4 23640.3 23859.6 2205.6 2458.6 2470.3 3001.8 3244.1 14373.1 14588.3 14601.8 14865.5 15339.5 1929.7 1992.8 2027.4 2049.9 2056.4 58769.0 74620.3 79775.2 80815.0 82050.0 10809.9 11248.2 11273.2 11287.7 11662.0 15996.4 16013.7 16044.0 16052.2 16084.4 8401.7 8608.4 8678.5 8830.4 8855.6 8202.7 8265.2 8270.0 8489.3 8495.4 6774.4 6861.3 6950.3 6973.0 6981.6 1802.9 1994.5 1996.8 2059.7 2094.9 955.8 1025.2 1055.3 1071.2 1100.8 19522.0 19666.4 19907.9 20075.5 20080.5 1002.1 1026.4 1030.7 1043.6 1046.0 10767.3 11464.3 11490.6 11493.5 11514.9 448538.0 461714.0 467130.0 469542.0 470018.0 88660.0 93813.0 93959.0 97801.0 98140.5 1029.9 1039.0 1073.6 1075.7 1078.0 17353.8 17743.6 18188.9 18216.6 18343.5 40718.0 41962.6 42359.2 42452.8 42593.8 57999.4 58259.0 58279.4 58624.1 58973.4 8457.3 8744.7 8775.7 8987.8 9204.4 12281.7 12844.2 13035.5 13139.7 13140.6 10846.8 10902.7 11432.2 11736.8 12158.7 10684.6 11100.7 11129.0 11138.7 11647.0 10850.6 11272.5 11522.9 11764.9 11799.3 8427.7 8707.5 8749.3 8831.8 8975.3 10761.6 11371.2 11396.5 11472.8 11497.0 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | [#3] mootools.html Cycles:180 Average:5669.57 Median:5030.30 stddev:3102.88 (61.7%) stddev-sans-first:3095.85 10:58:24 INFO - PROCESS | 11858 | Values: 1511.4 1537.3 1662.9 1758.8 1804.4 8299.4 8861.8 8864.0 8872.1 8878.4 7582.4 7797.8 8214.7 8484.3 8641.9 2476.7 2505.1 2505.4 2519.5 2521.0 2434.7 2497.8 2498.8 2500.1 2500.6 2484.1 2488.2 2503.1 2513.8 2514.9 2398.9 2400.7 2426.2 2426.5 2430.0 2460.8 2461.3 2478.7 2494.2 2497.1 8503.1 8578.4 8587.6 8601.6 8638.8 5395.2 5562.6 5565.0 5569.9 5569.9 3559.6 3619.7 3622.1 3628.2 3708.6 1205.0 1241.9 1260.2 1275.4 1285.7 12166.1 12184.5 12201.6 12208.7 12215.6 4731.5 4914.5 4970.8 5025.1 5034.5 10059.0 10065.6 10072.0 10076.3 10077.5 5603.4 5603.6 5615.0 5615.9 5619.9 4436.6 4456.3 5093.0 5126.4 5167.1 4105.5 4143.6 4185.7 4253.5 4272.4 1367.7 1369.9 1370.0 1401.8 1424.6 830.3 941.3 948.7 952.7 972.5 5655.1 5692.0 5708.1 5713.7 5786.4 474.4 504.3 508.8 509.5 518.6 3908.0 3939.8 4001.4 4013.3 4065.2 10010.9 10250.3 10366.8 10377.1 10380.7 10344.1 10354.3 10355.9 10356.9 10358.3 7707.5 7875.1 7947.9 7980.2 7990.6 5519.2 5593.0 5631.3 5715.9 5746.7 9114.2 9230.5 9283.8 9392.5 9395.0 9384.5 9509.4 9630.9 9695.6 9822.7 6982.7 7027.3 7144.0 7624.6 7777.8 8019.3 8177.6 8218.2 8221.0 8226.6 7108.8 7237.1 7240.0 7462.5 7472.6 7111.0 7141.0 7202.7 7328.1 7442.2 6780.5 6908.2 6916.0 6916.3 6919.5 4764.1 4804.0 4859.4 4864.4 4926.2 4834.1 4892.5 4986.5 5026.1 5071.1 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | [#4] prototype.html Cycles:180 Average:4704.58 Median:5274.26 stddev:1354.36 (25.7%) stddev-sans-first:1318.14 10:58:24 INFO - PROCESS | 11858 | Values: 350.8 355.9 363.2 366.8 368.1 5335.7 5346.2 5348.3 5375.4 5390.7 5068.6 5102.5 5191.4 5232.2 5347.9 4220.2 4231.7 4231.9 4236.0 4257.7 4229.9 4238.5 4243.2 4247.4 4254.2 4122.2 4149.4 4174.0 4201.5 4206.8 4172.6 4173.8 4184.8 4195.6 4212.8 3748.1 3765.8 3772.7 3774.0 3804.1 5001.7 5159.0 5180.3 5209.7 5210.1 4819.0 4825.8 4827.5 4828.3 4841.9 5509.3 5523.1 5531.8 5546.9 5551.6 3857.5 3988.6 4148.3 4148.6 4149.6 5671.6 5740.8 5744.3 5749.7 5798.7 4197.5 4204.0 4206.2 4210.0 4212.6 4209.3 4269.2 4269.8 4283.8 4284.8 4777.6 4790.8 4808.3 4824.6 4826.3 5564.5 5647.3 5648.6 5649.9 5651.5 1420.2 1421.7 1430.0 1443.3 1445.8 978.7 1000.3 1006.6 1006.8 1016.5 5091.8 5237.9 5257.6 5274.7 5336.2 5531.7 5559.4 5561.0 5569.2 5569.9 5061.6 5229.5 5251.6 5273.9 5280.6 2878.0 2923.9 2956.4 2963.9 2981.0 5724.7 5751.4 5834.6 5838.2 5853.2 5349.0 5601.0 5623.3 5664.4 5680.3 5706.4 5720.9 5798.9 5803.4 5809.7 5404.9 5465.5 5543.7 5551.6 5575.0 5689.1 5690.0 5728.9 5730.9 5738.8 6030.0 6051.5 6059.5 6061.2 6086.3 4151.3 4197.4 4228.7 4244.7 4247.8 5519.8 5610.8 5655.9 5764.4 5765.2 5612.5 5664.7 5677.9 5679.3 5697.9 5462.9 5532.3 5604.2 5659.0 5664.4 5515.9 5534.7 5555.0 5588.6 5596.6 5596.0 5656.4 5658.5 5660.5 5665.5 5259.6 5482.4 5514.9 5539.2 5541.6 10:58:24 INFO - PROCESS | 11858 | 10:58:24 INFO - PROCESS | 11858 | [#5] yui.html Cycles:180 Average:17144.71 Median:29703.79 stddev:22845.49 (76.9%) stddev-sans-first:22876.72 10:58:24 INFO - PROCESS | 11858 | Values: 826.4 834.7 859.4 860.3 875.3 14437.4 15282.5 15367.1 15388.2 15424.2 13411.7 14267.2 14294.0 14390.4 14422.9 866.4 881.0 882.7 885.7 886.1 733.0 755.7 858.5 873.9 881.0 917.6 920.0 920.1 920.2 921.1 911.5 914.2 914.3 914.5 915.1 671.3 672.5 672.7 672.8 672.9 13999.9 14184.6 14268.9 14283.4 14978.1 14380.1 14623.0 14888.9 15068.0 15204.2 11160.9 11209.9 11323.9 11410.0 11824.3 3739.8 3771.9 3832.0 3855.2 3900.2 58376.7 58419.2 58685.7 58817.4 60762.0 10408.2 10968.1 11105.3 11620.8 11809.4 20022.7 20350.7 20368.7 20402.9 20406.2 7955.4 8062.6 8119.1 8273.5 8415.3 4226.0 4493.4 4519.8 4524.5 4555.5 3339.4 3447.9 3448.1 3451.4 3454.1 590.2 597.9 598.2 599.3 615.7 531.6 590.8 694.1 694.5 701.3 8208.3 8571.0 8615.4 8649.6 8832.5 654.3 654.7 669.9 692.7 708.9 4215.9 4293.6 4357.6 4414.8 4464.3 60001.0 84809.6 86832.6 87805.6 89263.6 45930.3 65489.7 66896.0 78263.0 78338.6 69811.3 72188.6 72281.6 73167.0 73546.3 8271.4 8280.1 8284.0 8381.5 8565.8 47401.0 47950.5 48398.8 49113.3 49177.3 60842.0 61345.0 64565.4 67904.0 68469.0 10043.3 10116.8 10131.9 10252.0 10253.1 11574.2 11635.2 11732.5 11967.5 12218.5 10909.8 10998.7 11083.6 11176.3 11328.9 11111.7 11398.1 11558.9 11793.5 12057.9 10798.2 10859.3 11208.3 11499.6 11581.6 8875.9 9030.4 9230.4 9561.3 9635.6 9246.7 9580.2 9698.6 9701.5 9713.8 10:58:24 INFO - PROCESS | 11858 | -------- Summary: end -------- 10:58:24 INFO - PROCESS | 11858 | 10:58:25 INFO - TEST-INFO | 11858: exit 0 10:58:25 INFO - TEST-OK | dromaeo_css | took 1114518ms 10:58:25 INFO - TEST-START | kraken 10:58:25 INFO - operating with platform_type : linux_ 10:58:25 INFO - Initialising browser for kraken test... 10:58:25 INFO - TEST-INFO | started process 12161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI6od8_/profile http://localhost:46192/getInfo.html) 10:58:29 INFO - PROCESS | 12161 | __metrics Screen width/height:1600/1200 10:58:29 INFO - PROCESS | 12161 | colorDepth:24 10:58:29 INFO - PROCESS | 12161 | Browser inner width/height: 1024/697 10:58:29 INFO - PROCESS | 12161 | __metrics 10:58:30 INFO - PROCESS | 12161 | 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:58:30 INFO - PROCESS | 12161 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:58:30 INFO - PROCESS | 12161 | console.error: PushService: 10:58:30 INFO - PROCESS | 12161 | stateChangeProcessEnqueue: Error transitioning state 10:58:30 INFO - PROCESS | 12161 | UnknownError 10:58:31 INFO - TEST-INFO | 12161: exit 0 10:58:31 INFO - Browser initialized. 10:58:31 INFO - Running cycle 1/1 for kraken test... 10:58:31 INFO - TEST-INFO | started process 12256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI6od8_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:43 INFO - PROCESS | 12256 | RSS: Main: 141926400 10:58:43 INFO - PROCESS | 12256 | 10:58:45 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46192/tests/kraken/driver.html?testName=audio-beat-detection) 10:58:46 INFO - PROCESS | 12256 | RSS: Main: 183513088 10:58:46 INFO - PROCESS | 12256 | 10:58:49 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46192/tests/kraken/driver.html?testName=audio-dft) 10:58:49 INFO - PROCESS | 12256 | RSS: Main: 173633536 10:58:49 INFO - PROCESS | 12256 | 10:58:52 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46192/tests/kraken/driver.html?testName=audio-fft) 10:58:53 INFO - PROCESS | 12256 | RSS: Main: 265064448 10:58:53 INFO - PROCESS | 12256 | 10:58:55 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46192/tests/kraken/driver.html?testName=audio-oscillator) 10:58:55 INFO - PROCESS | 12256 | RSS: Main: 170905600 10:58:55 INFO - PROCESS | 12256 | 10:58:57 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:58:58 INFO - PROCESS | 12256 | RSS: Main: 173449216 10:58:58 INFO - PROCESS | 12256 | 10:59:01 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46192/tests/kraken/driver.html?testName=imaging-darkroom) 10:59:01 INFO - PROCESS | 12256 | RSS: Main: 212844544 10:59:01 INFO - PROCESS | 12256 | 10:59:05 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46192/tests/kraken/driver.html?testName=imaging-desaturate) 10:59:05 INFO - PROCESS | 12256 | RSS: Main: 211353600 10:59:05 INFO - PROCESS | 12256 | 10:59:08 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46192/tests/kraken/driver.html?testName=json-parse-financial) 10:59:09 INFO - PROCESS | 12256 | RSS: Main: 210587648 10:59:09 INFO - PROCESS | 12256 | 10:59:10 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:59:11 INFO - PROCESS | 12256 | RSS: Main: 172941312 10:59:11 INFO - PROCESS | 12256 | 10:59:12 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:59:13 INFO - PROCESS | 12256 | RSS: Main: 179150848 10:59:13 INFO - PROCESS | 12256 | 10:59:15 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:59:16 INFO - PROCESS | 12256 | RSS: Main: 188395520 10:59:16 INFO - PROCESS | 12256 | 10:59:18 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:59:19 INFO - PROCESS | 12256 | RSS: Main: 196403200 10:59:19 INFO - PROCESS | 12256 | 10:59:21 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:59:22 INFO - PROCESS | 12256 | RSS: Main: 193683456 10:59:22 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | Cycle 1(1): loaded http://localhost:46192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46192/tests/kraken/driver.html?testName=ai-astar) 10:59:24 INFO - PROCESS | 12256 | RSS: Main: 244707328 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | __start_tp_report 10:59:24 INFO - PROCESS | 12256 | _x_x_mozilla_page_load 10:59:24 INFO - PROCESS | 12256 | _x_x_mozilla_page_load_details 10:59:24 INFO - PROCESS | 12256 | |i|pagename|runs| 10:59:24 INFO - PROCESS | 12256 | |0;ai-astar;101;109;110;110;109;110;109;109;109;110 10:59:24 INFO - PROCESS | 12256 | |1;audio-beat-detection;140;118;119;162;124;120;116;122;142;116 10:59:24 INFO - PROCESS | 12256 | |2;audio-dft;160;159;162;160;158;159;160;160;160;161 10:59:24 INFO - PROCESS | 12256 | |3;audio-fft;75;76;76;103;76;75;75;76;98;75 10:59:24 INFO - PROCESS | 12256 | |4;audio-oscillator;81;81;119;82;82;82;112;82;81;120 10:59:24 INFO - PROCESS | 12256 | |5;imaging-gaussian-blur;116;116;117;118;117;118;116;116;117;117 10:59:24 INFO - PROCESS | 12256 | |6;imaging-darkroom;147;146;145;146;146;146;146;146;146;146 10:59:24 INFO - PROCESS | 12256 | |7;imaging-desaturate;85;84;84;85;84;85;85;85;84;84 10:59:24 INFO - PROCESS | 12256 | |8;json-parse-financial;51;50;49;50;56;52;50;50;49;50 10:59:24 INFO - PROCESS | 12256 | |9;json-stringify-tinderbox;59;60;59;59;60;59;60;60;60;61 10:59:24 INFO - PROCESS | 12256 | |10;stanford-crypto-aes;75;74;74;75;77;77;74;73;74;74 10:59:24 INFO - PROCESS | 12256 | |11;stanford-crypto-ccm;132;123;134;130;122;130;123;126;156;129 10:59:24 INFO - PROCESS | 12256 | |12;stanford-crypto-pbkdf2;152;155;157;157;160;154;154;157;153;153 10:59:24 INFO - PROCESS | 12256 | |13;stanford-crypto-sha256-iterative;66;62;63;61;63;61;62;61;61;59 10:59:24 INFO - PROCESS | 12256 | __end_tp_report 10:59:24 INFO - PROCESS | 12256 | __start_cc_report 10:59:24 INFO - PROCESS | 12256 | _x_x_mozilla_cycle_collect,1616 10:59:24 INFO - PROCESS | 12256 | __end_cc_report 10:59:24 INFO - PROCESS | 12256 | __startTimestamp1487703564395__endTimestamp 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | ------- Summary: start ------- 10:59:24 INFO - PROCESS | 12256 | Number of tests: 14 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.50 stddev:2.72 (2.5%) stddev-sans-first:0.53 10:59:24 INFO - PROCESS | 12256 | Values: 101.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:123.00 stddev:15.21 (12.4%) stddev-sans-first:15.48 10:59:24 INFO - PROCESS | 12256 | Values: 140.0 118.0 119.0 162.0 124.0 120.0 116.0 122.0 142.0 116.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 10:59:24 INFO - PROCESS | 12256 | Values: 160.0 159.0 162.0 160.0 158.0 159.0 160.0 160.0 160.0 161.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.62 (14.0%) stddev-sans-first:11.07 10:59:24 INFO - PROCESS | 12256 | Values: 75.0 76.0 76.0 103.0 76.0 75.0 75.0 76.0 98.0 75.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:81.50 stddev:17.24 (21.2%) stddev-sans-first:17.81 10:59:24 INFO - PROCESS | 12256 | Values: 81.0 81.0 119.0 82.0 82.0 82.0 112.0 82.0 81.0 120.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 10:59:24 INFO - PROCESS | 12256 | Values: 116.0 116.0 117.0 118.0 117.0 118.0 116.0 116.0 117.0 117.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 10:59:24 INFO - PROCESS | 12256 | Values: 147.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:59:24 INFO - PROCESS | 12256 | Values: 85.0 84.0 84.0 85.0 84.0 85.0 85.0 85.0 84.0 84.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:50.00 stddev:2.06 (4.1%) stddev-sans-first:2.18 10:59:24 INFO - PROCESS | 12256 | Values: 51.0 50.0 49.0 50.0 56.0 52.0 50.0 50.0 49.0 50.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 10:59:24 INFO - PROCESS | 12256 | Values: 59.0 60.0 59.0 59.0 60.0 59.0 60.0 60.0 60.0 61.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:1.34 (1.8%) stddev-sans-first:1.41 10:59:24 INFO - PROCESS | 12256 | Values: 75.0 74.0 74.0 75.0 77.0 77.0 74.0 73.0 74.0 74.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:130.00 stddev:9.85 (7.6%) stddev-sans-first:10.43 10:59:24 INFO - PROCESS | 12256 | Values: 132.0 123.0 134.0 130.0 122.0 130.0 123.0 126.0 156.0 129.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:2.49 (1.6%) stddev-sans-first:2.35 10:59:24 INFO - PROCESS | 12256 | Values: 152.0 155.0 157.0 157.0 160.0 154.0 154.0 157.0 153.0 153.0 10:59:24 INFO - PROCESS | 12256 | 10:59:24 INFO - PROCESS | 12256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.85 (3.0%) stddev-sans-first:1.24 10:59:24 INFO - PROCESS | 12256 | Values: 66.0 62.0 63.0 61.0 63.0 61.0 62.0 61.0 61.0 59.0 10:59:24 INFO - PROCESS | 12256 | -------- Summary: end -------- 10:59:24 INFO - PROCESS | 12256 | 10:59:25 INFO - TEST-INFO | 12256: exit 0 10:59:25 INFO - TEST-OK | kraken | took 59833ms 10:59:25 INFO - SUITE-END | took 1174s 10:59:25 INFO - Completed test suite (00:19:34) 10:59:25 INFO - javascript benchmark 10:59:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.622405311363, 3158.1157275962723, 3174.8888788892395, 3199.58405407297, 3221.420144374013, 5373.81191658292, 5430.56555475562, 5431.321084864392, 5455.263539422182, 5461.344638643368, 5452.945470545294, 5476.945230547693, 5489.835304940848, 5505.064139096353, 5510.448955104487, 4972.627052971024, 4987.625928055392, 4991.725455099968, 5050.671706339094, 5058.14011618024, 4850.175470170062, 4874.512548745115, 5004.949950500485, 5065.797368105272, 5085.898282034357, 4922.778474968617, 4944.975275123619, 4959.752012399384, 4966.5778408835295, 5009.04828082665, 5016.924746128811, 5027.622928280375, 5099.745012749348, 5110.080185566597, 5139.948600513984, 4760.190767569521, 4954.331165292675, 4967.379077615298, 5048.217526283432, 5081.3140226069745, 5240.711760853152, 5314.654547454403, 5329.2006199070065, 5346.759395827158, 5373.75818088183, 5733.312002559678, 5780.306363236438, 5889.1460738193155, 5889.263842019747, 5892.086726557391, 5610.046292130348, 5897.203877476529, 5907.734151963172, 5912.822615321547, 5917.585768996172, 5295.338082739658, 5423.267858839085, 5437.700926449043, 5477.233187353773, 5509.696966666792, 5976.193213916153, 5997.730102145414, 6009.248843894513, 6019.789307374221, 6020.428059334444, 5622.212890195376, 5771.913421298684, 5774.04728219839, 5785.652860828363, 5790.10253410722, 5745.597808153389, 5763.135529670583, 5785.739641716133, 5802.941970580325, 5873.148393482921, 5799.594028418054, 5806.361300256968, 5809.593328466966, 5814.011618024946, 5834.941650583524, 5770.971145144247, 5824.592278540462, 5825.24271844666, 5829.009068458372, 5852.063669812809, 4415.735055896656, 4487.842925497592, 4520.864374068783, 4542.3413605027745, 4543.45478542577, 4036.334004889219, 4064.3700226464944, 4072.837086516506, 4084.346504559256, 4105.753654780723, 5539.667619942817, 5539.723013849372, 5548.667079975134, 5549.250851135045, 5583.637063590853, 5674.432556744293, 5728.283964504437, 5738.655680659173, 5770.971145144247, 5857.560682948796, 5532.6680399176175, 5535.972320138454, 5539.169124631338, 5547.362053363834, 5570.888582228333, 4985.5762260208285, 4991.051700176955, 4993.850184494471, 4995.550400463976, 5025.120603894304, 5849.795257165979, 5880.970595146997, 6025.126356678169, 6129.540284478682, 6136.8772624548155, 5873.559483038704, 5937.34689184198, 5945.732442040205, 5972.163897054503, 5974.581779275582, 6180.011198208265, 6193.566450348612, 6195.721192546436, 6200.379962003944, 6205.317415084427, 5544.944550554443, 5581.7767289309595, 5763.682997435181, 5824.592278540462, 5829.358770535323, 5800.622959507618, 5845.09401042839, 5861.560382971209, 5928.644281343133, 5961.970190149022, 5762.510186634016, 5801.158831969256, 5807.593468457168, 5816.738246778989, 5818.9127163093435, 5515.862103447446, 5793.652380857162, 5800.419958004335, 5803.7388317524965, 5806.593538452268, 5482.451754824486, 5611.5230205433, 5623.409541998031, 5659.943400566106, 5769.105788602773, 5727.513161381329, 5767.942320576908, 5784.305883293863, 5788.0, 5788.7395067222915, 5426.945730542644, 5491.121420572689, 5492.340919089735, 5648.378678345461, 5661.490465858093], "value": 5394.323072899001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.6900639151662, 626.9341719119493, 649.7076315657954, 660.2077506991608, 671.0571646836197, 32901.341973160525, 43026.56973430265, 44089.559104408945, 44210.33684494735, 44264.0, 45172.77413612935, 45439.77280113595, 45632.0, 45639.0, 45689.31466028012, 8292.460990035659, 8771.91228087719, 8900.465972041698, 8914.197722205, 8921.241694455946, 8381.161883811632, 10819.621313254038, 11065.612703555376, 11072.0, 11341.886581134208, 11193.888061119365, 11246.437678116103, 11253.099752019818, 11257.155713321492, 11261.042811361043, 10821.0, 10861.34831910088, 10866.45667716611, 10873.0, 10887.401192934385, 10858.077063449617, 10904.073153781937, 10928.180386471047, 10938.945305273503, 10939.671809845717, 42572.0, 43002.0, 43025.78487107576, 43048.0, 43058.784706076585, 3355.6308806031316, 3541.1678255609913, 3559.5906470755936, 3694.11341278094, 3938.980305098456, 31507.684923150933, 32387.676123238703, 32391.838040809882, 32396.0, 32768.0, 4235.174141042498, 4297.828086876521, 4384.649228061748, 4387.4954380246045, 4436.401085853401, 325950.0, 326096.36951815325, 327773.0, 327918.0, 329155.0, 60407.69796150991, 60780.392196078355, 60787.39212607906, 60796.39203607996, 60915.39084609186, 39451.80274098611, 40298.194036119115, 40493.19013619711, 42579.0, 63012.0, 16156.434524791812, 16195.919020405057, 16211.946223495435, 16213.189340533163, 16221.432249871434, 11978.862008109216, 12178.939105304595, 13468.865311346957, 13583.117097388638, 13686.794698079537, 19706.113224904915, 20336.288229911883, 20342.0, 20541.89729051345, 20558.69161962572, 7037.19072306681, 7343.302386273295, 7383.372413344819, 7397.334239918433, 7438.44211684115, 952.5237381309346, 957.6169532187041, 1067.1622776120864, 1089.624079692505, 1103.939283339408, 28464.857675711904, 29403.264918377212, 30256.84871575672, 30269.848650756605, 30750.231244219074, 1070.6573896353093, 1135.9091272698165, 1163.6567212672282, 1211.4487908001838, 1262.5896583610363, 15387.149753148808, 15419.691606168039, 15446.845531544766, 15491.380344786083, 15552.766708499381, 519554.0, 526205.0, 527016.0, 527067.0, 527326.0, 59017.70491147603, 59479.02604869739, 59580.10629840556, 59585.702071489366, 59662.0, 1299.1166007115253, 1321.524251269523, 1324.7814110671632, 1400.292852109678, 1406.1563062162825, 30871.84564077165, 32465.675343246265, 32554.34891302208, 35018.824905875306, 35557.0, 55444.0, 56006.1599076006, 56111.158332624225, 56120.719396402754, 56144.71927640335, 464297.0, 467317.0, 467516.0, 467739.0, 468055.97916030604, 28930.132096037152, 30020.24949376283, 30297.848510757307, 30366.0, 30409.0, 46536.53463465322, 47455.52544474511, 47510.287345689154, 47679.76160119177, 48817.2677409832, 39550.80224598858, 40144.19711605693, 40905.59094409018, 43340.0, 44862.0, 39615.40576891291, 40386.39420408638, 40871.0, 40894.182116358104, 42178.7891060555, 41013.0, 41877.79061104675, 42054.15891682088, 42160.57839421566, 42258.154836903705, 34899.4765078519, 36572.81713591415, 36579.26841463103, 36885.81557092197, 37502.81248593739, 27329.590056148776, 27373.452530949668, 27398.0, 27398.72601273962, 27462.0], "value": 20572.814698682658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.9928380616808, 430.8276689324271, 430.93751406046107, 431.9244132276852, 443.39919409200553, 18370.724439133424, 18641.16114774835, 19812.50468738282, 20059.899700501515, 20090.69863952042, 17944.910275448638, 18485.722714159263, 19020.61958760824, 19528.121234544444, 19670.213191472325, 5732.742026608813, 5942.821715348547, 5975.25309336333, 5999.76000959961, 6004.639721616695, 5700.401457846929, 5831.329397119343, 5877.764889404419, 5935.851603709899, 5946.345901950782, 5885.5585831062845, 5890.263717035371, 5892.351841297454, 5895.616784908989, 5897.174395584621, 5780.161876527922, 5811.331696854873, 5851.151583020481, 5874.0, 5874.471297583216, 5264.368275806889, 5274.05067087924, 5274.2879711238875, 5278.1291086970605, 5278.340207474066, 23209.0, 23474.765252347428, 23599.410014749596, 23640.29079127612, 23859.64210536843, 2205.63607004844, 2458.569750293709, 2470.345358480004, 3001.8048826826184, 3244.107870335653, 14373.137611743328, 14588.34352454142, 14601.78097328541, 14865.479708210161, 15339.463118790789, 1929.729837822706, 1992.810682985114, 2027.4221846773598, 2049.938501844932, 2056.3830850744716, 58769.0, 74620.25379746188, 79775.20224797736, 80815.0, 82050.0, 10809.891901081046, 11248.156388270912, 11273.21087523882, 11287.661370158909, 11662.0, 15996.440124595583, 16013.679726405406, 16044.0, 16052.197390130446, 16084.43704470338, 8401.68953537782, 8608.354373422018, 8678.522681252465, 8830.42602230853, 8855.64577416909, 8202.712905048294, 8265.173482651808, 8270.0, 8489.320854331761, 8495.36284778644, 6774.356436138559, 6861.279565645636, 6950.270221626757, 6973.0, 6981.616011119438, 1802.8510886108222, 1994.4814348269265, 1996.830269427115, 2059.742532183477, 2094.916203351879, 955.7610597350663, 1025.2003437318904, 1055.2718624149313, 1071.23406764164, 1100.8073587122221, 19522.0, 19666.410007699793, 19907.900460497895, 20075.498112547302, 20080.49798755043, 1002.0680766886719, 1026.3892983674702, 1030.6701855406197, 1043.5877828257946, 1045.985394167656, 10767.300125491818, 11464.25482343645, 11490.597829076109, 11493.540258389738, 11514.884851151548, 448538.0, 461714.0, 467130.0, 469542.0, 470018.0, 88660.0, 93813.0, 93959.0, 97801.0, 98140.50929745306, 1029.9073083422527, 1038.953247103867, 1073.5652060915343, 1075.725689949058, 1077.956881724738, 17353.82646173522, 17743.556411089827, 18188.90905545464, 18216.635667286315, 18343.541411464288, 40718.0, 41962.580374195866, 42359.15281694287, 42452.787736061124, 42593.78703106465, 57999.4200057994, 58259.0, 58279.4172058274, 58624.120638191314, 58973.41026589679, 8457.345948038728, 8744.69393571222, 8775.692850750193, 8987.786648802328, 9204.401713888576, 12281.69295767613, 12844.165129266568, 13035.47858085666, 13139.737205256033, 13140.60578182656, 10846.837297440386, 10902.672919812418, 11432.199746017699, 11736.823947640964, 12158.696032599255, 10684.57261709554, 11100.722481937693, 11129.0, 11138.665840024812, 11647.0, 10850.565977360817, 11272.549098036316, 11522.884771152181, 11764.941175294069, 11799.292042477478, 8427.747167584983, 8707.521086340312, 8749.256313213447, 8831.823363532822, 8975.281977441658, 10761.623343182951, 11371.20401571882, 11396.48715807774, 11472.82790758156, 11497.0], "value": 9570.395984076864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.365226604826, 1537.2851623994843, 1662.8835981481293, 1758.7713597232357, 1804.395527498288, 8299.419040667155, 8861.778455538606, 8864.024957254713, 8872.068432814558, 8878.378513504058, 7582.4313176511705, 7797.7660670179985, 8214.712485063024, 8484.321254299657, 8641.91358086419, 2476.739942306054, 2505.110685706575, 2505.4112283613335, 2519.496100779842, 2521.042004038463, 2434.7443518430578, 2497.7502249775057, 2498.8250822442437, 2500.087468074149, 2500.574902266619, 2484.1057219401, 2488.22864911877, 2503.111395454615, 2513.773760361567, 2514.861682607465, 2398.8560686358787, 2400.699912510936, 2426.2357357432443, 2426.5146970605774, 2429.963550546743, 2460.778529932297, 2461.2862269941875, 2478.7025556933104, 2494.1893884487613, 2497.1010436242937, 8503.10717374673, 8578.39951203416, 8587.613557389932, 8601.61292741828, 8638.784030399227, 5395.21769343443, 5562.638428502134, 5564.972175139139, 5569.916451253194, 5569.944300556983, 3559.626239244894, 3619.7466177367332, 3622.094476380905, 3628.1655219299446, 3708.5735140458655, 1204.9879501204964, 1241.9130660853743, 1260.2249616485888, 1275.3941877608063, 1285.7428514297178, 12166.087543434278, 12184.451699673447, 12201.572944946973, 12208.694782630417, 12215.572454964034, 4731.485924504194, 4914.483979182206, 4970.751462426864, 5025.120603894304, 5034.521720436553, 10059.0, 10065.647702330383, 10072.043155900177, 10076.345037572535, 10077.54651040705, 5603.38362780102, 5603.635763675348, 5614.9719251403485, 5615.932972735167, 5619.915701264485, 4436.578525040116, 4456.331550267486, 5093.0, 5126.436092029874, 5167.121589329748, 4105.527864295645, 4143.627073563393, 4185.748855068706, 4253.532111467736, 4272.380504826782, 1367.712780316125, 1369.9246541440316, 1369.9931500342634, 1401.7967394727707, 1424.622475044114, 830.3274347778319, 941.2940294778916, 948.6584829461526, 952.7332346942867, 972.4894430424084, 5655.118274547986, 5692.0, 5708.0581704019205, 5713.74288157034, 5786.363500014995, 474.3927772451268, 504.2839168380908, 508.7941578459076, 509.48796459557906, 518.590313652218, 3907.9804600976813, 3939.763614183101, 4001.3997900315185, 4013.3177359848896, 4065.2479291331197, 10010.899891001143, 10250.333728307785, 10366.792664146826, 10377.11794497461, 10380.740481488023, 10344.069033786995, 10354.326968747007, 10355.896441035644, 10356.896431035593, 10358.274920755626, 7707.537547747153, 7875.094364148082, 7947.920520794718, 7980.241877021674, 7990.600469976478, 5519.172124181405, 5592.972035139798, 5631.2960879890015, 5715.8571035724435, 5746.683932383759, 9114.225290850352, 9230.492322922035, 9283.76790580241, 9392.483413412328, 9394.95302523483, 9384.483853388128, 9509.381890177116, 9630.903690963281, 9695.6121755129, 9822.65620703272, 6982.685779140053, 7027.262137475492, 7144.0, 7624.58064806441, 7777.766666999999, 8019.318357939641, 8177.550234737147, 8218.178182181735, 8220.972378452694, 8226.588670566329, 7108.751193708195, 7237.095363079615, 7240.022596949344, 7462.4776265660885, 7472.626368681435, 7111.040009598638, 7141.0, 7202.747903823341, 7328.083989501312, 7442.218567050381, 6780.457563394818, 6908.205556361083, 6916.0, 6916.273791252047, 6919.515633905578, 4764.142454358249, 4804.0, 4859.392575928009, 4864.440589332272, 4926.162552366178, 4834.129856625841, 4892.461829198856, 4986.501349864984, 5026.070177017264, 5071.0872043032605], "value": 4562.7276278312775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7965380079554, 355.91280136366584, 363.2408266722549, 366.790929170373, 368.0761289164197, 5335.733213339327, 5346.155576326166, 5348.304720386349, 5375.354957405112, 5390.676559406428, 5068.5945124390055, 5102.540771330579, 5191.351081114861, 5232.16285394337, 5347.919781203285, 4220.240356735786, 4231.746095234295, 4231.851885184019, 4235.9788201058955, 4257.659387249028, 4229.915401691965, 4238.512571054337, 4243.215005224043, 4247.362895565659, 4254.170436764832, 4122.196171746511, 4149.381741120966, 4173.979130104345, 4201.537830838605, 4206.831726730927, 4172.603602657743, 4173.770442625654, 4184.769837658928, 4195.55946625603, 4212.831486740527, 3748.11919198988, 3765.7928813915223, 3772.6981841452616, 3773.9811300943593, 3804.144067584799, 5001.699898006132, 5159.0, 5180.274761533388, 5209.739513024371, 5210.114280572312, 4819.036192761461, 4825.782839772219, 4827.489705353197, 4828.348172996635, 4841.9031619367415, 5509.283793106871, 5523.061079616475, 5531.778728850841, 5546.889062218774, 5551.639143455663, 3857.517810273716, 3988.581198974124, 4148.336266197424, 4148.585141485827, 4149.605787450188, 5671.602987790856, 5740.799072032501, 5744.3394009689, 5749.683767392792, 5798.652080875118, 4197.523461157932, 4203.957960420418, 4206.158768246363, 4210.0, 4212.620864122244, 4209.26337890874, 4269.210196113729, 4269.807858646368, 4283.828646854154, 4284.785760711952, 4777.61449179741, 4790.808367665254, 4808.27875818623, 4824.614030877591, 4826.348442960156, 5564.4991950724625, 5647.265855438766, 5648.604597678123, 5649.858753531194, 5651.519620832275, 1420.2259768426231, 1421.6516953346497, 1430.0, 1443.2999995002415, 1445.8288786083306, 978.6721448314894, 1000.3297790480395, 1006.5571148694551, 1006.7785087280787, 1016.5425558498705, 5091.7963281469065, 5237.895242095136, 5257.579393648575, 5274.657147285414, 5336.199570064444, 5531.668099913937, 5559.444055594408, 5561.0, 5569.162176481751, 5569.860753481114, 5061.620378471555, 5229.47705229474, 5251.579873610179, 5273.868153296198, 5280.603954703336, 2877.956830647542, 2923.9415211695646, 2956.438276727415, 2963.866626001835, 2980.970190298069, 5724.652892314131, 5751.396103409165, 5834.649921004753, 5838.241028666246, 5853.209816674695, 5349.0, 5601.019821531216, 5623.325200975909, 5664.374800127922, 5680.346760122638, 5706.429357064343, 5720.856978575485, 5798.9130163047585, 5803.361630220672, 5809.680467574324, 5404.945950540601, 5465.480779325958, 5543.699364763578, 5551.611387202857, 5574.996500629763, 5689.146628005667, 5690.0, 5728.942710573007, 5730.885382292414, 5738.799142030009, 6029.9698501508965, 6051.4553690168095, 6059.454649081604, 6061.181740465157, 6086.269647642134, 4151.315033019518, 4197.391378250076, 4228.70399072062, 4244.702870799015, 4247.768147237267, 5519.779208831602, 5610.831675049755, 5655.943440565542, 5764.394738552392, 5765.221695071112, 5612.494875461228, 5664.745086471201, 5677.892810902, 5679.318481782213, 5697.886042279214, 5462.86168837635, 5532.28080349552, 5604.187392828098, 5659.0, 5664.405237450173, 5515.889682206253, 5534.695591742493, 5555.0, 5588.552915766648, 5596.552275818006, 5595.972020139873, 5656.43435656431, 5658.519025882846, 5660.490555849993, 5665.490105890325, 5259.632495551108, 5482.42434544383, 5514.944850551443, 5539.224508568723, 5541.612087153861], "value": 4282.156979102808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.4132864899393, 834.6661335465812, 859.3554833874595, 860.3203469259286, 875.3434923807147, 14437.422503099877, 15282.465113721008, 15367.077975321488, 15388.23058847056, 15424.228788560555, 13411.664708382295, 14267.215303158322, 14294.0, 14390.424383024667, 14422.855771442282, 866.4368160695551, 881.0176653031855, 882.748416701237, 885.7032893980524, 886.0961818944672, 733.0323972356491, 755.6523998960457, 858.51064893011, 873.930085593151, 880.9779755506099, 917.6283605139896, 919.9862002069974, 920.148862302371, 920.1626519866923, 921.1341339141186, 911.4531281231275, 914.154407173362, 914.2777206007246, 914.5290175559592, 915.1306259053893, 671.2616122265468, 672.5057083043959, 672.6603065451965, 672.8385187555001, 672.9327067293281, 13999.930000350036, 14184.57446276603, 14268.857311426857, 14283.428662853474, 14978.10131392109, 14380.137191768423, 14623.0, 14888.851111488855, 15068.0, 15204.16377099259, 11160.944195279053, 11209.887901121048, 11323.850387554494, 11410.030147437477, 11824.290542567473, 3739.775613463201, 3771.8679846205528, 3832.0, 3855.248226595815, 3900.161465284949, 58376.70811645957, 58419.202751820994, 58685.70657146729, 58817.41182588162, 60762.0, 10408.167346612252, 10968.122550195965, 11105.278156919774, 11620.825687614693, 11809.40952952349, 20022.69965950512, 20350.694739578918, 20368.69446958297, 20402.89798550998, 20406.18375264973, 7955.4431189817315, 8062.637181326854, 8119.147489513634, 8273.544955027532, 8415.326773858076, 4226.0, 4493.393391892053, 4519.796609152596, 4524.547545245449, 4555.521670224579, 3339.4322965095994, 3447.896563103111, 3448.103493091814, 3451.378751824696, 3454.0501362125615, 590.164916642954, 597.9222701048923, 598.1595857819771, 599.3377318063564, 615.7013848283578, 531.6172355903743, 590.8079874040953, 694.0560837261321, 694.5346617766108, 701.3442431326624, 8208.343332533383, 8571.0, 8615.439996400213, 8649.567521623894, 8832.514211718417, 654.2574178307655, 654.6628486329544, 669.9448368819129, 692.715986445565, 708.9113860767404, 4215.936760948588, 4293.613574778285, 4357.607815296575, 4414.779261036935, 4464.330350447459, 60001.0, 84809.57595211985, 86832.5658371704, 87805.56097219473, 89263.55368223117, 45930.31104533435, 65489.67255163789, 66896.0, 78263.0, 78338.60830695924, 69811.30188698048, 72188.63905680439, 72281.63859180776, 73167.0, 73546.26453735394, 8271.379646526655, 8280.130586288353, 8284.0, 8381.455205411628, 8565.785855353666, 47401.0, 47950.520494794604, 48398.75800621115, 49113.263301049796, 49177.26234106563, 60842.0, 61345.0, 64565.35434645593, 67904.0, 68469.0, 10043.347182433119, 10116.797664046826, 10131.949340253252, 10252.0, 10253.07722304996, 11574.18980671345, 11635.185537012328, 11732.472038758448, 11967.521299148284, 12218.450169742206, 10909.83635245456, 10998.670039898816, 11083.556657733923, 11176.329420234812, 11328.886711132784, 11111.72220694489, 11398.08815294791, 11558.94220528892, 11793.469293881624, 12057.879421205676, 10798.190135739695, 10859.34843909368, 11208.327500350006, 11499.597514086967, 11581.594644187413, 8875.911240887508, 9030.413023153475, 9230.446173229628, 9561.330706850455, 9635.614575416905, 9246.676366327147, 9580.18568421692, 9698.563564639468, 9701.466419347003, 9713.757156071155], "value": 6925.388356406174, "unit": "score"}], "name": "dromaeo_css", "value": 7237.518439981888, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 119.0, 162.0, 124.0, 120.0, 116.0, 122.0, 142.0, 116.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 162.0, 160.0, 158.0, 159.0, 160.0, 160.0, 160.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 103.0, 76.0, 75.0, 75.0, 76.0, 98.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 119.0, 82.0, 82.0, 82.0, 112.0, 82.0, 81.0, 120.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 118.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 56.0, 52.0, 50.0, 50.0, 49.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 61.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 75.0, 77.0, 77.0, 74.0, 73.0, 74.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 134.0, 130.0, 122.0, 130.0, 123.0, 126.0, 156.0, 129.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 157.0, 157.0, 160.0, 154.0, 154.0, 157.0, 153.0, 153.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 61.0, 63.0, 61.0, 62.0, 61.0, 61.0, 59.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1449.1000000000001, "alertThreshold": 2.0}]} 10:59:25 INFO - Return code: 0 10:59:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:59:25 INFO - # TBPL SUCCESS # 10:59:25 INFO - Running post-action listener: _resource_record_post_action 10:59:25 INFO - [mozharness: 2017-02-21 18:59:25.703981Z] Finished run-tests step (success) 10:59:25 INFO - Running post-run listener: _resource_record_post_run 10:59:25 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 322306048; Read time: 0; Write time: 171748 10:59:25 INFO - TinderboxPrint: CPU usage
13.0% 10:59:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:59:25 INFO - TinderboxPrint: I/O write bytes / time
322,306,048 / 171,748 10:59:25 INFO - TinderboxPrint: CPU idle
8,253.5 (87.0%) 10:59:25 INFO - TinderboxPrint: CPU user
1,186.8 (12.5%) 10:59:25 INFO - TinderboxPrint: Swap in / out
0 / 0 10:59:25 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101273600; Read time: 0; Write time: 67420 10:59:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 221032448; Read time: 0; Write time: 104328 10:59:26 INFO - Running post-run listener: _upload_blobber_files 10:59:26 INFO - Blob upload gear active. 10:59:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:59:26 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:59:26 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:59:26 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:59:26 INFO - (blobuploader) - INFO - Open directory for files ... 10:59:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:59:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:59:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:29 INFO - (blobuploader) - INFO - Done attempting. 10:59:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:59:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:30 INFO - (blobuploader) - INFO - Done attempting. 10:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:31 INFO - (blobuploader) - INFO - Done attempting. 10:59:31 INFO - (blobuploader) - INFO - Iteration through files over. 10:59:31 INFO - Return code: 0 10:59:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:59:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:59:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/818dc9115ed478d32627ea95eca32eedadd6161143c773b0186df3395b5abeff5566781b94e13bd0c76be86556d52ef7d3e1197ccb0e40b194fd61c7031512cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230df34d8056390f7fcd1cdaeda1d7fc3157a80dae3adac37a8824848733fc46bc92eb2a86948b3eaa45972bed2ec25787afc3d7ad4dc7b5188d9a8644174d9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a8913a4c9a222eb3b3188f175b0ab01e148000d5b2b6cc235518254a82c1049a8eee1517a1b3fae73be2572458258e0c804e74a2d43641c3c591d4b7accfa4d"} 10:59:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:59:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:59:31 INFO - Contents: 10:59:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/818dc9115ed478d32627ea95eca32eedadd6161143c773b0186df3395b5abeff5566781b94e13bd0c76be86556d52ef7d3e1197ccb0e40b194fd61c7031512cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230df34d8056390f7fcd1cdaeda1d7fc3157a80dae3adac37a8824848733fc46bc92eb2a86948b3eaa45972bed2ec25787afc3d7ad4dc7b5188d9a8644174d9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a8913a4c9a222eb3b3188f175b0ab01e148000d5b2b6cc235518254a82c1049a8eee1517a1b3fae73be2572458258e0c804e74a2d43641c3c591d4b7accfa4d"} 10:59:31 INFO - Running post-run listener: copy_logs_to_upload_dir 10:59:31 INFO - Copying logs to upload dir... 10:59:31 INFO - mkdir: /builds/slave/test/build/upload/logs 10:59:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.278934 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-21 10:59:31.475321) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 10:59:31.478716) ========= 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=03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957 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-Beta/sha512/818dc9115ed478d32627ea95eca32eedadd6161143c773b0186df3395b5abeff5566781b94e13bd0c76be86556d52ef7d3e1197ccb0e40b194fd61c7031512cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230df34d8056390f7fcd1cdaeda1d7fc3157a80dae3adac37a8824848733fc46bc92eb2a86948b3eaa45972bed2ec25787afc3d7ad4dc7b5188d9a8644174d9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a8913a4c9a222eb3b3188f175b0ab01e148000d5b2b6cc235518254a82c1049a8eee1517a1b3fae73be2572458258e0c804e74a2d43641c3c591d4b7accfa4d"} build_url:https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/ZGv47rIpSZuP0-z7MGCd-g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/818dc9115ed478d32627ea95eca32eedadd6161143c773b0186df3395b5abeff5566781b94e13bd0c76be86556d52ef7d3e1197ccb0e40b194fd61c7031512cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/230df34d8056390f7fcd1cdaeda1d7fc3157a80dae3adac37a8824848733fc46bc92eb2a86948b3eaa45972bed2ec25787afc3d7ad4dc7b5188d9a8644174d9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a8913a4c9a222eb3b3188f175b0ab01e148000d5b2b6cc235518254a82c1049a8eee1517a1b3fae73be2572458258e0c804e74a2d43641c3c591d4b7accfa4d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 10:59:31.503993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:59:31.504333) ========= 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=03627c79f6bb3d1578c4a402000001ba-1487702337.415146-333571957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 10:59:31.588083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 10:59:31.588432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 10:59:31.588828) ========= ========= Total master_lag: 0.17 =========