builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1485559209.27 results: success (0) buildid: 20170127133620 builduid: 41444ef8a5a0436e9d8671f07b3cd6e1 revision: 07e5979a0222b793499d9f6d62680a6e5bab251c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.266520) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.266979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.267250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.280225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.280553) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-27 15:20:10-- 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% 50.3M=0s 2017-01-27 15:20:10 (50.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.412900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.413211) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019567 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.462429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:09.462789) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 07e5979a0222b793499d9f6d62680a6e5bab251c --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 07e5979a0222b793499d9f6d62680a6e5bab251c --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=97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-27 15:20:10,478 truncating revision to first 12 chars 2017-01-27 15:20:10,478 Setting DEBUG logging. 2017-01-27 15:20:10,478 attempt 1/10 2017-01-27 15:20:10,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/07e5979a0222?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 15:20:10,918 unpacking tar archive at: mozilla-beta-07e5979a0222/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:10.214754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:10.215073) ========= script_repo_revision: 07e5979a0222b793499d9f6d62680a6e5bab251c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:10.215476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:10.215754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 15:20:10.223222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-27 15:20:10.223539) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:20:11 INFO - MultiFileLogger online at 20170127 15:20:11 in /builds/slave/test 15:20:11 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 15:20:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:20:11 INFO - {'append_to_log': False, 15:20:11 INFO - 'base_work_dir': '/builds/slave/test', 15:20:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:20:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:20:11 INFO - 'branch': 'Mozilla-Beta', 15:20:11 INFO - 'buildbot_json_path': 'buildprops.json', 15:20:11 INFO - 'config_files': ('talos/linux_config.py',), 15:20:11 INFO - 'default_actions': ('clobber', 15:20:11 INFO - 'read-buildbot-config', 15:20:11 INFO - 'download-and-extract', 15:20:11 INFO - 'populate-webroot', 15:20:11 INFO - 'create-virtualenv', 15:20:11 INFO - 'install', 15:20:11 INFO - 'run-tests'), 15:20:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:20:11 INFO - 'download_minidump_stackwalk': True, 15:20:11 INFO - 'download_symbols': 'ondemand', 15:20:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:20:11 INFO - 'tooltool.py': '/tools/tooltool.py', 15:20:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:20:11 INFO - '/tools/misc-python/virtualenv.py')}, 15:20:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:20:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:20:11 INFO - 'installer_path': 'installer.exe', 15:20:11 INFO - 'log_level': 'info', 15:20:11 INFO - 'log_name': 'talos', 15:20:11 INFO - 'log_to_console': True, 15:20:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:20:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:20:11 INFO - 'opt_config_files': (), 15:20:11 INFO - 'pip_index': False, 15:20:11 INFO - 'sps_profile': False, 15:20:11 INFO - 'sps_profile_interval': 0, 15:20:11 INFO - 'suite': 'dromaeojs', 15:20:11 INFO - 'system_bits': '32', 15:20:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:20:11 INFO - 'title': 'talos-linux64-ix-068', 15:20:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:20:11 INFO - 'use_talos_json': True, 15:20:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:20:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:20:11 INFO - 'work_dir': 'build'} 15:20:11 INFO - [mozharness: 2017-01-27 23:20:11.335544Z] Running clobber step. 15:20:11 INFO - Running pre-action listener: _resource_record_pre_action 15:20:11 INFO - Running main action method: clobber 15:20:11 INFO - rmtree: /builds/slave/test/build 15:20:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:20:12 INFO - Running post-action listener: _resource_record_post_action 15:20:12 INFO - [mozharness: 2017-01-27 23:20:12.321288Z] Finished clobber step (success) 15:20:12 INFO - [mozharness: 2017-01-27 23:20:12.321386Z] Running read-buildbot-config step. 15:20:12 INFO - Running pre-action listener: _resource_record_pre_action 15:20:12 INFO - Running main action method: read_buildbot_config 15:20:12 INFO - Using buildbot properties: 15:20:12 INFO - { 15:20:12 INFO - "project": "", 15:20:12 INFO - "product": "firefox", 15:20:12 INFO - "script_repo_revision": "production", 15:20:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:20:12 INFO - "repository": "", 15:20:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:20:12 INFO - "buildid": "20170127133620", 15:20:12 INFO - "pgo_build": "True", 15:20:12 INFO - "basedir": "/builds/slave/test", 15:20:12 INFO - "buildnumber": 531, 15:20:12 INFO - "slavename": "talos-linux64-ix-068", 15:20:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:20:12 INFO - "platform": "ubuntu64_hw", 15:20:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:20:12 INFO - "branch": "mozilla-beta", 15:20:12 INFO - "repo_path": "releases/mozilla-beta", 15:20:12 INFO - "revision": "07e5979a0222b793499d9f6d62680a6e5bab251c", 15:20:12 INFO - "stage_platform": "linux64-pgo", 15:20:12 INFO - "builduid": "41444ef8a5a0436e9d8671f07b3cd6e1", 15:20:12 INFO - "slavebuilddir": "test" 15:20:12 INFO - } 15:20:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 15:20:12 INFO - Running post-action listener: _resource_record_post_action 15:20:12 INFO - [mozharness: 2017-01-27 23:20:12.323938Z] Finished read-buildbot-config step (success) 15:20:12 INFO - [mozharness: 2017-01-27 23:20:12.324025Z] Running download-and-extract step. 15:20:12 INFO - Running pre-action listener: _resource_record_pre_action 15:20:12 INFO - Running main action method: download_and_extract 15:20:12 INFO - mkdir: /builds/slave/test/build/tests 15:20: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')]} 15:20:12 INFO - trying https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 15:20:12 INFO - Downloading https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/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 15:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/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 15:20:12 INFO - Downloaded 1327 bytes. 15:20:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 15:20:12 INFO - Using the following test package requirements: 15:20:12 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 15:20:12 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:20:12 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 15:20:12 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'jsshell-linux-x86_64.zip'], 15:20:12 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:20:12 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 15:20:12 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 15:20:12 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 15:20:12 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:20:12 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:20:12 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:20:12 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:20:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 15:20:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:20:12 INFO - Fetch https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 15:20:13 INFO - Http code: 200 15:20:13 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 15:20:13 INFO - x-amz-cf-id: f90kk6YW0ow_YXcGs9GM70foANC3iY8AT69HFEMgn-wUyb568SYReA== 15:20:13 INFO - x-amz-version-id: N673l6N29ALXxMhZg0XnWWiBH8uJXVF0 15:20:13 INFO - Expected file size: 21951690 15:20:13 INFO - Obtained file size: 21951690 15:20:17 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 15:20:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 15:20:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:20:17 INFO - Fetch https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 15:20:18 INFO - Http code: 200 15:20:18 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 15:20:18 INFO - x-amz-cf-id: P-9pcjA2Q4oKRRcanLw7p67fgKp88OCiTj28MmbD1szJvnMmcc7xTw== 15:20:18 INFO - x-amz-version-id: N673l6N29ALXxMhZg0XnWWiBH8uJXVF0 15:20:18 INFO - Expected file size: 21951690 15:20:18 INFO - Obtained file size: 21951690 15:20:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 15:20:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:20:22 INFO - Fetch https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 15:20:23 INFO - Http code: 200 15:20:23 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 15:20:23 INFO - x-amz-cf-id: iaaO_xVMP5bdJlrNEopaRycNiRCOjUYw8DfsCQ1fpdt7gnnyys8dFw== 15:20:23 INFO - x-amz-version-id: IzxuTZEIa0XEz10lucBxezjt1hUw4aJW 15:20:23 INFO - Expected file size: 14402992 15:20:23 INFO - Obtained file size: 14402992 15:20:23 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')]} 15:20:23 INFO - trying https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 15:20:23 INFO - Downloading https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/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 15:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/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 15:20:24 INFO - Downloaded 57695612 bytes. 15:20:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 15:20:24 INFO - mkdir: /builds/slave/test/properties 15:20:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:20:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:20:24 INFO - Contents: 15:20:24 INFO - build_url:https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 15:20:25 INFO - Running post-action listener: _resource_record_post_action 15:20:25 INFO - Running post-action listener: set_extra_try_arguments 15:20:25 INFO - [mozharness: 2017-01-27 23:20:25.626442Z] Finished download-and-extract step (success) 15:20:25 INFO - [mozharness: 2017-01-27 23:20:25.626668Z] Running populate-webroot step. 15:20:25 INFO - Running pre-action listener: _resource_record_pre_action 15:20:25 INFO - Running main action method: populate_webroot 15:20:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:20:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:20:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:20:25 INFO - '--tppagecycles', 15:20:25 INFO - '7'], 15:20:25 INFO - 'tests': ['tsvgm']}}, 15:20:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:20:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:20:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:20:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:20:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['damp', 'tps']}, 15:20:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'tests': ['damp', 'tps']}, 15:20:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['dromaeo_dom']}, 15:20:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:20:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['basic_compositor_video']}, 15:20:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:20:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['a11yr', 15:20:25 INFO - 'ts_paint', 15:20:25 INFO - 'tpaint', 15:20:25 INFO - 'sessionrestore', 15:20:25 INFO - 'sessionrestore_no_auto_restore', 15:20:25 INFO - 'tabpaint']}, 15:20:25 INFO - 'other-e10s': {'tests': ['a11yr', 15:20:25 INFO - 'ts_paint', 15:20:25 INFO - 'tpaint', 15:20:25 INFO - 'sessionrestore', 15:20:25 INFO - 'sessionrestore_no_auto_restore', 15:20:25 INFO - 'tabpaint']}, 15:20:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:20:25 INFO - 'ts_paint', 15:20:25 INFO - 'tpaint', 15:20:25 INFO - 'sessionrestore', 15:20:25 INFO - 'sessionrestore_no_auto_restore', 15:20:25 INFO - 'tabpaint']}, 15:20:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:20:25 INFO - 'ts_paint', 15:20:25 INFO - 'tpaint', 15:20:25 INFO - 'sessionrestore', 15:20:25 INFO - 'sessionrestore_no_auto_restore', 15:20:25 INFO - 'tabpaint']}, 15:20:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['a11yr', 15:20:25 INFO - 'ts_paint', 15:20:25 INFO - 'tpaint', 15:20:25 INFO - 'sessionrestore', 15:20:25 INFO - 'sessionrestore_no_auto_restore', 15:20:25 INFO - 'tabpaint']}, 15:20:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['a11yr', 15:20:25 INFO - 'ts_paint', 15:20:25 INFO - 'tpaint', 15:20:25 INFO - 'sessionrestore', 15:20:25 INFO - 'sessionrestore_no_auto_restore', 15:20:25 INFO - 'tabpaint']}, 15:20:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['tsvgx', 15:20:25 INFO - 'tsvgr_opacity', 15:20:25 INFO - 'tart', 15:20:25 INFO - 'tscrollx', 15:20:25 INFO - 'cart']}, 15:20:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:20:25 INFO - 'tsvgr_opacity', 15:20:25 INFO - 'tart', 15:20:25 INFO - 'tscrollx', 15:20:25 INFO - 'cart']}, 15:20:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'talos_options': ['--disable-e10s'], 15:20:25 INFO - 'tests': ['tp5o']}, 15:20:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'tests': ['tp5o']}, 15:20:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'talos_options': ['--disable-e10s', 15:20:25 INFO - '--xperf_path', 15:20:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:25 INFO - 'tests': ['tp5n']}, 15:20:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:25 INFO - 'talos_options': ['--xperf_path', 15:20:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:25 INFO - 'tests': ['tp5n']}}, 15:20:25 INFO - 'talos.zip': {'path': '', 15:20:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:20:25 INFO - Running post-action listener: _resource_record_post_action 15:20:25 INFO - [mozharness: 2017-01-27 23:20:25.645108Z] Finished populate-webroot step (success) 15:20:25 INFO - [mozharness: 2017-01-27 23:20:25.645195Z] Running create-virtualenv step. 15:20:25 INFO - Running pre-action listener: _resource_record_pre_action 15:20:25 INFO - Running main action method: create_virtualenv 15:20:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:20:25 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 15:20:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:20:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:20:25 INFO - Using real prefix '/usr' 15:20:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:20:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:20:28 INFO - Installing pip.................done. 15:20:28 INFO - Return code: 0 15:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:20:28 INFO - Reading from file tmpfile_stdout 15:20:28 INFO - Output received: 15:20:28 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) 15:20:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:20:28 INFO - Using env: {'DISPLAY': ':0', 15:20:28 INFO - 'HOME': '/home/cltbld', 15:20:28 INFO - 'LANG': 'en_US.UTF-8', 15:20:28 INFO - 'LANGUAGE': 'en_US:en', 15:20:28 INFO - 'LOGNAME': 'cltbld', 15:20:28 INFO - 'MAIL': '/var/mail/cltbld', 15:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:28 INFO - 'MOZ_NO_REMOTE': '1', 15:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:28 INFO - 'NO_EM_RESTART': '1', 15:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:28 INFO - 'PWD': '/builds/slave/test', 15:20:28 INFO - 'SHELL': '/bin/bash', 15:20:28 INFO - 'SHLVL': '1', 15:20:28 INFO - 'TERM': 'linux', 15:20:28 INFO - 'TMOUT': '86400', 15:20:28 INFO - 'USER': 'cltbld', 15:20:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:28 INFO - '_': '/tools/buildbot/bin/python'} 15:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:28 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 15:20:28 INFO - Cleaning up... 15:20:28 INFO - Return code: 0 15:20:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:20:28 INFO - Using env: {'DISPLAY': ':0', 15:20:28 INFO - 'HOME': '/home/cltbld', 15:20:28 INFO - 'LANG': 'en_US.UTF-8', 15:20:28 INFO - 'LANGUAGE': 'en_US:en', 15:20:28 INFO - 'LOGNAME': 'cltbld', 15:20:28 INFO - 'MAIL': '/var/mail/cltbld', 15:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:28 INFO - 'MOZ_NO_REMOTE': '1', 15:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:28 INFO - 'NO_EM_RESTART': '1', 15:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:28 INFO - 'PWD': '/builds/slave/test', 15:20:28 INFO - 'SHELL': '/bin/bash', 15:20:28 INFO - 'SHLVL': '1', 15:20:28 INFO - 'TERM': 'linux', 15:20:28 INFO - 'TMOUT': '86400', 15:20:28 INFO - 'USER': 'cltbld', 15:20:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:28 INFO - '_': '/tools/buildbot/bin/python'} 15:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:28 INFO - Downloading/unpacking psutil>=3.1.1 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:20:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:31 INFO - Installing collected packages: psutil 15:20:31 INFO - Running setup.py install for psutil 15:20:31 INFO - building 'psutil._psutil_linux' extension 15:20:31 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 15:20:31 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 15:20:31 INFO - building 'psutil._psutil_posix' extension 15:20:31 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 15:20:31 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 15:20:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:31 INFO - Successfully installed psutil 15:20:31 INFO - Cleaning up... 15:20:31 INFO - Return code: 0 15:20:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:31 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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:31 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 15:20:31 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 15:20:31 INFO - Using env: {'DISPLAY': ':0', 15:20:31 INFO - 'HOME': '/home/cltbld', 15:20:31 INFO - 'LANG': 'en_US.UTF-8', 15:20:31 INFO - 'LANGUAGE': 'en_US:en', 15:20:31 INFO - 'LOGNAME': 'cltbld', 15:20:31 INFO - 'MAIL': '/var/mail/cltbld', 15:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:31 INFO - 'MOZ_NO_REMOTE': '1', 15:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:31 INFO - 'NO_EM_RESTART': '1', 15:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:31 INFO - 'PWD': '/builds/slave/test', 15:20:31 INFO - 'SHELL': '/bin/bash', 15:20:31 INFO - 'SHLVL': '1', 15:20:31 INFO - 'TERM': 'linux', 15:20:31 INFO - 'TMOUT': '86400', 15:20:31 INFO - 'USER': 'cltbld', 15:20:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:31 INFO - '_': '/tools/buildbot/bin/python'} 15:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:20:31 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 15:20:31 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 15:20:31 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 15:20:31 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 15:20:31 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 15:20:31 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 15:20:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:20:33 INFO - Installing collected packages: mozsystemmonitor 15:20:33 INFO - Running setup.py install for mozsystemmonitor 15:20:34 INFO - Successfully installed mozsystemmonitor 15:20:34 INFO - Cleaning up... 15:20:34 INFO - Return code: 0 15:20:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:34 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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:34 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 15:20:34 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 15:20:34 INFO - Using env: {'DISPLAY': ':0', 15:20:34 INFO - 'HOME': '/home/cltbld', 15:20:34 INFO - 'LANG': 'en_US.UTF-8', 15:20:34 INFO - 'LANGUAGE': 'en_US:en', 15:20:34 INFO - 'LOGNAME': 'cltbld', 15:20:34 INFO - 'MAIL': '/var/mail/cltbld', 15:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:34 INFO - 'MOZ_NO_REMOTE': '1', 15:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:34 INFO - 'NO_EM_RESTART': '1', 15:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:34 INFO - 'PWD': '/builds/slave/test', 15:20:34 INFO - 'SHELL': '/bin/bash', 15:20:34 INFO - 'SHLVL': '1', 15:20:34 INFO - 'TERM': 'linux', 15:20:34 INFO - 'TMOUT': '86400', 15:20:34 INFO - 'USER': 'cltbld', 15:20:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:34 INFO - '_': '/tools/buildbot/bin/python'} 15:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:20:34 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 15:20:34 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 15:20:34 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 15:20:34 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 15:20:34 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 15:20:34 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 15:20:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:20:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:20:36 INFO - warning: no files found matching '*.txt' 15:20:36 INFO - no previously-included directories found matching 'build' 15:20:36 INFO - no previously-included directories found matching 'dist' 15:20:36 INFO - no previously-included directories found matching '.git*' 15:20:36 INFO - Installing collected packages: jsonschema, functools32 15:20:36 INFO - Running setup.py install for functools32 15:20:36 INFO - warning: no files found matching '*.txt' 15:20:36 INFO - no previously-included directories found matching 'build' 15:20:36 INFO - no previously-included directories found matching 'dist' 15:20:36 INFO - no previously-included directories found matching '.git*' 15:20:36 INFO - Successfully installed jsonschema functools32 15:20:36 INFO - Cleaning up... 15:20:36 INFO - Return code: 0 15:20:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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', '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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:20: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 functools32==3.2.3-2 15:20:36 INFO - Using env: {'DISPLAY': ':0', 15:20:36 INFO - 'HOME': '/home/cltbld', 15:20:36 INFO - 'LANG': 'en_US.UTF-8', 15:20:36 INFO - 'LANGUAGE': 'en_US:en', 15:20:36 INFO - 'LOGNAME': 'cltbld', 15:20:36 INFO - 'MAIL': '/var/mail/cltbld', 15:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:36 INFO - 'MOZ_NO_REMOTE': '1', 15:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:36 INFO - 'NO_EM_RESTART': '1', 15:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:36 INFO - 'PWD': '/builds/slave/test', 15:20:36 INFO - 'SHELL': '/bin/bash', 15:20:36 INFO - 'SHLVL': '1', 15:20:36 INFO - 'TERM': 'linux', 15:20:36 INFO - 'TMOUT': '86400', 15:20:36 INFO - 'USER': 'cltbld', 15:20:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:36 INFO - '_': '/tools/buildbot/bin/python'} 15:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:20:37 INFO - Cleaning up... 15:20:37 INFO - Return code: 0 15:20:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:37 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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:37 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 15:20:37 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 15:20:37 INFO - Using env: {'DISPLAY': ':0', 15:20:37 INFO - 'HOME': '/home/cltbld', 15:20:37 INFO - 'LANG': 'en_US.UTF-8', 15:20:37 INFO - 'LANGUAGE': 'en_US:en', 15:20:37 INFO - 'LOGNAME': 'cltbld', 15:20:37 INFO - 'MAIL': '/var/mail/cltbld', 15:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:37 INFO - 'MOZ_NO_REMOTE': '1', 15:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:37 INFO - 'NO_EM_RESTART': '1', 15:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:37 INFO - 'PWD': '/builds/slave/test', 15:20:37 INFO - 'SHELL': '/bin/bash', 15:20:37 INFO - 'SHLVL': '1', 15:20:37 INFO - 'TERM': 'linux', 15:20:37 INFO - 'TMOUT': '86400', 15:20:37 INFO - 'USER': 'cltbld', 15:20:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:37 INFO - '_': '/tools/buildbot/bin/python'} 15:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:20:37 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 15:20:37 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 15:20:37 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 15:20:37 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 15:20:37 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 15:20:37 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 15:20:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:20:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:20:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 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 15:20:39 INFO - Downloading docopt-0.6.1.tar.gz 15:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:20:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:20:40 INFO - Running setup.py install for blobuploader 15:20:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:20:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:20:40 INFO - Running setup.py install for requests 15:20:40 INFO - Running setup.py install for docopt 15:20:40 INFO - Successfully installed blobuploader requests docopt 15:20:40 INFO - Cleaning up... 15:20:40 INFO - Return code: 0 15:20:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:40 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 15:20:40 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 15:20:40 INFO - Using env: {'DISPLAY': ':0', 15:20:40 INFO - 'HOME': '/home/cltbld', 15:20:40 INFO - 'LANG': 'en_US.UTF-8', 15:20:40 INFO - 'LANGUAGE': 'en_US:en', 15:20:40 INFO - 'LOGNAME': 'cltbld', 15:20:40 INFO - 'MAIL': '/var/mail/cltbld', 15:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:40 INFO - 'MOZ_NO_REMOTE': '1', 15:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:40 INFO - 'NO_EM_RESTART': '1', 15:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:40 INFO - 'PWD': '/builds/slave/test', 15:20:40 INFO - 'SHELL': '/bin/bash', 15:20:40 INFO - 'SHLVL': '1', 15:20:40 INFO - 'TERM': 'linux', 15:20:40 INFO - 'TMOUT': '86400', 15:20:40 INFO - 'USER': 'cltbld', 15:20:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:40 INFO - '_': '/tools/buildbot/bin/python'} 15:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:41 INFO - Running setup.py (path:/tmp/pip-2D5d0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:41 INFO - Running setup.py (path:/tmp/pip-9Oh4rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:41 INFO - Running setup.py (path:/tmp/pip-ZX4xlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:41 INFO - Running setup.py (path:/tmp/pip-k47Lzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:41 INFO - Running setup.py (path:/tmp/pip-gjmUsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:41 INFO - Running setup.py (path:/tmp/pip-2dgb5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:41 INFO - Running setup.py (path:/tmp/pip-aFG_64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:41 INFO - Running setup.py (path:/tmp/pip-MEdJpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:41 INFO - Running setup.py (path:/tmp/pip-TfF8lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:41 INFO - Running setup.py (path:/tmp/pip-5N5hdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:41 INFO - Running setup.py (path:/tmp/pip-CNPbGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:41 INFO - Running setup.py (path:/tmp/pip-CamAh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:41 INFO - Running setup.py (path:/tmp/pip-xhM3yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:42 INFO - Running setup.py (path:/tmp/pip-G4Paqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:42 INFO - Running setup.py (path:/tmp/pip-PlCNs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:42 INFO - Running setup.py (path:/tmp/pip-xeTzyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:42 INFO - Running setup.py (path:/tmp/pip-tJBBEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:20:42 INFO - Running setup.py install for manifestparser 15:20:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:20:42 INFO - Running setup.py install for mozcrash 15:20:42 INFO - Running setup.py install for mozdebug 15:20:42 INFO - Running setup.py install for mozdevice 15:20:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:20:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:20:42 INFO - Running setup.py install for mozfile 15:20:42 INFO - Running setup.py install for mozhttpd 15:20:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:20:42 INFO - Running setup.py install for mozinfo 15:20:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Running setup.py install for mozInstall 15:20:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Running setup.py install for mozleak 15:20:43 INFO - Running setup.py install for mozlog 15:20:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Running setup.py install for moznetwork 15:20:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Running setup.py install for mozprocess 15:20:43 INFO - Running setup.py install for mozprofile 15:20:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Running setup.py install for mozrunner 15:20:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:20:43 INFO - Running setup.py install for mozscreenshot 15:20:43 INFO - Running setup.py install for moztest 15:20:44 INFO - Running setup.py install for mozversion 15:20:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:20:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:20:44 INFO - Cleaning up... 15:20:44 INFO - Return code: 0 15:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:44 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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:44 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 15:20:44 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 15:20:44 INFO - Using env: {'DISPLAY': ':0', 15:20:44 INFO - 'HOME': '/home/cltbld', 15:20:44 INFO - 'LANG': 'en_US.UTF-8', 15:20:44 INFO - 'LANGUAGE': 'en_US:en', 15:20:44 INFO - 'LOGNAME': 'cltbld', 15:20:44 INFO - 'MAIL': '/var/mail/cltbld', 15:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:44 INFO - 'MOZ_NO_REMOTE': '1', 15:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:44 INFO - 'NO_EM_RESTART': '1', 15:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:44 INFO - 'PWD': '/builds/slave/test', 15:20:44 INFO - 'SHELL': '/bin/bash', 15:20:44 INFO - 'SHLVL': '1', 15:20:44 INFO - 'TERM': 'linux', 15:20:44 INFO - 'TMOUT': '86400', 15:20:44 INFO - 'USER': 'cltbld', 15:20:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:44 INFO - '_': '/tools/buildbot/bin/python'} 15:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:44 INFO - Running setup.py (path:/tmp/pip-Kx5lx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:44 INFO - Running setup.py (path:/tmp/pip-roP6ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:44 INFO - Running setup.py (path:/tmp/pip-luLgrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:44 INFO - Running setup.py (path:/tmp/pip-98R0DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:44 INFO - Running setup.py (path:/tmp/pip-CnPJBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:44 INFO - Running setup.py (path:/tmp/pip-gQjIxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:44 INFO - Running setup.py (path:/tmp/pip-yH3HSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:44 INFO - Running setup.py (path:/tmp/pip-Qsfqg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:44 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)) 15:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:44 INFO - Running setup.py (path:/tmp/pip-7HpkqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:45 INFO - Running setup.py (path:/tmp/pip-1iIHgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:45 INFO - Running setup.py (path:/tmp/pip-pDSHKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:45 INFO - Running setup.py (path:/tmp/pip-BobmxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:45 INFO - Running setup.py (path:/tmp/pip-c6FnJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:45 INFO - Running setup.py (path:/tmp/pip-F4BtVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:45 INFO - Running setup.py (path:/tmp/pip-5T5T8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:45 INFO - Running setup.py (path:/tmp/pip-RzfrC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:45 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)) 15:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:45 INFO - Running setup.py (path:/tmp/pip-dyok8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:45 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)) 15:20:45 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)) 15:20:45 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)) 15:20:45 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)) 15:20:45 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)) 15:20:45 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)) 15:20:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:48 INFO - Downloading blessings-1.6.tar.gz 15:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:20:48 INFO - Installing collected packages: blessings 15:20:48 INFO - Running setup.py install for blessings 15:20:48 INFO - Successfully installed blessings 15:20:48 INFO - Cleaning up... 15:20:48 INFO - Return code: 0 15:20:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:20:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:49 INFO - Reading from file tmpfile_stdout 15:20:49 INFO - Current package versions: 15:20:49 INFO - argparse == 1.2.1 15:20:49 INFO - blessings == 1.6 15:20:49 INFO - blobuploader == 1.2.4 15:20:49 INFO - docopt == 0.6.1 15:20:49 INFO - functools32 == 3.2.3-2 15:20:49 INFO - jsonschema == 2.5.1 15:20:49 INFO - manifestparser == 1.1 15:20:49 INFO - mozInstall == 1.12 15:20:49 INFO - mozcrash == 1.0 15:20:49 INFO - mozdebug == 0.1 15:20:49 INFO - mozdevice == 0.48 15:20:49 INFO - mozfile == 1.2 15:20:49 INFO - mozhttpd == 0.7 15:20:49 INFO - mozinfo == 0.9 15:20:49 INFO - mozleak == 0.1 15:20:49 INFO - mozlog == 3.4 15:20:49 INFO - moznetwork == 0.27 15:20:49 INFO - mozprocess == 0.23 15:20:49 INFO - mozprofile == 0.28 15:20:49 INFO - mozrunner == 6.13 15:20:49 INFO - mozscreenshot == 0.1 15:20:49 INFO - mozsystemmonitor == 0.3 15:20:49 INFO - moztest == 0.8 15:20:49 INFO - mozversion == 1.4 15:20:49 INFO - psutil == 3.1.1 15:20:49 INFO - requests == 1.2.3 15:20:49 INFO - wsgiref == 0.1.2 15:20:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:49 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')]} 15:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:49 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')]} 15:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:49 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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:49 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 15:20:49 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 15:20:49 INFO - Using env: {'DISPLAY': ':0', 15:20:49 INFO - 'HOME': '/home/cltbld', 15:20:49 INFO - 'LANG': 'en_US.UTF-8', 15:20:49 INFO - 'LANGUAGE': 'en_US:en', 15:20:49 INFO - 'LOGNAME': 'cltbld', 15:20:49 INFO - 'MAIL': '/var/mail/cltbld', 15:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:49 INFO - 'MOZ_NO_REMOTE': '1', 15:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:49 INFO - 'NO_EM_RESTART': '1', 15:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:49 INFO - 'PWD': '/builds/slave/test', 15:20:49 INFO - 'SHELL': '/bin/bash', 15:20:49 INFO - 'SHLVL': '1', 15:20:49 INFO - 'TERM': 'linux', 15:20:49 INFO - 'TMOUT': '86400', 15:20:49 INFO - 'USER': 'cltbld', 15:20:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:49 INFO - '_': '/tools/buildbot/bin/python'} 15:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 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)) 15:20:49 INFO - Cleaning up... 15:20:49 INFO - Return code: 0 15:20:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:20:49 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')]} 15:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:49 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')]} 15:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:49 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 0x7f5074d9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', '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 15:20:49 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 15:20:49 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 15:20:49 INFO - Using env: {'DISPLAY': ':0', 15:20:49 INFO - 'HOME': '/home/cltbld', 15:20:49 INFO - 'LANG': 'en_US.UTF-8', 15:20:49 INFO - 'LANGUAGE': 'en_US:en', 15:20:49 INFO - 'LOGNAME': 'cltbld', 15:20:49 INFO - 'MAIL': '/var/mail/cltbld', 15:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:49 INFO - 'MOZ_NO_REMOTE': '1', 15:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:49 INFO - 'NO_EM_RESTART': '1', 15:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:49 INFO - 'PWD': '/builds/slave/test', 15:20:49 INFO - 'SHELL': '/bin/bash', 15:20:49 INFO - 'SHLVL': '1', 15:20:49 INFO - 'TERM': 'linux', 15:20:49 INFO - 'TMOUT': '86400', 15:20:49 INFO - 'USER': 'cltbld', 15:20:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:49 INFO - '_': '/tools/buildbot/bin/python'} 15:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:20:49 INFO - Cleaning up... 15:20:49 INFO - Return code: 0 15:20:49 INFO - Running post-action listener: _resource_record_post_action 15:20:49 INFO - Running post-action listener: _start_resource_monitoring 15:20:49 INFO - Starting resource monitoring. 15:20:49 INFO - [mozharness: 2017-01-27 23:20:49.612820Z] Finished create-virtualenv step (success) 15:20:49 INFO - [mozharness: 2017-01-27 23:20:49.613400Z] Running install step. 15:20:49 INFO - Running pre-action listener: _resource_record_pre_action 15:20:49 INFO - Running main action method: install 15:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:49 INFO - Reading from file tmpfile_stdout 15:20:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:20:49 INFO - Reading from file tmpfile_stdout 15:20:49 INFO - Output received: 15:20:49 INFO - Usage: mozinstall [options] installer 15:20:49 INFO - Options: 15:20:49 INFO - -h, --help show this help message and exit 15:20:49 INFO - -d DEST, --destination=DEST 15:20:49 INFO - Directory to install application into. [default: 15:20:49 INFO - "/builds/slave/test"] 15:20:49 INFO - --app=APP Application being installed. [default: firefox] 15:20:49 INFO - mkdir: /builds/slave/test/build/application 15:20:49 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'] 15:20:49 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 15:21:03 INFO - Reading from file tmpfile_stdout 15:21:03 INFO - Output received: 15:21:03 INFO - /builds/slave/test/build/application/firefox/firefox 15:21:03 INFO - Running post-action listener: _resource_record_post_action 15:21:03 INFO - [mozharness: 2017-01-27 23:21:03.576928Z] Finished install step (success) 15:21:03 INFO - [mozharness: 2017-01-27 23:21:03.577170Z] Running run-tests step. 15:21:03 INFO - Running pre-action listener: _resource_record_pre_action 15:21:03 INFO - Running main action method: run_tests 15:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:21:03 INFO - Python 2.7.3 15:21:03 INFO - Return code: 0 15:21:03 INFO - grabbing minidump binary from tooltool 15:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:03 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 0x1981f60>, '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 0x1982d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19831d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:21:03 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 15:21:03 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 15:21:03 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 15:21:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:21:03 INFO - Return code: 0 15:21:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:21:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:21:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:21:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:21:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:21:03 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/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 15:21:03 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/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 15:21:03 INFO - Using env: {'DISPLAY': ':0', 15:21:03 INFO - 'HOME': '/home/cltbld', 15:21:03 INFO - 'LANG': 'en_US.UTF-8', 15:21:03 INFO - 'LANGUAGE': 'en_US:en', 15:21:03 INFO - 'LOGNAME': 'cltbld', 15:21:03 INFO - 'MAIL': '/var/mail/cltbld', 15:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:03 INFO - 'MOZ_NO_REMOTE': '1', 15:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:03 INFO - 'NO_EM_RESTART': '1', 15:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:03 INFO - 'PWD': '/builds/slave/test', 15:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:03 INFO - 'SHELL': '/bin/bash', 15:21:03 INFO - 'SHLVL': '1', 15:21:03 INFO - 'TERM': 'linux', 15:21:03 INFO - 'TMOUT': '86400', 15:21:03 INFO - 'USER': 'cltbld', 15:21:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230', 15:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:03 INFO - '_': '/tools/buildbot/bin/python'} 15:21:03 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/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 15:21:03 INFO - mozversion application_buildid: 20170127133620 15:21:03 INFO - mozversion application_changeset: 07e5979a0222b793499d9f6d62680a6e5bab251c 15:21:03 INFO - mozversion application_display_name: Firefox 15:21:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:21:03 INFO - mozversion application_name: Firefox 15:21:03 INFO - mozversion application_remotingname: firefox 15:21:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:21:03 INFO - mozversion application_vendor: Mozilla 15:21:03 INFO - mozversion application_version: 52.0 15:21:03 INFO - mozversion platform_buildid: 20170127133620 15:21:03 INFO - mozversion platform_changeset: 07e5979a0222b793499d9f6d62680a6e5bab251c 15:21:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:21:03 INFO - mozversion platform_version: 52.0 15:21:03 INFO - using testdate: 1485559263 15:21:03 INFO - actual date: 1485559263 15:21:03 INFO - starting webserver on 'localhost:51081' 15:21:03 INFO - SUITE-START | Running 2 tests 15:21:03 INFO - TEST-START | dromaeo_css 15:21:03 INFO - operating with platform_type : linux_ 15:21:03 INFO - Initialising browser for dromaeo_css test... 15:21:03 INFO - TEST-INFO | started process 8961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqHrHOS/profile http://localhost:51081/getInfo.html) 15:21:08 INFO - PROCESS | 8961 | __metrics Screen width/height:1600/1200 15:21:08 INFO - PROCESS | 8961 | colorDepth:24 15:21:08 INFO - PROCESS | 8961 | Browser inner width/height: 1024/697 15:21:08 INFO - PROCESS | 8961 | __metrics 15:21:08 INFO - PROCESS | 8961 | 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" 15:21:08 INFO - PROCESS | 8961 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:21:09 INFO - PROCESS | 8961 | console.error: PushService: 15:21:09 INFO - PROCESS | 8961 | stateChangeProcessEnqueue: Error transitioning state 15:21:09 INFO - PROCESS | 8961 | UnknownError 15:21:09 INFO - TEST-INFO | 8961: exit 0 15:21:09 INFO - Browser initialized. 15:21:09 INFO - Running cycle 1/1 for dromaeo_css test... 15:21:09 INFO - TEST-INFO | started process 9052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqHrHOS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:21 INFO - PROCESS | 9052 | RSS: Main: 144769024 15:21:21 INFO - PROCESS | 9052 | 15:24:23 INFO - PROCESS | 9052 | Cycle 1(1): loaded http://localhost:51081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51081/tests/dromaeo/cssquery-ext.html) 15:24:24 INFO - PROCESS | 9052 | RSS: Main: 236273664 15:24:24 INFO - PROCESS | 9052 | 15:27:26 INFO - PROCESS | 9052 | Cycle 1(1): loaded http://localhost:51081/tests/dromaeo/cssquery-ext.html (next: http://localhost:51081/tests/dromaeo/cssquery-jquery.html) 15:27:27 INFO - PROCESS | 9052 | RSS: Main: 238448640 15:27:27 INFO - PROCESS | 9052 | 15:30:28 INFO - PROCESS | 9052 | Cycle 1(1): loaded http://localhost:51081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51081/tests/dromaeo/cssquery-mootools.html) 15:30:29 INFO - PROCESS | 9052 | RSS: Main: 202530816 15:30:29 INFO - PROCESS | 9052 | 15:33:31 INFO - PROCESS | 9052 | Cycle 1(1): loaded http://localhost:51081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51081/tests/dromaeo/cssquery-prototype.html) 15:33:31 INFO - PROCESS | 9052 | RSS: Main: 223105024 15:33:31 INFO - PROCESS | 9052 | 15:36:34 INFO - PROCESS | 9052 | Cycle 1(1): loaded http://localhost:51081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51081/tests/dromaeo/cssquery-yui.html) 15:36:34 INFO - PROCESS | 9052 | RSS: Main: 176996352 15:36:34 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | Cycle 1(1): loaded http://localhost:51081/tests/dromaeo/cssquery-yui.html (next: http://localhost:51081/tests/dromaeo/cssquery-dojo.html) 15:39:37 INFO - PROCESS | 9052 | RSS: Main: 261058560 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | __start_tp_report 15:39:37 INFO - PROCESS | 9052 | _x_x_mozilla_page_load 15:39:37 INFO - PROCESS | 9052 | _x_x_mozilla_page_load_details 15:39:37 INFO - PROCESS | 9052 | |i|pagename|runs| 15:39:37 INFO - PROCESS | 9052 | |0;dojo.html;3261.217307846117;3303.15769478783;3316.9668303316957;3326.7005969462775;3338.916527086824;5666.405027472113;5755.021646320125;5764.048931926227;5765.481106700396;5789.652620842747;5739.368669446368;5784.13238014297;5788;5794.188813566094;5797.594168408213;5231.084560201968;5232.16285394337;5252.159654455288;5263.657862238962;5310.283111779918;5099.617528685345;5299.12564426871;5306.681599104066;5327.840164795062;5351.17056856186;5099.847004589849;5162.5095615916425;5180.948190518085;5188.688678679291;5208.036513245042;5224.529792318672;5244.082285600005;5269.420363759983;5318.707471089088;5327.493888080626;5181.989512045153;5204.583633309327;5276.182191760283;5286.656367336111;5302.670815830066;5491.121420572729;5553;5607.411221821691;5626.352969408529;5638.013347664142;5919.112133180014;5945.702714864283;5957.672328021957;6031.728572214261;6043.123747056696;6088.482478989291;6090.908636370458;6095.695215239265;6100.115483254903;6109.633421994695;5539.806106786284;5573.996680597531;5622.634528755618;5684.8294551163535;5823.039198532279;6289.7169627366875;6321.747130114836;6337.207849018872;6337.809865704036;6348.714307856158;6052.818415447544;6060.666663333471;6064.332923378425;6070.150178974947;6078.6048906820915;5948.2862056553495;5996.790112346047;6008.909866352008;6045.093236014633;6137.386261373917;6050.546209034252;6056.242969628796;6071.726772295257;6094.847628809227;6099.664518451527;6030.065339872239;6035.758569657164;6053.061775424816;6082.118092876508;6086.421789929949;4626.1210370029585;4665.86002419928;4681.344611754357;4692.694974826625;4696.976515117402;4175.874723758292;4218.514870789837;4227.027783609787;4245.639120674716;4266.402703621496;5869.413058694096;5874.676892770939;5878.470937615635;5879.147523609138;5902.055671092605;5969.3732158122775;6056.666883321372;6220.533459990428;6231.470325022424;6238.937610623836;5625.8593535161945;5739.426057394311;5750.654960702372;5808.041673123887;5836.970815145897;5226.268322434862;5253.975474782381;5260.368755749335;5268.025415298182;5274.841754747364;6142.560166306704;6271.027990661363;6312.4634406076;6337.302896681269;6339.429451349309;6027.547933904887;6115.510759139169;6145.310039739107;6147;6235.906461403173;6434.163558737334;6435.388638079375;6436.420722135031;6442.194725659293;6450.161479007699;6089.634621922522;6096.055111457731;6099;6099.207103076572;6100.054491553817;5907.527397808251;6023.728932197974;6040.7583696651645;6068.180795592539;6086.908696369469;5976.043832986701;5977.9402205977385;5981.880362392641;5986.491148252448;5992.280926288873;5955.285365756137;5959.761609535743;5964.105384192406;5967.671778052075;5970.402959703995;5751.252337196138;5832.1543376209365;5852.209951656472;5901.350851406256;5961.731722072604;5988.461038506555;6024.819255422344;6041.365656606169;6058.182145410313;6082.026875699867;5672.064109422065;5898.764049437975;5909.5863289569315;5912.083627037816;5918.763249469973 15:39:37 INFO - PROCESS | 9052 | |1;ext.html;579.8898209340225;616.657754946005;638.1130228981715;661.1273119482286;662.4634046422395;34340.1414964626;45028.3245751314;46340.536594634046;46411.53588464114;46459.30311045337;47081.29378059332;47635.52364476354;47651.76174119124;47702.76148619252;47768.28347574789;8313.376496762738;8497.107803680618;8986.2810975122;9134.36059475837;9157.45055296681;10686.839697404544;10941.343519388822;10951.671449856518;11295.717607059849;11299.152563557725;11145.387003714792;11224.775504489906;11226.887731122706;11230.606928757496;11232.438378081104;10942.726431839188;10997.34015959045;11000.119990400788;11002.229843910929;11005.669829905115;11066.889331106666;11089.390083545402;11126.499307531181;11129.888701112966;11129.888701113046;45415;45575.77212113918;45765.31352029689;45778.71106444698;45886.77056614729;3719.7910679029424;4064.2074795414906;4364.2798938175165;4425.291953287458;4426.535213802536;32322.35355292881;32925.83537082323;33088.66911330904;33287;34881.12797180091;4204.600562946515;4232.661387089056;4273.743575385487;4283.100548884707;4388.71473354231;335215.99999999756;338700;339210;340558;340797;64669;64784.35215647877;64918;65065.421401823354;65120.34879651238;40618;41547.584524154976;41696;43475.56524434715;43492;16703.248353824107;16897.155142243086;16897.493075207763;16912.830871691127;16933.661326773643;11853.525858965717;12077.75844483123;12603.684907877194;12856.678583035498;13098.803517947239;21199.78800212009;21323.78676213218;21373.96947290005;21465.141394344362;21497.67753483699;7518.28576285252;7530.849383012419;7551.546907185587;7586.924130758732;7625.618719064025;982.9262805289488;1046.3669479964665;1080.1259814222317;1114.5374669512223;1135.7501349703052;32792.28837200075;33165.66834331674;33193.502097468554;33302.666973330444;33476.33047339039;1137.2494153858413;1152.625396746044;1173.3879588518757;1180.451090243041;1234.7777400067894;17560;17753;17828.910855445898;17881.37415190462;17924.820751792315;539736;541407;544402;545044;545340;61945.380546194865;62269.37730622636;62289.68855155695;62319;62389.37610623836;1267.7591257661015;1345.1391109689807;1386.5424409944694;1420.936057877398;1425.950091746784;32625.673743262265;33838.32323353568;34422.48366274558;34501;34580;53462.73268633632;53942.19086713781;53986.73006634942;54108.45891541192;54109.458905412015;367667;369538;370547;370644;371324;29857;30248.54627180638;30535.389292214477;30860.537091943188;30991.225219368793;49974;50325.74837125791;51041;51059.48940510696;52011.479885200664;41006.79496602498;42921.35617965671;43239;43662.34506482469;44102.779486102365;42786.14427711366;43118.35322470103;43817.56182438135;43822;44768.328475073555;31767.52348714725;32233;32358.35283294368;32401.351972959936;32899.67100329062;36149.4772492264;38307.2338553233;38665.44563522578;38767.612323877525;38821.6117838818;28453.288667783472;28597.571036434885;28685.569716454687;28749.712502874703;28969.7103028967 15:39:37 INFO - PROCESS | 9052 | |2;jquery.html;411.3870333203526;417.95611460796636;426.8826072829971;427.8951656844073;430.5930895303939;18868.62262754744;19318.420447386565;20424;20459.283925062628;20738.89630551849;20071.297504587343;20358.185672573116;20461.897690511563;21033.36899893006;21142.68285975708;5836.883262334762;6116.113163591277;6119.449249567538;6120.387961203866;6124.1732366130445;5793;5898.1447690084915;5933.228680271559;5967.104934259853;6037.0642550404755;5913.674747888865;5917.437843404869;5919.49684276837;5922.703864806764;5922.792702255422;5736.254286942692;5939.910901336483;5971.373005834412;5981.162637230791;6001.609895356788;5397.379301380313;5427.348718153847;5431.158170483542;5431.538319242869;5433.049216387117;24555.38611534708;24731.876340618182;24753.5049299013;24918.127865524802;24928.626070608956;2445.501880963655;2458.2256589174353;2531.0255551612577;2702.5405681034076;2723.7140100289384;12320.630381088582;14990.100593964396;15151.772723409158;15463;15836;1999.1203870297022;2022.2416593777334;2057.753069631639;2068.7103805467245;2126.627840127987;51480;65537;76589.61705191495;79976.20023799746;80951.59524202341;11046.668599942015;11445.370504622326;11540.422978851024;11547.249428787101;11572.826407603892;16812.915935420246;16813.831861681225;16819.074950877573;16827;16846.32614695423;8257.669693212205;8410.116937721574;8471.872921906177;8533.53065581399;8577.485350878967;7948.125706172316;7978.3218426434405;8083.717069902643;8086.878696819553;8186.467879587808;6927.688254028581;6975.093237879043;7008.509404341749;7029.332213439715;7068;2012.7685316188533;2059.577786553753;2065.6808717552362;2090.686397040456;2122.904469298885;989.8069876374182;993.4287784523927;1022.4121130350078;1054.7732237568805;1058.8888166742536;20095.19619215215;20858.877432998026;20946.89526552388;20949.581008380053;21382.358529244146;1042.6455005298083;1074.2372915230274;1084.3114622214794;1108.2076315434342;1153.1754795321385;11401.372924489233;11693.649190524298;11979.161458697981;12007.699807504881;12073.698157546132;452491;452994;458964;495076;495767;48082.27876581854;57602;70882.64558677173;77941;79464.60267698625;1020.6478764826123;1064.606095744564;1064.8296272596347;1066.8079745645703;1070.4861666400172;17670.558236044202;18050.548736281697;18563.81436185675;18582.628347433245;18690.626187475904;40082.79958600305;40414.191716164925;40673.1865362697;41261.58738412698;41884.534041308405;51131.48868511267;53525.197122042424;54296.18555721588;54387.50211583754;56100.158497623386;8686.695965641173;9051.954740226256;9187.632494700138;9274.397164184576;9400.106989835955;13286.136401133896;13389.799153012907;13735.175889446666;13808.654783630489;13908.86091139116;11035.337879727242;11564.537418503165;11618.88381116178;11746.941265293619;12222.327771972272;9635;10142.746431339276;10401.739956501147;10477.476126193813;10489.947550262199;11609.941950290195;11888.643340699793;12283.57007504733;12355.93822030884;12651.93674031624;9065;9152.22206112488;9156.084391561057;9249.352545321763;9535.713928582154;11842.940785296018;12127.9084882361;12239.388030598613;12303.384830758247;12307.20003199789 15:39:37 INFO - PROCESS | 9052 | |3;mootools.html;1358.307263295719;1515.4620109860998;1547.82973872874;1699.5496193508723;1822.544363909022;7754.8836767448465;8829.690960816373;9201.355905086646;9212.585433655484;9214.354995150343;8838.646454141843;8916.687915922945;8934.419262747933;9030.68392606259;9043;2396.8921398537022;2432.659427680126;2434.8295619306655;2435.5250726108416;2436.61014237722;2375.8455700379504;2438.451348446603;2446.1193970170725;2446.290575733044;2449.1672831237374;2324.476992676651;2331.533693261346;2354.21133920137;2373.8100951923807;2387.594109001474;2291.702078729771;2306.9307920762403;2309.6650985606993;2325.4418939454495;2350.3536527455085;2294.139697613395;2318.988405057964;2336.2874323331375;2342.0865862313713;2343.121329501437;8798.868016979686;8826.382153249275;8928;8982.775430614221;8993.910060899438;5113.335266415379;5309.946900531023;5322.893542129135;5327.094393953037;5327.280817089721;3403.8638454461793;3485.721142308609;3529.29414117175;3536.5579302587175;3565.5186549815703;1092.9398883061428;1114.9163812713998;1116.2019156303281;1152.1071169843356;1162.3781277016756;12442.315672638002;12532.060095492874;12545.184563003375;12552.8117078243;12573;4262.573742625713;4499.212637788374;4554.863354099382;4555.043440877386;4587.885302867388;9889.901100989042;9904.801903962025;9906.851397229048;9911.603535858629;9912.306138570375;5330.253764472977;5335.466453354634;5337.119375303031;5338.412774594792;5344.706041167773;4130.772807495617;4333.285007973712;4375.956240437618;4473.46318441789;4997.100521906092;3947.940780888289;3968.960310396859;4062.939055914164;4065.6747460203114;4077.2660921033907;1184.798584240681;1212.9757404851853;1223.1193540650718;1234.2717796500108;1236.3879879459726;833.5207255827802;910.9569542873373;915.6154415145521;938.4088024544493;973.2360097323708;5916.526677865761;5937.851553711192;6064.575479716377;6166.105914642441;6292.087647291117;947.3747326764441;1035.8498017787379;1072.1369297715257;1094.0536435982817;1110.0952723530297;3672.265546890633;3781.004385288147;3874.1283211277237;3897.415387691869;3903.648671619511;10517.316374435637;10745.247832651796;10874.130069594414;10907.945460272647;11122.61070862516;10757.193210509244;10805.973432523897;10836.674899752863;10839.729006774895;10846.728831779268;8283.83432331362;8392.874106888401;8422.915770842335;8470.364722645703;8478.321734261368;5432.837014889559;5435.972820135874;5513.255710479194;5520.972395137998;5614.07367784311;9917.504124793588;9951.651692190739;9993.400395976265;10073.445960472245;10090.34412763168;10225.539850706587;10271.897281027394;10319.432431216355;10338.741531461774;10433.791324173322;7940.444168908121;7971.800704982422;8011.559364235023;8087.676492940216;8096.5546894921345;8539.914600853912;8618.52598107085;8637.870431943651;8641.351898607756;8645.697400590949;7563.394928405824;7737.690492380242;7859.764207073797;7913.525188488709;8050.27547520726;7459.552426854406;7541.208173141741;7602.581857997863;7607.809804754926;7625.580593067434;6730.293319201413;6902.758403456056;6953.68708408133;6954.513184077066;6972.581645101107;5255.395629502656;5320.840374788762;5351.3043304370185;5359.196120581944;5375.946240537544;5103.795848166032;5219.660722053054;5270.183121616155;5276.788928442973;5337.066013447554 15:39:37 INFO - PROCESS | 9052 | |4;prototype.html;343.1284537275321;349.16026955172816;355.87900113961246;357.1161375595401;365.8554870826024;5492.324840923522;5509.311336082979;5510.752016159272;5518.779248830042;5533.584981126412;5119.436861945183;5244.501772331632;5301.628885977973;5373.76403427212;5415.48552887476;4301.526832048487;4306.5262821089655;4309.762963037032;4317.805698743564;4331.913361732763;4284.871453856389;4286.342467670049;4296.613304802567;4317.784110794448;4318.762468064255;4028.436018957348;4201.70588058836;4219.156168766243;4227.915441691164;4294.957050429487;4203.579642035803;4207.705460617758;4212.9789351053205;4214.178235244129;4219.11398606293;3731.8134093295225;3742.0644838790304;3767.5683240368485;3774.226283611853;3792.4500947362476;5113.437521872591;5121.487851214886;5214.947850521484;5280.313559237313;5290.92063619046;4851.975740121276;4857.368542089541;4868.981231636372;4880.682755620909;4882.43851957026;5607.775688972436;5609.775608975636;5612.69130197839;5626.690532020737;5629.183768353607;4005.2590270799997;4042.191561687674;4078.4494093297617;4101.651359634435;4114.177164567069;5844.970775146139;5873.177755114288;5875.764969401219;5876.471117599393;5883.8529036774;4231.597998190167;4233.872983810491;4242.469691288589;4244.617984381421;4291.270484017725;4233.91532169361;4295.098029413858;4299.075698724727;4334.176506463762;4337.332540487578;4811.927821082687;4825.600575833039;4863.537963893425;4864.440589332201;4897.191963326082;5698.886022279614;5705.286839145107;5707.172459993278;5728.369879313273;5730.885382292331;1386.272207091285;1420.5525259543417;1431.7065001674632;1436.5977526292654;1450.6074168797861;977.5796407544824;987.9280980136632;993.7664648807524;998.4758002048983;1006.713086770267;5227.686338819683;5236.429071278601;5258.92111618326;5271.471273330768;5318.282031925718;5583.581231407579;5592.524635406036;5602.355729091125;5608.383077861432;5610.438956104357;5234.607404444682;5307.65500242483;5308.734563271821;5321.86695332612;5532.861678458071;2987.850607469618;2997.2057404787747;3008.172752493082;3009.187519369758;3009.337945651953;5807.535397168301;5810.593258471951;5825.300963884361;5870.970645146833;5886.735096920649;5554.472714914704;5746.310442746897;5754.07238575082;5768.278965129359;5806.0099048989805;5786.652800831964;5788.594798364074;5807.303123625192;5820.883582328414;5890.410958904161;5352.678839269656;5625.268715067015;5647.407022262603;5653.915191272052;5666.744996475251;5562.916556251578;5569.972150139223;5576.275084239023;5576.302962129734;5579.684430961268;5789.407912824007;5798.942010580009;5830.591858570029;5859.2382990211;5866.530677545871;3922.7057970651745;4002.3196056669854;4023.2758103540473;4089;4110.835566577303;5656.462636049569;5668.631538949955;5688.800891968761;5691.203231547669;5692.658440493584;5674.290713660793;5678.608740858516;5686.857828554319;5698;5701.40135285789;5421.241026256248;5677.176809362537;5703.287089113861;5715.771369145187;5746.281714785652;5689.914651280152;5692.658440493584;5746.454086861741;5765.106408506688;5772.682502462405;5646.576506761927;5706.343770466449;5767.711614419346;5770.50950669181;5778.8266352009505;5623.8875222496135;5644.491995720405;5666.603337766317;5675.545956323567;5688.203651488878 15:39:37 INFO - PROCESS | 9052 | |5;yui.html;812.7968007998004;812.9959500017482;838.7777239031656;844.6410275632854;893.4639216470123;13860.099093558913;15180.924095379507;15188.164650944194;15299.694006119871;15493.612659683513;14234.71530569388;14488.637784055403;15090.698186036272;15250.771238431433;15322.080675159497;739.0835364148444;855.4311382930359;873.2097451806126;873.7509809704236;875.439718580106;743.7396911081132;853.479377579679;860.1699360117485;874.5845723281423;880.9603567839431;912.4342907397423;923.376720713519;930.4882314726907;930.6510058727977;932.1657116880388;921.1111277617065;922.9077092290785;925.6390007896925;926.3793258516777;929.5770424456856;674.4233680203405;675.9324067593251;678.1624693503519;678.7217240931194;681.0635376357509;14830.629234269121;14833;14843.332050057774;14898.478553250692;16157;14057.422525164453;14466;14659.560213193621;14748.852511474963;14849.183294918776;11775.470103845262;11862.347570883598;12215.206011609216;12240.755184896252;12463;3875.069983204039;3903.6486716195395;3937.6062393760394;3939.940900886489;3942.763434193929;70456.29543704548;70985;71566.28433715648;72270.27729722689;72321.27678723198;11243.269187502787;11359.772804543863;11411.885881141248;11452.255603385753;11741.412929353499;20143.29498467576;20148.19407223724;20173.798262017484;20182.293619723532;20308.492287692927;7884.17216192303;7981.72063977758;8056.234657707509;8158.632861521246;8250.298724608476;4627.6529260305615;4632.16621008215;4695.741734204583;4718.05638872227;4752.881177970509;3421.9486707699402;3493.8602455901987;3499.825008749552;3537.7346698997676;3547;606.8209878085976;611.3550204534259;612.5895649914568;612.9724162412703;613.6624856329001;624.5253607258517;688.50771698235;712.3944647049966;748.8015675845905;761.7219714804056;9043.366964312567;9857.35927164732;9944.80110397788;10016.348937319051;10023.14803241718;684.9178098628197;692.4425837201102;757.8484303139284;758.742027710581;776.7436745873848;4576.6109880660515;4676.883077923079;4766.856994290177;4813.4945830687975;4819.9759001205475;56774.71612641993;82916;91527;95715.52142239244;98439;78644;80243;80626.5968670153;82821;84570;71634.64182679054;71791.2820871795;71927;72039;73011.2698873015;8486.40595158333;8848.690295839615;9010.81978360416;9346.392484488486;9422.152006319464;51620.48379516157;51712.224316636035;52451.90278777588;52870.735646321526;53569.73215133899;54238.457615423344;54471.18293225526;61068.38931610627;63216.68391658012;64164.03753943601;12992.545260915822;13024.413901374272;13380.665483362995;13513.594592162252;13630.250336231205;14700.485483008044;14766.852331476548;14829.777553336924;15866;16125.919370403073;13634.659133521742;13741.587752367444;14199.929000355345;14288.142711437347;14756.63108422298;12188.817167742669;13557.932210338886;13849.792253116413;13854.584362469142;14450.638734031734;13646;13711.451541938211;13794.103383280055;13908.930455347658;13961.441542338192;10747.89252107469;11454.770904582028;11474.598389056342;11733.706657333634;11744;11017.228793984345;11359.48882300315;11412;11416.265995822134;11579.42102894835 15:39:37 INFO - PROCESS | 9052 | __end_tp_report 15:39:37 INFO - PROCESS | 9052 | __start_cc_report 15:39:37 INFO - PROCESS | 9052 | _x_x_mozilla_cycle_collect,938 15:39:37 INFO - PROCESS | 9052 | __end_cc_report 15:39:37 INFO - PROCESS | 9052 | __startTimestamp1485560377457__endTimestamp 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | ------- Summary: start ------- 15:39:37 INFO - PROCESS | 9052 | Number of tests: 6 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | [#0] dojo.html Cycles:165 Average:5683.17 Median:5909.59 stddev:636.79 (10.8%) stddev-sans-first:609.74 15:39:37 INFO - PROCESS | 9052 | Values: 3261.2 3303.2 3317.0 3326.7 3338.9 5666.4 5755.0 5764.0 5765.5 5789.7 5739.4 5784.1 5788.0 5794.2 5797.6 5231.1 5232.2 5252.2 5263.7 5310.3 5099.6 5299.1 5306.7 5327.8 5351.2 5099.8 5162.5 5180.9 5188.7 5208.0 5224.5 5244.1 5269.4 5318.7 5327.5 5182.0 5204.6 5276.2 5286.7 5302.7 5491.1 5553.0 5607.4 5626.4 5638.0 5919.1 5945.7 5957.7 6031.7 6043.1 6088.5 6090.9 6095.7 6100.1 6109.6 5539.8 5574.0 5622.6 5684.8 5823.0 6289.7 6321.7 6337.2 6337.8 6348.7 6052.8 6060.7 6064.3 6070.2 6078.6 5948.3 5996.8 6008.9 6045.1 6137.4 6050.5 6056.2 6071.7 6094.8 6099.7 6030.1 6035.8 6053.1 6082.1 6086.4 4626.1 4665.9 4681.3 4692.7 4697.0 4175.9 4218.5 4227.0 4245.6 4266.4 5869.4 5874.7 5878.5 5879.1 5902.1 5969.4 6056.7 6220.5 6231.5 6238.9 5625.9 5739.4 5750.7 5808.0 5837.0 5226.3 5254.0 5260.4 5268.0 5274.8 6142.6 6271.0 6312.5 6337.3 6339.4 6027.5 6115.5 6145.3 6147.0 6235.9 6434.2 6435.4 6436.4 6442.2 6450.2 6089.6 6096.1 6099.0 6099.2 6100.1 5907.5 6023.7 6040.8 6068.2 6086.9 5976.0 5977.9 5981.9 5986.5 5992.3 5955.3 5959.8 5964.1 5967.7 5970.4 5751.3 5832.2 5852.2 5901.4 5961.7 5988.5 6024.8 6041.4 6058.2 6082.0 5672.1 5898.8 5909.6 5912.1 5918.8 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | [#1] ext.html Cycles:180 Average:58941.42 Median:201908.24 stddev:112935.73 (55.9%) stddev-sans-first:113167.53 15:39:37 INFO - PROCESS | 9052 | Values: 579.9 616.7 638.1 661.1 662.5 34340.1 45028.3 46340.5 46411.5 46459.3 47081.3 47635.5 47651.8 47702.8 47768.3 8313.4 8497.1 8986.3 9134.4 9157.5 10686.8 10941.3 10951.7 11295.7 11299.2 11145.4 11224.8 11226.9 11230.6 11232.4 10942.7 10997.3 11000.1 11002.2 11005.7 11066.9 11089.4 11126.5 11129.9 11129.9 45415.0 45575.8 45765.3 45778.7 45886.8 3719.8 4064.2 4364.3 4425.3 4426.5 32322.4 32925.8 33088.7 33287.0 34881.1 4204.6 4232.7 4273.7 4283.1 4388.7 335216.0 338700.0 339210.0 340558.0 340797.0 64669.0 64784.4 64918.0 65065.4 65120.3 40618.0 41547.6 41696.0 43475.6 43492.0 16703.2 16897.2 16897.5 16912.8 16933.7 11853.5 12077.8 12603.7 12856.7 13098.8 21199.8 21323.8 21374.0 21465.1 21497.7 7518.3 7530.8 7551.5 7586.9 7625.6 982.9 1046.4 1080.1 1114.5 1135.8 32792.3 33165.7 33193.5 33302.7 33476.3 1137.2 1152.6 1173.4 1180.5 1234.8 17560.0 17753.0 17828.9 17881.4 17924.8 539736.0 541407.0 544402.0 545044.0 545340.0 61945.4 62269.4 62289.7 62319.0 62389.4 1267.8 1345.1 1386.5 1420.9 1426.0 32625.7 33838.3 34422.5 34501.0 34580.0 53462.7 53942.2 53986.7 54108.5 54109.5 367667.0 369538.0 370547.0 370644.0 371324.0 29857.0 30248.5 30535.4 30860.5 30991.2 49974.0 50325.7 51041.0 51059.5 52011.5 41006.8 42921.4 43239.0 43662.3 44102.8 42786.1 43118.4 43817.6 43822.0 44768.3 31767.5 32233.0 32358.4 32401.4 32899.7 36149.5 38307.2 38665.4 38767.6 38821.6 28453.3 28597.6 28685.6 28749.7 28969.7 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | [#2] jquery.html Cycles:180 Average:27891.33 Median:24742.69 stddev:77112.06 (311.7%) stddev-sans-first:77300.77 15:39:37 INFO - PROCESS | 9052 | Values: 411.4 418.0 426.9 427.9 430.6 18868.6 19318.4 20424.0 20459.3 20738.9 20071.3 20358.2 20461.9 21033.4 21142.7 5836.9 6116.1 6119.4 6120.4 6124.2 5793.0 5898.1 5933.2 5967.1 6037.1 5913.7 5917.4 5919.5 5922.7 5922.8 5736.3 5939.9 5971.4 5981.2 6001.6 5397.4 5427.3 5431.2 5431.5 5433.0 24555.4 24731.9 24753.5 24918.1 24928.6 2445.5 2458.2 2531.0 2702.5 2723.7 12320.6 14990.1 15151.8 15463.0 15836.0 1999.1 2022.2 2057.8 2068.7 2126.6 51480.0 65537.0 76589.6 79976.2 80951.6 11046.7 11445.4 11540.4 11547.2 11572.8 16812.9 16813.8 16819.1 16827.0 16846.3 8257.7 8410.1 8471.9 8533.5 8577.5 7948.1 7978.3 8083.7 8086.9 8186.5 6927.7 6975.1 7008.5 7029.3 7068.0 2012.8 2059.6 2065.7 2090.7 2122.9 989.8 993.4 1022.4 1054.8 1058.9 20095.2 20858.9 20946.9 20949.6 21382.4 1042.6 1074.2 1084.3 1108.2 1153.2 11401.4 11693.6 11979.2 12007.7 12073.7 452491.0 452994.0 458964.0 495076.0 495767.0 48082.3 57602.0 70882.6 77941.0 79464.6 1020.6 1064.6 1064.8 1066.8 1070.5 17670.6 18050.5 18563.8 18582.6 18690.6 40082.8 40414.2 40673.2 41261.6 41884.5 51131.5 53525.2 54296.2 54387.5 56100.2 8686.7 9052.0 9187.6 9274.4 9400.1 13286.1 13389.8 13735.2 13808.7 13908.9 11035.3 11564.5 11618.9 11746.9 12222.3 9635.0 10142.7 10401.7 10477.5 10489.9 11609.9 11888.6 12283.6 12355.9 12651.9 9065.0 9152.2 9156.1 9249.4 9535.7 11842.9 12127.9 12239.4 12303.4 12307.2 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | [#3] mootools.html Cycles:180 Average:5813.57 Median:5050.45 stddev:3305.12 (65.4%) stddev-sans-first:3297.43 15:39:37 INFO - PROCESS | 9052 | Values: 1358.3 1515.5 1547.8 1699.5 1822.5 7754.9 8829.7 9201.4 9212.6 9214.4 8838.6 8916.7 8934.4 9030.7 9043.0 2396.9 2432.7 2434.8 2435.5 2436.6 2375.8 2438.5 2446.1 2446.3 2449.2 2324.5 2331.5 2354.2 2373.8 2387.6 2291.7 2306.9 2309.7 2325.4 2350.4 2294.1 2319.0 2336.3 2342.1 2343.1 8798.9 8826.4 8928.0 8982.8 8993.9 5113.3 5309.9 5322.9 5327.1 5327.3 3403.9 3485.7 3529.3 3536.6 3565.5 1092.9 1114.9 1116.2 1152.1 1162.4 12442.3 12532.1 12545.2 12552.8 12573.0 4262.6 4499.2 4554.9 4555.0 4587.9 9889.9 9904.8 9906.9 9911.6 9912.3 5330.3 5335.5 5337.1 5338.4 5344.7 4130.8 4333.3 4376.0 4473.5 4997.1 3947.9 3969.0 4062.9 4065.7 4077.3 1184.8 1213.0 1223.1 1234.3 1236.4 833.5 911.0 915.6 938.4 973.2 5916.5 5937.9 6064.6 6166.1 6292.1 947.4 1035.8 1072.1 1094.1 1110.1 3672.3 3781.0 3874.1 3897.4 3903.6 10517.3 10745.2 10874.1 10907.9 11122.6 10757.2 10806.0 10836.7 10839.7 10846.7 8283.8 8392.9 8422.9 8470.4 8478.3 5432.8 5436.0 5513.3 5521.0 5614.1 9917.5 9951.7 9993.4 10073.4 10090.3 10225.5 10271.9 10319.4 10338.7 10433.8 7940.4 7971.8 8011.6 8087.7 8096.6 8539.9 8618.5 8637.9 8641.4 8645.7 7563.4 7737.7 7859.8 7913.5 8050.3 7459.6 7541.2 7602.6 7607.8 7625.6 6730.3 6902.8 6953.7 6954.5 6972.6 5255.4 5320.8 5351.3 5359.2 5375.9 5103.8 5219.7 5270.2 5276.8 5337.1 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | [#4] prototype.html Cycles:180 Average:4746.13 Median:5418.36 stddev:1373.84 (25.4%) stddev-sans-first:1337.36 15:39:37 INFO - PROCESS | 9052 | Values: 343.1 349.2 355.9 357.1 365.9 5492.3 5509.3 5510.8 5518.8 5533.6 5119.4 5244.5 5301.6 5373.8 5415.5 4301.5 4306.5 4309.8 4317.8 4331.9 4284.9 4286.3 4296.6 4317.8 4318.8 4028.4 4201.7 4219.2 4227.9 4295.0 4203.6 4207.7 4213.0 4214.2 4219.1 3731.8 3742.1 3767.6 3774.2 3792.5 5113.4 5121.5 5214.9 5280.3 5290.9 4852.0 4857.4 4869.0 4880.7 4882.4 5607.8 5609.8 5612.7 5626.7 5629.2 4005.3 4042.2 4078.4 4101.7 4114.2 5845.0 5873.2 5875.8 5876.5 5883.9 4231.6 4233.9 4242.5 4244.6 4291.3 4233.9 4295.1 4299.1 4334.2 4337.3 4811.9 4825.6 4863.5 4864.4 4897.2 5698.9 5705.3 5707.2 5728.4 5730.9 1386.3 1420.6 1431.7 1436.6 1450.6 977.6 987.9 993.8 998.5 1006.7 5227.7 5236.4 5258.9 5271.5 5318.3 5583.6 5592.5 5602.4 5608.4 5610.4 5234.6 5307.7 5308.7 5321.9 5532.9 2987.9 2997.2 3008.2 3009.2 3009.3 5807.5 5810.6 5825.3 5871.0 5886.7 5554.5 5746.3 5754.1 5768.3 5806.0 5786.7 5788.6 5807.3 5820.9 5890.4 5352.7 5625.3 5647.4 5653.9 5666.7 5562.9 5570.0 5576.3 5576.3 5579.7 5789.4 5798.9 5830.6 5859.2 5866.5 3922.7 4002.3 4023.3 4089.0 4110.8 5656.5 5668.6 5688.8 5691.2 5692.7 5674.3 5678.6 5686.9 5698.0 5701.4 5421.2 5677.2 5703.3 5715.8 5746.3 5689.9 5692.7 5746.5 5765.1 5772.7 5646.6 5706.3 5767.7 5770.5 5778.8 5623.9 5644.5 5666.6 5675.5 5688.2 15:39:37 INFO - PROCESS | 9052 | 15:39:37 INFO - PROCESS | 9052 | [#5] yui.html Cycles:180 Average:18580.56 Median:4816.74 stddev:24457.98 (507.8%) stddev-sans-first:24490.20 15:39:37 INFO - PROCESS | 9052 | Values: 812.8 813.0 838.8 844.6 893.5 13860.1 15180.9 15188.2 15299.7 15493.6 14234.7 14488.6 15090.7 15250.8 15322.1 739.1 855.4 873.2 873.8 875.4 743.7 853.5 860.2 874.6 881.0 912.4 923.4 930.5 930.7 932.2 921.1 922.9 925.6 926.4 929.6 674.4 675.9 678.2 678.7 681.1 14830.6 14833.0 14843.3 14898.5 16157.0 14057.4 14466.0 14659.6 14748.9 14849.2 11775.5 11862.3 12215.2 12240.8 12463.0 3875.1 3903.6 3937.6 3939.9 3942.8 70456.3 70985.0 71566.3 72270.3 72321.3 11243.3 11359.8 11411.9 11452.3 11741.4 20143.3 20148.2 20173.8 20182.3 20308.5 7884.2 7981.7 8056.2 8158.6 8250.3 4627.7 4632.2 4695.7 4718.1 4752.9 3421.9 3493.9 3499.8 3537.7 3547.0 606.8 611.4 612.6 613.0 613.7 624.5 688.5 712.4 748.8 761.7 9043.4 9857.4 9944.8 10016.3 10023.1 684.9 692.4 757.8 758.7 776.7 4576.6 4676.9 4766.9 4813.5 4820.0 56774.7 82916.0 91527.0 95715.5 98439.0 78644.0 80243.0 80626.6 82821.0 84570.0 71634.6 71791.3 71927.0 72039.0 73011.3 8486.4 8848.7 9010.8 9346.4 9422.2 51620.5 51712.2 52451.9 52870.7 53569.7 54238.5 54471.2 61068.4 63216.7 64164.0 12992.5 13024.4 13380.7 13513.6 13630.3 14700.5 14766.9 14829.8 15866.0 16125.9 13634.7 13741.6 14199.9 14288.1 14756.6 12188.8 13557.9 13849.8 13854.6 14450.6 13646.0 13711.5 13794.1 13908.9 13961.4 10747.9 11454.8 11474.6 11733.7 11744.0 11017.2 11359.5 11412.0 11416.3 11579.4 15:39:37 INFO - PROCESS | 9052 | -------- Summary: end -------- 15:39:37 INFO - PROCESS | 9052 | 15:39:38 INFO - TEST-INFO | 9052: exit 0 15:39:38 INFO - TEST-OK | dromaeo_css | took 1114240ms 15:39:38 INFO - TEST-START | kraken 15:39:38 INFO - operating with platform_type : linux_ 15:39:38 INFO - Initialising browser for kraken test... 15:39:38 INFO - TEST-INFO | started process 9356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbLYigu/profile http://localhost:51081/getInfo.html) 15:39:41 INFO - PROCESS | 9356 | __metrics Screen width/height:1600/1200 15:39:41 INFO - PROCESS | 9356 | colorDepth:24 15:39:41 INFO - PROCESS | 9356 | Browser inner width/height: 1024/697 15:39:41 INFO - PROCESS | 9356 | __metrics 15:39:42 INFO - PROCESS | 9356 | 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" 15:39:42 INFO - PROCESS | 9356 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:39:43 INFO - PROCESS | 9356 | console.error: PushService: 15:39:43 INFO - PROCESS | 9356 | stateChangeProcessEnqueue: Error transitioning state 15:39:43 INFO - PROCESS | 9356 | UnknownError 15:39:43 INFO - TEST-INFO | 9356: exit 0 15:39:43 INFO - Browser initialized. 15:39:43 INFO - Running cycle 1/1 for kraken test... 15:39:43 INFO - TEST-INFO | started process 9452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbLYigu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:55 INFO - PROCESS | 9452 | RSS: Main: 141344768 15:39:55 INFO - PROCESS | 9452 | 15:39:57 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51081/tests/kraken/driver.html?testName=audio-beat-detection) 15:39:58 INFO - PROCESS | 9452 | RSS: Main: 183246848 15:39:58 INFO - PROCESS | 9452 | 15:40:01 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51081/tests/kraken/driver.html?testName=audio-dft) 15:40:01 INFO - PROCESS | 9452 | RSS: Main: 172380160 15:40:01 INFO - PROCESS | 9452 | 15:40:04 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51081/tests/kraken/driver.html?testName=audio-fft) 15:40:05 INFO - PROCESS | 9452 | RSS: Main: 264171520 15:40:05 INFO - PROCESS | 9452 | 15:40:07 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51081/tests/kraken/driver.html?testName=audio-oscillator) 15:40:07 INFO - PROCESS | 9452 | RSS: Main: 171716608 15:40:07 INFO - PROCESS | 9452 | 15:40:10 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:40:10 INFO - PROCESS | 9452 | RSS: Main: 172892160 15:40:10 INFO - PROCESS | 9452 | 15:40:13 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51081/tests/kraken/driver.html?testName=imaging-darkroom) 15:40:14 INFO - PROCESS | 9452 | RSS: Main: 212168704 15:40:14 INFO - PROCESS | 9452 | 15:40:17 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51081/tests/kraken/driver.html?testName=imaging-desaturate) 15:40:18 INFO - PROCESS | 9452 | RSS: Main: 210575360 15:40:18 INFO - PROCESS | 9452 | 15:40:20 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51081/tests/kraken/driver.html?testName=json-parse-financial) 15:40:21 INFO - PROCESS | 9452 | RSS: Main: 209813504 15:40:21 INFO - PROCESS | 9452 | 15:40:22 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:40:23 INFO - PROCESS | 9452 | RSS: Main: 171737088 15:40:23 INFO - PROCESS | 9452 | 15:40:25 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:40:25 INFO - PROCESS | 9452 | RSS: Main: 179093504 15:40:25 INFO - PROCESS | 9452 | 15:40:27 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:40:28 INFO - PROCESS | 9452 | RSS: Main: 188051456 15:40:28 INFO - PROCESS | 9452 | 15:40:30 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:40:31 INFO - PROCESS | 9452 | RSS: Main: 196407296 15:40:31 INFO - PROCESS | 9452 | 15:40:34 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:40:34 INFO - PROCESS | 9452 | RSS: Main: 192573440 15:40:34 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:51081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51081/tests/kraken/driver.html?testName=ai-astar) 15:40:36 INFO - PROCESS | 9452 | RSS: Main: 244428800 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | __start_tp_report 15:40:36 INFO - PROCESS | 9452 | _x_x_mozilla_page_load 15:40:36 INFO - PROCESS | 9452 | _x_x_mozilla_page_load_details 15:40:36 INFO - PROCESS | 9452 | |i|pagename|runs| 15:40:36 INFO - PROCESS | 9452 | |0;ai-astar;106;115;111;111;113;112;111;114;112;112 15:40:36 INFO - PROCESS | 9452 | |1;audio-beat-detection;153;118;119;161;119;122;116;118;147;120 15:40:36 INFO - PROCESS | 9452 | |2;audio-dft;160;162;162;160;161;161;163;160;161;161 15:40:36 INFO - PROCESS | 9452 | |3;audio-fft;75;77;77;104;77;77;75;76;96;76 15:40:36 INFO - PROCESS | 9452 | |4;audio-oscillator;82;82;123;81;83;82;101;81;81;110 15:40:36 INFO - PROCESS | 9452 | |5;imaging-gaussian-blur;117;117;117;119;118;119;118;116;117;117 15:40:36 INFO - PROCESS | 9452 | |6;imaging-darkroom;147;147;147;146;147;147;147;146;146;147 15:40:36 INFO - PROCESS | 9452 | |7;imaging-desaturate;86;85;85;86;85;85;85;84;84;85 15:40:36 INFO - PROCESS | 9452 | |8;json-parse-financial;53;50;49;50;48;51;50;51;50;50 15:40:36 INFO - PROCESS | 9452 | |9;json-stringify-tinderbox;57;61;58;58;60;58;59;58;58;59 15:40:36 INFO - PROCESS | 9452 | |10;stanford-crypto-aes;76;74;75;83;76;75;81;75;74;74 15:40:36 INFO - PROCESS | 9452 | |11;stanford-crypto-ccm;143;124;123;121;140;129;127;120;159;122 15:40:36 INFO - PROCESS | 9452 | |12;stanford-crypto-pbkdf2;156;163;156;154;158;160;156;160;158;158 15:40:36 INFO - PROCESS | 9452 | |13;stanford-crypto-sha256-iterative;64;65;63;62;63;63;66;62;63;61 15:40:36 INFO - PROCESS | 9452 | __end_tp_report 15:40:36 INFO - PROCESS | 9452 | __start_cc_report 15:40:36 INFO - PROCESS | 9452 | _x_x_mozilla_cycle_collect,1550 15:40:36 INFO - PROCESS | 9452 | __end_cc_report 15:40:36 INFO - PROCESS | 9452 | __startTimestamp1485560436694__endTimestamp 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | ------- Summary: start ------- 15:40:36 INFO - PROCESS | 9452 | Number of tests: 14 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:2.41 (2.1%) stddev-sans-first:1.41 15:40:36 INFO - PROCESS | 9452 | Values: 106.0 115.0 111.0 111.0 113.0 112.0 111.0 114.0 112.0 112.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:121.00 stddev:17.20 (14.2%) stddev-sans-first:15.97 15:40:36 INFO - PROCESS | 9452 | Values: 153.0 118.0 119.0 161.0 119.0 122.0 116.0 118.0 147.0 120.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 15:40:36 INFO - PROCESS | 9452 | Values: 160.0 162.0 162.0 160.0 161.0 161.0 163.0 160.0 161.0 161.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#3] audio-fft Cycles:10 Average:81.00 Median:77.00 stddev:10.22 (13.3%) stddev-sans-first:10.61 15:40:36 INFO - PROCESS | 9452 | Values: 75.0 77.0 77.0 104.0 77.0 77.0 75.0 76.0 96.0 76.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:15.24 (18.7%) stddev-sans-first:15.84 15:40:36 INFO - PROCESS | 9452 | Values: 82.0 82.0 123.0 81.0 83.0 82.0 101.0 81.0 81.0 110.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 15:40:36 INFO - PROCESS | 9452 | Values: 117.0 117.0 117.0 119.0 118.0 119.0 118.0 116.0 117.0 117.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:40:36 INFO - PROCESS | 9452 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 15:40:36 INFO - PROCESS | 9452 | Values: 86.0 85.0 85.0 86.0 85.0 85.0 85.0 84.0 84.0 85.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:1.32 (2.6%) stddev-sans-first:0.93 15:40:36 INFO - PROCESS | 9452 | Values: 53.0 50.0 49.0 50.0 48.0 51.0 50.0 51.0 50.0 50.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.50 stddev:1.17 (2.0%) stddev-sans-first:1.09 15:40:36 INFO - PROCESS | 9452 | Values: 57.0 61.0 58.0 58.0 60.0 58.0 59.0 58.0 58.0 59.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:3.13 (4.1%) stddev-sans-first:3.32 15:40:36 INFO - PROCESS | 9452 | Values: 76.0 74.0 75.0 83.0 76.0 75.0 81.0 75.0 74.0 74.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:128.00 stddev:12.66 (9.9%) stddev-sans-first:12.64 15:40:36 INFO - PROCESS | 9452 | Values: 143.0 124.0 123.0 121.0 140.0 129.0 127.0 120.0 159.0 122.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:158.00 stddev:2.60 (1.6%) stddev-sans-first:2.67 15:40:36 INFO - PROCESS | 9452 | Values: 156.0 163.0 156.0 154.0 158.0 160.0 156.0 160.0 158.0 158.0 15:40:36 INFO - PROCESS | 9452 | 15:40:36 INFO - PROCESS | 9452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.54 15:40:36 INFO - PROCESS | 9452 | Values: 64.0 65.0 63.0 62.0 63.0 63.0 66.0 62.0 63.0 61.0 15:40:36 INFO - PROCESS | 9452 | -------- Summary: end -------- 15:40:36 INFO - PROCESS | 9452 | 15:40:37 INFO - TEST-INFO | 9452: exit 0 15:40:37 INFO - TEST-OK | kraken | took 59639ms 15:40:37 INFO - SUITE-END | took 1173s 15:40:37 INFO - Completed test suite (00:19:33) 15:40:37 INFO - javascript benchmark 15:40:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3261.217307846117, 3303.15769478783, 3316.9668303316957, 3326.7005969462775, 3338.916527086824, 5666.405027472113, 5755.021646320125, 5764.048931926227, 5765.481106700396, 5789.652620842747, 5739.368669446368, 5784.13238014297, 5788.0, 5794.188813566094, 5797.594168408213, 5231.084560201968, 5232.16285394337, 5252.159654455288, 5263.657862238962, 5310.283111779918, 5099.617528685345, 5299.12564426871, 5306.681599104066, 5327.840164795062, 5351.17056856186, 5099.847004589849, 5162.5095615916425, 5180.948190518085, 5188.688678679291, 5208.036513245042, 5224.529792318672, 5244.082285600005, 5269.420363759983, 5318.707471089088, 5327.493888080626, 5181.989512045153, 5204.583633309327, 5276.182191760283, 5286.656367336111, 5302.670815830066, 5491.121420572729, 5553.0, 5607.411221821691, 5626.352969408529, 5638.013347664142, 5919.112133180014, 5945.702714864283, 5957.672328021957, 6031.728572214261, 6043.123747056696, 6088.482478989291, 6090.908636370458, 6095.695215239265, 6100.115483254903, 6109.633421994695, 5539.806106786284, 5573.996680597531, 5622.634528755618, 5684.8294551163535, 5823.039198532279, 6289.7169627366875, 6321.747130114836, 6337.207849018872, 6337.809865704036, 6348.714307856158, 6052.818415447544, 6060.666663333471, 6064.332923378425, 6070.150178974947, 6078.6048906820915, 5948.2862056553495, 5996.790112346047, 6008.909866352008, 6045.093236014633, 6137.386261373917, 6050.546209034252, 6056.242969628796, 6071.726772295257, 6094.847628809227, 6099.664518451527, 6030.065339872239, 6035.758569657164, 6053.061775424816, 6082.118092876508, 6086.421789929949, 4626.1210370029585, 4665.86002419928, 4681.344611754357, 4692.694974826625, 4696.976515117402, 4175.874723758292, 4218.514870789837, 4227.027783609787, 4245.639120674716, 4266.402703621496, 5869.413058694096, 5874.676892770939, 5878.470937615635, 5879.147523609138, 5902.055671092605, 5969.3732158122775, 6056.666883321372, 6220.533459990428, 6231.470325022424, 6238.937610623836, 5625.8593535161945, 5739.426057394311, 5750.654960702372, 5808.041673123887, 5836.970815145897, 5226.268322434862, 5253.975474782381, 5260.368755749335, 5268.025415298182, 5274.841754747364, 6142.560166306704, 6271.027990661363, 6312.4634406076, 6337.302896681269, 6339.429451349309, 6027.547933904887, 6115.510759139169, 6145.310039739107, 6147.0, 6235.906461403173, 6434.163558737334, 6435.388638079375, 6436.420722135031, 6442.194725659293, 6450.161479007699, 6089.634621922522, 6096.055111457731, 6099.0, 6099.207103076572, 6100.054491553817, 5907.527397808251, 6023.728932197974, 6040.7583696651645, 6068.180795592539, 6086.908696369469, 5976.043832986701, 5977.9402205977385, 5981.880362392641, 5986.491148252448, 5992.280926288873, 5955.285365756137, 5959.761609535743, 5964.105384192406, 5967.671778052075, 5970.402959703995, 5751.252337196138, 5832.1543376209365, 5852.209951656472, 5901.350851406256, 5961.731722072604, 5988.461038506555, 6024.819255422344, 6041.365656606169, 6058.182145410313, 6082.026875699867, 5672.064109422065, 5898.764049437975, 5909.5863289569315, 5912.083627037816, 5918.763249469973], "value": 5640.67864438582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8898209340225, 616.657754946005, 638.1130228981715, 661.1273119482286, 662.4634046422395, 34340.1414964626, 45028.3245751314, 46340.536594634046, 46411.53588464114, 46459.30311045337, 47081.29378059332, 47635.52364476354, 47651.76174119124, 47702.76148619252, 47768.28347574789, 8313.376496762738, 8497.107803680618, 8986.2810975122, 9134.36059475837, 9157.45055296681, 10686.839697404544, 10941.343519388822, 10951.671449856518, 11295.717607059849, 11299.152563557725, 11145.387003714792, 11224.775504489906, 11226.887731122706, 11230.606928757496, 11232.438378081104, 10942.726431839188, 10997.34015959045, 11000.119990400788, 11002.229843910929, 11005.669829905115, 11066.889331106666, 11089.390083545402, 11126.499307531181, 11129.888701112966, 11129.888701113046, 45415.0, 45575.77212113918, 45765.31352029689, 45778.71106444698, 45886.77056614729, 3719.7910679029424, 4064.2074795414906, 4364.2798938175165, 4425.291953287458, 4426.535213802536, 32322.35355292881, 32925.83537082323, 33088.66911330904, 33287.0, 34881.12797180091, 4204.600562946515, 4232.661387089056, 4273.743575385487, 4283.100548884707, 4388.71473354231, 335215.99999999756, 338700.0, 339210.0, 340558.0, 340797.0, 64669.0, 64784.35215647877, 64918.0, 65065.421401823354, 65120.34879651238, 40618.0, 41547.584524154976, 41696.0, 43475.56524434715, 43492.0, 16703.248353824107, 16897.155142243086, 16897.493075207763, 16912.830871691127, 16933.661326773643, 11853.525858965717, 12077.75844483123, 12603.684907877194, 12856.678583035498, 13098.803517947239, 21199.78800212009, 21323.78676213218, 21373.96947290005, 21465.141394344362, 21497.67753483699, 7518.28576285252, 7530.849383012419, 7551.546907185587, 7586.924130758732, 7625.618719064025, 982.9262805289488, 1046.3669479964665, 1080.1259814222317, 1114.5374669512223, 1135.7501349703052, 32792.28837200075, 33165.66834331674, 33193.502097468554, 33302.666973330444, 33476.33047339039, 1137.2494153858413, 1152.625396746044, 1173.3879588518757, 1180.451090243041, 1234.7777400067894, 17560.0, 17753.0, 17828.910855445898, 17881.37415190462, 17924.820751792315, 539736.0, 541407.0, 544402.0, 545044.0, 545340.0, 61945.380546194865, 62269.37730622636, 62289.68855155695, 62319.0, 62389.37610623836, 1267.7591257661015, 1345.1391109689807, 1386.5424409944694, 1420.936057877398, 1425.950091746784, 32625.673743262265, 33838.32323353568, 34422.48366274558, 34501.0, 34580.0, 53462.73268633632, 53942.19086713781, 53986.73006634942, 54108.45891541192, 54109.458905412015, 367667.0, 369538.0, 370547.0, 370644.0, 371324.0, 29857.0, 30248.54627180638, 30535.389292214477, 30860.537091943188, 30991.225219368793, 49974.0, 50325.74837125791, 51041.0, 51059.48940510696, 52011.479885200664, 41006.79496602498, 42921.35617965671, 43239.0, 43662.34506482469, 44102.779486102365, 42786.14427711366, 43118.35322470103, 43817.56182438135, 43822.0, 44768.328475073555, 31767.52348714725, 32233.0, 32358.35283294368, 32401.351972959936, 32899.67100329062, 36149.4772492264, 38307.2338553233, 38665.44563522578, 38767.612323877525, 38821.6117838818, 28453.288667783472, 28597.571036434885, 28685.569716454687, 28749.712502874703, 28969.7103028967], "value": 20949.864325873707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.3870333203526, 417.95611460796636, 426.8826072829971, 427.8951656844073, 430.5930895303939, 18868.62262754744, 19318.420447386565, 20424.0, 20459.283925062628, 20738.89630551849, 20071.297504587343, 20358.185672573116, 20461.897690511563, 21033.36899893006, 21142.68285975708, 5836.883262334762, 6116.113163591277, 6119.449249567538, 6120.387961203866, 6124.1732366130445, 5793.0, 5898.1447690084915, 5933.228680271559, 5967.104934259853, 6037.0642550404755, 5913.674747888865, 5917.437843404869, 5919.49684276837, 5922.703864806764, 5922.792702255422, 5736.254286942692, 5939.910901336483, 5971.373005834412, 5981.162637230791, 6001.609895356788, 5397.379301380313, 5427.348718153847, 5431.158170483542, 5431.538319242869, 5433.049216387117, 24555.38611534708, 24731.876340618182, 24753.5049299013, 24918.127865524802, 24928.626070608956, 2445.501880963655, 2458.2256589174353, 2531.0255551612577, 2702.5405681034076, 2723.7140100289384, 12320.630381088582, 14990.100593964396, 15151.772723409158, 15463.0, 15836.0, 1999.1203870297022, 2022.2416593777334, 2057.753069631639, 2068.7103805467245, 2126.627840127987, 51480.0, 65537.0, 76589.61705191495, 79976.20023799746, 80951.59524202341, 11046.668599942015, 11445.370504622326, 11540.422978851024, 11547.249428787101, 11572.826407603892, 16812.915935420246, 16813.831861681225, 16819.074950877573, 16827.0, 16846.32614695423, 8257.669693212205, 8410.116937721574, 8471.872921906177, 8533.53065581399, 8577.485350878967, 7948.125706172316, 7978.3218426434405, 8083.717069902643, 8086.878696819553, 8186.467879587808, 6927.688254028581, 6975.093237879043, 7008.509404341749, 7029.332213439715, 7068.0, 2012.7685316188533, 2059.577786553753, 2065.6808717552362, 2090.686397040456, 2122.904469298885, 989.8069876374182, 993.4287784523927, 1022.4121130350078, 1054.7732237568805, 1058.8888166742536, 20095.19619215215, 20858.877432998026, 20946.89526552388, 20949.581008380053, 21382.358529244146, 1042.6455005298083, 1074.2372915230274, 1084.3114622214794, 1108.2076315434342, 1153.1754795321385, 11401.372924489233, 11693.649190524298, 11979.161458697981, 12007.699807504881, 12073.698157546132, 452491.0, 452994.0, 458964.0, 495076.0, 495767.0, 48082.27876581854, 57602.0, 70882.64558677173, 77941.0, 79464.60267698625, 1020.6478764826123, 1064.606095744564, 1064.8296272596347, 1066.8079745645703, 1070.4861666400172, 17670.558236044202, 18050.548736281697, 18563.81436185675, 18582.628347433245, 18690.626187475904, 40082.79958600305, 40414.191716164925, 40673.1865362697, 41261.58738412698, 41884.534041308405, 51131.48868511267, 53525.197122042424, 54296.18555721588, 54387.50211583754, 56100.158497623386, 8686.695965641173, 9051.954740226256, 9187.632494700138, 9274.397164184576, 9400.106989835955, 13286.136401133896, 13389.799153012907, 13735.175889446666, 13808.654783630489, 13908.86091139116, 11035.337879727242, 11564.537418503165, 11618.88381116178, 11746.941265293619, 12222.327771972272, 9635.0, 10142.746431339276, 10401.739956501147, 10477.476126193813, 10489.947550262199, 11609.941950290195, 11888.643340699793, 12283.57007504733, 12355.93822030884, 12651.93674031624, 9065.0, 9152.22206112488, 9156.084391561057, 9249.352545321763, 9535.713928582154, 11842.940785296018, 12127.9084882361, 12239.388030598613, 12303.384830758247, 12307.20003199789], "value": 9602.830810250525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.307263295719, 1515.4620109860998, 1547.82973872874, 1699.5496193508723, 1822.544363909022, 7754.8836767448465, 8829.690960816373, 9201.355905086646, 9212.585433655484, 9214.354995150343, 8838.646454141843, 8916.687915922945, 8934.419262747933, 9030.68392606259, 9043.0, 2396.8921398537022, 2432.659427680126, 2434.8295619306655, 2435.5250726108416, 2436.61014237722, 2375.8455700379504, 2438.451348446603, 2446.1193970170725, 2446.290575733044, 2449.1672831237374, 2324.476992676651, 2331.533693261346, 2354.21133920137, 2373.8100951923807, 2387.594109001474, 2291.702078729771, 2306.9307920762403, 2309.6650985606993, 2325.4418939454495, 2350.3536527455085, 2294.139697613395, 2318.988405057964, 2336.2874323331375, 2342.0865862313713, 2343.121329501437, 8798.868016979686, 8826.382153249275, 8928.0, 8982.775430614221, 8993.910060899438, 5113.335266415379, 5309.946900531023, 5322.893542129135, 5327.094393953037, 5327.280817089721, 3403.8638454461793, 3485.721142308609, 3529.29414117175, 3536.5579302587175, 3565.5186549815703, 1092.9398883061428, 1114.9163812713998, 1116.2019156303281, 1152.1071169843356, 1162.3781277016756, 12442.315672638002, 12532.060095492874, 12545.184563003375, 12552.8117078243, 12573.0, 4262.573742625713, 4499.212637788374, 4554.863354099382, 4555.043440877386, 4587.885302867388, 9889.901100989042, 9904.801903962025, 9906.851397229048, 9911.603535858629, 9912.306138570375, 5330.253764472977, 5335.466453354634, 5337.119375303031, 5338.412774594792, 5344.706041167773, 4130.772807495617, 4333.285007973712, 4375.956240437618, 4473.46318441789, 4997.100521906092, 3947.940780888289, 3968.960310396859, 4062.939055914164, 4065.6747460203114, 4077.2660921033907, 1184.798584240681, 1212.9757404851853, 1223.1193540650718, 1234.2717796500108, 1236.3879879459726, 833.5207255827802, 910.9569542873373, 915.6154415145521, 938.4088024544493, 973.2360097323708, 5916.526677865761, 5937.851553711192, 6064.575479716377, 6166.105914642441, 6292.087647291117, 947.3747326764441, 1035.8498017787379, 1072.1369297715257, 1094.0536435982817, 1110.0952723530297, 3672.265546890633, 3781.004385288147, 3874.1283211277237, 3897.415387691869, 3903.648671619511, 10517.316374435637, 10745.247832651796, 10874.130069594414, 10907.945460272647, 11122.61070862516, 10757.193210509244, 10805.973432523897, 10836.674899752863, 10839.729006774895, 10846.728831779268, 8283.83432331362, 8392.874106888401, 8422.915770842335, 8470.364722645703, 8478.321734261368, 5432.837014889559, 5435.972820135874, 5513.255710479194, 5520.972395137998, 5614.07367784311, 9917.504124793588, 9951.651692190739, 9993.400395976265, 10073.445960472245, 10090.34412763168, 10225.539850706587, 10271.897281027394, 10319.432431216355, 10338.741531461774, 10433.791324173322, 7940.444168908121, 7971.800704982422, 8011.559364235023, 8087.676492940216, 8096.5546894921345, 8539.914600853912, 8618.52598107085, 8637.870431943651, 8641.351898607756, 8645.697400590949, 7563.394928405824, 7737.690492380242, 7859.764207073797, 7913.525188488709, 8050.27547520726, 7459.552426854406, 7541.208173141741, 7602.581857997863, 7607.809804754926, 7625.580593067434, 6730.293319201413, 6902.758403456056, 6953.68708408133, 6954.513184077066, 6972.581645101107, 5255.395629502656, 5320.840374788762, 5351.3043304370185, 5359.196120581944, 5375.946240537544, 5103.795848166032, 5219.660722053054, 5270.183121616155, 5276.788928442973, 5337.066013447554], "value": 4657.302934417368, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1284537275321, 349.16026955172816, 355.87900113961246, 357.1161375595401, 365.8554870826024, 5492.324840923522, 5509.311336082979, 5510.752016159272, 5518.779248830042, 5533.584981126412, 5119.436861945183, 5244.501772331632, 5301.628885977973, 5373.76403427212, 5415.48552887476, 4301.526832048487, 4306.5262821089655, 4309.762963037032, 4317.805698743564, 4331.913361732763, 4284.871453856389, 4286.342467670049, 4296.613304802567, 4317.784110794448, 4318.762468064255, 4028.436018957348, 4201.70588058836, 4219.156168766243, 4227.915441691164, 4294.957050429487, 4203.579642035803, 4207.705460617758, 4212.9789351053205, 4214.178235244129, 4219.11398606293, 3731.8134093295225, 3742.0644838790304, 3767.5683240368485, 3774.226283611853, 3792.4500947362476, 5113.437521872591, 5121.487851214886, 5214.947850521484, 5280.313559237313, 5290.92063619046, 4851.975740121276, 4857.368542089541, 4868.981231636372, 4880.682755620909, 4882.43851957026, 5607.775688972436, 5609.775608975636, 5612.69130197839, 5626.690532020737, 5629.183768353607, 4005.2590270799997, 4042.191561687674, 4078.4494093297617, 4101.651359634435, 4114.177164567069, 5844.970775146139, 5873.177755114288, 5875.764969401219, 5876.471117599393, 5883.8529036774, 4231.597998190167, 4233.872983810491, 4242.469691288589, 4244.617984381421, 4291.270484017725, 4233.91532169361, 4295.098029413858, 4299.075698724727, 4334.176506463762, 4337.332540487578, 4811.927821082687, 4825.600575833039, 4863.537963893425, 4864.440589332201, 4897.191963326082, 5698.886022279614, 5705.286839145107, 5707.172459993278, 5728.369879313273, 5730.885382292331, 1386.272207091285, 1420.5525259543417, 1431.7065001674632, 1436.5977526292654, 1450.6074168797861, 977.5796407544824, 987.9280980136632, 993.7664648807524, 998.4758002048983, 1006.713086770267, 5227.686338819683, 5236.429071278601, 5258.92111618326, 5271.471273330768, 5318.282031925718, 5583.581231407579, 5592.524635406036, 5602.355729091125, 5608.383077861432, 5610.438956104357, 5234.607404444682, 5307.65500242483, 5308.734563271821, 5321.86695332612, 5532.861678458071, 2987.850607469618, 2997.2057404787747, 3008.172752493082, 3009.187519369758, 3009.337945651953, 5807.535397168301, 5810.593258471951, 5825.300963884361, 5870.970645146833, 5886.735096920649, 5554.472714914704, 5746.310442746897, 5754.07238575082, 5768.278965129359, 5806.0099048989805, 5786.652800831964, 5788.594798364074, 5807.303123625192, 5820.883582328414, 5890.410958904161, 5352.678839269656, 5625.268715067015, 5647.407022262603, 5653.915191272052, 5666.744996475251, 5562.916556251578, 5569.972150139223, 5576.275084239023, 5576.302962129734, 5579.684430961268, 5789.407912824007, 5798.942010580009, 5830.591858570029, 5859.2382990211, 5866.530677545871, 3922.7057970651745, 4002.3196056669854, 4023.2758103540473, 4089.0, 4110.835566577303, 5656.462636049569, 5668.631538949955, 5688.800891968761, 5691.203231547669, 5692.658440493584, 5674.290713660793, 5678.608740858516, 5686.857828554319, 5698.0, 5701.40135285789, 5421.241026256248, 5677.176809362537, 5703.287089113861, 5715.771369145187, 5746.281714785652, 5689.914651280152, 5692.658440493584, 5746.454086861741, 5765.106408506688, 5772.682502462405, 5646.576506761927, 5706.343770466449, 5767.711614419346, 5770.50950669181, 5778.8266352009505, 5623.8875222496135, 5644.491995720405, 5666.603337766317, 5675.545956323567, 5688.203651488878], "value": 4313.0114060961105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.7968007998004, 812.9959500017482, 838.7777239031656, 844.6410275632854, 893.4639216470123, 13860.099093558913, 15180.924095379507, 15188.164650944194, 15299.694006119871, 15493.612659683513, 14234.71530569388, 14488.637784055403, 15090.698186036272, 15250.771238431433, 15322.080675159497, 739.0835364148444, 855.4311382930359, 873.2097451806126, 873.7509809704236, 875.439718580106, 743.7396911081132, 853.479377579679, 860.1699360117485, 874.5845723281423, 880.9603567839431, 912.4342907397423, 923.376720713519, 930.4882314726907, 930.6510058727977, 932.1657116880388, 921.1111277617065, 922.9077092290785, 925.6390007896925, 926.3793258516777, 929.5770424456856, 674.4233680203405, 675.9324067593251, 678.1624693503519, 678.7217240931194, 681.0635376357509, 14830.629234269121, 14833.0, 14843.332050057774, 14898.478553250692, 16157.0, 14057.422525164453, 14466.0, 14659.560213193621, 14748.852511474963, 14849.183294918776, 11775.470103845262, 11862.347570883598, 12215.206011609216, 12240.755184896252, 12463.0, 3875.069983204039, 3903.6486716195395, 3937.6062393760394, 3939.940900886489, 3942.763434193929, 70456.29543704548, 70985.0, 71566.28433715648, 72270.27729722689, 72321.27678723198, 11243.269187502787, 11359.772804543863, 11411.885881141248, 11452.255603385753, 11741.412929353499, 20143.29498467576, 20148.19407223724, 20173.798262017484, 20182.293619723532, 20308.492287692927, 7884.17216192303, 7981.72063977758, 8056.234657707509, 8158.632861521246, 8250.298724608476, 4627.6529260305615, 4632.16621008215, 4695.741734204583, 4718.05638872227, 4752.881177970509, 3421.9486707699402, 3493.8602455901987, 3499.825008749552, 3537.7346698997676, 3547.0, 606.8209878085976, 611.3550204534259, 612.5895649914568, 612.9724162412703, 613.6624856329001, 624.5253607258517, 688.50771698235, 712.3944647049966, 748.8015675845905, 761.7219714804056, 9043.366964312567, 9857.35927164732, 9944.80110397788, 10016.348937319051, 10023.14803241718, 684.9178098628197, 692.4425837201102, 757.8484303139284, 758.742027710581, 776.7436745873848, 4576.6109880660515, 4676.883077923079, 4766.856994290177, 4813.4945830687975, 4819.9759001205475, 56774.71612641993, 82916.0, 91527.0, 95715.52142239244, 98439.0, 78644.0, 80243.0, 80626.5968670153, 82821.0, 84570.0, 71634.64182679054, 71791.2820871795, 71927.0, 72039.0, 73011.2698873015, 8486.40595158333, 8848.690295839615, 9010.81978360416, 9346.392484488486, 9422.152006319464, 51620.48379516157, 51712.224316636035, 52451.90278777588, 52870.735646321526, 53569.73215133899, 54238.457615423344, 54471.18293225526, 61068.38931610627, 63216.68391658012, 64164.03753943601, 12992.545260915822, 13024.413901374272, 13380.665483362995, 13513.594592162252, 13630.250336231205, 14700.485483008044, 14766.852331476548, 14829.777553336924, 15866.0, 16125.919370403073, 13634.659133521742, 13741.587752367444, 14199.929000355345, 14288.142711437347, 14756.63108422298, 12188.817167742669, 13557.932210338886, 13849.792253116413, 13854.584362469142, 14450.638734031734, 13646.0, 13711.451541938211, 13794.103383280055, 13908.930455347658, 13961.441542338192, 10747.89252107469, 11454.770904582028, 11474.598389056342, 11733.706657333634, 11744.0, 11017.228793984345, 11359.48882300315, 11412.0, 11416.265995822134, 11579.42102894835], "value": 7455.40774318965, "unit": "score"}], "name": "dromaeo_css", "value": 7442.586551026769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 111.0, 111.0, 113.0, 112.0, 111.0, 114.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 119.0, 161.0, 119.0, 122.0, 116.0, 118.0, 147.0, 120.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 160.0, 161.0, 161.0, 163.0, 160.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 104.0, 77.0, 77.0, 75.0, 76.0, 96.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 123.0, 81.0, 83.0, 82.0, 101.0, 81.0, 81.0, 110.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 118.0, 119.0, 118.0, 116.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 49.0, 50.0, 48.0, 51.0, 50.0, 51.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 58.0, 58.0, 60.0, 58.0, 59.0, 58.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 83.0, 76.0, 75.0, 81.0, 75.0, 74.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 123.0, 121.0, 140.0, 129.0, 127.0, 120.0, 159.0, 122.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 163.0, 156.0, 154.0, 158.0, 160.0, 156.0, 160.0, 158.0, 158.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 62.0, 63.0, 63.0, 66.0, 62.0, 63.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1459.9, "alertThreshold": 2.0}]} 15:40:37 INFO - Return code: 0 15:40:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:40:37 INFO - # TBPL SUCCESS # 15:40:37 INFO - Running post-action listener: _resource_record_post_action 15:40:37 INFO - [mozharness: 2017-01-27 23:40:37.985588Z] Finished run-tests step (success) 15:40:37 INFO - Running post-run listener: _resource_record_post_run 15:40:38 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 321241088; Read time: 0; Write time: 201248 15:40:38 INFO - TinderboxPrint: CPU usage
13.0% 15:40:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:40:38 INFO - TinderboxPrint: I/O write bytes / time
321,241,088 / 201,248 15:40:38 INFO - TinderboxPrint: CPU idle
8,252.6 (87.0%) 15:40:38 INFO - TinderboxPrint: CPU user
1,186.8 (12.5%) 15:40:38 INFO - TinderboxPrint: Swap in / out
0 / 0 15:40:38 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100892672; Read time: 0; Write time: 88868 15:40:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 220348416; Read time: 0; Write time: 112380 15:40:38 INFO - Running post-run listener: _upload_blobber_files 15:40:38 INFO - Blob upload gear active. 15:40:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:40:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:40:39 INFO - (blobuploader) - INFO - Open directory for files ... 15:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:42 INFO - (blobuploader) - INFO - Done attempting. 15:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:42 INFO - (blobuploader) - INFO - Done attempting. 15:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:43 INFO - (blobuploader) - INFO - Done attempting. 15:40:43 INFO - (blobuploader) - INFO - Iteration through files over. 15:40:43 INFO - Return code: 0 15:40:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:40:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:40:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca7f50cfe41ec79620219e8b386d3e74f5a9f3e6171383c20ccffaa8e4d1098bd7bc879989b5210f4bc58bc9e96441680155e175e4fed9b0beacee3553bfcca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f8ef3a15468350c295cf7e3f93bad4af99b40520896894ea4aabf44d78cef2d947631ff34055114316799b946d644f6923b8e5f7c645d145664a2bc573e6503c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/533a612db541e54b33f94058587fa0abfc29f7bae7927334077bf34e75844a9197e494a2c0f7cfbc5dd586fa62c9a20d592eda351cc015f8de25d710c2360e7d"} 15:40:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:40:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:40:43 INFO - Contents: 15:40:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca7f50cfe41ec79620219e8b386d3e74f5a9f3e6171383c20ccffaa8e4d1098bd7bc879989b5210f4bc58bc9e96441680155e175e4fed9b0beacee3553bfcca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f8ef3a15468350c295cf7e3f93bad4af99b40520896894ea4aabf44d78cef2d947631ff34055114316799b946d644f6923b8e5f7c645d145664a2bc573e6503c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/533a612db541e54b33f94058587fa0abfc29f7bae7927334077bf34e75844a9197e494a2c0f7cfbc5dd586fa62c9a20d592eda351cc015f8de25d710c2360e7d"} 15:40:43 INFO - Running post-run listener: copy_logs_to_upload_dir 15:40:43 INFO - Copying logs to upload dir... 15:40:43 INFO - mkdir: /builds/slave/test/build/upload/logs 15:40:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.594967 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-27 15:40:42.814235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 15:40:42.817960) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230 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/ca7f50cfe41ec79620219e8b386d3e74f5a9f3e6171383c20ccffaa8e4d1098bd7bc879989b5210f4bc58bc9e96441680155e175e4fed9b0beacee3553bfcca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f8ef3a15468350c295cf7e3f93bad4af99b40520896894ea4aabf44d78cef2d947631ff34055114316799b946d644f6923b8e5f7c645d145664a2bc573e6503c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/533a612db541e54b33f94058587fa0abfc29f7bae7927334077bf34e75844a9197e494a2c0f7cfbc5dd586fa62c9a20d592eda351cc015f8de25d710c2360e7d"} build_url:https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/MxxaeMzYSmSHTDpNopQZzQ/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/ca7f50cfe41ec79620219e8b386d3e74f5a9f3e6171383c20ccffaa8e4d1098bd7bc879989b5210f4bc58bc9e96441680155e175e4fed9b0beacee3553bfcca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f8ef3a15468350c295cf7e3f93bad4af99b40520896894ea4aabf44d78cef2d947631ff34055114316799b946d644f6923b8e5f7c645d145664a2bc573e6503c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/533a612db541e54b33f94058587fa0abfc29f7bae7927334077bf34e75844a9197e494a2c0f7cfbc5dd586fa62c9a20d592eda351cc015f8de25d710c2360e7d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 15:40:42.842829) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:40:42.843163) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1485559209.665467-2116852230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 15:40:42.927538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 15:40:42.927861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 15:40:42.928146) ========= ========= Total master_lag: 0.14 =========