builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1477918675.79 results: success (0) buildid: 20161031030202 builduid: f081758597ca469e9265bc7a5fa9f6e3 revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:55.791990) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:55.792430) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:55.792702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:55.814082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:55.814444) ========= 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=00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 05:57:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-31 05:57:56 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.312136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.140359) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.141408) ========= 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=00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020176 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.192064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.192416) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e3279760cd977aac30bd9e8032d3ee71f55d2a67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e3279760cd977aac30bd9e8032d3ee71f55d2a67 --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=00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 05:57:56,508 truncating revision to first 12 chars 2016-10-31 05:57:56,508 Setting DEBUG logging. 2016-10-31 05:57:56,508 attempt 1/10 2016-10-31 05:57:56,508 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e3279760cd97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 05:57:56,817 unpacking tar archive at: mozilla-central-e3279760cd97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.815447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.815752) ========= script_repo_revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.816131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.816409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 05:57:56.825579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-31 05:57:56.825842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:57 INFO - MultiFileLogger online at 20161031 05:57:57 in /builds/slave/test 05:57:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:57:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:57 INFO - {'append_to_log': False, 05:57:57 INFO - 'base_work_dir': '/builds/slave/test', 05:57:57 INFO - 'blob_upload_branch': 'Firefox', 05:57:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:57 INFO - 'branch': 'Firefox', 05:57:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:57 INFO - 'config_files': ('talos/linux_config.py',), 05:57:57 INFO - 'default_actions': ('clobber', 05:57:57 INFO - 'read-buildbot-config', 05:57:57 INFO - 'download-and-extract', 05:57:57 INFO - 'populate-webroot', 05:57:57 INFO - 'create-virtualenv', 05:57:57 INFO - 'install', 05:57:57 INFO - 'run-tests'), 05:57:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:57 INFO - 'download_minidump_stackwalk': True, 05:57:57 INFO - 'download_symbols': 'ondemand', 05:57:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:57 INFO - 'installer_path': 'installer.exe', 05:57:57 INFO - 'log_level': 'info', 05:57:57 INFO - 'log_name': 'talos', 05:57:57 INFO - 'log_to_console': True, 05:57:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:57 INFO - 'opt_config_files': (), 05:57:57 INFO - 'pip_index': False, 05:57:57 INFO - 'sps_profile': False, 05:57:57 INFO - 'sps_profile_interval': 0, 05:57:57 INFO - 'suite': 'dromaeojs-e10s', 05:57:57 INFO - 'system_bits': '32', 05:57:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:57 INFO - 'title': 'talos-linux64-ix-016', 05:57:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:57 INFO - 'use_talos_json': True, 05:57:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:57 INFO - 'work_dir': 'build'} 05:57:57 INFO - [mozharness: 2016-10-31 12:57:57.247366Z] Running clobber step. 05:57:57 INFO - Running pre-action listener: _resource_record_pre_action 05:57:57 INFO - Running main action method: clobber 05:57:57 INFO - rmtree: /builds/slave/test/build 05:57:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:57 INFO - Running post-action listener: _resource_record_post_action 05:57:57 INFO - [mozharness: 2016-10-31 12:57:57.710700Z] Finished clobber step (success) 05:57:57 INFO - [mozharness: 2016-10-31 12:57:57.710799Z] Running read-buildbot-config step. 05:57:57 INFO - Running pre-action listener: _resource_record_pre_action 05:57:57 INFO - Running main action method: read_buildbot_config 05:57:57 INFO - Using buildbot properties: 05:57:57 INFO - { 05:57:57 INFO - "project": "", 05:57:57 INFO - "product": "firefox", 05:57:57 INFO - "script_repo_revision": "production", 05:57:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:57:57 INFO - "repository": "", 05:57:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:57:57 INFO - "buildid": "20161031030202", 05:57:57 INFO - "stage_platform": "linux64-pgo", 05:57:57 INFO - "basedir": "/builds/slave/test", 05:57:57 INFO - "nightly_build": "True", 05:57:57 INFO - "buildnumber": 149, 05:57:57 INFO - "slavename": "talos-linux64-ix-016", 05:57:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:57:57 INFO - "platform": "ubuntu64_hw", 05:57:57 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:57:57 INFO - "branch": "mozilla-central", 05:57:57 INFO - "repo_path": "mozilla-central", 05:57:57 INFO - "revision": "e3279760cd977aac30bd9e8032d3ee71f55d2a67", 05:57:57 INFO - "pgo_build": "True", 05:57:57 INFO - "builduid": "f081758597ca469e9265bc7a5fa9f6e3", 05:57:57 INFO - "slavebuilddir": "test" 05:57:57 INFO - } 05:57:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:57:57 INFO - Running post-action listener: _resource_record_post_action 05:57:57 INFO - [mozharness: 2016-10-31 12:57:57.713318Z] Finished read-buildbot-config step (success) 05:57:57 INFO - [mozharness: 2016-10-31 12:57:57.713407Z] Running download-and-extract step. 05:57:57 INFO - Running pre-action listener: _resource_record_pre_action 05:57:57 INFO - Running main action method: download_and_extract 05:57:57 INFO - mkdir: /builds/slave/test/build/tests 05:57:57 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')]} 05:57:57 INFO - trying https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:57:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:57:58 INFO - Downloaded 1361 bytes. 05:57:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:57:58 INFO - Using the following test package requirements: 05:57:58 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:57:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:57:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'jsshell-linux-x86_64.zip'], 05:57:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:57:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:57:58 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:57:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:57:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:57:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:57:58 INFO - Http code: 200 05:57:58 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 05:57:58 INFO - x-amz-cf-id: iwtisJ7RKpKKFFOeOUfjCnQT7j1hPqmxgMDdDeL7Y7XvPU7sykw4Wg== 05:57:58 INFO - x-amz-version-id: iw0Bo5fSe8cpQdKHHehU_HTFhImWdduh 05:57:59 INFO - Expected file size: 22006598 05:57:59 INFO - Obtained file size: 22006598 05:58:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:58:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:58:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:58:03 INFO - Http code: 200 05:58:03 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 05:58:03 INFO - x-amz-cf-id: dFYX0yEBXFVR3BU-JIw3kjtxXlYsHvDErJu-YrZVvIXxXDSkUwePIg== 05:58:03 INFO - x-amz-version-id: iw0Bo5fSe8cpQdKHHehU_HTFhImWdduh 05:58:04 INFO - Expected file size: 22006598 05:58:04 INFO - Obtained file size: 22006598 05:58:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:58:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:58:09 INFO - Http code: 200 05:58:09 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 05:58:09 INFO - x-amz-cf-id: 2Q07JnzVbdGxKIZXGCayx15_7NsNQhqocI3GzhD8Nqy_AG87wMW3Nw== 05:58:09 INFO - x-amz-version-id: AEvTWZTpa0.EuoIaDf.Gl8TO18ZH_xWB 05:58:10 INFO - Expected file size: 14409038 05:58:10 INFO - Obtained file size: 14409038 05:58:10 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')]} 05:58:10 INFO - trying https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:58:12 INFO - Downloaded 59625743 bytes. 05:58:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:12 INFO - mkdir: /builds/slave/test/properties 05:58:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:12 INFO - Contents: 05:58:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:13 INFO - Running post-action listener: _resource_record_post_action 05:58:13 INFO - Running post-action listener: set_extra_try_arguments 05:58:13 INFO - [mozharness: 2016-10-31 12:58:13.695873Z] Finished download-and-extract step (success) 05:58:13 INFO - [mozharness: 2016-10-31 12:58:13.696101Z] Running populate-webroot step. 05:58:13 INFO - Running pre-action listener: _resource_record_pre_action 05:58:13 INFO - Running main action method: populate_webroot 05:58:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:13 INFO - '--tppagecycles', 05:58:13 INFO - '7'], 05:58:13 INFO - 'tests': ['tsvgm']}}, 05:58:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['damp', 'tps']}, 05:58:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'tests': ['damp', 'tps']}, 05:58:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['dromaeo_dom']}, 05:58:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['basic_compositor_video']}, 05:58:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['a11yr', 05:58:13 INFO - 'ts_paint', 05:58:13 INFO - 'tpaint', 05:58:13 INFO - 'sessionrestore', 05:58:13 INFO - 'sessionrestore_no_auto_restore', 05:58:13 INFO - 'tabpaint']}, 05:58:13 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:13 INFO - 'ts_paint', 05:58:13 INFO - 'tpaint', 05:58:13 INFO - 'sessionrestore', 05:58:13 INFO - 'sessionrestore_no_auto_restore', 05:58:13 INFO - 'tabpaint']}, 05:58:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:13 INFO - 'ts_paint', 05:58:13 INFO - 'tpaint', 05:58:13 INFO - 'sessionrestore', 05:58:13 INFO - 'sessionrestore_no_auto_restore', 05:58:13 INFO - 'tabpaint']}, 05:58:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:13 INFO - 'ts_paint', 05:58:13 INFO - 'tpaint', 05:58:13 INFO - 'sessionrestore', 05:58:13 INFO - 'sessionrestore_no_auto_restore', 05:58:13 INFO - 'tabpaint']}, 05:58:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['a11yr', 05:58:13 INFO - 'ts_paint', 05:58:13 INFO - 'tpaint', 05:58:13 INFO - 'sessionrestore', 05:58:13 INFO - 'sessionrestore_no_auto_restore', 05:58:13 INFO - 'tabpaint']}, 05:58:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['a11yr', 05:58:13 INFO - 'ts_paint', 05:58:13 INFO - 'tpaint', 05:58:13 INFO - 'sessionrestore', 05:58:13 INFO - 'sessionrestore_no_auto_restore', 05:58:13 INFO - 'tabpaint']}, 05:58:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['tsvgx', 05:58:13 INFO - 'tsvgr_opacity', 05:58:13 INFO - 'tart', 05:58:13 INFO - 'tscrollx', 05:58:13 INFO - 'cart']}, 05:58:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:13 INFO - 'tsvgr_opacity', 05:58:13 INFO - 'tart', 05:58:13 INFO - 'tscrollx', 05:58:13 INFO - 'cart']}, 05:58:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'talos_options': ['--disable-e10s'], 05:58:13 INFO - 'tests': ['tp5o']}, 05:58:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'tests': ['tp5o']}, 05:58:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'talos_options': ['--disable-e10s', 05:58:13 INFO - '--xperf_path', 05:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:13 INFO - 'tests': ['tp5n']}, 05:58:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:13 INFO - 'talos_options': ['--xperf_path', 05:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:13 INFO - 'tests': ['tp5n']}}, 05:58:13 INFO - 'talos.zip': {'path': '', 05:58:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:13 INFO - Running post-action listener: _resource_record_post_action 05:58:13 INFO - [mozharness: 2016-10-31 12:58:13.715351Z] Finished populate-webroot step (success) 05:58:13 INFO - [mozharness: 2016-10-31 12:58:13.715439Z] Running create-virtualenv step. 05:58:13 INFO - Running pre-action listener: _resource_record_pre_action 05:58:13 INFO - Running main action method: create_virtualenv 05:58:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:13 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 05:58:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:13 INFO - Using real prefix '/usr' 05:58:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:16 INFO - Installing pip.................done. 05:58:16 INFO - Return code: 0 05:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:58:16 INFO - Reading from file tmpfile_stdout 05:58:16 INFO - Output received: 05:58:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:58:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:16 INFO - Using env: {'DISPLAY': ':0', 05:58:16 INFO - 'HOME': '/home/cltbld', 05:58:16 INFO - 'LANG': 'en_US.UTF-8', 05:58:16 INFO - 'LANGUAGE': 'en_US:en', 05:58:16 INFO - 'LOGNAME': 'cltbld', 05:58:16 INFO - 'MAIL': '/var/mail/cltbld', 05:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:16 INFO - 'MOZ_NO_REMOTE': '1', 05:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:16 INFO - 'NO_EM_RESTART': '1', 05:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:16 INFO - 'PWD': '/builds/slave/test', 05:58:16 INFO - 'SHELL': '/bin/bash', 05:58:16 INFO - 'SHLVL': '1', 05:58:16 INFO - 'TERM': 'linux', 05:58:16 INFO - 'TMOUT': '86400', 05:58:16 INFO - 'USER': 'cltbld', 05:58:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:16 INFO - '_': '/tools/buildbot/bin/python'} 05:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:16 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 05:58:16 INFO - Cleaning up... 05:58:16 INFO - Return code: 0 05:58:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:16 INFO - Using env: {'DISPLAY': ':0', 05:58:16 INFO - 'HOME': '/home/cltbld', 05:58:16 INFO - 'LANG': 'en_US.UTF-8', 05:58:16 INFO - 'LANGUAGE': 'en_US:en', 05:58:16 INFO - 'LOGNAME': 'cltbld', 05:58:16 INFO - 'MAIL': '/var/mail/cltbld', 05:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:16 INFO - 'MOZ_NO_REMOTE': '1', 05:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:16 INFO - 'NO_EM_RESTART': '1', 05:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:16 INFO - 'PWD': '/builds/slave/test', 05:58:16 INFO - 'SHELL': '/bin/bash', 05:58:16 INFO - 'SHLVL': '1', 05:58:16 INFO - 'TERM': 'linux', 05:58:16 INFO - 'TMOUT': '86400', 05:58:16 INFO - 'USER': 'cltbld', 05:58:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:16 INFO - '_': '/tools/buildbot/bin/python'} 05:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:16 INFO - Downloading/unpacking psutil>=3.1.1 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:18 INFO - Installing collected packages: psutil 05:58:18 INFO - Running setup.py install for psutil 05:58:19 INFO - building 'psutil._psutil_linux' extension 05:58:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:58:19 INFO - building 'psutil._psutil_posix' extension 05:58:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:58:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:58:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:19 INFO - Successfully installed psutil 05:58:19 INFO - Cleaning up... 05:58:19 INFO - Return code: 0 05:58:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:19 INFO - Using env: {'DISPLAY': ':0', 05:58:19 INFO - 'HOME': '/home/cltbld', 05:58:19 INFO - 'LANG': 'en_US.UTF-8', 05:58:19 INFO - 'LANGUAGE': 'en_US:en', 05:58:19 INFO - 'LOGNAME': 'cltbld', 05:58:19 INFO - 'MAIL': '/var/mail/cltbld', 05:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:19 INFO - 'MOZ_NO_REMOTE': '1', 05:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:19 INFO - 'NO_EM_RESTART': '1', 05:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:19 INFO - 'PWD': '/builds/slave/test', 05:58:19 INFO - 'SHELL': '/bin/bash', 05:58:19 INFO - 'SHLVL': '1', 05:58:19 INFO - 'TERM': 'linux', 05:58:19 INFO - 'TMOUT': '86400', 05:58:19 INFO - 'USER': 'cltbld', 05:58:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:19 INFO - '_': '/tools/buildbot/bin/python'} 05:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:21 INFO - Installing collected packages: mozsystemmonitor 05:58:21 INFO - Running setup.py install for mozsystemmonitor 05:58:21 INFO - Successfully installed mozsystemmonitor 05:58:21 INFO - Cleaning up... 05:58:21 INFO - Return code: 0 05:58:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:21 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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:21 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 05:58:21 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 05:58:21 INFO - Using env: {'DISPLAY': ':0', 05:58:21 INFO - 'HOME': '/home/cltbld', 05:58:21 INFO - 'LANG': 'en_US.UTF-8', 05:58:21 INFO - 'LANGUAGE': 'en_US:en', 05:58:21 INFO - 'LOGNAME': 'cltbld', 05:58:21 INFO - 'MAIL': '/var/mail/cltbld', 05:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:21 INFO - 'MOZ_NO_REMOTE': '1', 05:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:21 INFO - 'NO_EM_RESTART': '1', 05:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:21 INFO - 'PWD': '/builds/slave/test', 05:58:21 INFO - 'SHELL': '/bin/bash', 05:58:21 INFO - 'SHLVL': '1', 05:58:21 INFO - 'TERM': 'linux', 05:58:21 INFO - 'TMOUT': '86400', 05:58:21 INFO - 'USER': 'cltbld', 05:58:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:21 INFO - '_': '/tools/buildbot/bin/python'} 05:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:24 INFO - warning: no files found matching '*.txt' 05:58:24 INFO - no previously-included directories found matching 'build' 05:58:24 INFO - no previously-included directories found matching 'dist' 05:58:24 INFO - no previously-included directories found matching '.git*' 05:58:24 INFO - Installing collected packages: jsonschema, functools32 05:58:24 INFO - Running setup.py install for functools32 05:58:24 INFO - warning: no files found matching '*.txt' 05:58:24 INFO - no previously-included directories found matching 'build' 05:58:24 INFO - no previously-included directories found matching 'dist' 05:58:24 INFO - no previously-included directories found matching '.git*' 05:58:24 INFO - Successfully installed jsonschema functools32 05:58:24 INFO - Cleaning up... 05:58:24 INFO - Return code: 0 05:58:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:24 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 05:58:24 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 05:58:24 INFO - Using env: {'DISPLAY': ':0', 05:58:24 INFO - 'HOME': '/home/cltbld', 05:58:24 INFO - 'LANG': 'en_US.UTF-8', 05:58:24 INFO - 'LANGUAGE': 'en_US:en', 05:58:24 INFO - 'LOGNAME': 'cltbld', 05:58:24 INFO - 'MAIL': '/var/mail/cltbld', 05:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:24 INFO - 'MOZ_NO_REMOTE': '1', 05:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:24 INFO - 'NO_EM_RESTART': '1', 05:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:24 INFO - 'PWD': '/builds/slave/test', 05:58:24 INFO - 'SHELL': '/bin/bash', 05:58:24 INFO - 'SHLVL': '1', 05:58:24 INFO - 'TERM': 'linux', 05:58:24 INFO - 'TMOUT': '86400', 05:58:24 INFO - 'USER': 'cltbld', 05:58:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:24 INFO - '_': '/tools/buildbot/bin/python'} 05:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:24 INFO - Cleaning up... 05:58:24 INFO - Return code: 0 05:58:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:24 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 05:58:24 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 05:58:24 INFO - Using env: {'DISPLAY': ':0', 05:58:24 INFO - 'HOME': '/home/cltbld', 05:58:24 INFO - 'LANG': 'en_US.UTF-8', 05:58:24 INFO - 'LANGUAGE': 'en_US:en', 05:58:24 INFO - 'LOGNAME': 'cltbld', 05:58:24 INFO - 'MAIL': '/var/mail/cltbld', 05:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:24 INFO - 'MOZ_NO_REMOTE': '1', 05:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:24 INFO - 'NO_EM_RESTART': '1', 05:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:24 INFO - 'PWD': '/builds/slave/test', 05:58:24 INFO - 'SHELL': '/bin/bash', 05:58:24 INFO - 'SHLVL': '1', 05:58:24 INFO - 'TERM': 'linux', 05:58:24 INFO - 'TMOUT': '86400', 05:58:24 INFO - 'USER': 'cltbld', 05:58:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:24 INFO - '_': '/tools/buildbot/bin/python'} 05:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:26 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 05:58:26 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 05:58:26 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 05:58:26 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 05:58:26 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 05:58:26 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 05:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:27 INFO - Downloading docopt-0.6.1.tar.gz 05:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:27 INFO - Running setup.py install for blobuploader 05:58:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:27 INFO - Running setup.py install for requests 05:58:28 INFO - Running setup.py install for docopt 05:58:28 INFO - Successfully installed blobuploader requests docopt 05:58:28 INFO - Cleaning up... 05:58:28 INFO - Return code: 0 05:58:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:28 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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:28 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 05:58:28 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 05:58:28 INFO - Using env: {'DISPLAY': ':0', 05:58:28 INFO - 'HOME': '/home/cltbld', 05:58:28 INFO - 'LANG': 'en_US.UTF-8', 05:58:28 INFO - 'LANGUAGE': 'en_US:en', 05:58:28 INFO - 'LOGNAME': 'cltbld', 05:58:28 INFO - 'MAIL': '/var/mail/cltbld', 05:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:28 INFO - 'MOZ_NO_REMOTE': '1', 05:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:28 INFO - 'NO_EM_RESTART': '1', 05:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:28 INFO - 'PWD': '/builds/slave/test', 05:58:28 INFO - 'SHELL': '/bin/bash', 05:58:28 INFO - 'SHLVL': '1', 05:58:28 INFO - 'TERM': 'linux', 05:58:28 INFO - 'TMOUT': '86400', 05:58:28 INFO - 'USER': 'cltbld', 05:58:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:28 INFO - '_': '/tools/buildbot/bin/python'} 05:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:28 INFO - Running setup.py (path:/tmp/pip-pSB6aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:28 INFO - Running setup.py (path:/tmp/pip-oSovZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:28 INFO - Running setup.py (path:/tmp/pip-hcfc0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:28 INFO - Running setup.py (path:/tmp/pip-ACLUmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:28 INFO - Running setup.py (path:/tmp/pip-vKdQCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:28 INFO - Running setup.py (path:/tmp/pip-prfYDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:28 INFO - Running setup.py (path:/tmp/pip-fCYz14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:29 INFO - Running setup.py (path:/tmp/pip-2dHrmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:29 INFO - Running setup.py (path:/tmp/pip-GETRZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:29 INFO - Running setup.py (path:/tmp/pip-WbQ6Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:29 INFO - Running setup.py (path:/tmp/pip-sWXECI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:29 INFO - Running setup.py (path:/tmp/pip-veSzAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:29 INFO - Running setup.py (path:/tmp/pip-qhjXGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:29 INFO - Running setup.py (path:/tmp/pip-ojwT2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:29 INFO - Running setup.py (path:/tmp/pip-JupxQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:29 INFO - Running setup.py (path:/tmp/pip-upXoFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:29 INFO - Running setup.py (path:/tmp/pip-IZdpuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:29 INFO - Running setup.py install for manifestparser 05:58:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Running setup.py install for mozcrash 05:58:29 INFO - Running setup.py install for mozdebug 05:58:30 INFO - Running setup.py install for mozdevice 05:58:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for mozfile 05:58:30 INFO - Running setup.py install for mozhttpd 05:58:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for mozinfo 05:58:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for mozInstall 05:58:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for mozleak 05:58:30 INFO - Running setup.py install for mozlog 05:58:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for moznetwork 05:58:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Running setup.py install for mozprocess 05:58:30 INFO - Running setup.py install for mozprofile 05:58:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:31 INFO - Running setup.py install for mozrunner 05:58:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:31 INFO - Running setup.py install for mozscreenshot 05:58:31 INFO - Running setup.py install for moztest 05:58:31 INFO - Running setup.py install for mozversion 05:58:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:31 INFO - Cleaning up... 05:58:31 INFO - Return code: 0 05:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:31 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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:31 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 05:58:31 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 05:58:31 INFO - Using env: {'DISPLAY': ':0', 05:58:31 INFO - 'HOME': '/home/cltbld', 05:58:31 INFO - 'LANG': 'en_US.UTF-8', 05:58:31 INFO - 'LANGUAGE': 'en_US:en', 05:58:31 INFO - 'LOGNAME': 'cltbld', 05:58:31 INFO - 'MAIL': '/var/mail/cltbld', 05:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:31 INFO - 'MOZ_NO_REMOTE': '1', 05:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:31 INFO - 'NO_EM_RESTART': '1', 05:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:31 INFO - 'PWD': '/builds/slave/test', 05:58:31 INFO - 'SHELL': '/bin/bash', 05:58:31 INFO - 'SHLVL': '1', 05:58:31 INFO - 'TERM': 'linux', 05:58:31 INFO - 'TMOUT': '86400', 05:58:31 INFO - 'USER': 'cltbld', 05:58:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:31 INFO - '_': '/tools/buildbot/bin/python'} 05:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:31 INFO - Running setup.py (path:/tmp/pip-Hcnq_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:31 INFO - Running setup.py (path:/tmp/pip-Kx9BE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:31 INFO - Running setup.py (path:/tmp/pip-K_PAq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:31 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)) 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:32 INFO - Running setup.py (path:/tmp/pip-WAS1Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:32 INFO - Running setup.py (path:/tmp/pip-bORlVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:32 INFO - Running setup.py (path:/tmp/pip-J0akb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:32 INFO - Running setup.py (path:/tmp/pip-DWQVSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:32 INFO - Running setup.py (path:/tmp/pip-Xx613D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:32 INFO - Running setup.py (path:/tmp/pip-I5dftG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:32 INFO - Running setup.py (path:/tmp/pip-1VqqeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:32 INFO - Running setup.py (path:/tmp/pip-KfXk95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:32 INFO - Running setup.py (path:/tmp/pip-ewQ689-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 INFO - Running setup.py (path:/tmp/pip-wgoyYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Running setup.py (path:/tmp/pip-bYXJEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 INFO - Running setup.py (path:/tmp/pip-Ktx12v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 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)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:32 INFO - Running setup.py (path:/tmp/pip-l3SqEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:32 INFO - Running setup.py (path:/tmp/pip-mHdTwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:34 INFO - Downloading blessings-1.6.tar.gz 05:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:35 INFO - Installing collected packages: blessings 05:58:35 INFO - Running setup.py install for blessings 05:58:35 INFO - Successfully installed blessings 05:58:35 INFO - Cleaning up... 05:58:35 INFO - Return code: 0 05:58:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:35 INFO - Reading from file tmpfile_stdout 05:58:35 INFO - Current package versions: 05:58:35 INFO - argparse == 1.2.1 05:58:35 INFO - blessings == 1.6 05:58:35 INFO - blobuploader == 1.2.4 05:58:35 INFO - docopt == 0.6.1 05:58:35 INFO - functools32 == 3.2.3-2 05:58:35 INFO - jsonschema == 2.5.1 05:58:35 INFO - manifestparser == 1.1 05:58:35 INFO - mozInstall == 1.12 05:58:35 INFO - mozcrash == 0.17 05:58:35 INFO - mozdebug == 0.1 05:58:35 INFO - mozdevice == 0.48 05:58:35 INFO - mozfile == 1.2 05:58:35 INFO - mozhttpd == 0.7 05:58:35 INFO - mozinfo == 0.9 05:58:35 INFO - mozleak == 0.1 05:58:35 INFO - mozlog == 3.4 05:58:35 INFO - moznetwork == 0.27 05:58:35 INFO - mozprocess == 0.23 05:58:35 INFO - mozprofile == 0.28 05:58:35 INFO - mozrunner == 6.12 05:58:35 INFO - mozscreenshot == 0.1 05:58:35 INFO - mozsystemmonitor == 0.3 05:58:35 INFO - moztest == 0.7 05:58:35 INFO - mozversion == 1.4 05:58:35 INFO - psutil == 3.1.1 05:58:35 INFO - requests == 1.2.3 05:58:35 INFO - wsgiref == 0.1.2 05:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:35 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')]} 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 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')]} 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:35 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 05:58:35 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 05:58:35 INFO - Using env: {'DISPLAY': ':0', 05:58:35 INFO - 'HOME': '/home/cltbld', 05:58:35 INFO - 'LANG': 'en_US.UTF-8', 05:58:35 INFO - 'LANGUAGE': 'en_US:en', 05:58:35 INFO - 'LOGNAME': 'cltbld', 05:58:35 INFO - 'MAIL': '/var/mail/cltbld', 05:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:35 INFO - 'MOZ_NO_REMOTE': '1', 05:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:35 INFO - 'NO_EM_RESTART': '1', 05:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:35 INFO - 'PWD': '/builds/slave/test', 05:58:35 INFO - 'SHELL': '/bin/bash', 05:58:35 INFO - 'SHLVL': '1', 05:58:35 INFO - 'TERM': 'linux', 05:58:35 INFO - 'TMOUT': '86400', 05:58:35 INFO - 'USER': 'cltbld', 05:58:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:35 INFO - '_': '/tools/buildbot/bin/python'} 05:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 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)) 05:58:35 INFO - Cleaning up... 05:58:35 INFO - Return code: 0 05:58:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:35 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')]} 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 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')]} 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 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 0x7f6f61f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, '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': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', '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 05:58:35 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 05:58:35 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 05:58:35 INFO - Using env: {'DISPLAY': ':0', 05:58:35 INFO - 'HOME': '/home/cltbld', 05:58:35 INFO - 'LANG': 'en_US.UTF-8', 05:58:35 INFO - 'LANGUAGE': 'en_US:en', 05:58:35 INFO - 'LOGNAME': 'cltbld', 05:58:35 INFO - 'MAIL': '/var/mail/cltbld', 05:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:35 INFO - 'MOZ_NO_REMOTE': '1', 05:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:35 INFO - 'NO_EM_RESTART': '1', 05:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:35 INFO - 'PWD': '/builds/slave/test', 05:58:35 INFO - 'SHELL': '/bin/bash', 05:58:35 INFO - 'SHLVL': '1', 05:58:35 INFO - 'TERM': 'linux', 05:58:35 INFO - 'TMOUT': '86400', 05:58:35 INFO - 'USER': 'cltbld', 05:58:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:35 INFO - '_': '/tools/buildbot/bin/python'} 05:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:35 INFO - Cleaning up... 05:58:35 INFO - Return code: 0 05:58:35 INFO - Running post-action listener: _resource_record_post_action 05:58:35 INFO - Running post-action listener: _start_resource_monitoring 05:58:35 INFO - Starting resource monitoring. 05:58:35 INFO - [mozharness: 2016-10-31 12:58:35.922874Z] Finished create-virtualenv step (success) 05:58:35 INFO - [mozharness: 2016-10-31 12:58:35.923341Z] Running install step. 05:58:35 INFO - Running pre-action listener: _resource_record_pre_action 05:58:35 INFO - Running main action method: install 05:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:36 INFO - Reading from file tmpfile_stdout 05:58:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:36 INFO - Reading from file tmpfile_stdout 05:58:36 INFO - Output received: 05:58:36 INFO - Usage: mozinstall [options] installer 05:58:36 INFO - Options: 05:58:36 INFO - -h, --help show this help message and exit 05:58:36 INFO - -d DEST, --destination=DEST 05:58:36 INFO - Directory to install application into. [default: 05:58:36 INFO - "/builds/slave/test"] 05:58:36 INFO - --app=APP Application being installed. [default: firefox] 05:58:36 INFO - mkdir: /builds/slave/test/build/application 05:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:58:53 INFO - Reading from file tmpfile_stdout 05:58:53 INFO - Output received: 05:58:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:53 INFO - Running post-action listener: _resource_record_post_action 05:58:53 INFO - [mozharness: 2016-10-31 12:58:53.476675Z] Finished install step (success) 05:58:53 INFO - [mozharness: 2016-10-31 12:58:53.476920Z] Running run-tests step. 05:58:53 INFO - Running pre-action listener: _resource_record_pre_action 05:58:53 INFO - Running main action method: run_tests 05:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:53 INFO - Python 2.7.3 05:58:53 INFO - Return code: 0 05:58:53 INFO - grabbing minidump binary from tooltool 05:58:53 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')]} 05:58:53 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 0x175a790>, '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 0x175b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:53 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 05:58:53 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 05:58:53 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 05:58:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:53 INFO - Return code: 0 05:58:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:58:53 INFO - Using env: {'DISPLAY': ':0', 05:58:53 INFO - 'HOME': '/home/cltbld', 05:58:53 INFO - 'LANG': 'en_US.UTF-8', 05:58:53 INFO - 'LANGUAGE': 'en_US:en', 05:58:53 INFO - 'LOGNAME': 'cltbld', 05:58:53 INFO - 'MAIL': '/var/mail/cltbld', 05:58:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:53 INFO - 'MOZ_NO_REMOTE': '1', 05:58:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:53 INFO - 'NO_EM_RESTART': '1', 05:58:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:53 INFO - 'PWD': '/builds/slave/test', 05:58:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:53 INFO - 'SHELL': '/bin/bash', 05:58:53 INFO - 'SHLVL': '1', 05:58:53 INFO - 'TERM': 'linux', 05:58:53 INFO - 'TMOUT': '86400', 05:58:53 INFO - 'USER': 'cltbld', 05:58:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561', 05:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:53 INFO - '_': '/tools/buildbot/bin/python'} 05:58:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:58:53 INFO - mozversion application_buildid: 20161031030202 05:58:53 INFO - mozversion application_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 05:58:53 INFO - mozversion application_display_name: Nightly 05:58:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:53 INFO - mozversion application_name: Firefox 05:58:53 INFO - mozversion application_remotingname: firefox 05:58:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:58:53 INFO - mozversion application_vendor: Mozilla 05:58:53 INFO - mozversion application_version: 52.0a1 05:58:53 INFO - mozversion platform_buildid: 20161031030202 05:58:53 INFO - mozversion platform_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 05:58:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:58:53 INFO - mozversion platform_version: 52.0a1 05:58:53 INFO - using testdate: 1477918733 05:58:53 INFO - actual date: 1477918733 05:58:53 INFO - starting webserver on 'localhost:56421' 05:58:53 INFO - SUITE-START | Running 2 tests 05:58:53 INFO - TEST-START | dromaeo_css 05:58:53 INFO - operating with platform_type : linux_ 05:58:53 INFO - Initialising browser for dromaeo_css test... 05:58:53 INFO - TEST-INFO | started process 22788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUSBins/profile http://localhost:56421/getInfo.html) 05:58:58 INFO - PROCESS | 22788 | __metrics Screen width/height:1600/1200 05:58:58 INFO - PROCESS | 22788 | colorDepth:24 05:58:58 INFO - PROCESS | 22788 | Browser inner width/height: 1024/697 05:58:58 INFO - PROCESS | 22788 | __metrics 05:58:58 ERROR - PROCESS | 22788 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 05:58:59 INFO - TEST-INFO | 22788: exit 0 05:58:59 INFO - Browser initialized. 05:58:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:59 INFO - TEST-INFO | started process 22911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUSBins/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:11 INFO - PROCESS | 22911 | RSS: Main: 186843136 05:59:11 INFO - PROCESS | 22911 | 06:00:01 INFO - PROCESS | 22911 | 1477918801698 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:02:12 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:56421/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56421/tests/dromaeo/cssquery-ext.html) 06:02:14 INFO - PROCESS | 22911 | RSS: Main: 199352320 06:02:14 INFO - PROCESS | 22911 | 06:05:16 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:56421/tests/dromaeo/cssquery-ext.html (next: http://localhost:56421/tests/dromaeo/cssquery-jquery.html) 06:05:16 INFO - PROCESS | 22911 | RSS: Main: 197431296 06:05:16 INFO - PROCESS | 22911 | 06:08:18 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:56421/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56421/tests/dromaeo/cssquery-mootools.html) 06:08:19 INFO - PROCESS | 22911 | RSS: Main: 199782400 06:08:19 INFO - PROCESS | 22911 | 06:11:21 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:56421/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56421/tests/dromaeo/cssquery-prototype.html) 06:11:21 INFO - PROCESS | 22911 | RSS: Main: 195981312 06:11:21 INFO - PROCESS | 22911 | 06:14:24 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:56421/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56421/tests/dromaeo/cssquery-yui.html) 06:14:24 INFO - PROCESS | 22911 | RSS: Main: 199716864 06:14:24 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:56421/tests/dromaeo/cssquery-yui.html (next: http://localhost:56421/tests/dromaeo/cssquery-dojo.html) 06:17:27 INFO - PROCESS | 22911 | RSS: Main: 199135232 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | __start_tp_report 06:17:27 INFO - PROCESS | 22911 | _x_x_mozilla_page_load 06:17:27 INFO - PROCESS | 22911 | _x_x_mozilla_page_load_details 06:17:27 INFO - PROCESS | 22911 | |i|pagename|runs| 06:17:27 INFO - PROCESS | 22911 | |0;dojo.html;2980.3145276586383;2996.595459612953;3006.6692663806975;3030.378772351668;3031.6968303169674;5273.841784746459;5348.197770334452;5358.410574836765;5363.785448582062;5374.301340825692;5385.623006389545;5390.73046347683;5400.486953739398;5445.863853403657;5492.395836457987;4844.176489996709;4862.076205520957;4941.184704523749;4993.800247990076;5040.773165207556;4679.60223381013;4917.975410122945;4930.285108659242;4953.702777833323;5010.72441015744;4699.060187962404;4818.373611430527;4829.782659780283;4894;4911.361523001987;4848.17581011229;4851.490593487668;4857.319975203474;4917.36074310341;4962;4912.877178070541;4920.704757714549;4928.063667903087;4933.605311575066;4999.8000079996755;5233.058049551079;5318.840434786924;5343.65266257692;5350.973245133789;5358.437364076754;5693.77224911003;5717.542596592262;5725.08398656213;5732.140178973145;5756.942430575725;5518.2826232589505;5593.412691667398;5852.4440178183;5867.794627188071;5869.295684517842;5368.382635996872;5419.918701219485;5431.022415965124;5453.045716999589;5504.091824848935;5868.559858010666;5882.382349853289;5887.852803679943;5899.439553242435;5909;5402.35171779389;5687.573431992617;5695.231143795535;5701.486866182064;5702.885942281131;5575.107982722826;5674.716264186774;5735.827925162252;5759.136129580513;5849.824505264849;5754.395788442237;5785.218995435646;5788.739506722123;5789.565782566325;5807.738651760681;5695.231143795535;5776.653400795965;5811.215485909433;5812.157237200667;5823.505002074787;4286.978565107217;4369.47566292047;4402.647788176938;4408.184485870124;4472.530384309601;3878.50211631526;3919.8236079376497;3925.803709814498;3974.6621537169085;3977.065389633434;5416.891662166735;5451.400345961941;5480.26016487777;5481.862953426196;5482.862928426742;5622.128570071563;5678.716064196774;5694.971525142348;5766.855828604234;5781.19063331134;5523.806666766724;5529.087700529448;5531.3362396511875;5533.087040638249;5554.72226388679;4932.926006109911;4957.479464656231;4984.077945580079;4993.051320249214;5023.397192336943;5711.314642242957;5785.132230165509;5872.588918775645;5971.3132989705;5981.401859814071;5772.480476757112;5794.62334948227;5813.09896965971;5816.41835816415;5839.854003649943;5929.6145750526075;5987.520998320037;6037.577369584263;6037.939620603738;6040.909386359296;5479.178123281539;5586.190002449541;5643.88712225745;5707.828765137053;5713.800016999385;5779.971100144472;5812.883742325214;5829.47534721877;5830.5627077968475;5879.7060146993335;5660.462256085665;5705.115707065412;5714.657120572612;5721.914171287351;5728.398518155534;5395.3525576931015;5427.185922111715;5615.157726341082;5628.099504079328;5677.801276955287;5615.747291371817;5633.802816901389;5666.801661941812;5705.22979397776;5721.313442386941;5678.886422271614;5696.344920334214;5738.540916726735;5745.913811292918;5747.942520574741;5339.7597108131;5342.225377320345;5538.141588053858;5543.556515478833;5599.412061733459 06:17:27 INFO - PROCESS | 22911 | |1;ext.html;563.3802816901409;570.3355590736792;575.6718670357892;583.1922786940088;586.6274915428702;40355.39466907995;42317.15365692688;42398.15203695924;46289.7685511572;46327.768361158145;44434.33348499767;44917.7754111229;45231.547684523146;45264.3210351845;45315;8778.297736181106;8799.428037177595;8946.507942063185;8950.86573701395;8955.507447090407;8764.386492945465;8783.912160878404;8807.33944954131;8830.690925817598;8835.160659737314;8851.77870553235;8876.556172191365;8922;8922.776930576754;8929.419587726778;8740.956295218546;8775.824483510358;8842.115788421172;8858.069902660192;8862.158094980967;8682.6092825823;8728.694495692684;8760.824783504295;8769.07924667907;8775.824483510294;41365.37951930724;41753.373699394535;41791.7910410446;41805.79097104525;41896.37155442671;3288.19439237386;3502.964970350289;3548.024293319332;3733.4213196954515;3874.418837174418;31359.84320078408;31373.215669608213;31956.520652190236;31968.360632787448;32606.836965815255;4310.418093557361;4441.289393697025;4455.287154055336;4462.085272519126;4474.060447306069;346898;348811;349142;350063;351445.99999999744;59440.70279648661;59839.40160598338;59881.70059149763;59900;59978.40021599728;60795.69602151961;61223.38776612266;61369.69315153396;61376.38623613796;61547.6922615384;15787.052776833198;15952.122633255283;16024.599385015235;16028.358865645478;16047.598810029842;11716.06271498295;11739.823902641467;11740.765184696258;11828.23116497425;11830.822537661941;14551.563453096423;15991.840081599035;18516.629667406847;18529.629407411776;18673;6986.231514533397;7074.504784665127;7187.209406965229;7529.616324328132;7609.581473019037;914.154407173362;975.8145952269047;1001.4942454060653;1013.9138173255209;1020.0972139656309;30224.84887575548;30599;31096;31378;31409.42012686107;1058.941758203306;1065.1265961911158;1134.5915470430639;1137.8748337682848;1163.1857699610136;15793.21033948298;16405.507834764976;16412.589685257724;16512.25694843735;16737.581560460843;521442;525764;526745;527498;528202;56387.15419268714;56436;56639.71680141573;56941.14588281179;57017.71491142518;1306.6994591243877;1339.6048165791115;1344.2069179184132;1352.0603180789258;1370.7943808428815;29622.703772961995;31205.843970780003;31391.84304078465;31455.370892581563;31822.681773181972;49953.00093998027;50781.746091269306;50798;50802;50850.98298034092;443503;444715;445561;445983;448431;26713.599296010965;27067.323316917234;27268.863655681595;27399;27413.58879616847;45562.5533943945;45946;47474.762626186646;47522.762386187846;47583;38813.805930970164;42199.367009494264;45413.31880021869;46380;46667.299990499494;38885.61114388933;39486.80256598699;40722.389164163156;42718.57281427146;43210.56789432065;42512.57487425086;42724.145517088866;43091.56908430876;43292.78353608338;43526.34710479282;41851.7907410461;42334.36498452587;42408.15183696247;42535;43217.567824321355;28319.752037194587;28833.56749648799;29577.8238808212;30762.384752305275;31113.37773244568 06:17:27 INFO - PROCESS | 22911 | |2;jquery.html;385.2141631072612;388.4057392189949;394.5364197068444;399.25937386148695;421.7827818673384;15888.682226355495;16475.093869837183;18149.455516334514;19544.120514576844;19561.706574401378;11978.700532486691;12648.683782905431;12651.304178270191;14256.501022464216;18799.90600047001;5237.711925844077;5456.672599644015;5462.071447853875;5471.562275018009;5488.780448782044;5243.475652434764;5312.787488500475;5358.946410535903;5360.463953604647;5372.7313634318325;5362.892742145154;5548.6948217848;5851.64890106595;5861;5867.88264234715;5864.266966629171;5882.23530940975;5906.055031195031;5933.5549833762425;5968.67172305523;5664.433556644344;5682.971585142089;5705.4294570543025;5715.228444160027;5719.19931209631;13171.275579843104;13612.31938403076;13760.449582016707;14003.78994315076;14222.359993800304;2102.6005059038735;2137.5831712816007;2297.7472478027403;2333.8833058347186;2552.6043463263222;10183.23625728066;10387.324823886423;10875.184361172944;13107.14803537767;13915.652108697364;1889.2915156816193;1926.9325573604856;1982.9900850495656;1990.28349794074;1992.5815578728484;77575.61212193903;82575.58712206461;84074.57962710208;84796;85096.57451712702;10751.301165424222;10840.728981775519;11053.502592383362;11076.169287303484;11216.887831121747;15526.611834704223;15538.844611553966;15578.454754083552;15631.218439078228;15633.3746650135;7756;7837.882431763528;8125;8210.425270231026;8228.711995080144;7561.508501947355;7564.281393267741;7609.315161635479;7781.260780225983;7807.102183248886;4601.401817763669;4681.7659117044695;4692.272697731857;4694.81220751173;4770.880727981828;1911.1686416408907;1936.6901295792607;1942.8348590369694;1960.6176795524736;1967.6261510312995;883.8939327280767;951.357833462424;995.9741466289734;999.645125980281;1098.912077043721;18045.819541804678;18526.907365463085;18900.338488153124;19342.516437088903;19540.31608893682;934.444005816538;966.0098399140937;971.9902800972042;1021.2953062386929;1041.286718597763;10329.328593641389;10779.78440431187;10827.67516974492;10834.187435942336;10905.454727263605;337313;337786;339267;452452;484057;85795;88301.67547486792;88814.55592721995;89685.55157224172;90037;1030.845373194027;1031.664708969573;1081.853949716794;1098.319042193845;1101.1356085472864;16507.91746041262;16711;17153.313867445162;17266;17598.560035999202;37769;38230.808845955595;39205.80397097996;39356.409653855786;40264.194716104925;55892.72053639706;56079.71960140173;56183.719081405965;57417.42582574121;58891.41108588859;7288.234735352924;7601.429892758176;7779.105402878741;7822.178671239438;8025.23760242776;9520.809583808423;12465.439055242718;13319.467221311426;13327.86672133305;13359.1316564423;11354;11576.94211528937;11665;11685.941570292094;11977.401129943642;11169.329840209613;11334.319940803578;11478.196526243417;11537.250078744855;11683.649490515298;11214.607488738182;11366.886331136913;11619.593314233962;11810.350430726392;11976.940115299367;7863.567503787347;7885.3297469713425;7951.681932722627;8155.551444670363;8306;8350.707725229588;10134.847977280495;10564.524596393334;10746.140308775122;10961.890381096406 06:17:27 INFO - PROCESS | 22911 | |3;mootools.html;1453.0918176139917;1489.4116823854577;1608.5335252776695;1652.9090900000494;1752.9035903025328;7258.129024517066;7394;7854.646540905659;8347.499150050993;8401.83196336073;7772.68909243631;8035.6383962721675;8040.8391832163325;8299.253067223948;8308.210719981607;2250.9212177573786;2276.7932995512324;2280.977190228093;2281.4068342231058;2285.897134628946;2238.7201599800023;2275.476640372707;2313.595120853852;2316.791488766011;2317.953640927189;2273.920412785553;2274.7270327560714;2298.5747636687265;2299.678045073683;2304.3893368257427;2245.9438514037115;2250.909963601454;2267.580497607948;2275.4993901341677;2277.943051423719;2220.9555808883892;2251.3358559225067;2256.1201131558705;2258.6612008198736;2273.943151421211;8144.918550814535;8236.888020117267;8243.175682431769;8250.174982501761;8268.462549934235;4828.73441960692;4923.606111511071;4961.429435614915;4962.851114466535;4964.553190212898;3047;3141.1204862638497;3359.051749985003;3359.6640335966454;3361.243720162968;1081.8809930907594;1096.0354887698854;1110.8333749937494;1125.6285425809544;1159.7912375772357;11053.613123540717;11072.944635276852;11134.944325278402;11143.442827858657;11181.273217240854;4292.12011537634;4387.319965405367;4472.485664148599;4476.843310484118;4524.434445694288;9368.718938431857;9378.249740020781;9381.343305968516;9394.530273486298;9408.529573521297;4846.418429788448;4890;4893.363862697826;4903.950960490421;4906.90186196274;4027.9194416111513;4138.627523522837;4402.075564131568;4467.955320446819;4474.082813023322;3746.3631182699005;3770.849166033383;3783.281176576497;3807.3717836556657;3872.5159355080614;1250.6435665835193;1251.8748125187408;1272.497363541396;1273.7770890094382;1276.9680757981125;968.6028728221536;977.1986970683971;986.363795351994;1002.7042022603349;1002.9548670309854;5628.859278517988;5677.886442271214;5771.94228057714;5785.566082543826;5904.822855314347;431.13127048996296;435.34263262473894;444.7042716593494;446.1678968723372;450.3852241690135;4096.897577560525;4111.075008123208;4144.79276036197;4168.333066709312;4180.581941805795;9304.209142222986;9651.372660777028;9659.951700241454;9684.32209745311;9786.853197202048;9568.665096721581;9592.232621390272;9596.376235544667;9617.086376794194;9636.132748052709;7323.487355885143;7452.925470745332;7550.924490755132;7563.621818909032;7671.424643151674;5780.075187969905;5854.385289544536;5934.9406505934385;5944.940550594439;6011.098335249748;8948.776280593038;9017.368784185044;9069.727908162766;9148.725538233864;9246.398984066283;8990.730278091667;9144.222741067084;9278.489683067495;9309.20871725911;9394.718158455258;6372.36276372359;6535.673216339259;7117.501774875916;7141.285871412817;7200.207977122617;7698.961505192438;7981.48120372174;8009.639566219417;8015.398845086525;8022;7190.676419561237;7322.90579771657;7453.739119130804;7487.700491980259;7530.736424225345;6928.7228510859;7210.783676489714;7229.819254518679;7269.854602908018;7372.189059203591;6609.603423794588;6725.428338591275;6729.427998620172;6731.1922569292;6734.4275736560985;5037.617601747106;5056.6207534434325;5122.052420302107;5258.8159414420315;5307.283516725192;4835.975820120877;4969.875753106201;5022.673526220784;5098.97450512745;5147.819826306061 06:17:27 INFO - PROCESS | 22911 | |4;prototype.html;321.8439057057328;326.3228800239503;334.80246654473865;337.90200841755893;342.0849228314259;5426.050441172799;5433.429489903562;5434.646747961379;5462.672239665623;5486.231927530139;5341.519263266306;5383.488568585988;5408.4050754416985;5417.756200970956;5436.782528698857;4085.3667681509414;4182.456280683522;4292.488893997015;4313.654907607384;4332.1335732853395;4205;4210.400047981762;4212.304969680014;4213.346931225665;4219.831206751726;4160.521540022906;4175.561566035568;4204.516480604724;4205.873823785291;4227.8308867645255;4024.8188831502653;4150.024744185114;4152.1695660867945;4152.792360381969;4188.6649068074485;3656.561212654472;3660.670539651444;3665.120371110941;3665.845258743487;3674.5039419678537;5208.869778255536;5234.214867769827;5239;5295.179247216687;5308.283381743492;4595.793189306489;4683.391159149322;4746.145693775119;4746.857594272177;4797.856064318041;5542.61201715876;5564.527015203713;5569.8607534811545;5597.7201139943245;5647.632903861236;3992.5208974922903;3996.680265578747;4000.4799376080923;4032.193561287754;4032.737872038308;5654.349749778787;5801.796937107223;5827.300723913115;5843.737031833578;5872.735726892342;4118.094019315746;4143.316352801814;4148.688848336386;4158.584141585878;4174.039970806671;4176.4570605821655;4200.789960501963;4204.684648651363;4207.389928460356;4219.915601687949;4697.859064228079;4795.640326975491;4813.3983252093485;4820.084184005028;4827.227643577081;5537.667739935617;5559.6664200148125;5564.410954934126;5622.381538030813;5649.435056494318;1427.0082292806608;1462.4278900182135;1463.3926920327945;1470.2207829850197;1470.6396932751545;878.0517041595062;926.7127190570944;933.780561568031;949.4635530925005;951.167728237792;4736.455307639597;4747.786349614275;4770.594499467515;4778.522147785263;4783.1868582341085;4988.226824842155;5040.924386134211;5049.545540901337;5079.044567841408;5082.847514574569;4543.204939135638;4710.010897711519;4740.525947405232;4750.334953106568;4755.857324280277;2651.6552848130004;2673.25148958292;2678.901650323397;2682.1417146512927;2701.730186812195;5082.001619044781;5246.845693947325;5279.841604751864;5306.973465132727;5330.668332292317;4747.881302967385;5079.746012699424;5126.307948426915;5128.615353848476;5152.7166005869285;5121.795128194905;5127.717975511383;5160;5179.912218434096;5221.3734351878775;5003.874903127451;5041.823536176216;5068.797248110034;5074.5686616637995;5080.085584594661;4808.591269742111;4970.950290497193;4975;4977.552020318044;5012.523810238022;5115.03071317538;5137.794488220429;5140.254663073908;5143.014164022912;5184.351956005499;3724.739268251305;3740.270647223765;3760.777747232106;3762.6049264827893;3788.6888997711926;5106.208537676517;5126.359205099363;5448.83653490396;5839.240898683144;5842.561807864512;5716.427982304899;5724.31132815812;5734.598578099493;5740.024195886793;5759.596828221985;5558.833235002957;5690.292912126429;5718.428157184248;5720.713964301852;5738.938296415176;5564.721763911869;5577.860553486195;5605.663660180402;5610.943890561205;5616.915746263728;5507.752151153128;5616.382197958303;5652.971735141298;5658;5682.886342273214;5519.862003449946;5550.2507161534295;5559.193916881949;5567.66594004361;5583.357913839798 06:17:27 INFO - PROCESS | 22911 | |5;yui.html;707.0843257980914;707.3704403081258;775.2286474957416;777.3353782515949;816.2735165702529;14330.355134018968;14389.1366518009;14526.782098268535;15400.075995440282;15442.459513917016;13275.933620331909;13489.190648561093;13491.257980811051;13556.796648050287;13584.796228056586;782.2099679323895;799.6481548118824;806.7418426103649;808.0747544062045;813.4062134641715;805.6455159729729;813.3290035720524;813.7762115418249;817.497239197892;819.1358117186365;841.2092632925062;846.7290467050547;846.7502086884384;847.4322204123253;851.2849206666399;830.6137645994642;840.017179899516;845.243507061183;846.0270688707974;846.0989046665281;619.1517620859452;621.7202258983475;622.9845352076087;623.7504998000836;624.2041397218537;12829;14419.78370324446;14495.202763847985;14541.27293635314;14603.123812571173;13005.544805931842;13395.397207125703;13579.456821727119;14024.298785060808;14501.70996580073;11938.22401543897;12011.879881201163;12073.93963030188;12091.879081209163;12210.816837747441;3697.186618943828;3711.5546134463766;3721.292954338667;3746.194568167857;3789.943150852712;63317.68341158311;64195.358046419875;64354.35645643531;64755;66171.99999999952;9908.405495670282;10196.745081373025;10437.217208709226;10594.364338139736;10906.655069160168;18110;18250.634987300444;18759.718604220947;19673.21307147727;19842.50393740139;7292.343689067903;7453.515521491086;7458.291462311072;7562.621868906533;7647.923520764833;4229.344451610005;4328.848490302824;4329;4361.433013708198;4397.428334316518;3378.3412234614507;3431.227973705946;3460.377132116193;3484.320557491265;3489.1277180704824;580.7386675995818;589.9882002359928;598.3806760003375;600.5165841497636;602.5721737566289;713.5219403000002;721.1310371002929;730.2514922204782;744.8473063022068;747.6411322565199;8485.193906578865;8727.825443491094;8829.69096081634;8909.020007799138;9243.676471323472;582.1006544888158;647.0133047103111;693.7883945396702;694.6422592364936;733.6515155301296;4085.611866872642;4294.312909934458;4340.348947657877;4410.625096866738;4472.44094488189;70832.29167708257;76498;88741.55629221942;88767;93499.53250233705;43570.128597428506;43732.3440148398;44268.778656106515;45563;73311.63344183245;65000.349996499426;65411;65554;65765.67117164479;65941.34058659352;8434.409591328793;8458.830823383621;8563.785905352415;8866.33502487329;8906.153915378029;42415.57584424116;44589.55410445854;44880.77559612181;45548.31677524906;47082;53564.1965370512;54855.725721371135;55245.44754552564;55890.16164757613;58689.70655146697;11667.299962002307;11758.764824703629;12089.81865272004;12156.1490695654;12444.81332779991;12851.293178875252;12854.164479308814;13089.149205301625;13224.933875330562;13785.379657915619;12282.508699651913;12477.438515267017;12870.806937896126;12943.611691649265;13750.037497375488;12297.877021230031;12690.302033388252;12873.163244389085;13398;13409.463621455032;12035.819462708241;12514.874851251736;12766.936165319114;12828.358582070672;12976.221426714428;9384.249260059316;10061.144802691853;10156.949215253877;10279.640212592523;10507.31702439339;10348.706411698538;10429.68710938673;10450.216233782648;10580.735481613021;10591.89408105909 06:17:27 INFO - PROCESS | 22911 | __end_tp_report 06:17:27 INFO - PROCESS | 22911 | __start_cc_report 06:17:27 INFO - PROCESS | 22911 | _x_x_mozilla_cycle_collect,334 06:17:27 INFO - PROCESS | 22911 | __end_cc_report 06:17:27 INFO - PROCESS | 22911 | __startTimestamp1477919847873__endTimestamp 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | ------- Summary: start ------- 06:17:27 INFO - PROCESS | 22911 | Number of tests: 6 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | [#0] dojo.html Cycles:165 Average:5350.30 Median:5543.56 stddev:622.62 (11.2%) stddev-sans-first:596.13 06:17:27 INFO - PROCESS | 22911 | Values: 2980.3 2996.6 3006.7 3030.4 3031.7 5273.8 5348.2 5358.4 5363.8 5374.3 5385.6 5390.7 5400.5 5445.9 5492.4 4844.2 4862.1 4941.2 4993.8 5040.8 4679.6 4918.0 4930.3 4953.7 5010.7 4699.1 4818.4 4829.8 4894.0 4911.4 4848.2 4851.5 4857.3 4917.4 4962.0 4912.9 4920.7 4928.1 4933.6 4999.8 5233.1 5318.8 5343.7 5351.0 5358.4 5693.8 5717.5 5725.1 5732.1 5756.9 5518.3 5593.4 5852.4 5867.8 5869.3 5368.4 5419.9 5431.0 5453.0 5504.1 5868.6 5882.4 5887.9 5899.4 5909.0 5402.4 5687.6 5695.2 5701.5 5702.9 5575.1 5674.7 5735.8 5759.1 5849.8 5754.4 5785.2 5788.7 5789.6 5807.7 5695.2 5776.7 5811.2 5812.2 5823.5 4287.0 4369.5 4402.6 4408.2 4472.5 3878.5 3919.8 3925.8 3974.7 3977.1 5416.9 5451.4 5480.3 5481.9 5482.9 5622.1 5678.7 5695.0 5766.9 5781.2 5523.8 5529.1 5531.3 5533.1 5554.7 4932.9 4957.5 4984.1 4993.1 5023.4 5711.3 5785.1 5872.6 5971.3 5981.4 5772.5 5794.6 5813.1 5816.4 5839.9 5929.6 5987.5 6037.6 6037.9 6040.9 5479.2 5586.2 5643.9 5707.8 5713.8 5780.0 5812.9 5829.5 5830.6 5879.7 5660.5 5705.1 5714.7 5721.9 5728.4 5395.4 5427.2 5615.2 5628.1 5677.8 5615.7 5633.8 5666.8 5705.2 5721.3 5678.9 5696.3 5738.5 5745.9 5747.9 5339.8 5342.2 5538.1 5543.6 5599.4 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | [#1] ext.html Cycles:180 Average:60343.19 Median:43214.07 stddev:118222.64 (273.6%) stddev-sans-first:118469.08 06:17:27 INFO - PROCESS | 22911 | Values: 563.4 570.3 575.7 583.2 586.6 40355.4 42317.2 42398.2 46289.8 46327.8 44434.3 44917.8 45231.5 45264.3 45315.0 8778.3 8799.4 8946.5 8950.9 8955.5 8764.4 8783.9 8807.3 8830.7 8835.2 8851.8 8876.6 8922.0 8922.8 8929.4 8741.0 8775.8 8842.1 8858.1 8862.2 8682.6 8728.7 8760.8 8769.1 8775.8 41365.4 41753.4 41791.8 41805.8 41896.4 3288.2 3503.0 3548.0 3733.4 3874.4 31359.8 31373.2 31956.5 31968.4 32606.8 4310.4 4441.3 4455.3 4462.1 4474.1 346898.0 348811.0 349142.0 350063.0 351446.0 59440.7 59839.4 59881.7 59900.0 59978.4 60795.7 61223.4 61369.7 61376.4 61547.7 15787.1 15952.1 16024.6 16028.4 16047.6 11716.1 11739.8 11740.8 11828.2 11830.8 14551.6 15991.8 18516.6 18529.6 18673.0 6986.2 7074.5 7187.2 7529.6 7609.6 914.2 975.8 1001.5 1013.9 1020.1 30224.8 30599.0 31096.0 31378.0 31409.4 1058.9 1065.1 1134.6 1137.9 1163.2 15793.2 16405.5 16412.6 16512.3 16737.6 521442.0 525764.0 526745.0 527498.0 528202.0 56387.2 56436.0 56639.7 56941.1 57017.7 1306.7 1339.6 1344.2 1352.1 1370.8 29622.7 31205.8 31391.8 31455.4 31822.7 49953.0 50781.7 50798.0 50802.0 50851.0 443503.0 444715.0 445561.0 445983.0 448431.0 26713.6 27067.3 27268.9 27399.0 27413.6 45562.6 45946.0 47474.8 47522.8 47583.0 38813.8 42199.4 45413.3 46380.0 46667.3 38885.6 39486.8 40722.4 42718.6 43210.6 42512.6 42724.1 43091.6 43292.8 43526.3 41851.8 42334.4 42408.2 42535.0 43217.6 28319.8 28833.6 29577.8 30762.4 31113.4 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | [#2] jquery.html Cycles:180 Average:25530.29 Median:169932.80 stddev:65902.95 (38.8%) stddev-sans-first:66060.78 06:17:27 INFO - PROCESS | 22911 | Values: 385.2 388.4 394.5 399.3 421.8 15888.7 16475.1 18149.5 19544.1 19561.7 11978.7 12648.7 12651.3 14256.5 18799.9 5237.7 5456.7 5462.1 5471.6 5488.8 5243.5 5312.8 5358.9 5360.5 5372.7 5362.9 5548.7 5851.6 5861.0 5867.9 5864.3 5882.2 5906.1 5933.6 5968.7 5664.4 5683.0 5705.4 5715.2 5719.2 13171.3 13612.3 13760.4 14003.8 14222.4 2102.6 2137.6 2297.7 2333.9 2552.6 10183.2 10387.3 10875.2 13107.1 13915.7 1889.3 1926.9 1983.0 1990.3 1992.6 77575.6 82575.6 84074.6 84796.0 85096.6 10751.3 10840.7 11053.5 11076.2 11216.9 15526.6 15538.8 15578.5 15631.2 15633.4 7756.0 7837.9 8125.0 8210.4 8228.7 7561.5 7564.3 7609.3 7781.3 7807.1 4601.4 4681.8 4692.3 4694.8 4770.9 1911.2 1936.7 1942.8 1960.6 1967.6 883.9 951.4 996.0 999.6 1098.9 18045.8 18526.9 18900.3 19342.5 19540.3 934.4 966.0 972.0 1021.3 1041.3 10329.3 10779.8 10827.7 10834.2 10905.5 337313.0 337786.0 339267.0 452452.0 484057.0 85795.0 88301.7 88814.6 89685.6 90037.0 1030.8 1031.7 1081.9 1098.3 1101.1 16507.9 16711.0 17153.3 17266.0 17598.6 37769.0 38230.8 39205.8 39356.4 40264.2 55892.7 56079.7 56183.7 57417.4 58891.4 7288.2 7601.4 7779.1 7822.2 8025.2 9520.8 12465.4 13319.5 13327.9 13359.1 11354.0 11576.9 11665.0 11685.9 11977.4 11169.3 11334.3 11478.2 11537.3 11683.6 11214.6 11366.9 11619.6 11810.4 11976.9 7863.6 7885.3 7951.7 8155.6 8306.0 8350.7 10134.8 10564.5 10746.1 10961.9 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | [#3] mootools.html Cycles:180 Average:5394.02 Median:5047.12 stddev:2947.44 (58.4%) stddev-sans-first:2940.83 06:17:27 INFO - PROCESS | 22911 | Values: 1453.1 1489.4 1608.5 1652.9 1752.9 7258.1 7394.0 7854.6 8347.5 8401.8 7772.7 8035.6 8040.8 8299.3 8308.2 2250.9 2276.8 2281.0 2281.4 2285.9 2238.7 2275.5 2313.6 2316.8 2318.0 2273.9 2274.7 2298.6 2299.7 2304.4 2245.9 2250.9 2267.6 2275.5 2277.9 2221.0 2251.3 2256.1 2258.7 2273.9 8144.9 8236.9 8243.2 8250.2 8268.5 4828.7 4923.6 4961.4 4962.9 4964.6 3047.0 3141.1 3359.1 3359.7 3361.2 1081.9 1096.0 1110.8 1125.6 1159.8 11053.6 11072.9 11134.9 11143.4 11181.3 4292.1 4387.3 4472.5 4476.8 4524.4 9368.7 9378.2 9381.3 9394.5 9408.5 4846.4 4890.0 4893.4 4904.0 4906.9 4027.9 4138.6 4402.1 4468.0 4474.1 3746.4 3770.8 3783.3 3807.4 3872.5 1250.6 1251.9 1272.5 1273.8 1277.0 968.6 977.2 986.4 1002.7 1003.0 5628.9 5677.9 5771.9 5785.6 5904.8 431.1 435.3 444.7 446.2 450.4 4096.9 4111.1 4144.8 4168.3 4180.6 9304.2 9651.4 9660.0 9684.3 9786.9 9568.7 9592.2 9596.4 9617.1 9636.1 7323.5 7452.9 7550.9 7563.6 7671.4 5780.1 5854.4 5934.9 5944.9 6011.1 8948.8 9017.4 9069.7 9148.7 9246.4 8990.7 9144.2 9278.5 9309.2 9394.7 6372.4 6535.7 7117.5 7141.3 7200.2 7699.0 7981.5 8009.6 8015.4 8022.0 7190.7 7322.9 7453.7 7487.7 7530.7 6928.7 7210.8 7229.8 7269.9 7372.2 6609.6 6725.4 6729.4 6731.2 6734.4 5037.6 5056.6 5122.1 5258.8 5307.3 4836.0 4969.9 5022.7 5099.0 5147.8 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | [#4] prototype.html Cycles:180 Average:4536.78 Median:5059.17 stddev:1310.33 (25.9%) stddev-sans-first:1275.25 06:17:27 INFO - PROCESS | 22911 | Values: 321.8 326.3 334.8 337.9 342.1 5426.1 5433.4 5434.6 5462.7 5486.2 5341.5 5383.5 5408.4 5417.8 5436.8 4085.4 4182.5 4292.5 4313.7 4332.1 4205.0 4210.4 4212.3 4213.3 4219.8 4160.5 4175.6 4204.5 4205.9 4227.8 4024.8 4150.0 4152.2 4152.8 4188.7 3656.6 3660.7 3665.1 3665.8 3674.5 5208.9 5234.2 5239.0 5295.2 5308.3 4595.8 4683.4 4746.1 4746.9 4797.9 5542.6 5564.5 5569.9 5597.7 5647.6 3992.5 3996.7 4000.5 4032.2 4032.7 5654.3 5801.8 5827.3 5843.7 5872.7 4118.1 4143.3 4148.7 4158.6 4174.0 4176.5 4200.8 4204.7 4207.4 4219.9 4697.9 4795.6 4813.4 4820.1 4827.2 5537.7 5559.7 5564.4 5622.4 5649.4 1427.0 1462.4 1463.4 1470.2 1470.6 878.1 926.7 933.8 949.5 951.2 4736.5 4747.8 4770.6 4778.5 4783.2 4988.2 5040.9 5049.5 5079.0 5082.8 4543.2 4710.0 4740.5 4750.3 4755.9 2651.7 2673.3 2678.9 2682.1 2701.7 5082.0 5246.8 5279.8 5307.0 5330.7 4747.9 5079.7 5126.3 5128.6 5152.7 5121.8 5127.7 5160.0 5179.9 5221.4 5003.9 5041.8 5068.8 5074.6 5080.1 4808.6 4971.0 4975.0 4977.6 5012.5 5115.0 5137.8 5140.3 5143.0 5184.4 3724.7 3740.3 3760.8 3762.6 3788.7 5106.2 5126.4 5448.8 5839.2 5842.6 5716.4 5724.3 5734.6 5740.0 5759.6 5558.8 5690.3 5718.4 5720.7 5738.9 5564.7 5577.9 5605.7 5610.9 5616.9 5507.8 5616.4 5653.0 5658.0 5682.9 5519.9 5550.3 5559.2 5567.7 5583.4 06:17:27 INFO - PROCESS | 22911 | 06:17:27 INFO - PROCESS | 22911 | [#5] yui.html Cycles:180 Average:16489.57 Median:44429.17 stddev:21281.56 (47.9%) stddev-sans-first:21308.26 06:17:27 INFO - PROCESS | 22911 | Values: 707.1 707.4 775.2 777.3 816.3 14330.4 14389.1 14526.8 15400.1 15442.5 13275.9 13489.2 13491.3 13556.8 13584.8 782.2 799.6 806.7 808.1 813.4 805.6 813.3 813.8 817.5 819.1 841.2 846.7 846.8 847.4 851.3 830.6 840.0 845.2 846.0 846.1 619.2 621.7 623.0 623.8 624.2 12829.0 14419.8 14495.2 14541.3 14603.1 13005.5 13395.4 13579.5 14024.3 14501.7 11938.2 12011.9 12073.9 12091.9 12210.8 3697.2 3711.6 3721.3 3746.2 3789.9 63317.7 64195.4 64354.4 64755.0 66172.0 9908.4 10196.7 10437.2 10594.4 10906.7 18110.0 18250.6 18759.7 19673.2 19842.5 7292.3 7453.5 7458.3 7562.6 7647.9 4229.3 4328.8 4329.0 4361.4 4397.4 3378.3 3431.2 3460.4 3484.3 3489.1 580.7 590.0 598.4 600.5 602.6 713.5 721.1 730.3 744.8 747.6 8485.2 8727.8 8829.7 8909.0 9243.7 582.1 647.0 693.8 694.6 733.7 4085.6 4294.3 4340.3 4410.6 4472.4 70832.3 76498.0 88741.6 88767.0 93499.5 43570.1 43732.3 44268.8 45563.0 73311.6 65000.3 65411.0 65554.0 65765.7 65941.3 8434.4 8458.8 8563.8 8866.3 8906.2 42415.6 44589.6 44880.8 45548.3 47082.0 53564.2 54855.7 55245.4 55890.2 58689.7 11667.3 11758.8 12089.8 12156.1 12444.8 12851.3 12854.2 13089.1 13224.9 13785.4 12282.5 12477.4 12870.8 12943.6 13750.0 12297.9 12690.3 12873.2 13398.0 13409.5 12035.8 12514.9 12766.9 12828.4 12976.2 9384.2 10061.1 10156.9 10279.6 10507.3 10348.7 10429.7 10450.2 10580.7 10591.9 06:17:27 INFO - PROCESS | 22911 | -------- Summary: end -------- 06:17:27 INFO - PROCESS | 22911 | 06:17:28 INFO - TEST-INFO | 22911: exit 0 06:17:28 INFO - TEST-OK | dromaeo_css | took 1115133ms 06:17:28 INFO - TEST-START | kraken 06:17:28 INFO - operating with platform_type : linux_ 06:17:28 INFO - Initialising browser for kraken test... 06:17:28 INFO - TEST-INFO | started process 23275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp644NtM/profile http://localhost:56421/getInfo.html) 06:17:33 INFO - PROCESS | 23275 | __metrics Screen width/height:1600/1200 06:17:33 INFO - PROCESS | 23275 | colorDepth:24 06:17:33 INFO - PROCESS | 23275 | Browser inner width/height: 1024/697 06:17:33 INFO - PROCESS | 23275 | __metrics 06:17:33 ERROR - PROCESS | 23275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 06:17:34 INFO - TEST-INFO | 23275: exit 0 06:17:34 INFO - Browser initialized. 06:17:34 INFO - Running cycle 1/1 for kraken test... 06:17:34 INFO - TEST-INFO | started process 23396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp644NtM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:46 INFO - PROCESS | 23396 | RSS: Main: 186777600 06:17:46 INFO - PROCESS | 23396 | 06:17:49 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56421/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:50 INFO - PROCESS | 23396 | RSS: Main: 194899968 06:17:50 INFO - PROCESS | 23396 | 06:17:53 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56421/tests/kraken/driver.html?testName=audio-dft) 06:17:53 INFO - PROCESS | 23396 | RSS: Main: 197627904 06:17:53 INFO - PROCESS | 23396 | 06:17:56 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56421/tests/kraken/driver.html?testName=audio-fft) 06:17:57 INFO - PROCESS | 23396 | RSS: Main: 194064384 06:17:57 INFO - PROCESS | 23396 | 06:17:59 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56421/tests/kraken/driver.html?testName=audio-oscillator) 06:18:00 INFO - PROCESS | 23396 | RSS: Main: 194469888 06:18:00 INFO - PROCESS | 23396 | 06:18:02 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56421/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:02 INFO - PROCESS | 23396 | RSS: Main: 195006464 06:18:02 INFO - PROCESS | 23396 | 06:18:05 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56421/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:06 INFO - PROCESS | 23396 | RSS: Main: 195371008 06:18:06 INFO - PROCESS | 23396 | 06:18:09 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56421/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:10 INFO - PROCESS | 23396 | RSS: Main: 193335296 06:18:10 INFO - PROCESS | 23396 | 06:18:13 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56421/tests/kraken/driver.html?testName=json-parse-financial) 06:18:13 INFO - PROCESS | 23396 | RSS: Main: 194490368 06:18:13 INFO - PROCESS | 23396 | 06:18:15 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56421/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:16 INFO - PROCESS | 23396 | RSS: Main: 194121728 06:18:16 INFO - PROCESS | 23396 | 06:18:17 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:18 INFO - PROCESS | 23396 | RSS: Main: 194068480 06:18:18 INFO - PROCESS | 23396 | 06:18:20 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:21 INFO - PROCESS | 23396 | RSS: Main: 194314240 06:18:21 INFO - PROCESS | 23396 | 06:18:24 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:24 INFO - PROCESS | 23396 | RSS: Main: 194465792 06:18:24 INFO - PROCESS | 23396 | 06:18:27 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:28 INFO - PROCESS | 23396 | RSS: Main: 194633728 06:18:28 INFO - PROCESS | 23396 | 06:18:29 INFO - PROCESS | 23396 | Cycle 1(1): loaded http://localhost:56421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56421/tests/kraken/driver.html?testName=ai-astar) 06:18:30 INFO - PROCESS | 23396 | RSS: Main: 196079616 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | __start_tp_report 06:18:30 INFO - PROCESS | 23396 | _x_x_mozilla_page_load 06:18:30 INFO - PROCESS | 23396 | _x_x_mozilla_page_load_details 06:18:30 INFO - PROCESS | 23396 | |i|pagename|runs| 06:18:30 INFO - PROCESS | 23396 | |0;ai-astar;109;113;114;112;112;112;114;112;113;113 06:18:30 INFO - PROCESS | 23396 | |1;audio-beat-detection;147;123;123;166;126;124;125;122;160;133 06:18:30 INFO - PROCESS | 23396 | |2;audio-dft;165;165;168;168;169;164;165;163;163;161 06:18:30 INFO - PROCESS | 23396 | |3;audio-fft;75;76;76;112;77;77;78;78;103;77 06:18:30 INFO - PROCESS | 23396 | |4;audio-oscillator;82;81;109;83;83;83;104;82;82;113 06:18:30 INFO - PROCESS | 23396 | |5;imaging-gaussian-blur;118;117;119;117;117;118;118;118;118;118 06:18:30 INFO - PROCESS | 23396 | |6;imaging-darkroom;149;149;146;147;147;147;147;149;147;147 06:18:30 INFO - PROCESS | 23396 | |7;imaging-desaturate;85;85;87;85;85;86;84;84;85;84 06:18:30 INFO - PROCESS | 23396 | |8;json-parse-financial;54;53;54;56;60;57;53;54;54;56 06:18:30 INFO - PROCESS | 23396 | |9;json-stringify-tinderbox;65;64;65;63;64;64;65;64;63;63 06:18:30 INFO - PROCESS | 23396 | |10;stanford-crypto-aes;80;79;80;81;80;80;80;84;83;80 06:18:30 INFO - PROCESS | 23396 | |11;stanford-crypto-ccm;145;136;141;131;133;137;149;138;173;131 06:18:30 INFO - PROCESS | 23396 | |12;stanford-crypto-pbkdf2;168;170;173;171;166;173;170;169;177;174 06:18:30 INFO - PROCESS | 23396 | |13;stanford-crypto-sha256-iterative;70;65;65;66;65;67;69;63;64;68 06:18:30 INFO - PROCESS | 23396 | __end_tp_report 06:18:30 INFO - PROCESS | 23396 | __start_cc_report 06:18:30 INFO - PROCESS | 23396 | _x_x_mozilla_cycle_collect,842 06:18:30 INFO - PROCESS | 23396 | __end_cc_report 06:18:30 INFO - PROCESS | 23396 | __startTimestamp1477919910224__endTimestamp 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | ------- Summary: start ------- 06:18:30 INFO - PROCESS | 23396 | Number of tests: 14 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.43 (1.3%) stddev-sans-first:0.83 06:18:30 INFO - PROCESS | 23396 | Values: 109.0 113.0 114.0 112.0 112.0 112.0 114.0 112.0 113.0 113.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:129.50 stddev:16.64 (12.9%) stddev-sans-first:17.07 06:18:30 INFO - PROCESS | 23396 | Values: 147.0 123.0 123.0 166.0 126.0 124.0 125.0 122.0 160.0 133.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.56 (1.6%) stddev-sans-first:2.71 06:18:30 INFO - PROCESS | 23396 | Values: 165.0 165.0 168.0 168.0 169.0 164.0 165.0 163.0 163.0 161.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:13.17 (17.1%) stddev-sans-first:13.65 06:18:30 INFO - PROCESS | 23396 | Values: 75.0 76.0 76.0 112.0 77.0 77.0 78.0 78.0 103.0 77.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:12.93 (15.8%) stddev-sans-first:13.37 06:18:30 INFO - PROCESS | 23396 | Values: 82.0 81.0 109.0 83.0 83.0 83.0 104.0 82.0 82.0 113.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:18:30 INFO - PROCESS | 23396 | Values: 118.0 117.0 119.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 06:18:30 INFO - PROCESS | 23396 | Values: 149.0 149.0 146.0 147.0 147.0 147.0 147.0 149.0 147.0 147.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 06:18:30 INFO - PROCESS | 23396 | Values: 85.0 85.0 87.0 85.0 85.0 86.0 84.0 84.0 85.0 84.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:2.18 (4.0%) stddev-sans-first:2.28 06:18:30 INFO - PROCESS | 23396 | Values: 54.0 53.0 54.0 56.0 60.0 57.0 53.0 54.0 54.0 56.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 06:18:30 INFO - PROCESS | 23396 | Values: 65.0 64.0 65.0 63.0 64.0 64.0 65.0 64.0 63.0 63.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:1.57 (2.0%) stddev-sans-first:1.64 06:18:30 INFO - PROCESS | 23396 | Values: 80.0 79.0 80.0 81.0 80.0 80.0 80.0 84.0 83.0 80.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:139.50 stddev:12.55 (9.0%) stddev-sans-first:13.24 06:18:30 INFO - PROCESS | 23396 | Values: 145.0 136.0 141.0 131.0 133.0 137.0 149.0 138.0 173.0 131.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:172.00 stddev:3.21 (1.9%) stddev-sans-first:3.21 06:18:30 INFO - PROCESS | 23396 | Values: 168.0 170.0 173.0 171.0 166.0 173.0 170.0 169.0 177.0 174.0 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:2.25 (3.4%) stddev-sans-first:1.92 06:18:30 INFO - PROCESS | 23396 | Values: 70.0 65.0 65.0 66.0 65.0 67.0 69.0 63.0 64.0 68.0 06:18:30 INFO - PROCESS | 23396 | -------- Summary: end -------- 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | 06:18:30 INFO - PROCESS | 23396 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:30 INFO - PROCESS | 23396 | 06:18:31 INFO - TEST-INFO | 23396: exit 0 06:18:31 INFO - TEST-OK | kraken | took 62541ms 06:18:31 INFO - SUITE-END | took 1177s 06:18:31 INFO - Completed test suite (00:19:38) 06:18:31 INFO - javascript benchmark 06:18:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6969.768097409405, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2980.3145276586383, 2996.595459612953, 3006.6692663806975, 3030.378772351668, 3031.6968303169674, 5273.841784746459, 5348.197770334452, 5358.410574836765, 5363.785448582062, 5374.301340825692, 5385.623006389545, 5390.73046347683, 5400.486953739398, 5445.863853403657, 5492.395836457987, 4844.176489996709, 4862.076205520957, 4941.184704523749, 4993.800247990076, 5040.773165207556, 4679.60223381013, 4917.975410122945, 4930.285108659242, 4953.702777833323, 5010.72441015744, 4699.060187962404, 4818.373611430527, 4829.782659780283, 4894.0, 4911.361523001987, 4848.17581011229, 4851.490593487668, 4857.319975203474, 4917.36074310341, 4962.0, 4912.877178070541, 4920.704757714549, 4928.063667903087, 4933.605311575066, 4999.8000079996755, 5233.058049551079, 5318.840434786924, 5343.65266257692, 5350.973245133789, 5358.437364076754, 5693.77224911003, 5717.542596592262, 5725.08398656213, 5732.140178973145, 5756.942430575725, 5518.2826232589505, 5593.412691667398, 5852.4440178183, 5867.794627188071, 5869.295684517842, 5368.382635996872, 5419.918701219485, 5431.022415965124, 5453.045716999589, 5504.091824848935, 5868.559858010666, 5882.382349853289, 5887.852803679943, 5899.439553242435, 5909.0, 5402.35171779389, 5687.573431992617, 5695.231143795535, 5701.486866182064, 5702.885942281131, 5575.107982722826, 5674.716264186774, 5735.827925162252, 5759.136129580513, 5849.824505264849, 5754.395788442237, 5785.218995435646, 5788.739506722123, 5789.565782566325, 5807.738651760681, 5695.231143795535, 5776.653400795965, 5811.215485909433, 5812.157237200667, 5823.505002074787, 4286.978565107217, 4369.47566292047, 4402.647788176938, 4408.184485870124, 4472.530384309601, 3878.50211631526, 3919.8236079376497, 3925.803709814498, 3974.6621537169085, 3977.065389633434, 5416.891662166735, 5451.400345961941, 5480.26016487777, 5481.862953426196, 5482.862928426742, 5622.128570071563, 5678.716064196774, 5694.971525142348, 5766.855828604234, 5781.19063331134, 5523.806666766724, 5529.087700529448, 5531.3362396511875, 5533.087040638249, 5554.72226388679, 4932.926006109911, 4957.479464656231, 4984.077945580079, 4993.051320249214, 5023.397192336943, 5711.314642242957, 5785.132230165509, 5872.588918775645, 5971.3132989705, 5981.401859814071, 5772.480476757112, 5794.62334948227, 5813.09896965971, 5816.41835816415, 5839.854003649943, 5929.6145750526075, 5987.520998320037, 6037.577369584263, 6037.939620603738, 6040.909386359296, 5479.178123281539, 5586.190002449541, 5643.88712225745, 5707.828765137053, 5713.800016999385, 5779.971100144472, 5812.883742325214, 5829.47534721877, 5830.5627077968475, 5879.7060146993335, 5660.462256085665, 5705.115707065412, 5714.657120572612, 5721.914171287351, 5728.398518155534, 5395.3525576931015, 5427.185922111715, 5615.157726341082, 5628.099504079328, 5677.801276955287, 5615.747291371817, 5633.802816901389, 5666.801661941812, 5705.22979397776, 5721.313442386941, 5678.886422271614, 5696.344920334214, 5738.540916726735, 5745.913811292918, 5747.942520574741, 5339.7597108131, 5342.225377320345, 5538.141588053858, 5543.556515478833, 5599.412061733459], "value": 5306.682994846532, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3802816901409, 570.3355590736792, 575.6718670357892, 583.1922786940088, 586.6274915428702, 40355.39466907995, 42317.15365692688, 42398.15203695924, 46289.7685511572, 46327.768361158145, 44434.33348499767, 44917.7754111229, 45231.547684523146, 45264.3210351845, 45315.0, 8778.297736181106, 8799.428037177595, 8946.507942063185, 8950.86573701395, 8955.507447090407, 8764.386492945465, 8783.912160878404, 8807.33944954131, 8830.690925817598, 8835.160659737314, 8851.77870553235, 8876.556172191365, 8922.0, 8922.776930576754, 8929.419587726778, 8740.956295218546, 8775.824483510358, 8842.115788421172, 8858.069902660192, 8862.158094980967, 8682.6092825823, 8728.694495692684, 8760.824783504295, 8769.07924667907, 8775.824483510294, 41365.37951930724, 41753.373699394535, 41791.7910410446, 41805.79097104525, 41896.37155442671, 3288.19439237386, 3502.964970350289, 3548.024293319332, 3733.4213196954515, 3874.418837174418, 31359.84320078408, 31373.215669608213, 31956.520652190236, 31968.360632787448, 32606.836965815255, 4310.418093557361, 4441.289393697025, 4455.287154055336, 4462.085272519126, 4474.060447306069, 346898.0, 348811.0, 349142.0, 350063.0, 351445.99999999744, 59440.70279648661, 59839.40160598338, 59881.70059149763, 59900.0, 59978.40021599728, 60795.69602151961, 61223.38776612266, 61369.69315153396, 61376.38623613796, 61547.6922615384, 15787.052776833198, 15952.122633255283, 16024.599385015235, 16028.358865645478, 16047.598810029842, 11716.06271498295, 11739.823902641467, 11740.765184696258, 11828.23116497425, 11830.822537661941, 14551.563453096423, 15991.840081599035, 18516.629667406847, 18529.629407411776, 18673.0, 6986.231514533397, 7074.504784665127, 7187.209406965229, 7529.616324328132, 7609.581473019037, 914.154407173362, 975.8145952269047, 1001.4942454060653, 1013.9138173255209, 1020.0972139656309, 30224.84887575548, 30599.0, 31096.0, 31378.0, 31409.42012686107, 1058.941758203306, 1065.1265961911158, 1134.5915470430639, 1137.8748337682848, 1163.1857699610136, 15793.21033948298, 16405.507834764976, 16412.589685257724, 16512.25694843735, 16737.581560460843, 521442.0, 525764.0, 526745.0, 527498.0, 528202.0, 56387.15419268714, 56436.0, 56639.71680141573, 56941.14588281179, 57017.71491142518, 1306.6994591243877, 1339.6048165791115, 1344.2069179184132, 1352.0603180789258, 1370.7943808428815, 29622.703772961995, 31205.843970780003, 31391.84304078465, 31455.370892581563, 31822.681773181972, 49953.00093998027, 50781.746091269306, 50798.0, 50802.0, 50850.98298034092, 443503.0, 444715.0, 445561.0, 445983.0, 448431.0, 26713.599296010965, 27067.323316917234, 27268.863655681595, 27399.0, 27413.58879616847, 45562.5533943945, 45946.0, 47474.762626186646, 47522.762386187846, 47583.0, 38813.805930970164, 42199.367009494264, 45413.31880021869, 46380.0, 46667.299990499494, 38885.61114388933, 39486.80256598699, 40722.389164163156, 42718.57281427146, 43210.56789432065, 42512.57487425086, 42724.145517088866, 43091.56908430876, 43292.78353608338, 43526.34710479282, 41851.7907410461, 42334.36498452587, 42408.15183696247, 42535.0, 43217.567824321355, 28319.752037194587, 28833.56749648799, 29577.8238808212, 30762.384752305275, 31113.37773244568], "value": 20050.774701820934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2141631072612, 388.4057392189949, 394.5364197068444, 399.25937386148695, 421.7827818673384, 15888.682226355495, 16475.093869837183, 18149.455516334514, 19544.120514576844, 19561.706574401378, 11978.700532486691, 12648.683782905431, 12651.304178270191, 14256.501022464216, 18799.90600047001, 5237.711925844077, 5456.672599644015, 5462.071447853875, 5471.562275018009, 5488.780448782044, 5243.475652434764, 5312.787488500475, 5358.946410535903, 5360.463953604647, 5372.7313634318325, 5362.892742145154, 5548.6948217848, 5851.64890106595, 5861.0, 5867.88264234715, 5864.266966629171, 5882.23530940975, 5906.055031195031, 5933.5549833762425, 5968.67172305523, 5664.433556644344, 5682.971585142089, 5705.4294570543025, 5715.228444160027, 5719.19931209631, 13171.275579843104, 13612.31938403076, 13760.449582016707, 14003.78994315076, 14222.359993800304, 2102.6005059038735, 2137.5831712816007, 2297.7472478027403, 2333.8833058347186, 2552.6043463263222, 10183.23625728066, 10387.324823886423, 10875.184361172944, 13107.14803537767, 13915.652108697364, 1889.2915156816193, 1926.9325573604856, 1982.9900850495656, 1990.28349794074, 1992.5815578728484, 77575.61212193903, 82575.58712206461, 84074.57962710208, 84796.0, 85096.57451712702, 10751.301165424222, 10840.728981775519, 11053.502592383362, 11076.169287303484, 11216.887831121747, 15526.611834704223, 15538.844611553966, 15578.454754083552, 15631.218439078228, 15633.3746650135, 7756.0, 7837.882431763528, 8125.0, 8210.425270231026, 8228.711995080144, 7561.508501947355, 7564.281393267741, 7609.315161635479, 7781.260780225983, 7807.102183248886, 4601.401817763669, 4681.7659117044695, 4692.272697731857, 4694.81220751173, 4770.880727981828, 1911.1686416408907, 1936.6901295792607, 1942.8348590369694, 1960.6176795524736, 1967.6261510312995, 883.8939327280767, 951.357833462424, 995.9741466289734, 999.645125980281, 1098.912077043721, 18045.819541804678, 18526.907365463085, 18900.338488153124, 19342.516437088903, 19540.31608893682, 934.444005816538, 966.0098399140937, 971.9902800972042, 1021.2953062386929, 1041.286718597763, 10329.328593641389, 10779.78440431187, 10827.67516974492, 10834.187435942336, 10905.454727263605, 337313.0, 337786.0, 339267.0, 452452.0, 484057.0, 85795.0, 88301.67547486792, 88814.55592721995, 89685.55157224172, 90037.0, 1030.845373194027, 1031.664708969573, 1081.853949716794, 1098.319042193845, 1101.1356085472864, 16507.91746041262, 16711.0, 17153.313867445162, 17266.0, 17598.560035999202, 37769.0, 38230.808845955595, 39205.80397097996, 39356.409653855786, 40264.194716104925, 55892.72053639706, 56079.71960140173, 56183.719081405965, 57417.42582574121, 58891.41108588859, 7288.234735352924, 7601.429892758176, 7779.105402878741, 7822.178671239438, 8025.23760242776, 9520.809583808423, 12465.439055242718, 13319.467221311426, 13327.86672133305, 13359.1316564423, 11354.0, 11576.94211528937, 11665.0, 11685.941570292094, 11977.401129943642, 11169.329840209613, 11334.319940803578, 11478.196526243417, 11537.250078744855, 11683.649490515298, 11214.607488738182, 11366.886331136913, 11619.593314233962, 11810.350430726392, 11976.940115299367, 7863.567503787347, 7885.3297469713425, 7951.681932722627, 8155.551444670363, 8306.0, 8350.707725229588, 10134.847977280495, 10564.524596393334, 10746.140308775122, 10961.890381096406], "value": 8813.431063518658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.0918176139917, 1489.4116823854577, 1608.5335252776695, 1652.9090900000494, 1752.9035903025328, 7258.129024517066, 7394.0, 7854.646540905659, 8347.499150050993, 8401.83196336073, 7772.68909243631, 8035.6383962721675, 8040.8391832163325, 8299.253067223948, 8308.210719981607, 2250.9212177573786, 2276.7932995512324, 2280.977190228093, 2281.4068342231058, 2285.897134628946, 2238.7201599800023, 2275.476640372707, 2313.595120853852, 2316.791488766011, 2317.953640927189, 2273.920412785553, 2274.7270327560714, 2298.5747636687265, 2299.678045073683, 2304.3893368257427, 2245.9438514037115, 2250.909963601454, 2267.580497607948, 2275.4993901341677, 2277.943051423719, 2220.9555808883892, 2251.3358559225067, 2256.1201131558705, 2258.6612008198736, 2273.943151421211, 8144.918550814535, 8236.888020117267, 8243.175682431769, 8250.174982501761, 8268.462549934235, 4828.73441960692, 4923.606111511071, 4961.429435614915, 4962.851114466535, 4964.553190212898, 3047.0, 3141.1204862638497, 3359.051749985003, 3359.6640335966454, 3361.243720162968, 1081.8809930907594, 1096.0354887698854, 1110.8333749937494, 1125.6285425809544, 1159.7912375772357, 11053.613123540717, 11072.944635276852, 11134.944325278402, 11143.442827858657, 11181.273217240854, 4292.12011537634, 4387.319965405367, 4472.485664148599, 4476.843310484118, 4524.434445694288, 9368.718938431857, 9378.249740020781, 9381.343305968516, 9394.530273486298, 9408.529573521297, 4846.418429788448, 4890.0, 4893.363862697826, 4903.950960490421, 4906.90186196274, 4027.9194416111513, 4138.627523522837, 4402.075564131568, 4467.955320446819, 4474.082813023322, 3746.3631182699005, 3770.849166033383, 3783.281176576497, 3807.3717836556657, 3872.5159355080614, 1250.6435665835193, 1251.8748125187408, 1272.497363541396, 1273.7770890094382, 1276.9680757981125, 968.6028728221536, 977.1986970683971, 986.363795351994, 1002.7042022603349, 1002.9548670309854, 5628.859278517988, 5677.886442271214, 5771.94228057714, 5785.566082543826, 5904.822855314347, 431.13127048996296, 435.34263262473894, 444.7042716593494, 446.1678968723372, 450.3852241690135, 4096.897577560525, 4111.075008123208, 4144.79276036197, 4168.333066709312, 4180.581941805795, 9304.209142222986, 9651.372660777028, 9659.951700241454, 9684.32209745311, 9786.853197202048, 9568.665096721581, 9592.232621390272, 9596.376235544667, 9617.086376794194, 9636.132748052709, 7323.487355885143, 7452.925470745332, 7550.924490755132, 7563.621818909032, 7671.424643151674, 5780.075187969905, 5854.385289544536, 5934.9406505934385, 5944.940550594439, 6011.098335249748, 8948.776280593038, 9017.368784185044, 9069.727908162766, 9148.725538233864, 9246.398984066283, 8990.730278091667, 9144.222741067084, 9278.489683067495, 9309.20871725911, 9394.718158455258, 6372.36276372359, 6535.673216339259, 7117.501774875916, 7141.285871412817, 7200.207977122617, 7698.961505192438, 7981.48120372174, 8009.639566219417, 8015.398845086525, 8022.0, 7190.676419561237, 7322.90579771657, 7453.739119130804, 7487.700491980259, 7530.736424225345, 6928.7228510859, 7210.783676489714, 7229.819254518679, 7269.854602908018, 7372.189059203591, 6609.603423794588, 6725.428338591275, 6729.427998620172, 6731.1922569292, 6734.4275736560985, 5037.617601747106, 5056.6207534434325, 5122.052420302107, 5258.8159414420315, 5307.283516725192, 4835.975820120877, 4969.875753106201, 5022.673526220784, 5098.97450512745, 5147.819826306061], "value": 4321.536094539841, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.8439057057328, 326.3228800239503, 334.80246654473865, 337.90200841755893, 342.0849228314259, 5426.050441172799, 5433.429489903562, 5434.646747961379, 5462.672239665623, 5486.231927530139, 5341.519263266306, 5383.488568585988, 5408.4050754416985, 5417.756200970956, 5436.782528698857, 4085.3667681509414, 4182.456280683522, 4292.488893997015, 4313.654907607384, 4332.1335732853395, 4205.0, 4210.400047981762, 4212.304969680014, 4213.346931225665, 4219.831206751726, 4160.521540022906, 4175.561566035568, 4204.516480604724, 4205.873823785291, 4227.8308867645255, 4024.8188831502653, 4150.024744185114, 4152.1695660867945, 4152.792360381969, 4188.6649068074485, 3656.561212654472, 3660.670539651444, 3665.120371110941, 3665.845258743487, 3674.5039419678537, 5208.869778255536, 5234.214867769827, 5239.0, 5295.179247216687, 5308.283381743492, 4595.793189306489, 4683.391159149322, 4746.145693775119, 4746.857594272177, 4797.856064318041, 5542.61201715876, 5564.527015203713, 5569.8607534811545, 5597.7201139943245, 5647.632903861236, 3992.5208974922903, 3996.680265578747, 4000.4799376080923, 4032.193561287754, 4032.737872038308, 5654.349749778787, 5801.796937107223, 5827.300723913115, 5843.737031833578, 5872.735726892342, 4118.094019315746, 4143.316352801814, 4148.688848336386, 4158.584141585878, 4174.039970806671, 4176.4570605821655, 4200.789960501963, 4204.684648651363, 4207.389928460356, 4219.915601687949, 4697.859064228079, 4795.640326975491, 4813.3983252093485, 4820.084184005028, 4827.227643577081, 5537.667739935617, 5559.6664200148125, 5564.410954934126, 5622.381538030813, 5649.435056494318, 1427.0082292806608, 1462.4278900182135, 1463.3926920327945, 1470.2207829850197, 1470.6396932751545, 878.0517041595062, 926.7127190570944, 933.780561568031, 949.4635530925005, 951.167728237792, 4736.455307639597, 4747.786349614275, 4770.594499467515, 4778.522147785263, 4783.1868582341085, 4988.226824842155, 5040.924386134211, 5049.545540901337, 5079.044567841408, 5082.847514574569, 4543.204939135638, 4710.010897711519, 4740.525947405232, 4750.334953106568, 4755.857324280277, 2651.6552848130004, 2673.25148958292, 2678.901650323397, 2682.1417146512927, 2701.730186812195, 5082.001619044781, 5246.845693947325, 5279.841604751864, 5306.973465132727, 5330.668332292317, 4747.881302967385, 5079.746012699424, 5126.307948426915, 5128.615353848476, 5152.7166005869285, 5121.795128194905, 5127.717975511383, 5160.0, 5179.912218434096, 5221.3734351878775, 5003.874903127451, 5041.823536176216, 5068.797248110034, 5074.5686616637995, 5080.085584594661, 4808.591269742111, 4970.950290497193, 4975.0, 4977.552020318044, 5012.523810238022, 5115.03071317538, 5137.794488220429, 5140.254663073908, 5143.014164022912, 5184.351956005499, 3724.739268251305, 3740.270647223765, 3760.777747232106, 3762.6049264827893, 3788.6888997711926, 5106.208537676517, 5126.359205099363, 5448.83653490396, 5839.240898683144, 5842.561807864512, 5716.427982304899, 5724.31132815812, 5734.598578099493, 5740.024195886793, 5759.596828221985, 5558.833235002957, 5690.292912126429, 5718.428157184248, 5720.713964301852, 5738.938296415176, 5564.721763911869, 5577.860553486195, 5605.663660180402, 5610.943890561205, 5616.915746263728, 5507.752151153128, 5616.382197958303, 5652.971735141298, 5658.0, 5682.886342273214, 5519.862003449946, 5550.2507161534295, 5559.193916881949, 5567.66594004361, 5583.357913839798], "value": 4123.597722277154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.0843257980914, 707.3704403081258, 775.2286474957416, 777.3353782515949, 816.2735165702529, 14330.355134018968, 14389.1366518009, 14526.782098268535, 15400.075995440282, 15442.459513917016, 13275.933620331909, 13489.190648561093, 13491.257980811051, 13556.796648050287, 13584.796228056586, 782.2099679323895, 799.6481548118824, 806.7418426103649, 808.0747544062045, 813.4062134641715, 805.6455159729729, 813.3290035720524, 813.7762115418249, 817.497239197892, 819.1358117186365, 841.2092632925062, 846.7290467050547, 846.7502086884384, 847.4322204123253, 851.2849206666399, 830.6137645994642, 840.017179899516, 845.243507061183, 846.0270688707974, 846.0989046665281, 619.1517620859452, 621.7202258983475, 622.9845352076087, 623.7504998000836, 624.2041397218537, 12829.0, 14419.78370324446, 14495.202763847985, 14541.27293635314, 14603.123812571173, 13005.544805931842, 13395.397207125703, 13579.456821727119, 14024.298785060808, 14501.70996580073, 11938.22401543897, 12011.879881201163, 12073.93963030188, 12091.879081209163, 12210.816837747441, 3697.186618943828, 3711.5546134463766, 3721.292954338667, 3746.194568167857, 3789.943150852712, 63317.68341158311, 64195.358046419875, 64354.35645643531, 64755.0, 66171.99999999952, 9908.405495670282, 10196.745081373025, 10437.217208709226, 10594.364338139736, 10906.655069160168, 18110.0, 18250.634987300444, 18759.718604220947, 19673.21307147727, 19842.50393740139, 7292.343689067903, 7453.515521491086, 7458.291462311072, 7562.621868906533, 7647.923520764833, 4229.344451610005, 4328.848490302824, 4329.0, 4361.433013708198, 4397.428334316518, 3378.3412234614507, 3431.227973705946, 3460.377132116193, 3484.320557491265, 3489.1277180704824, 580.7386675995818, 589.9882002359928, 598.3806760003375, 600.5165841497636, 602.5721737566289, 713.5219403000002, 721.1310371002929, 730.2514922204782, 744.8473063022068, 747.6411322565199, 8485.193906578865, 8727.825443491094, 8829.69096081634, 8909.020007799138, 9243.676471323472, 582.1006544888158, 647.0133047103111, 693.7883945396702, 694.6422592364936, 733.6515155301296, 4085.611866872642, 4294.312909934458, 4340.348947657877, 4410.625096866738, 4472.44094488189, 70832.29167708257, 76498.0, 88741.55629221942, 88767.0, 93499.53250233705, 43570.128597428506, 43732.3440148398, 44268.778656106515, 45563.0, 73311.63344183245, 65000.349996499426, 65411.0, 65554.0, 65765.67117164479, 65941.34058659352, 8434.409591328793, 8458.830823383621, 8563.785905352415, 8866.33502487329, 8906.153915378029, 42415.57584424116, 44589.55410445854, 44880.77559612181, 45548.31677524906, 47082.0, 53564.1965370512, 54855.725721371135, 55245.44754552564, 55890.16164757613, 58689.70655146697, 11667.299962002307, 11758.764824703629, 12089.81865272004, 12156.1490695654, 12444.81332779991, 12851.293178875252, 12854.164479308814, 13089.149205301625, 13224.933875330562, 13785.379657915619, 12282.508699651913, 12477.438515267017, 12870.806937896126, 12943.611691649265, 13750.037497375488, 12297.877021230031, 12690.302033388252, 12873.163244389085, 13398.0, 13409.463621455032, 12035.819462708241, 12514.874851251736, 12766.936165319114, 12828.358582070672, 12976.221426714428, 9384.249260059316, 10061.144802691853, 10156.949215253877, 10279.640212592523, 10507.31702439339, 10348.706411698538, 10429.68710938673, 10450.216233782648, 10580.735481613021, 10591.89408105909], "value": 6858.800810628287, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 114.0, 112.0, 112.0, 112.0, 114.0, 112.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 123.0, 166.0, 126.0, 124.0, 125.0, 122.0, 160.0, 133.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 168.0, 168.0, 169.0, 164.0, 165.0, 163.0, 163.0, 161.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 112.0, 77.0, 77.0, 78.0, 78.0, 103.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 83.0, 83.0, 83.0, 104.0, 82.0, 82.0, 113.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 146.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 85.0, 85.0, 86.0, 84.0, 84.0, 85.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 56.0, 60.0, 57.0, 53.0, 54.0, 54.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 81.0, 80.0, 80.0, 80.0, 84.0, 83.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 136.0, 141.0, 131.0, 133.0, 137.0, 149.0, 138.0, 173.0, 131.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 173.0, 171.0, 166.0, 173.0, 170.0, 169.0, 177.0, 174.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 65.0, 66.0, 65.0, 67.0, 69.0, 63.0, 64.0, 68.0], "value": 66.2, "unit": "score"}]}]} 06:18:31 INFO - Return code: 0 06:18:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:32 ERROR - # TBPL SUCCESS # 06:18:32 INFO - Running post-action listener: _resource_record_post_action 06:18:32 INFO - [mozharness: 2016-10-31 13:18:32.020672Z] Finished run-tests step (success) 06:18:32 INFO - Running post-run listener: _resource_record_post_run 06:18:32 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392228864; Read time: 28; Write time: 235204 06:18:32 INFO - TinderboxPrint: CPU usage
13.4% 06:18:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 06:18:32 INFO - TinderboxPrint: I/O write bytes / time
392,228,864 / 235,204 06:18:32 INFO - TinderboxPrint: CPU idle
8,255.8 (86.6%) 06:18:32 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 06:18:32 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103878656; Read time: 0; Write time: 80532 06:18:32 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288350208; Read time: 0; Write time: 154672 06:18:32 INFO - Running post-run listener: _upload_blobber_files 06:18:32 INFO - Blob upload gear active. 06:18:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:33 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:18:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:18:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:33 INFO - (blobuploader) - INFO - Done attempting. 06:18:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:18:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:18:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:34 INFO - (blobuploader) - INFO - Done attempting. 06:18:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:38 INFO - (blobuploader) - INFO - Done attempting. 06:18:38 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:38 INFO - Return code: 0 06:18:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0df74d19373f552a11657c0e7059cafdbb91bcf846820cc7ef7bf167271a84f3abb5349357bd2f8b0d8abffdb1a8d78d96945055054a27a1871c5c9c18eaef3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b131a6a18c18e80f40e432c2aff7dbd8625b40c92749387e379d261cfe8438e10757a8fbfd57becc5cb6f14f3e3bc1ad93daa898e5ee234b0ce8e12ea6ce245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc475eb3fd301e39a125107cb09214c7dda05e2704a5a4190b2675fd5899f0186b37f8afb9b52608eb1c97cd6a731cadccd2f3c0d4b1521a29c069e6bd4edb29"} 06:18:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:38 INFO - Contents: 06:18:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0df74d19373f552a11657c0e7059cafdbb91bcf846820cc7ef7bf167271a84f3abb5349357bd2f8b0d8abffdb1a8d78d96945055054a27a1871c5c9c18eaef3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b131a6a18c18e80f40e432c2aff7dbd8625b40c92749387e379d261cfe8438e10757a8fbfd57becc5cb6f14f3e3bc1ad93daa898e5ee234b0ce8e12ea6ce245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc475eb3fd301e39a125107cb09214c7dda05e2704a5a4190b2675fd5899f0186b37f8afb9b52608eb1c97cd6a731cadccd2f3c0d4b1521a29c069e6bd4edb29"} 06:18:38 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:38 INFO - Copying logs to upload dir... 06:18:38 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.806155 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-31 06:18:38.860656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 06:18:38.868756) ========= 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=00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0df74d19373f552a11657c0e7059cafdbb91bcf846820cc7ef7bf167271a84f3abb5349357bd2f8b0d8abffdb1a8d78d96945055054a27a1871c5c9c18eaef3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b131a6a18c18e80f40e432c2aff7dbd8625b40c92749387e379d261cfe8438e10757a8fbfd57becc5cb6f14f3e3bc1ad93daa898e5ee234b0ce8e12ea6ce245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc475eb3fd301e39a125107cb09214c7dda05e2704a5a4190b2675fd5899f0186b37f8afb9b52608eb1c97cd6a731cadccd2f3c0d4b1521a29c069e6bd4edb29"} build_url:https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/Ok_5Ccq5RaatwKufopAHfQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0df74d19373f552a11657c0e7059cafdbb91bcf846820cc7ef7bf167271a84f3abb5349357bd2f8b0d8abffdb1a8d78d96945055054a27a1871c5c9c18eaef3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b131a6a18c18e80f40e432c2aff7dbd8625b40c92749387e379d261cfe8438e10757a8fbfd57becc5cb6f14f3e3bc1ad93daa898e5ee234b0ce8e12ea6ce245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc475eb3fd301e39a125107cb09214c7dda05e2704a5a4190b2675fd5899f0186b37f8afb9b52608eb1c97cd6a731cadccd2f3c0d4b1521a29c069e6bd4edb29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 06:18:38.897269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:18:38.897655) ========= 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=00204705a9daa57ed339a427000001b9-1477918509.334030-1255951561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:18:38.947124) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 06:18:38.950497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 06:18:38.950836) ========= ========= Total master_lag: 0.35 =========