builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1477979164.48 results: success (0) buildid: 20161031193142 builduid: 257574d6c4e24fcb82ea96173cec80ab revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.475438) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.475861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.476163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.490602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.490873) ========= 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=232498196343f89f466a4a9a000001c8-1477979164.280565-314372488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 22:46:04-- 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% 70.6M=0s 2016-10-31 22:46:05 (70.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.584971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.585277) ========= 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=232498196343f89f466a4a9a000001c8-1477979164.280565-314372488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014039 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:04.634024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 22:46:04.634378) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --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 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --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=232498196343f89f466a4a9a000001c8-1477979164.280565-314372488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 22:46:05,140 truncating revision to first 12 chars 2016-10-31 22:46:05,141 Setting DEBUG logging. 2016-10-31 22:46:05,141 attempt 1/10 2016-10-31 22:46:05,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21153294d3a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 22:46:06,334 unpacking tar archive at: mozilla-central-21153294d3a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.541064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 22:46:06.188669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:06.188987) ========= script_repo_revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:06.189372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:06.189633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 22:46:06.198844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-31 22:46:06.199108) ========= /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=232498196343f89f466a4a9a000001c8-1477979164.280565-314372488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:46:06 INFO - MultiFileLogger online at 20161031 22:46:06 in /builds/slave/test 22:46:06 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 22:46:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:46:06 INFO - {'append_to_log': False, 22:46:06 INFO - 'base_work_dir': '/builds/slave/test', 22:46:06 INFO - 'blob_upload_branch': 'Firefox', 22:46:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:46:06 INFO - 'branch': 'Firefox', 22:46:06 INFO - 'buildbot_json_path': 'buildprops.json', 22:46:06 INFO - 'config_files': ('talos/linux_config.py',), 22:46:06 INFO - 'default_actions': ('clobber', 22:46:06 INFO - 'read-buildbot-config', 22:46:06 INFO - 'download-and-extract', 22:46:06 INFO - 'populate-webroot', 22:46:06 INFO - 'create-virtualenv', 22:46:06 INFO - 'install', 22:46:06 INFO - 'run-tests'), 22:46:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:46:06 INFO - 'download_minidump_stackwalk': True, 22:46:06 INFO - 'download_symbols': 'ondemand', 22:46:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:46:06 INFO - 'tooltool.py': '/tools/tooltool.py', 22:46:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:46:06 INFO - '/tools/misc-python/virtualenv.py')}, 22:46:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:46:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:46:06 INFO - 'installer_path': 'installer.exe', 22:46:06 INFO - 'log_level': 'info', 22:46:06 INFO - 'log_name': 'talos', 22:46:06 INFO - 'log_to_console': True, 22:46:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:46:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:46:06 INFO - 'opt_config_files': (), 22:46:06 INFO - 'pip_index': False, 22:46:06 INFO - 'sps_profile': False, 22:46:06 INFO - 'sps_profile_interval': 0, 22:46:06 INFO - 'suite': 'dromaeojs-e10s', 22:46:06 INFO - 'system_bits': '32', 22:46:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:46:06 INFO - 'title': 'talos-linux64-ix-025', 22:46:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:46:06 INFO - 'use_talos_json': True, 22:46:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:46:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:46:06 INFO - 'work_dir': 'build'} 22:46:06 INFO - [mozharness: 2016-11-01 05:46:06.805577Z] Running clobber step. 22:46:06 INFO - Running pre-action listener: _resource_record_pre_action 22:46:06 INFO - Running main action method: clobber 22:46:06 INFO - rmtree: /builds/slave/test/build 22:46:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:46:07 INFO - Running post-action listener: _resource_record_post_action 22:46:07 INFO - [mozharness: 2016-11-01 05:46:07.269014Z] Finished clobber step (success) 22:46:07 INFO - [mozharness: 2016-11-01 05:46:07.269115Z] Running read-buildbot-config step. 22:46:07 INFO - Running pre-action listener: _resource_record_pre_action 22:46:07 INFO - Running main action method: read_buildbot_config 22:46:07 INFO - Using buildbot properties: 22:46:07 INFO - { 22:46:07 INFO - "project": "", 22:46:07 INFO - "product": "firefox", 22:46:07 INFO - "script_repo_revision": "production", 22:46:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:46:07 INFO - "repository": "", 22:46:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:46:07 INFO - "buildid": "20161031193142", 22:46:07 INFO - "pgo_build": "True", 22:46:07 INFO - "basedir": "/builds/slave/test", 22:46:07 INFO - "buildnumber": 152, 22:46:07 INFO - "slavename": "talos-linux64-ix-025", 22:46:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:46:07 INFO - "platform": "ubuntu64_hw", 22:46:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:46:07 INFO - "branch": "mozilla-central", 22:46:07 INFO - "repo_path": "mozilla-central", 22:46:07 INFO - "revision": "21153294d3a0bf7ce8e5e6bb1a0e684745b88fda", 22:46:07 INFO - "stage_platform": "linux64-pgo", 22:46:07 INFO - "builduid": "257574d6c4e24fcb82ea96173cec80ab", 22:46:07 INFO - "slavebuilddir": "test" 22:46:07 INFO - } 22:46:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:46:07 INFO - Running post-action listener: _resource_record_post_action 22:46:07 INFO - [mozharness: 2016-11-01 05:46:07.271595Z] Finished read-buildbot-config step (success) 22:46:07 INFO - [mozharness: 2016-11-01 05:46:07.271684Z] Running download-and-extract step. 22:46:07 INFO - Running pre-action listener: _resource_record_pre_action 22:46:07 INFO - Running main action method: download_and_extract 22:46:07 INFO - mkdir: /builds/slave/test/build/tests 22:46:07 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')]} 22:46:07 INFO - trying https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:46:07 INFO - Downloading https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/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 22:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/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 22:46:07 INFO - Downloaded 1361 bytes. 22:46:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:46:07 INFO - Using the following test package requirements: 22:46:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:46:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:46:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:46:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'jsshell-linux-x86_64.zip'], 22:46:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:46:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:46:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:46:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:46:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:46:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:46:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:46:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:46:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:46:07 INFO - Fetch https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:46:08 INFO - Http code: 200 22:46:08 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 22:46:08 INFO - x-amz-cf-id: a47uYiF1XqrTdb3n-RjXabjGHY2fi2iujiOBH2cxgbuZQ_R5i13qWg== 22:46:08 INFO - x-amz-version-id: gRHub8y9biQmYPiXeOh1z0ZAvnO6C_6Y 22:46:08 INFO - Expected file size: 22019557 22:46:08 INFO - Obtained file size: 22019557 22:46:12 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 22:46:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:46:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:46:12 INFO - Fetch https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:46:13 INFO - Http code: 200 22:46:13 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 22:46:13 INFO - x-amz-cf-id: gGHbF3JD6vDYk8-AjQZn8zcpCs1OKIGLtvh7ShhSEe9g_vUOa8V4uA== 22:46:13 INFO - x-amz-version-id: gRHub8y9biQmYPiXeOh1z0ZAvnO6C_6Y 22:46:13 INFO - Expected file size: 22019557 22:46:13 INFO - Obtained file size: 22019557 22:46:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:46:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:46:18 INFO - Fetch https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:46:18 INFO - Http code: 200 22:46:18 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 22:46:18 INFO - x-amz-cf-id: TKc6RJBgRH35Z84XyL0zKJu2NSGCa_fdpOZkf4LW-0MRQant-1SDMA== 22:46:18 INFO - x-amz-version-id: r0uKGvEyDEyp9oe5DI2tMWhygOPc_zHM 22:46:18 INFO - Expected file size: 14409038 22:46:18 INFO - Obtained file size: 14409038 22:46: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')]} 22:46:19 INFO - trying https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:46:19 INFO - Downloading https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/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 22:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/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 22:46:20 INFO - Downloaded 59621087 bytes. 22:46:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:46:20 INFO - mkdir: /builds/slave/test/properties 22:46:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:46:20 INFO - Writing to file /builds/slave/test/properties/build_url 22:46:20 INFO - Contents: 22:46:20 INFO - build_url:https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:46:20 INFO - Running post-action listener: _resource_record_post_action 22:46:20 INFO - Running post-action listener: set_extra_try_arguments 22:46:20 INFO - [mozharness: 2016-11-01 05:46:20.910974Z] Finished download-and-extract step (success) 22:46:20 INFO - [mozharness: 2016-11-01 05:46:20.911201Z] Running populate-webroot step. 22:46:20 INFO - Running pre-action listener: _resource_record_pre_action 22:46:20 INFO - Running main action method: populate_webroot 22:46:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:46:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:46:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:46:20 INFO - '--tppagecycles', 22:46:20 INFO - '7'], 22:46:20 INFO - 'tests': ['tsvgm']}}, 22:46:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:46:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:46:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:46:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:46:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['damp', 'tps']}, 22:46:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'tests': ['damp', 'tps']}, 22:46:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['dromaeo_dom']}, 22:46:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:46:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['basic_compositor_video']}, 22:46:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:46:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['a11yr', 22:46:20 INFO - 'ts_paint', 22:46:20 INFO - 'tpaint', 22:46:20 INFO - 'sessionrestore', 22:46:20 INFO - 'sessionrestore_no_auto_restore', 22:46:20 INFO - 'tabpaint']}, 22:46:20 INFO - 'other-e10s': {'tests': ['a11yr', 22:46:20 INFO - 'ts_paint', 22:46:20 INFO - 'tpaint', 22:46:20 INFO - 'sessionrestore', 22:46:20 INFO - 'sessionrestore_no_auto_restore', 22:46:20 INFO - 'tabpaint']}, 22:46:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:46:20 INFO - 'ts_paint', 22:46:20 INFO - 'tpaint', 22:46:20 INFO - 'sessionrestore', 22:46:20 INFO - 'sessionrestore_no_auto_restore', 22:46:20 INFO - 'tabpaint']}, 22:46:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:46:20 INFO - 'ts_paint', 22:46:20 INFO - 'tpaint', 22:46:20 INFO - 'sessionrestore', 22:46:20 INFO - 'sessionrestore_no_auto_restore', 22:46:20 INFO - 'tabpaint']}, 22:46:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['a11yr', 22:46:20 INFO - 'ts_paint', 22:46:20 INFO - 'tpaint', 22:46:20 INFO - 'sessionrestore', 22:46:20 INFO - 'sessionrestore_no_auto_restore', 22:46:20 INFO - 'tabpaint']}, 22:46:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['a11yr', 22:46:20 INFO - 'ts_paint', 22:46:20 INFO - 'tpaint', 22:46:20 INFO - 'sessionrestore', 22:46:20 INFO - 'sessionrestore_no_auto_restore', 22:46:20 INFO - 'tabpaint']}, 22:46:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['tsvgx', 22:46:20 INFO - 'tsvgr_opacity', 22:46:20 INFO - 'tart', 22:46:20 INFO - 'tscrollx', 22:46:20 INFO - 'cart']}, 22:46:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:46:20 INFO - 'tsvgr_opacity', 22:46:20 INFO - 'tart', 22:46:20 INFO - 'tscrollx', 22:46:20 INFO - 'cart']}, 22:46:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'talos_options': ['--disable-e10s'], 22:46:20 INFO - 'tests': ['tp5o']}, 22:46:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'tests': ['tp5o']}, 22:46:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'talos_options': ['--disable-e10s', 22:46:20 INFO - '--xperf_path', 22:46:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:20 INFO - 'tests': ['tp5n']}, 22:46:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:20 INFO - 'talos_options': ['--xperf_path', 22:46:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:20 INFO - 'tests': ['tp5n']}}, 22:46:20 INFO - 'talos.zip': {'path': '', 22:46:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:46:20 INFO - Running post-action listener: _resource_record_post_action 22:46:20 INFO - [mozharness: 2016-11-01 05:46:20.926500Z] Finished populate-webroot step (success) 22:46:20 INFO - [mozharness: 2016-11-01 05:46:20.926589Z] Running create-virtualenv step. 22:46:20 INFO - Running pre-action listener: _resource_record_pre_action 22:46:20 INFO - Running main action method: create_virtualenv 22:46:20 INFO - Creating virtualenv /builds/slave/test/build/venv 22:46:20 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 22:46:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:46:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:46:21 INFO - Using real prefix '/usr' 22:46:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:46:21 INFO - Installing distribute.............................................................................................................................................................................................done. 22:46:23 INFO - Installing pip.................done. 22:46:23 INFO - Return code: 0 22:46:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:46:23 INFO - Reading from file tmpfile_stdout 22:46:23 INFO - Output received: 22:46:23 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) 22:46:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:23 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 22:46:23 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 22:46:23 INFO - Using env: {'DISPLAY': ':0', 22:46:23 INFO - 'HOME': '/home/cltbld', 22:46:23 INFO - 'LANG': 'en_US.UTF-8', 22:46:23 INFO - 'LANGUAGE': 'en_US:en', 22:46:23 INFO - 'LOGNAME': 'cltbld', 22:46:23 INFO - 'MAIL': '/var/mail/cltbld', 22:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:23 INFO - 'MOZ_NO_REMOTE': '1', 22:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:23 INFO - 'NO_EM_RESTART': '1', 22:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:23 INFO - 'PWD': '/builds/slave/test', 22:46:23 INFO - 'SHELL': '/bin/bash', 22:46:23 INFO - 'SHLVL': '1', 22:46:23 INFO - 'TERM': 'linux', 22:46:23 INFO - 'TMOUT': '86400', 22:46:23 INFO - 'USER': 'cltbld', 22:46:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:23 INFO - '_': '/tools/buildbot/bin/python'} 22:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:23 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 22:46:23 INFO - Cleaning up... 22:46:23 INFO - Return code: 0 22:46:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:23 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 22:46:23 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 22:46:23 INFO - Using env: {'DISPLAY': ':0', 22:46:23 INFO - 'HOME': '/home/cltbld', 22:46:23 INFO - 'LANG': 'en_US.UTF-8', 22:46:23 INFO - 'LANGUAGE': 'en_US:en', 22:46:23 INFO - 'LOGNAME': 'cltbld', 22:46:23 INFO - 'MAIL': '/var/mail/cltbld', 22:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:23 INFO - 'MOZ_NO_REMOTE': '1', 22:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:23 INFO - 'NO_EM_RESTART': '1', 22:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:23 INFO - 'PWD': '/builds/slave/test', 22:46:23 INFO - 'SHELL': '/bin/bash', 22:46:23 INFO - 'SHLVL': '1', 22:46:23 INFO - 'TERM': 'linux', 22:46:23 INFO - 'TMOUT': '86400', 22:46:23 INFO - 'USER': 'cltbld', 22:46:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:23 INFO - '_': '/tools/buildbot/bin/python'} 22:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:24 INFO - Downloading/unpacking psutil>=3.1.1 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:46:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:26 INFO - Installing collected packages: psutil 22:46:26 INFO - Running setup.py install for psutil 22:46:26 INFO - building 'psutil._psutil_linux' extension 22:46:26 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 22:46:26 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 22:46:26 INFO - building 'psutil._psutil_posix' extension 22:46:26 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 22:46:26 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 22:46:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:26 INFO - Successfully installed psutil 22:46:26 INFO - Cleaning up... 22:46:26 INFO - Return code: 0 22:46:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:46:26 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')]} 22:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:26 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')]} 22:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:26 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:26 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 22:46:26 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 22:46:26 INFO - Using env: {'DISPLAY': ':0', 22:46:26 INFO - 'HOME': '/home/cltbld', 22:46:26 INFO - 'LANG': 'en_US.UTF-8', 22:46:26 INFO - 'LANGUAGE': 'en_US:en', 22:46:26 INFO - 'LOGNAME': 'cltbld', 22:46:26 INFO - 'MAIL': '/var/mail/cltbld', 22:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:26 INFO - 'MOZ_NO_REMOTE': '1', 22:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:26 INFO - 'NO_EM_RESTART': '1', 22:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:26 INFO - 'PWD': '/builds/slave/test', 22:46:26 INFO - 'SHELL': '/bin/bash', 22:46:26 INFO - 'SHLVL': '1', 22:46:26 INFO - 'TERM': 'linux', 22:46:26 INFO - 'TMOUT': '86400', 22:46:26 INFO - 'USER': 'cltbld', 22:46:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:26 INFO - '_': '/tools/buildbot/bin/python'} 22:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:46:28 INFO - Installing collected packages: mozsystemmonitor 22:46:28 INFO - Running setup.py install for mozsystemmonitor 22:46:29 INFO - Successfully installed mozsystemmonitor 22:46:29 INFO - Cleaning up... 22:46:29 INFO - Return code: 0 22:46:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:29 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:29 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 22:46:29 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 22:46:29 INFO - Using env: {'DISPLAY': ':0', 22:46:29 INFO - 'HOME': '/home/cltbld', 22:46:29 INFO - 'LANG': 'en_US.UTF-8', 22:46:29 INFO - 'LANGUAGE': 'en_US:en', 22:46:29 INFO - 'LOGNAME': 'cltbld', 22:46:29 INFO - 'MAIL': '/var/mail/cltbld', 22:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:29 INFO - 'MOZ_NO_REMOTE': '1', 22:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:29 INFO - 'NO_EM_RESTART': '1', 22:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:29 INFO - 'PWD': '/builds/slave/test', 22:46:29 INFO - 'SHELL': '/bin/bash', 22:46:29 INFO - 'SHLVL': '1', 22:46:29 INFO - 'TERM': 'linux', 22:46:29 INFO - 'TMOUT': '86400', 22:46:29 INFO - 'USER': 'cltbld', 22:46:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:29 INFO - '_': '/tools/buildbot/bin/python'} 22:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:29 INFO - Downloading/unpacking jsonschema==2.5.1 22:46:29 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 22:46:29 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 22:46:29 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 22:46:29 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 22:46:29 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 22:46:29 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 22:46:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:46:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:31 INFO - Downloading functools32-3.2.3-2.tar.gz 22:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:46:31 INFO - warning: no files found matching '*.txt' 22:46:31 INFO - no previously-included directories found matching 'build' 22:46:31 INFO - no previously-included directories found matching 'dist' 22:46:31 INFO - no previously-included directories found matching '.git*' 22:46:31 INFO - Installing collected packages: jsonschema, functools32 22:46:31 INFO - Running setup.py install for functools32 22:46:31 INFO - warning: no files found matching '*.txt' 22:46:31 INFO - no previously-included directories found matching 'build' 22:46:31 INFO - no previously-included directories found matching 'dist' 22:46:31 INFO - no previously-included directories found matching '.git*' 22:46:31 INFO - Successfully installed jsonschema functools32 22:46:31 INFO - Cleaning up... 22:46:31 INFO - Return code: 0 22:46:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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')]} 22:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:46:31 INFO - Using env: {'DISPLAY': ':0', 22:46:31 INFO - 'HOME': '/home/cltbld', 22:46:31 INFO - 'LANG': 'en_US.UTF-8', 22:46:31 INFO - 'LANGUAGE': 'en_US:en', 22:46:31 INFO - 'LOGNAME': 'cltbld', 22:46:31 INFO - 'MAIL': '/var/mail/cltbld', 22:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:31 INFO - 'MOZ_NO_REMOTE': '1', 22:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:31 INFO - 'NO_EM_RESTART': '1', 22:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:31 INFO - 'PWD': '/builds/slave/test', 22:46:31 INFO - 'SHELL': '/bin/bash', 22:46:31 INFO - 'SHLVL': '1', 22:46:31 INFO - 'TERM': 'linux', 22:46:31 INFO - 'TMOUT': '86400', 22:46:31 INFO - 'USER': 'cltbld', 22:46:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:31 INFO - '_': '/tools/buildbot/bin/python'} 22:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:46:31 INFO - Cleaning up... 22:46:31 INFO - Return code: 0 22:46:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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')]} 22:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:46:31 INFO - Using env: {'DISPLAY': ':0', 22:46:31 INFO - 'HOME': '/home/cltbld', 22:46:31 INFO - 'LANG': 'en_US.UTF-8', 22:46:31 INFO - 'LANGUAGE': 'en_US:en', 22:46:31 INFO - 'LOGNAME': 'cltbld', 22:46:31 INFO - 'MAIL': '/var/mail/cltbld', 22:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:31 INFO - 'MOZ_NO_REMOTE': '1', 22:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:31 INFO - 'NO_EM_RESTART': '1', 22:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:31 INFO - 'PWD': '/builds/slave/test', 22:46:31 INFO - 'SHELL': '/bin/bash', 22:46:31 INFO - 'SHLVL': '1', 22:46:31 INFO - 'TERM': 'linux', 22:46:31 INFO - 'TMOUT': '86400', 22:46:31 INFO - 'USER': 'cltbld', 22:46:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:31 INFO - '_': '/tools/buildbot/bin/python'} 22:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:32 INFO - Downloading/unpacking blobuploader==1.2.4 22:46:32 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 22:46:32 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 22:46:32 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 22:46:32 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 22:46:32 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 22:46:32 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 22:46:34 INFO - Downloading blobuploader-1.2.4.tar.gz 22:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:46:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:46:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:34 INFO - Downloading docopt-0.6.1.tar.gz 22:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:46:34 INFO - Installing collected packages: blobuploader, requests, docopt 22:46:34 INFO - Running setup.py install for blobuploader 22:46:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:46:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:46:34 INFO - Running setup.py install for requests 22:46:35 INFO - Running setup.py install for docopt 22:46:35 INFO - Successfully installed blobuploader requests docopt 22:46:35 INFO - Cleaning up... 22:46:35 INFO - Return code: 0 22:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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')]} 22:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:35 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:35 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 22:46:35 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 22:46:35 INFO - Using env: {'DISPLAY': ':0', 22:46:35 INFO - 'HOME': '/home/cltbld', 22:46:35 INFO - 'LANG': 'en_US.UTF-8', 22:46:35 INFO - 'LANGUAGE': 'en_US:en', 22:46:35 INFO - 'LOGNAME': 'cltbld', 22:46:35 INFO - 'MAIL': '/var/mail/cltbld', 22:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:35 INFO - 'MOZ_NO_REMOTE': '1', 22:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:35 INFO - 'NO_EM_RESTART': '1', 22:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:35 INFO - 'PWD': '/builds/slave/test', 22:46:35 INFO - 'SHELL': '/bin/bash', 22:46:35 INFO - 'SHLVL': '1', 22:46:35 INFO - 'TERM': 'linux', 22:46:35 INFO - 'TMOUT': '86400', 22:46:35 INFO - 'USER': 'cltbld', 22:46:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:35 INFO - '_': '/tools/buildbot/bin/python'} 22:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:35 INFO - Running setup.py (path:/tmp/pip-fLgKB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:35 INFO - Running setup.py (path:/tmp/pip-htAkYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:35 INFO - Running setup.py (path:/tmp/pip-0paF5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:35 INFO - Running setup.py (path:/tmp/pip-930YKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:35 INFO - Running setup.py (path:/tmp/pip-QvUzR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:36 INFO - Running setup.py (path:/tmp/pip-k022RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:46:36 INFO - Running setup.py (path:/tmp/pip-mNdEtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:46:36 INFO - Running setup.py (path:/tmp/pip-wUeHsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:46:36 INFO - Running setup.py (path:/tmp/pip-Rf0DLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:46:36 INFO - Running setup.py (path:/tmp/pip-qvtklE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:46:36 INFO - Running setup.py (path:/tmp/pip-Viqec_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:46:36 INFO - Running setup.py (path:/tmp/pip-nTzpl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:46:36 INFO - Running setup.py (path:/tmp/pip-WF0uRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:46:36 INFO - Running setup.py (path:/tmp/pip-GJH37n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:36 INFO - Running setup.py (path:/tmp/pip-VqWXQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:46:36 INFO - Running setup.py (path:/tmp/pip-Pamr2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:46:36 INFO - Running setup.py (path:/tmp/pip-5fTYXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:46:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:46:36 INFO - Running setup.py install for manifestparser 22:46:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Running setup.py install for mozcrash 22:46:37 INFO - Running setup.py install for mozdebug 22:46:37 INFO - Running setup.py install for mozdevice 22:46:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Running setup.py install for mozfile 22:46:37 INFO - Running setup.py install for mozhttpd 22:46:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Running setup.py install for mozinfo 22:46:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Running setup.py install for mozInstall 22:46:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Running setup.py install for mozleak 22:46:37 INFO - Running setup.py install for mozlog 22:46:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:46:37 INFO - Running setup.py install for moznetwork 22:46:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:46:38 INFO - Running setup.py install for mozprocess 22:46:38 INFO - Running setup.py install for mozprofile 22:46:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:46:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:46:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:46:38 INFO - Running setup.py install for mozrunner 22:46:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:46:38 INFO - Running setup.py install for mozscreenshot 22:46:38 INFO - Running setup.py install for moztest 22:46:38 INFO - Running setup.py install for mozversion 22:46:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:46:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:46:38 INFO - Cleaning up... 22:46:38 INFO - Return code: 0 22:46:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:38 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:38 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 22:46:38 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 22:46:38 INFO - Using env: {'DISPLAY': ':0', 22:46:38 INFO - 'HOME': '/home/cltbld', 22:46:38 INFO - 'LANG': 'en_US.UTF-8', 22:46:38 INFO - 'LANGUAGE': 'en_US:en', 22:46:38 INFO - 'LOGNAME': 'cltbld', 22:46:38 INFO - 'MAIL': '/var/mail/cltbld', 22:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:38 INFO - 'MOZ_NO_REMOTE': '1', 22:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:38 INFO - 'NO_EM_RESTART': '1', 22:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:38 INFO - 'PWD': '/builds/slave/test', 22:46:38 INFO - 'SHELL': '/bin/bash', 22:46:38 INFO - 'SHLVL': '1', 22:46:38 INFO - 'TERM': 'linux', 22:46:38 INFO - 'TMOUT': '86400', 22:46:38 INFO - 'USER': 'cltbld', 22:46:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:38 INFO - '_': '/tools/buildbot/bin/python'} 22:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:38 INFO - Running setup.py (path:/tmp/pip-u5syl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:39 INFO - Running setup.py (path:/tmp/pip-EkElUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:39 INFO - Running setup.py (path:/tmp/pip-gG3iEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:39 INFO - Running setup.py (path:/tmp/pip-iL19yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:39 INFO - Running setup.py (path:/tmp/pip-tU_VyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:39 INFO - Running setup.py (path:/tmp/pip-z5sRzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:46:39 INFO - Running setup.py (path:/tmp/pip-sqfer5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:46:39 INFO - Running setup.py (path:/tmp/pip-g59OxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:46:39 INFO - Running setup.py (path:/tmp/pip-q9B7Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:46:39 INFO - Running setup.py (path:/tmp/pip-TwTMqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:46:39 INFO - Running setup.py (path:/tmp/pip-dVrH8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:46:39 INFO - Running setup.py (path:/tmp/pip-u0V1mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:46:39 INFO - Running setup.py (path:/tmp/pip-B8HA59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:46:39 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)) 22:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:46:39 INFO - Running setup.py (path:/tmp/pip-5bZpBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:46:40 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)) 22:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:40 INFO - Running setup.py (path:/tmp/pip-b0aV2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:40 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)) 22:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:46:40 INFO - Running setup.py (path:/tmp/pip-mCDUwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:46:40 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)) 22:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:46:40 INFO - Running setup.py (path:/tmp/pip-Slfewf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:46:40 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)) 22:46:40 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)) 22:46:40 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)) 22:46:40 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)) 22:46:40 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)) 22:46:40 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)) 22:46:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:46:40 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 22:46:40 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 22:46:40 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 22:46:40 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 22:46:40 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 22:46:40 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 22:46:42 INFO - Downloading blessings-1.6.tar.gz 22:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:46:42 INFO - Installing collected packages: blessings 22:46:42 INFO - Running setup.py install for blessings 22:46:42 INFO - Successfully installed blessings 22:46:42 INFO - Cleaning up... 22:46:42 INFO - Return code: 0 22:46:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:46:42 INFO - Reading from file tmpfile_stdout 22:46:42 INFO - Current package versions: 22:46:42 INFO - argparse == 1.2.1 22:46:42 INFO - blessings == 1.6 22:46:42 INFO - blobuploader == 1.2.4 22:46:42 INFO - docopt == 0.6.1 22:46:42 INFO - functools32 == 3.2.3-2 22:46:42 INFO - jsonschema == 2.5.1 22:46:42 INFO - manifestparser == 1.1 22:46:42 INFO - mozInstall == 1.12 22:46:42 INFO - mozcrash == 0.17 22:46:42 INFO - mozdebug == 0.1 22:46:42 INFO - mozdevice == 0.48 22:46:42 INFO - mozfile == 1.2 22:46:42 INFO - mozhttpd == 0.7 22:46:42 INFO - mozinfo == 0.9 22:46:42 INFO - mozleak == 0.1 22:46:42 INFO - mozlog == 3.4 22:46:42 INFO - moznetwork == 0.27 22:46:42 INFO - mozprocess == 0.23 22:46:42 INFO - mozprofile == 0.28 22:46:42 INFO - mozrunner == 6.12 22:46:42 INFO - mozscreenshot == 0.1 22:46:42 INFO - mozsystemmonitor == 0.3 22:46:42 INFO - moztest == 0.7 22:46:42 INFO - mozversion == 1.4 22:46:42 INFO - psutil == 3.1.1 22:46:42 INFO - requests == 1.2.3 22:46:42 INFO - wsgiref == 0.1.2 22:46:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46:42 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')]} 22:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 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')]} 22:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:42 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 22:46:42 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 22:46:42 INFO - Using env: {'DISPLAY': ':0', 22:46:42 INFO - 'HOME': '/home/cltbld', 22:46:42 INFO - 'LANG': 'en_US.UTF-8', 22:46:42 INFO - 'LANGUAGE': 'en_US:en', 22:46:42 INFO - 'LOGNAME': 'cltbld', 22:46:42 INFO - 'MAIL': '/var/mail/cltbld', 22:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:42 INFO - 'MOZ_NO_REMOTE': '1', 22:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:42 INFO - 'NO_EM_RESTART': '1', 22:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:42 INFO - 'PWD': '/builds/slave/test', 22:46:42 INFO - 'SHELL': '/bin/bash', 22:46:42 INFO - 'SHLVL': '1', 22:46:42 INFO - 'TERM': 'linux', 22:46:42 INFO - 'TMOUT': '86400', 22:46:42 INFO - 'USER': 'cltbld', 22:46:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:42 INFO - '_': '/tools/buildbot/bin/python'} 22:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 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)) 22:46:42 INFO - Cleaning up... 22:46:42 INFO - Return code: 0 22:46:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:46:42 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')]} 22:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 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')]} 22:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 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 0x7f5cdd43ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, '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': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', '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 22:46:42 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 22:46:42 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 22:46:42 INFO - Using env: {'DISPLAY': ':0', 22:46:42 INFO - 'HOME': '/home/cltbld', 22:46:42 INFO - 'LANG': 'en_US.UTF-8', 22:46:42 INFO - 'LANGUAGE': 'en_US:en', 22:46:42 INFO - 'LOGNAME': 'cltbld', 22:46:42 INFO - 'MAIL': '/var/mail/cltbld', 22:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:42 INFO - 'MOZ_NO_REMOTE': '1', 22:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:42 INFO - 'NO_EM_RESTART': '1', 22:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:42 INFO - 'PWD': '/builds/slave/test', 22:46:42 INFO - 'SHELL': '/bin/bash', 22:46:42 INFO - 'SHLVL': '1', 22:46:42 INFO - 'TERM': 'linux', 22:46:42 INFO - 'TMOUT': '86400', 22:46:42 INFO - 'USER': 'cltbld', 22:46:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:42 INFO - '_': '/tools/buildbot/bin/python'} 22:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:46:43 INFO - Cleaning up... 22:46:43 INFO - Return code: 0 22:46:43 INFO - Running post-action listener: _resource_record_post_action 22:46:43 INFO - Running post-action listener: _start_resource_monitoring 22:46:43 INFO - Starting resource monitoring. 22:46:43 INFO - [mozharness: 2016-11-01 05:46:43.106696Z] Finished create-virtualenv step (success) 22:46:43 INFO - [mozharness: 2016-11-01 05:46:43.107206Z] Running install step. 22:46:43 INFO - Running pre-action listener: _resource_record_pre_action 22:46:43 INFO - Running main action method: install 22:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:46:43 INFO - Reading from file tmpfile_stdout 22:46:43 INFO - Detecting whether we're running mozinstall >=1.0... 22:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:46:43 INFO - Reading from file tmpfile_stdout 22:46:43 INFO - Output received: 22:46:43 INFO - Usage: mozinstall [options] installer 22:46:43 INFO - Options: 22:46:43 INFO - -h, --help show this help message and exit 22:46:43 INFO - -d DEST, --destination=DEST 22:46:43 INFO - Directory to install application into. [default: 22:46:43 INFO - "/builds/slave/test"] 22:46:43 INFO - --app=APP Application being installed. [default: firefox] 22:46:43 INFO - mkdir: /builds/slave/test/build/application 22:46:43 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'] 22:46:43 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 22:47:00 INFO - Reading from file tmpfile_stdout 22:47:00 INFO - Output received: 22:47:00 INFO - /builds/slave/test/build/application/firefox/firefox 22:47:00 INFO - Running post-action listener: _resource_record_post_action 22:47:00 INFO - [mozharness: 2016-11-01 05:47:00.368329Z] Finished install step (success) 22:47:00 INFO - [mozharness: 2016-11-01 05:47:00.368574Z] Running run-tests step. 22:47:00 INFO - Running pre-action listener: _resource_record_pre_action 22:47:00 INFO - Running main action method: run_tests 22:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:47:00 INFO - Python 2.7.3 22:47:00 INFO - Return code: 0 22:47:00 INFO - grabbing minidump binary from tooltool 22:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:00 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 0x20f8930>, '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 0x20f9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f9cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:47:00 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 22:47:00 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 22:47:00 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 22:47:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:47:00 INFO - Return code: 0 22:47:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:47:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:47:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:47:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:47:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:47:00 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/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 22:47:00 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/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 22:47:00 INFO - Using env: {'DISPLAY': ':0', 22:47:00 INFO - 'HOME': '/home/cltbld', 22:47:00 INFO - 'LANG': 'en_US.UTF-8', 22:47:00 INFO - 'LANGUAGE': 'en_US:en', 22:47:00 INFO - 'LOGNAME': 'cltbld', 22:47:00 INFO - 'MAIL': '/var/mail/cltbld', 22:47:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:47:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:00 INFO - 'MOZ_NO_REMOTE': '1', 22:47:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:00 INFO - 'NO_EM_RESTART': '1', 22:47:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:00 INFO - 'PWD': '/builds/slave/test', 22:47:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:47:00 INFO - 'SHELL': '/bin/bash', 22:47:00 INFO - 'SHLVL': '1', 22:47:00 INFO - 'TERM': 'linux', 22:47:00 INFO - 'TMOUT': '86400', 22:47:00 INFO - 'USER': 'cltbld', 22:47:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1477979164.280565-314372488', 22:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:00 INFO - '_': '/tools/buildbot/bin/python'} 22:47:00 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/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 22:47:00 INFO - mozversion application_buildid: 20161031193142 22:47:00 INFO - mozversion application_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 22:47:00 INFO - mozversion application_display_name: Nightly 22:47:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:47:00 INFO - mozversion application_name: Firefox 22:47:00 INFO - mozversion application_remotingname: firefox 22:47:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:47:00 INFO - mozversion application_vendor: Mozilla 22:47:00 INFO - mozversion application_version: 52.0a1 22:47:00 INFO - mozversion platform_buildid: 20161031193142 22:47:00 INFO - mozversion platform_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 22:47:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:47:00 INFO - mozversion platform_version: 52.0a1 22:47:00 INFO - using testdate: 1477979220 22:47:00 INFO - actual date: 1477979220 22:47:00 INFO - starting webserver on 'localhost:58408' 22:47:00 INFO - SUITE-START | Running 2 tests 22:47:00 INFO - TEST-START | dromaeo_css 22:47:00 INFO - operating with platform_type : linux_ 22:47:00 INFO - Initialising browser for dromaeo_css test... 22:47:00 INFO - TEST-INFO | started process 8879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaU4dUE/profile http://localhost:58408/getInfo.html) 22:47:05 INFO - PROCESS | 8879 | __metrics Screen width/height:1600/1200 22:47:05 INFO - PROCESS | 8879 | colorDepth:24 22:47:05 INFO - PROCESS | 8879 | Browser inner width/height: 1024/697 22:47:05 INFO - PROCESS | 8879 | __metrics 22:47:05 ERROR - PROCESS | 8879 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 22:47:06 INFO - TEST-INFO | 8879: exit 0 22:47:06 INFO - Browser initialized. 22:47:06 INFO - Running cycle 1/1 for dromaeo_css test... 22:47:06 INFO - TEST-INFO | started process 9000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaU4dUE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:47:18 INFO - PROCESS | 9000 | RSS: Main: 185233408 22:47:18 INFO - PROCESS | 9000 | 22:48:08 INFO - PROCESS | 9000 | 1477979288631 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] 22:50:20 INFO - PROCESS | 9000 | Cycle 1(1): loaded http://localhost:58408/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58408/tests/dromaeo/cssquery-ext.html) 22:50:21 INFO - PROCESS | 9000 | RSS: Main: 197922816 22:50:21 INFO - PROCESS | 9000 | 22:53:23 INFO - PROCESS | 9000 | Cycle 1(1): loaded http://localhost:58408/tests/dromaeo/cssquery-ext.html (next: http://localhost:58408/tests/dromaeo/cssquery-jquery.html) 22:53:23 INFO - PROCESS | 9000 | RSS: Main: 196374528 22:53:23 INFO - PROCESS | 9000 | 22:56:25 INFO - PROCESS | 9000 | Cycle 1(1): loaded http://localhost:58408/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58408/tests/dromaeo/cssquery-mootools.html) 22:56:26 INFO - PROCESS | 9000 | RSS: Main: 198119424 22:56:26 INFO - PROCESS | 9000 | 22:59:28 INFO - PROCESS | 9000 | Cycle 1(1): loaded http://localhost:58408/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58408/tests/dromaeo/cssquery-prototype.html) 22:59:29 INFO - PROCESS | 9000 | RSS: Main: 195080192 22:59:29 INFO - PROCESS | 9000 | 23:02:31 INFO - PROCESS | 9000 | Cycle 1(1): loaded http://localhost:58408/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58408/tests/dromaeo/cssquery-yui.html) 23:02:32 INFO - PROCESS | 9000 | RSS: Main: 198615040 23:02:32 INFO - PROCESS | 9000 | 23:05:34 INFO - PROCESS | 9000 | Cycle 1(1): loaded http://localhost:58408/tests/dromaeo/cssquery-yui.html (next: http://localhost:58408/tests/dromaeo/cssquery-dojo.html) 23:05:35 INFO - PROCESS | 9000 | RSS: Main: 198533120 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | __start_tp_report 23:05:35 INFO - PROCESS | 9000 | _x_x_mozilla_page_load 23:05:35 INFO - PROCESS | 9000 | _x_x_mozilla_page_load_details 23:05:35 INFO - PROCESS | 9000 | |i|pagename|runs| 23:05:35 INFO - PROCESS | 9000 | |0;dojo.html;3061.2040869373955;3061.4183305172014;3070.3552254026654;3099.4111118887417;3113.20613243623;5290.444503327153;5363.195520671901;5375.354957405117;5450.836474905755;5497.642653227537;5382.434844341346;5421.241026256327;5449.3188351456065;5475.09660905951;5575.776968921248;4909.9754501227535;4945.109880221558;4959.70241785494;4963.503649635026;5072.9492705073035;4897.485763994782;5001.799928002875;5016.072026675059;5027.572656324217;5052.545270925616;4837.782299796482;4934.185859333205;5014.222795466709;5019.6486245962615;5059.3422855028975;4864.367632207825;4901.215805471107;4907.214845624719;4922.581580565657;5015.84952451427;4846.369971903665;4901.387326584177;4902.19113846215;4903.398266455211;4922.975385123087;5383.515483606455;5389.191621256804;5436.809711660112;5438.184272359178;5451.945480545183;5650.943490565083;5722.54219662426;5746.42535746422;5803.796867109673;5822.621529600562;5873.735681894325;5884.146798714162;5885.852853678693;5896.204012458306;5940;5455.672659640434;5464.098423760114;5465.098258787295;5472.315960504937;5478.890422191534;5769.1634712967225;5799.33307669615;5860.531157507389;5891.528677705774;5960.8807823844145;5706.828795136153;5727.627704199213;5733.483986441241;5762.164486149485;5782.3639399666;5738.5982981191755;5747.913781293284;5797.942020579824;5801.6519008859605;5844.503217226584;5499.862503437366;5580;5738.110592858114;5789.536837053026;5811.041178205549;5822.70886455684;5859.267591551056;5864.797716468114;5880.970595146997;5891.1457838614015;4501.717010651949;4506.504284528699;4508.774561271924;4517.774111294422;4552.658550608718;3889.4554762333296;3892.2799282132896;3915.980420097881;3921.980285125888;4005.459262999516;5491.752871120809;5531.059719847635;5546.057170281062;5569.554435645138;5573.749181286852;5790.594658373873;5804.1293805929445;5817.418258174149;5825.359210486843;5876.206712093898;5395.622306438511;5411.56707463402;5459.508644222039;5486.039943009957;5543.61194716366;5042.899142017139;5071.239314102914;5078.08594453002;5083.212102124176;5101.387833460009;5942.494887934574;6026.186464827279;6028.879422411527;6033.125196846433;6105.450509453993;5671.801486947937;5738.885222295614;5849.356570777126;5877.235959325431;5882.176495290748;6084.907528414842;6090.543209259235;6101.298350689727;6149.538784591084;6165.784197553064;5765.308163020464;5814.476697097281;5819.330776960704;5829.067349224104;5882.588218824641;5606.355269143937;5845.970770146292;5856.824295271149;5868.354481007001;5882.470577648032;5508.504234618904;5592.804251851166;5634.0422128239115;5642.887142257214;5690.544756419394;5624.100143976944;5645.661260324229;5647.29408823897;5708.257926469532;5724.570657200643;5462.590305727007;5582.330120385417;5650.491455769001;5689.2319536862;5690.857728556819;5757.596968212185;5758.1362795581;5770.9711451444155;5796.565257605781;5818.912716309174;5635.098384258499;5643.661380317194;5691.402402747652;5705.4579814917515;5709.771609135588 23:05:35 INFO - PROCESS | 9000 | |1;ext.html;562.92400525929;589.3340525206517;590.9556783241258;594.1829983772313;608.3247595169361;41114.17771644565;42558.14883702324;42586;46755;46877.29684054734;43432.56567434325;43953.56046439543;44062.11875762483;44095.3385699214;44226.55773442273;8706.129387061306;8891;8896.911030889672;8902.06528314524;8921.910780892205;8644;8844.248238899701;8845.115488451167;8853.24747396472;8856.690015849446;8769.824603507926;8843.071477494866;8882.777930551756;8900.332475064364;8939.508327042011;8746.737597872074;8807.119288071206;8811.118888111201;8827.735167944971;8848.734537963872;8605.784855378666;8692.13078692132;8702.651893924236;8704.651813927436;8746.562671866444;40231.39652905209;40726.592734072576;40742.796286018674;40744;40847.183056338705;3529.124496070729;3601.675849173561;3781.2437512497336;3946.5264168299987;3952.5256969163597;30517.237069073228;30800;31492.685073149205;31738.365232695447;31941.680583194102;3326.284848757529;3713.3130370881204;3716.5168528091444;3805.486259354979;3819.083419979213;322727;323352;324081;324143;326213;55876;55881.441185587624;56148;56391;56496;57699.42300576941;58469.41530584725;58644;58711.11933321004;58714.70642646845;15283.847161528465;15544.222788860512;15556.844431555766;15579.376824926876;15605.219739013004;12019;12076.51693932233;12187.634370968884;12212.75574488523;12227.327496987573;15195.353115252481;15970.121643309729;16235.83764162367;16245.51263462098;16716.58208544796;6374.649394283266;6465.418112369909;6520.934790652128;6596.010598410181;6658.866822663616;878.4114643189079;1001.6944831826218;1002.9097381235724;1015.4110615842793;1189.6609466302061;30242.54636180459;30308.696913031028;31114.53328200079;31159;31218.687813122033;986.40815510693;1063.7659714862718;1066.664000839733;1087.0868470484672;1171.4611278811672;15157.772633410508;15263.313150908236;15317.540473785804;15320.693586128215;15509.689806203813;462803;463885;466599;466655.66820645134;468191;55482.445175548535;55705.44294557002;55959;56151;56172.719136404055;1296.5526893221822;1347.4879545772544;1366.2827015816777;1369.0348304445342;1371.7050834070524;26701.599476007486;29095.709042910148;29576;29762.553561697026;30209.848950755106;47018.52981470142;47210.76394618005;47358.52641473541;47499.28751068806;47559.76220118877;404554;406977;407424;408039;408343;33530.66469335275;33627.66372336245;33899;33939.49090763591;34920;44760;44977.77511112423;45593;46296;46963.29555056609;38522;38908.221835563694;39230.41154382744;40272.19455610813;40491.1901761969;38918.6108138915;39048;39139.41290880696;39995.800021000876;40450.59549404468;38514;38685.226295474495;39353.80323098366;39625;41856.58143418527;30905.69094309118;34999.82500087585;35788;35949.64050359463;35988.22123677081;26819.865900671153;27119.322016949733;27377.452450951267;27608.723912760615;29313.41373172482 23:05:35 INFO - PROCESS | 9000 | |2;jquery.html;371.43727253211404;385.2122409672221;387.66660671822234;400.95751047277065;406.54060911170393;17557.47327580173;19778.40664780055;20484.28305009325;20712.792872071273;20759.792402075975;18335.724964125548;18385.058390657498;18590.34933777318;19254.229830806788;19575.119119639614;5382.138857782756;5418.241446197536;5573.637713548606;5674.262345895048;5677.630953987978;5449.291592093042;5553.611247212697;5555.583331250152;5556.91664625031;5563.638363506379;5504.4770746778995;5509.669419834802;5554.50009499145;5616.663000219979;5906.793262235801;5948.672822994755;6012.3085845127935;6017.488513476338;6018.759249630009;6037.396260373971;5615.438456154352;5772.480476757112;5824.592278540504;5830.183774271605;5830.533557315404;14240.501582444565;14721.116732996055;14791.334389952477;21464.892675536677;22649.54700905989;2293.575688497633;2317.1310758465575;2485.142625794116;2780.708025657317;2958.9704102959126;9916.285277463783;10383.636572719919;10678.25252232344;10866.293690910066;10884.727881802939;1928.7106933959878;1940.7282980382759;2002.9484520626643;2015.7681866585383;2048.9077991490417;77855;80206.59896700538;80473;81350;82618.58690706508;10742.624008159677;10867.365503765832;11117.221794474472;11180.776384472265;11268.830967535494;15641.765373519407;15653.530394088195;15689.68620627581;15693.921530392503;15697.215139242991;7518.436117291225;7778.183290754502;7981.2018798119725;8009.3192078673965;8067.636956336979;7314.707411703473;7317.15852676949;7357.963210183915;7536;7545.132309784335;4771.093492236464;4833.709977401367;4844.297576851337;4871.318015477836;4999.925001124986;1909.7326374307609;1963.9312624058375;2030.6547886859269;2039.7042428847733;2071.54426026274;840.7813968368268;908.6365453818526;940.1444685336447;979.1970584121095;1016.0398423489731;17484.193809366814;19092;19153.56348273885;19163.233470661296;19619.705704414446;943.217129782279;949.3307218411004;966.7244835221928;1015.5937624949931;1028.3932479836933;9717;10570;10693.625723099654;10729.83905241422;10738.624148154777;440424.1915161679;442105;443803;443977;446385;50334.24498632523;50773.49226507761;55504;59595;88098;983.5721461164417;1000.8598796168542;1003.1423133221283;1006.4263369879098;1006.9848952265722;16507.58731031734;16738.832611673726;17278.91360543189;17332.30670773155;17333.826661733223;42522;42955.7852210737;43094.35358469563;43345;43901.78049109734;56788;57045.714771425875;57332.71333643305;58350.7082464585;59691;7615.352695020763;7820.882686759589;8471.703490377808;8479.872801908099;8835.116488351114;12286.569970051005;12694.428750706056;13182.538611148564;13435.328233588478;13520.12119212248;6107.84730381744;7144.714211431692;11333.376664283544;11489.885101149215;11764.705882352804;10536.209784266364;10904.291221070605;11005.284656497302;11743.823842642538;11992.100592455776;11200.32798032088;11493;12027.27836329823;12130.272183669009;12210.206336588093;8488.660453581788;8522.911886587826;8584.914150858662;8650.178233067849;9067.365284430027;10257.384556926609;11679.124065694938;11894.583689570823;11922.344271065174;11956.58151964677 23:05:35 INFO - PROCESS | 9000 | |3;mootools.html;1466.5013895275604;1488.4195163886084;1623.1478473801253;1744.720844664854;1751.3957684598809;7187.640617969094;7539.886901696465;7806.570638614874;8387.119352467987;8400.621972011259;7752.922470775291;8047.637856296466;8058.959705201481;8241.022154682878;8255.380846436512;2308.6190778521523;2342.0397636968846;2344.2498400511845;2347.8004369628516;2348.4598542335275;2307.976920230801;2331.6152834782324;2382.0828980842416;2389;2394.3774618599114;2353.470469144437;2355.811535077198;2369.7156341239074;2382.059086660768;2387.510560335127;2267.875266860322;2283.8058765004994;2300.700908881843;2308.4113551044543;2366.6213405854983;2299.1722979727283;2312.9421764455856;2313.375388645073;2320.6170981787986;2341.8829058547176;8123.634436450315;8206.548639824807;8213.79465513361;8220.177982201792;8254.628541715638;4773.785179666923;4944.678595891256;4969.180085285923;5027.597792176617;5111.591072714174;3187.9537402898836;3247.8700851966128;3355.1108956126645;3369.848356823949;3379.9155021124425;1030.1912998296377;1098.4288170151556;1100.5817789240118;1124.859392575928;1143.0341361549476;10966.177536684701;11084.501197446134;11118.888811111867;11187.272827266203;11209.047230985376;4248.34150706641;4405.207062728739;4467.816028752383;4492.820287188476;4551.249043907785;9583.233341332676;9594.904050959542;9596.040395960488;9607.51962401891;9623.56693948774;4996.950030499721;5007.524285192901;5012.624053196025;5022.6233032522705;5075.720835354091;4406.361077643724;4583.991521865184;4594;4624.768761561909;4629.6990695605355;3813.4279858020964;3818.6563209311294;3897.376419772879;3988.521377434726;3994.141259629194;1303.2636560343376;1326.2175316563273;1337.1442276942764;1340.6246251049722;1345.8250427444566;929.8000929800126;943;946.4747065378643;948.643439880963;957.9808403831885;5403;5522.144067669517;5612.102063669793;5612.579056570774;5690.516306113944;902.6118768929292;911.3711539038175;934.8457504511815;940.1303793990531;957.4255446731905;3747.775133491999;3780.3006443807985;3832.463455116286;3851.364524853424;3939.9803000985385;9753.658621948198;10002.549885255181;10026.799464010679;10089.192864570818;10149.543270552844;9944.502774861228;10025.097741203326;10053.849192262122;10096.949515252376;10098.141657959155;7338.302861228175;7517.812054698677;7604.581748003913;7661.923380766232;7662;5334.573234141337;5408.486193811582;5465.426130256265;5565.16522521625;5684.63049901755;8959.910400895908;8977.820443591223;8992.550372481219;9000.86498702533;9114.772130696785;9262.768430789285;9264.351495395527;9270.582823772811;9337.953310233677;9364.20404265645;6620.602763834186;6739.494537909774;6851.040854280504;6997.895031574429;7000.61496617691;7923.405744569296;7983.600819959095;7985.840283194188;7994.5203287802915;8004.959975200087;6647.401733843783;6688.598684078971;6699.799006029827;6772.25505194438;6925.58446493212;6484.157059582224;6643.069970204078;6768.120144381199;6819.624920629413;6835.58986460814;6100.389961003864;6106.145139680537;6158.630482171084;6245.219347581552;6265.185525881606;4770.737609431515;4873.074115917964;4906.55840974314;4937.925931111108;5042.949570504248;4836.202026665702;4871.366722326216;4879.902401952012;4949.554540091409;4965.4041515018425 23:05:35 INFO - PROCESS | 9000 | |4;prototype.html;318.0981916267381;321.8246055899535;328.7041662503747;329.95404567520956;342.8251591688238;5285.550728188108;5406.567474602032;5433.8369848904595;5460.645058071227;5465.453454654533;5247.344081989751;5331.440198779121;5366.772789292449;5394.622376433651;5409.56723462123;4236.152769446107;4243.408721729352;4249.426327445786;4254.255505286563;4263.740217684632;4144.48193975753;4218.1563687262515;4223.873283801491;4273.166732487166;4278.9786051069705;4207;4214.536400995888;4217.177650358181;4226;4226.661867050629;4157.97921010396;4169.10364271683;4204.915901681965;4207.831686732527;4228.302330115527;3654.843642251058;3711.5175027246555;3731.917743854279;3743.5507739071486;3755.8497660093562;5215.713135777569;5227.03986005248;5245;5246.658967167122;5259.15853463444;4863.8540843774745;4889.779959901813;4890.144224760653;4893.559579637849;4915.827946021908;5351.2240725095035;5679.318481782171;5684;5693.971530142364;5720.283914825577;4003.15933653933;4007.979960100181;4022.5374081980654;4027.335489644205;4032.2741906456827;5897.262842144732;5899.203607512974;5911.527077833763;5920.881582368328;5933.762649494059;4022.8994275143355;4070.6336429720873;4080.3471444568727;4098.241825262336;4107.691923105779;4131.814068366871;4148.460700108966;4150.115669609592;4152.875413737593;4163.812628431728;4741.952580474152;4762.690425122356;4763.666543341933;4765.404324459442;4792.185328494164;5543.392416199337;5677.318721753333;5688.971555142198;5698.373178950312;5706.71466426677;1433.6917562724063;1448.5659197394505;1458.344778676189;1459.4599998000594;1467.8605532474398;894.2890402130322;918.4581097152712;924.5654542365078;925.8379783537854;934.2992755433424;4792.520747925179;4818.831340903052;4826.758662066883;4840.128776820206;4848.75756212195;5087.31321271631;5093.439721630618;5124.948750512522;5153.974230128825;5162.74186290684;4787.281907713871;4846.39420072491;4871.756412179377;4877.561019508261;5148.536631703089;3055.495843185894;3106.7999960040743;3114.8286844223785;3118.6725393833776;3129.8435078246453;6093.69531523422;6096.969515152396;6104.664243466563;6119.938800612026;6141.570090093651;5617.915731264035;5928.081147422156;5940.851348785151;5948.881022379528;5969.537463321514;5993.9700301498215;6005.729742161613;6008.279006519246;6044.667543285162;6054.939450605438;5624.409437009219;5797.594168408171;5817.214676018683;5837.795677151449;5853.502452291603;5751;5789.45000224978;5789.94210057894;5793.652380857162;5802.332731735735;6095.9390406097145;6137.815865524041;6138.662373569497;6139.416755408229;6170.580766423658;4038.818253178673;4076.775777332275;4104.343305071175;4139.4204811327045;4143.274926887722;5892.026171232514;5907;5910.822675319747;5915.58590898633;5936.8812623748145;5551.361593416647;5743.712814359182;5760.769569217352;5785.797497087582;5797.159411885337;5611.57913156523;5650.547956163579;5666.526703057152;5702.714864256854;5720.8283751487525;5684;5692.719138194039;5704.857378565569;5714.485661299842;5722.141678748221;5439.48324909133;5731.254936858182;5750.539956803362;5758.481736643722;5761.740721667451;5634.352049514195;5658.632188907708;5688.63023903445;5697.7720891165545;5705.885882282414 23:05:35 INFO - PROCESS | 9000 | |5;yui.html;686.4988558352405;690.4407429981713;738.3945164964728;748.457368407904;779.0495595373644;13070.738585228302;13521.797173042387;13568.98232632554;13616.319184040796;13628.114172578787;13378.732425351487;13587.660308492292;13596;13607.183568985867;13613.162223099904;660.270401206667;678.3284548297199;786.1156199275815;793.1949071692237;802.229859335039;818.6725309876037;818.7216346442209;819.8975128108957;820.2904487618197;820.958952052398;862.6290695001147;862.9611667474948;863.4905405810571;865.3034307382554;866.1252135343285;850.5407080176698;855.8673405622138;858.1118542308743;858.6436628799041;858.6436628799041;625.8685676008043;626.3642402960999;626.5081910700125;626.8401557602828;627.2253766598247;11672.299662020221;11771.882281177164;11804.11469139818;11831.645050648494;11988.700282493008;11942.402879855972;12100.576479823252;12389.380530973416;12480;13668.31658417085;12118.333491657955;12192.878071219264;12322.445489952974;12378.938105309506;12379.75240495194;3928.5874983126932;3936.5472970608175;3974.1455587048636;4017.196560687845;4163.625273725379;61626.69186654038;61719.6914015427;62311;63162.36837631657;65350.346496534905;10756.247062705692;10837;10882.29265097766;10886.971820426494;10964.725881853017;19012.144453499626;19155.904220479086;19221.90389048046;19256.133473993705;19305.710414343797;7793.181715919747;7816.53100813953;7925.167857375008;8147.470414423044;8195.221453961864;3791.5829258781514;3859.208862183246;3863.826127824255;3900.6489415952133;3909.7458665186673;3030.3787723516625;3098.3493466372315;3118.9064328070194;3153.369326134782;3276.3447310537986;648.4909346163239;655.5116438253436;658.6136183334013;662.9933700662932;669.491186698113;556.9275994120738;566.4081035318103;669.9296573859674;688.5971706551624;693.4279219643814;8291.543965081857;8339.95830020846;8389;8596.785080372916;8626.094260102724;557.3618207152869;661.9871596457427;694.9513534052568;735.5623404074568;737.6975440069546;4340.60934515895;4404.013431244562;4617.976910115428;4631.652626053059;4668.976655116703;72892.63553682198;90031.54984225037;90210.54894725616;91534;92959.53520232356;79280;80210.5989470049;81216.18783812204;82407;82725;43745.68762937117;57068.714656426455;71147.99999999897;71373;72075;7439.256074392518;8807.295416366547;8933.19601235892;8973.641054357753;8980.101989800967;48005.51994480011;48406.5159348402;49021.26468103052;49813.50186498234;50286.24570631517;39997.80001099976;40796.592034080466;61612.38387616246;65667;67393.32606674067;9540.761480963032;9584.90415095868;9660.661876834278;9749.561269742737;10686.89313106859;10812.133316689551;11006.284591501526;11018;11095.001449869551;11300.152488563226;11203.831942520706;11231.775364492827;11270.436478176221;11498.137639677225;11502.53989840397;10348.741281467723;10509.054185123376;10611.628592999208;11108.055815255793;11224.831627525431;10176.542055607664;10306.278560500992;10448.738781530523;10852.077573406348;10959.123270138529;8317.500949943023;8906.153915378029;9077.409968352036;9267.53662316895;9632.084951929555;7962.538587342919;8371.748847534584;8725.171108744658;8918.643254269757;9487.905120948702 23:05:35 INFO - PROCESS | 9000 | __end_tp_report 23:05:35 INFO - PROCESS | 9000 | __start_cc_report 23:05:35 INFO - PROCESS | 9000 | _x_x_mozilla_cycle_collect,340 23:05:35 INFO - PROCESS | 9000 | __end_cc_report 23:05:35 INFO - PROCESS | 9000 | __startTimestamp1477980335238__endTimestamp 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | ------- Summary: start ------- 23:05:35 INFO - PROCESS | 9000 | Number of tests: 6 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | [#0] dojo.html Cycles:165 Average:5407.41 Median:5624.10 stddev:622.22 (11.1%) stddev-sans-first:596.29 23:05:35 INFO - PROCESS | 9000 | Values: 3061.2 3061.4 3070.4 3099.4 3113.2 5290.4 5363.2 5375.4 5450.8 5497.6 5382.4 5421.2 5449.3 5475.1 5575.8 4910.0 4945.1 4959.7 4963.5 5072.9 4897.5 5001.8 5016.1 5027.6 5052.5 4837.8 4934.2 5014.2 5019.6 5059.3 4864.4 4901.2 4907.2 4922.6 5015.8 4846.4 4901.4 4902.2 4903.4 4923.0 5383.5 5389.2 5436.8 5438.2 5451.9 5650.9 5722.5 5746.4 5803.8 5822.6 5873.7 5884.1 5885.9 5896.2 5940.0 5455.7 5464.1 5465.1 5472.3 5478.9 5769.2 5799.3 5860.5 5891.5 5960.9 5706.8 5727.6 5733.5 5762.2 5782.4 5738.6 5747.9 5797.9 5801.7 5844.5 5499.9 5580.0 5738.1 5789.5 5811.0 5822.7 5859.3 5864.8 5881.0 5891.1 4501.7 4506.5 4508.8 4517.8 4552.7 3889.5 3892.3 3916.0 3922.0 4005.5 5491.8 5531.1 5546.1 5569.6 5573.7 5790.6 5804.1 5817.4 5825.4 5876.2 5395.6 5411.6 5459.5 5486.0 5543.6 5042.9 5071.2 5078.1 5083.2 5101.4 5942.5 6026.2 6028.9 6033.1 6105.5 5671.8 5738.9 5849.4 5877.2 5882.2 6084.9 6090.5 6101.3 6149.5 6165.8 5765.3 5814.5 5819.3 5829.1 5882.6 5606.4 5846.0 5856.8 5868.4 5882.5 5508.5 5592.8 5634.0 5642.9 5690.5 5624.1 5645.7 5647.3 5708.3 5724.6 5462.6 5582.3 5650.5 5689.2 5690.9 5757.6 5758.1 5771.0 5796.6 5818.9 5635.1 5643.7 5691.4 5705.5 5709.8 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | [#1] ext.html Cycles:180 Average:56004.10 Median:40361.40 stddev:106511.55 (263.9%) stddev-sans-first:106729.00 23:05:35 INFO - PROCESS | 9000 | Values: 562.9 589.3 591.0 594.2 608.3 41114.2 42558.1 42586.0 46755.0 46877.3 43432.6 43953.6 44062.1 44095.3 44226.6 8706.1 8891.0 8896.9 8902.1 8921.9 8644.0 8844.2 8845.1 8853.2 8856.7 8769.8 8843.1 8882.8 8900.3 8939.5 8746.7 8807.1 8811.1 8827.7 8848.7 8605.8 8692.1 8702.7 8704.7 8746.6 40231.4 40726.6 40742.8 40744.0 40847.2 3529.1 3601.7 3781.2 3946.5 3952.5 30517.2 30800.0 31492.7 31738.4 31941.7 3326.3 3713.3 3716.5 3805.5 3819.1 322727.0 323352.0 324081.0 324143.0 326213.0 55876.0 55881.4 56148.0 56391.0 56496.0 57699.4 58469.4 58644.0 58711.1 58714.7 15283.8 15544.2 15556.8 15579.4 15605.2 12019.0 12076.5 12187.6 12212.8 12227.3 15195.4 15970.1 16235.8 16245.5 16716.6 6374.6 6465.4 6520.9 6596.0 6658.9 878.4 1001.7 1002.9 1015.4 1189.7 30242.5 30308.7 31114.5 31159.0 31218.7 986.4 1063.8 1066.7 1087.1 1171.5 15157.8 15263.3 15317.5 15320.7 15509.7 462803.0 463885.0 466599.0 466655.7 468191.0 55482.4 55705.4 55959.0 56151.0 56172.7 1296.6 1347.5 1366.3 1369.0 1371.7 26701.6 29095.7 29576.0 29762.6 30209.8 47018.5 47210.8 47358.5 47499.3 47559.8 404554.0 406977.0 407424.0 408039.0 408343.0 33530.7 33627.7 33899.0 33939.5 34920.0 44760.0 44977.8 45593.0 46296.0 46963.3 38522.0 38908.2 39230.4 40272.2 40491.2 38918.6 39048.0 39139.4 39995.8 40450.6 38514.0 38685.2 39353.8 39625.0 41856.6 30905.7 34999.8 35788.0 35949.6 35988.2 26819.9 27119.3 27377.5 27608.7 29313.4 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | [#2] jquery.html Cycles:180 Average:26617.75 Median:394.31 stddev:72866.77 (18479.5%) stddev-sans-first:73044.54 23:05:35 INFO - PROCESS | 9000 | Values: 371.4 385.2 387.7 401.0 406.5 17557.5 19778.4 20484.3 20712.8 20759.8 18335.7 18385.1 18590.3 19254.2 19575.1 5382.1 5418.2 5573.6 5674.3 5677.6 5449.3 5553.6 5555.6 5556.9 5563.6 5504.5 5509.7 5554.5 5616.7 5906.8 5948.7 6012.3 6017.5 6018.8 6037.4 5615.4 5772.5 5824.6 5830.2 5830.5 14240.5 14721.1 14791.3 21464.9 22649.5 2293.6 2317.1 2485.1 2780.7 2959.0 9916.3 10383.6 10678.3 10866.3 10884.7 1928.7 1940.7 2002.9 2015.8 2048.9 77855.0 80206.6 80473.0 81350.0 82618.6 10742.6 10867.4 11117.2 11180.8 11268.8 15641.8 15653.5 15689.7 15693.9 15697.2 7518.4 7778.2 7981.2 8009.3 8067.6 7314.7 7317.2 7358.0 7536.0 7545.1 4771.1 4833.7 4844.3 4871.3 4999.9 1909.7 1963.9 2030.7 2039.7 2071.5 840.8 908.6 940.1 979.2 1016.0 17484.2 19092.0 19153.6 19163.2 19619.7 943.2 949.3 966.7 1015.6 1028.4 9717.0 10570.0 10693.6 10729.8 10738.6 440424.2 442105.0 443803.0 443977.0 446385.0 50334.2 50773.5 55504.0 59595.0 88098.0 983.6 1000.9 1003.1 1006.4 1007.0 16507.6 16738.8 17278.9 17332.3 17333.8 42522.0 42955.8 43094.4 43345.0 43901.8 56788.0 57045.7 57332.7 58350.7 59691.0 7615.4 7820.9 8471.7 8479.9 8835.1 12286.6 12694.4 13182.5 13435.3 13520.1 6107.8 7144.7 11333.4 11489.9 11764.7 10536.2 10904.3 11005.3 11743.8 11992.1 11200.3 11493.0 12027.3 12130.3 12210.2 8488.7 8522.9 8584.9 8650.2 9067.4 10257.4 11679.1 11894.6 11922.3 11956.6 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | [#3] mootools.html Cycles:180 Average:5381.34 Median:5002.24 stddev:2933.04 (58.6%) stddev-sans-first:2926.51 23:05:35 INFO - PROCESS | 9000 | Values: 1466.5 1488.4 1623.1 1744.7 1751.4 7187.6 7539.9 7806.6 8387.1 8400.6 7752.9 8047.6 8059.0 8241.0 8255.4 2308.6 2342.0 2344.2 2347.8 2348.5 2308.0 2331.6 2382.1 2389.0 2394.4 2353.5 2355.8 2369.7 2382.1 2387.5 2267.9 2283.8 2300.7 2308.4 2366.6 2299.2 2312.9 2313.4 2320.6 2341.9 8123.6 8206.5 8213.8 8220.2 8254.6 4773.8 4944.7 4969.2 5027.6 5111.6 3188.0 3247.9 3355.1 3369.8 3379.9 1030.2 1098.4 1100.6 1124.9 1143.0 10966.2 11084.5 11118.9 11187.3 11209.0 4248.3 4405.2 4467.8 4492.8 4551.2 9583.2 9594.9 9596.0 9607.5 9623.6 4997.0 5007.5 5012.6 5022.6 5075.7 4406.4 4584.0 4594.0 4624.8 4629.7 3813.4 3818.7 3897.4 3988.5 3994.1 1303.3 1326.2 1337.1 1340.6 1345.8 929.8 943.0 946.5 948.6 958.0 5403.0 5522.1 5612.1 5612.6 5690.5 902.6 911.4 934.8 940.1 957.4 3747.8 3780.3 3832.5 3851.4 3940.0 9753.7 10002.5 10026.8 10089.2 10149.5 9944.5 10025.1 10053.8 10096.9 10098.1 7338.3 7517.8 7604.6 7661.9 7662.0 5334.6 5408.5 5465.4 5565.2 5684.6 8959.9 8977.8 8992.6 9000.9 9114.8 9262.8 9264.4 9270.6 9338.0 9364.2 6620.6 6739.5 6851.0 6997.9 7000.6 7923.4 7983.6 7985.8 7994.5 8005.0 6647.4 6688.6 6699.8 6772.3 6925.6 6484.2 6643.1 6768.1 6819.6 6835.6 6100.4 6106.1 6158.6 6245.2 6265.2 4770.7 4873.1 4906.6 4937.9 5042.9 4836.2 4871.4 4879.9 4949.6 4965.4 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | [#4] prototype.html Cycles:180 Average:4738.15 Median:5272.35 stddev:1404.78 (26.6%) stddev-sans-first:1368.98 23:05:35 INFO - PROCESS | 9000 | Values: 318.1 321.8 328.7 330.0 342.8 5285.6 5406.6 5433.8 5460.6 5465.5 5247.3 5331.4 5366.8 5394.6 5409.6 4236.2 4243.4 4249.4 4254.3 4263.7 4144.5 4218.2 4223.9 4273.2 4279.0 4207.0 4214.5 4217.2 4226.0 4226.7 4158.0 4169.1 4204.9 4207.8 4228.3 3654.8 3711.5 3731.9 3743.6 3755.8 5215.7 5227.0 5245.0 5246.7 5259.2 4863.9 4889.8 4890.1 4893.6 4915.8 5351.2 5679.3 5684.0 5694.0 5720.3 4003.2 4008.0 4022.5 4027.3 4032.3 5897.3 5899.2 5911.5 5920.9 5933.8 4022.9 4070.6 4080.3 4098.2 4107.7 4131.8 4148.5 4150.1 4152.9 4163.8 4742.0 4762.7 4763.7 4765.4 4792.2 5543.4 5677.3 5689.0 5698.4 5706.7 1433.7 1448.6 1458.3 1459.5 1467.9 894.3 918.5 924.6 925.8 934.3 4792.5 4818.8 4826.8 4840.1 4848.8 5087.3 5093.4 5124.9 5154.0 5162.7 4787.3 4846.4 4871.8 4877.6 5148.5 3055.5 3106.8 3114.8 3118.7 3129.8 6093.7 6097.0 6104.7 6119.9 6141.6 5617.9 5928.1 5940.9 5948.9 5969.5 5994.0 6005.7 6008.3 6044.7 6054.9 5624.4 5797.6 5817.2 5837.8 5853.5 5751.0 5789.5 5789.9 5793.7 5802.3 6095.9 6137.8 6138.7 6139.4 6170.6 4038.8 4076.8 4104.3 4139.4 4143.3 5892.0 5907.0 5910.8 5915.6 5936.9 5551.4 5743.7 5760.8 5785.8 5797.2 5611.6 5650.5 5666.5 5702.7 5720.8 5684.0 5692.7 5704.9 5714.5 5722.1 5439.5 5731.3 5750.5 5758.5 5761.7 5634.4 5658.6 5688.6 5697.8 5705.9 23:05:35 INFO - PROCESS | 9000 | 23:05:35 INFO - PROCESS | 9000 | [#5] yui.html Cycles:180 Average:16971.80 Median:62015.35 stddev:23572.85 (38.0%) stddev-sans-first:23607.26 23:05:35 INFO - PROCESS | 9000 | Values: 686.5 690.4 738.4 748.5 779.0 13070.7 13521.8 13569.0 13616.3 13628.1 13378.7 13587.7 13596.0 13607.2 13613.2 660.3 678.3 786.1 793.2 802.2 818.7 818.7 819.9 820.3 821.0 862.6 863.0 863.5 865.3 866.1 850.5 855.9 858.1 858.6 858.6 625.9 626.4 626.5 626.8 627.2 11672.3 11771.9 11804.1 11831.6 11988.7 11942.4 12100.6 12389.4 12480.0 13668.3 12118.3 12192.9 12322.4 12378.9 12379.8 3928.6 3936.5 3974.1 4017.2 4163.6 61626.7 61719.7 62311.0 63162.4 65350.3 10756.2 10837.0 10882.3 10887.0 10964.7 19012.1 19155.9 19221.9 19256.1 19305.7 7793.2 7816.5 7925.2 8147.5 8195.2 3791.6 3859.2 3863.8 3900.6 3909.7 3030.4 3098.3 3118.9 3153.4 3276.3 648.5 655.5 658.6 663.0 669.5 556.9 566.4 669.9 688.6 693.4 8291.5 8340.0 8389.0 8596.8 8626.1 557.4 662.0 695.0 735.6 737.7 4340.6 4404.0 4618.0 4631.7 4669.0 72892.6 90031.5 90210.5 91534.0 92959.5 79280.0 80210.6 81216.2 82407.0 82725.0 43745.7 57068.7 71148.0 71373.0 72075.0 7439.3 8807.3 8933.2 8973.6 8980.1 48005.5 48406.5 49021.3 49813.5 50286.2 39997.8 40796.6 61612.4 65667.0 67393.3 9540.8 9584.9 9660.7 9749.6 10686.9 10812.1 11006.3 11018.0 11095.0 11300.2 11203.8 11231.8 11270.4 11498.1 11502.5 10348.7 10509.1 10611.6 11108.1 11224.8 10176.5 10306.3 10448.7 10852.1 10959.1 8317.5 8906.2 9077.4 9267.5 9632.1 7962.5 8371.7 8725.2 8918.6 9487.9 23:05:35 INFO - PROCESS | 9000 | -------- Summary: end -------- 23:05:35 INFO - PROCESS | 9000 | 23:05:36 INFO - TEST-INFO | 9000: exit 0 23:05:36 INFO - TEST-OK | dromaeo_css | took 1115640ms 23:05:36 INFO - TEST-START | kraken 23:05:36 INFO - operating with platform_type : linux_ 23:05:36 INFO - Initialising browser for kraken test... 23:05:36 INFO - TEST-INFO | started process 9355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQF215q/profile http://localhost:58408/getInfo.html) 23:05:40 INFO - PROCESS | 9355 | __metrics Screen width/height:1600/1200 23:05:40 INFO - PROCESS | 9355 | colorDepth:24 23:05:40 INFO - PROCESS | 9355 | Browser inner width/height: 1024/697 23:05:40 INFO - PROCESS | 9355 | __metrics 23:05:41 ERROR - PROCESS | 9355 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 23:05:42 INFO - TEST-INFO | 9355: exit 0 23:05:42 INFO - Browser initialized. 23:05:42 INFO - Running cycle 1/1 for kraken test... 23:05:42 INFO - TEST-INFO | started process 9478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQF215q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:05:54 INFO - PROCESS | 9478 | RSS: Main: 184643584 23:05:54 INFO - PROCESS | 9478 | 23:05:57 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58408/tests/kraken/driver.html?testName=audio-beat-detection) 23:05:58 INFO - PROCESS | 9478 | RSS: Main: 197836800 23:05:58 INFO - PROCESS | 9478 | 23:06:01 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58408/tests/kraken/driver.html?testName=audio-dft) 23:06:01 INFO - PROCESS | 9478 | RSS: Main: 195866624 23:06:01 INFO - PROCESS | 9478 | 23:06:04 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58408/tests/kraken/driver.html?testName=audio-fft) 23:06:05 INFO - PROCESS | 9478 | RSS: Main: 192233472 23:06:05 INFO - PROCESS | 9478 | 23:06:07 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58408/tests/kraken/driver.html?testName=audio-oscillator) 23:06:07 INFO - PROCESS | 9478 | RSS: Main: 192782336 23:06:07 INFO - PROCESS | 9478 | 23:06:10 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58408/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:06:10 INFO - PROCESS | 9478 | RSS: Main: 193056768 23:06:10 INFO - PROCESS | 9478 | 23:06:13 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58408/tests/kraken/driver.html?testName=imaging-darkroom) 23:06:14 INFO - PROCESS | 9478 | RSS: Main: 193298432 23:06:14 INFO - PROCESS | 9478 | 23:06:17 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58408/tests/kraken/driver.html?testName=imaging-desaturate) 23:06:18 INFO - PROCESS | 9478 | RSS: Main: 192294912 23:06:18 INFO - PROCESS | 9478 | 23:06:21 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58408/tests/kraken/driver.html?testName=json-parse-financial) 23:06:21 INFO - PROCESS | 9478 | RSS: Main: 193241088 23:06:21 INFO - PROCESS | 9478 | 23:06:23 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58408/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:06:24 INFO - PROCESS | 9478 | RSS: Main: 193716224 23:06:24 INFO - PROCESS | 9478 | 23:06:25 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:06:26 INFO - PROCESS | 9478 | RSS: Main: 193708032 23:06:26 INFO - PROCESS | 9478 | 23:06:28 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:06:29 INFO - PROCESS | 9478 | RSS: Main: 193937408 23:06:29 INFO - PROCESS | 9478 | 23:06:31 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:06:32 INFO - PROCESS | 9478 | RSS: Main: 193695744 23:06:32 INFO - PROCESS | 9478 | 23:06:35 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:06:36 INFO - PROCESS | 9478 | RSS: Main: 194318336 23:06:36 INFO - PROCESS | 9478 | 23:06:37 INFO - PROCESS | 9478 | Cycle 1(1): loaded http://localhost:58408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58408/tests/kraken/driver.html?testName=ai-astar) 23:06:38 INFO - PROCESS | 9478 | RSS: Main: 195690496 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | __start_tp_report 23:06:38 INFO - PROCESS | 9478 | _x_x_mozilla_page_load 23:06:38 INFO - PROCESS | 9478 | _x_x_mozilla_page_load_details 23:06:38 INFO - PROCESS | 9478 | |i|pagename|runs| 23:06:38 INFO - PROCESS | 9478 | |0;ai-astar;106;114;115;112;114;114;114;113;112;112 23:06:38 INFO - PROCESS | 9478 | |1;audio-beat-detection;159;127;128;169;127;126;132;127;166;134 23:06:38 INFO - PROCESS | 9478 | |2;audio-dft;163;163;165;168;164;161;163;164;163;163 23:06:38 INFO - PROCESS | 9478 | |3;audio-fft;74;75;76;113;77;78;76;78;104;76 23:06:38 INFO - PROCESS | 9478 | |4;audio-oscillator;83;82;119;83;83;82;104;82;82;125 23:06:38 INFO - PROCESS | 9478 | |5;imaging-gaussian-blur;117;117;117;118;119;119;118;118;120;118 23:06:38 INFO - PROCESS | 9478 | |6;imaging-darkroom;147;147;148;147;147;149;147;147;147;146 23:06:38 INFO - PROCESS | 9478 | |7;imaging-desaturate;85;85;85;85;86;85;85;85;86;87 23:06:38 INFO - PROCESS | 9478 | |8;json-parse-financial;53;52;57;52;55;59;53;54;54;56 23:06:38 INFO - PROCESS | 9478 | |9;json-stringify-tinderbox;61;62;60;62;63;62;62;62;62;61 23:06:38 INFO - PROCESS | 9478 | |10;stanford-crypto-aes;80;81;83;81;84;80;82;82;83;80 23:06:38 INFO - PROCESS | 9478 | |11;stanford-crypto-ccm;141;155;148;140;132;136;135;133;181;133 23:06:38 INFO - PROCESS | 9478 | |12;stanford-crypto-pbkdf2;169;170;165;169;167;172;165;174;164;170 23:06:38 INFO - PROCESS | 9478 | |13;stanford-crypto-sha256-iterative;63;65;66;64;69;69;66;64;64;63 23:06:38 INFO - PROCESS | 9478 | __end_tp_report 23:06:38 INFO - PROCESS | 9478 | __start_cc_report 23:06:38 INFO - PROCESS | 9478 | _x_x_mozilla_cycle_collect,818 23:06:38 INFO - PROCESS | 9478 | __end_cc_report 23:06:38 INFO - PROCESS | 9478 | __startTimestamp1477980398088__endTimestamp 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | ------- Summary: start ------- 23:06:38 INFO - PROCESS | 9478 | Number of tests: 14 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:2.55 (2.2%) stddev-sans-first:1.12 23:06:38 INFO - PROCESS | 9478 | Values: 106.0 114.0 115.0 112.0 114.0 114.0 114.0 113.0 112.0 112.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:133.00 stddev:17.71 (13.3%) stddev-sans-first:17.32 23:06:38 INFO - PROCESS | 9478 | Values: 159.0 127.0 128.0 169.0 127.0 126.0 132.0 127.0 166.0 134.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.83 (1.1%) stddev-sans-first:1.92 23:06:38 INFO - PROCESS | 9478 | Values: 163.0 163.0 165.0 168.0 164.0 161.0 163.0 164.0 163.0 163.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.82 (18.2%) stddev-sans-first:14.29 23:06:38 INFO - PROCESS | 9478 | Values: 74.0 75.0 76.0 113.0 77.0 78.0 76.0 78.0 104.0 76.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:82.00 stddev:17.00 (20.7%) stddev-sans-first:17.69 23:06:38 INFO - PROCESS | 9478 | Values: 83.0 82.0 119.0 83.0 83.0 82.0 104.0 82.0 82.0 125.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:0.97 23:06:38 INFO - PROCESS | 9478 | Values: 117.0 117.0 117.0 118.0 119.0 119.0 118.0 118.0 120.0 118.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 23:06:38 INFO - PROCESS | 9478 | Values: 147.0 147.0 148.0 147.0 147.0 149.0 147.0 147.0 147.0 146.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 23:06:38 INFO - PROCESS | 9478 | Values: 85.0 85.0 85.0 85.0 86.0 85.0 85.0 85.0 86.0 87.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:2.27 (4.2%) stddev-sans-first:2.35 23:06:38 INFO - PROCESS | 9478 | Values: 53.0 52.0 57.0 52.0 55.0 59.0 53.0 54.0 54.0 56.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 23:06:38 INFO - PROCESS | 9478 | Values: 61.0 62.0 60.0 62.0 63.0 62.0 62.0 62.0 62.0 61.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.43 (1.7%) stddev-sans-first:1.39 23:06:38 INFO - PROCESS | 9478 | Values: 80.0 81.0 83.0 81.0 84.0 80.0 82.0 82.0 83.0 80.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:140.50 stddev:15.12 (10.8%) stddev-sans-first:16.02 23:06:38 INFO - PROCESS | 9478 | Values: 141.0 155.0 148.0 140.0 132.0 136.0 135.0 133.0 181.0 133.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.50 stddev:3.24 (1.9%) stddev-sans-first:3.43 23:06:38 INFO - PROCESS | 9478 | Values: 169.0 170.0 165.0 169.0 167.0 172.0 165.0 174.0 164.0 170.0 23:06:38 INFO - PROCESS | 9478 | 23:06:38 INFO - PROCESS | 9478 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.21 (3.4%) stddev-sans-first:2.19 23:06:38 INFO - PROCESS | 9478 | Values: 63.0 65.0 66.0 64.0 69.0 69.0 66.0 64.0 64.0 63.0 23:06:38 INFO - PROCESS | 9478 | -------- Summary: end -------- 23:06:38 INFO - PROCESS | 9478 | 23:06:39 INFO - TEST-INFO | 9478: exit 0 23:06:39 INFO - TEST-OK | kraken | took 63012ms 23:06:39 INFO - SUITE-END | took 1178s 23:06:39 INFO - Completed test suite (00:19:39) 23:06:39 INFO - javascript benchmark 23:06:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6990.637091746905, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.2040869373955, 3061.4183305172014, 3070.3552254026654, 3099.4111118887417, 3113.20613243623, 5290.444503327153, 5363.195520671901, 5375.354957405117, 5450.836474905755, 5497.642653227537, 5382.434844341346, 5421.241026256327, 5449.3188351456065, 5475.09660905951, 5575.776968921248, 4909.9754501227535, 4945.109880221558, 4959.70241785494, 4963.503649635026, 5072.9492705073035, 4897.485763994782, 5001.799928002875, 5016.072026675059, 5027.572656324217, 5052.545270925616, 4837.782299796482, 4934.185859333205, 5014.222795466709, 5019.6486245962615, 5059.3422855028975, 4864.367632207825, 4901.215805471107, 4907.214845624719, 4922.581580565657, 5015.84952451427, 4846.369971903665, 4901.387326584177, 4902.19113846215, 4903.398266455211, 4922.975385123087, 5383.515483606455, 5389.191621256804, 5436.809711660112, 5438.184272359178, 5451.945480545183, 5650.943490565083, 5722.54219662426, 5746.42535746422, 5803.796867109673, 5822.621529600562, 5873.735681894325, 5884.146798714162, 5885.852853678693, 5896.204012458306, 5940.0, 5455.672659640434, 5464.098423760114, 5465.098258787295, 5472.315960504937, 5478.890422191534, 5769.1634712967225, 5799.33307669615, 5860.531157507389, 5891.528677705774, 5960.8807823844145, 5706.828795136153, 5727.627704199213, 5733.483986441241, 5762.164486149485, 5782.3639399666, 5738.5982981191755, 5747.913781293284, 5797.942020579824, 5801.6519008859605, 5844.503217226584, 5499.862503437366, 5580.0, 5738.110592858114, 5789.536837053026, 5811.041178205549, 5822.70886455684, 5859.267591551056, 5864.797716468114, 5880.970595146997, 5891.1457838614015, 4501.717010651949, 4506.504284528699, 4508.774561271924, 4517.774111294422, 4552.658550608718, 3889.4554762333296, 3892.2799282132896, 3915.980420097881, 3921.980285125888, 4005.459262999516, 5491.752871120809, 5531.059719847635, 5546.057170281062, 5569.554435645138, 5573.749181286852, 5790.594658373873, 5804.1293805929445, 5817.418258174149, 5825.359210486843, 5876.206712093898, 5395.622306438511, 5411.56707463402, 5459.508644222039, 5486.039943009957, 5543.61194716366, 5042.899142017139, 5071.239314102914, 5078.08594453002, 5083.212102124176, 5101.387833460009, 5942.494887934574, 6026.186464827279, 6028.879422411527, 6033.125196846433, 6105.450509453993, 5671.801486947937, 5738.885222295614, 5849.356570777126, 5877.235959325431, 5882.176495290748, 6084.907528414842, 6090.543209259235, 6101.298350689727, 6149.538784591084, 6165.784197553064, 5765.308163020464, 5814.476697097281, 5819.330776960704, 5829.067349224104, 5882.588218824641, 5606.355269143937, 5845.970770146292, 5856.824295271149, 5868.354481007001, 5882.470577648032, 5508.504234618904, 5592.804251851166, 5634.0422128239115, 5642.887142257214, 5690.544756419394, 5624.100143976944, 5645.661260324229, 5647.29408823897, 5708.257926469532, 5724.570657200643, 5462.590305727007, 5582.330120385417, 5650.491455769001, 5689.2319536862, 5690.857728556819, 5757.596968212185, 5758.1362795581, 5770.9711451444155, 5796.565257605781, 5818.912716309174, 5635.098384258499, 5643.661380317194, 5691.402402747652, 5705.4579814917515, 5709.771609135588], "value": 5364.338012956478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.92400525929, 589.3340525206517, 590.9556783241258, 594.1829983772313, 608.3247595169361, 41114.17771644565, 42558.14883702324, 42586.0, 46755.0, 46877.29684054734, 43432.56567434325, 43953.56046439543, 44062.11875762483, 44095.3385699214, 44226.55773442273, 8706.129387061306, 8891.0, 8896.911030889672, 8902.06528314524, 8921.910780892205, 8644.0, 8844.248238899701, 8845.115488451167, 8853.24747396472, 8856.690015849446, 8769.824603507926, 8843.071477494866, 8882.777930551756, 8900.332475064364, 8939.508327042011, 8746.737597872074, 8807.119288071206, 8811.118888111201, 8827.735167944971, 8848.734537963872, 8605.784855378666, 8692.13078692132, 8702.651893924236, 8704.651813927436, 8746.562671866444, 40231.39652905209, 40726.592734072576, 40742.796286018674, 40744.0, 40847.183056338705, 3529.124496070729, 3601.675849173561, 3781.2437512497336, 3946.5264168299987, 3952.5256969163597, 30517.237069073228, 30800.0, 31492.685073149205, 31738.365232695447, 31941.680583194102, 3326.284848757529, 3713.3130370881204, 3716.5168528091444, 3805.486259354979, 3819.083419979213, 322727.0, 323352.0, 324081.0, 324143.0, 326213.0, 55876.0, 55881.441185587624, 56148.0, 56391.0, 56496.0, 57699.42300576941, 58469.41530584725, 58644.0, 58711.11933321004, 58714.70642646845, 15283.847161528465, 15544.222788860512, 15556.844431555766, 15579.376824926876, 15605.219739013004, 12019.0, 12076.51693932233, 12187.634370968884, 12212.75574488523, 12227.327496987573, 15195.353115252481, 15970.121643309729, 16235.83764162367, 16245.51263462098, 16716.58208544796, 6374.649394283266, 6465.418112369909, 6520.934790652128, 6596.010598410181, 6658.866822663616, 878.4114643189079, 1001.6944831826218, 1002.9097381235724, 1015.4110615842793, 1189.6609466302061, 30242.54636180459, 30308.696913031028, 31114.53328200079, 31159.0, 31218.687813122033, 986.40815510693, 1063.7659714862718, 1066.664000839733, 1087.0868470484672, 1171.4611278811672, 15157.772633410508, 15263.313150908236, 15317.540473785804, 15320.693586128215, 15509.689806203813, 462803.0, 463885.0, 466599.0, 466655.66820645134, 468191.0, 55482.445175548535, 55705.44294557002, 55959.0, 56151.0, 56172.719136404055, 1296.5526893221822, 1347.4879545772544, 1366.2827015816777, 1369.0348304445342, 1371.7050834070524, 26701.599476007486, 29095.709042910148, 29576.0, 29762.553561697026, 30209.848950755106, 47018.52981470142, 47210.76394618005, 47358.52641473541, 47499.28751068806, 47559.76220118877, 404554.0, 406977.0, 407424.0, 408039.0, 408343.0, 33530.66469335275, 33627.66372336245, 33899.0, 33939.49090763591, 34920.0, 44760.0, 44977.77511112423, 45593.0, 46296.0, 46963.29555056609, 38522.0, 38908.221835563694, 39230.41154382744, 40272.19455610813, 40491.1901761969, 38918.6108138915, 39048.0, 39139.41290880696, 39995.800021000876, 40450.59549404468, 38514.0, 38685.226295474495, 39353.80323098366, 39625.0, 41856.58143418527, 30905.69094309118, 34999.82500087585, 35788.0, 35949.64050359463, 35988.22123677081, 26819.865900671153, 27119.322016949733, 27377.452450951267, 27608.723912760615, 29313.41373172482], "value": 19351.900300907022, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.43727253211404, 385.2122409672221, 387.66660671822234, 400.95751047277065, 406.54060911170393, 17557.47327580173, 19778.40664780055, 20484.28305009325, 20712.792872071273, 20759.792402075975, 18335.724964125548, 18385.058390657498, 18590.34933777318, 19254.229830806788, 19575.119119639614, 5382.138857782756, 5418.241446197536, 5573.637713548606, 5674.262345895048, 5677.630953987978, 5449.291592093042, 5553.611247212697, 5555.583331250152, 5556.91664625031, 5563.638363506379, 5504.4770746778995, 5509.669419834802, 5554.50009499145, 5616.663000219979, 5906.793262235801, 5948.672822994755, 6012.3085845127935, 6017.488513476338, 6018.759249630009, 6037.396260373971, 5615.438456154352, 5772.480476757112, 5824.592278540504, 5830.183774271605, 5830.533557315404, 14240.501582444565, 14721.116732996055, 14791.334389952477, 21464.892675536677, 22649.54700905989, 2293.575688497633, 2317.1310758465575, 2485.142625794116, 2780.708025657317, 2958.9704102959126, 9916.285277463783, 10383.636572719919, 10678.25252232344, 10866.293690910066, 10884.727881802939, 1928.7106933959878, 1940.7282980382759, 2002.9484520626643, 2015.7681866585383, 2048.9077991490417, 77855.0, 80206.59896700538, 80473.0, 81350.0, 82618.58690706508, 10742.624008159677, 10867.365503765832, 11117.221794474472, 11180.776384472265, 11268.830967535494, 15641.765373519407, 15653.530394088195, 15689.68620627581, 15693.921530392503, 15697.215139242991, 7518.436117291225, 7778.183290754502, 7981.2018798119725, 8009.3192078673965, 8067.636956336979, 7314.707411703473, 7317.15852676949, 7357.963210183915, 7536.0, 7545.132309784335, 4771.093492236464, 4833.709977401367, 4844.297576851337, 4871.318015477836, 4999.925001124986, 1909.7326374307609, 1963.9312624058375, 2030.6547886859269, 2039.7042428847733, 2071.54426026274, 840.7813968368268, 908.6365453818526, 940.1444685336447, 979.1970584121095, 1016.0398423489731, 17484.193809366814, 19092.0, 19153.56348273885, 19163.233470661296, 19619.705704414446, 943.217129782279, 949.3307218411004, 966.7244835221928, 1015.5937624949931, 1028.3932479836933, 9717.0, 10570.0, 10693.625723099654, 10729.83905241422, 10738.624148154777, 440424.1915161679, 442105.0, 443803.0, 443977.0, 446385.0, 50334.24498632523, 50773.49226507761, 55504.0, 59595.0, 88098.0, 983.5721461164417, 1000.8598796168542, 1003.1423133221283, 1006.4263369879098, 1006.9848952265722, 16507.58731031734, 16738.832611673726, 17278.91360543189, 17332.30670773155, 17333.826661733223, 42522.0, 42955.7852210737, 43094.35358469563, 43345.0, 43901.78049109734, 56788.0, 57045.714771425875, 57332.71333643305, 58350.7082464585, 59691.0, 7615.352695020763, 7820.882686759589, 8471.703490377808, 8479.872801908099, 8835.116488351114, 12286.569970051005, 12694.428750706056, 13182.538611148564, 13435.328233588478, 13520.12119212248, 6107.84730381744, 7144.714211431692, 11333.376664283544, 11489.885101149215, 11764.705882352804, 10536.209784266364, 10904.291221070605, 11005.284656497302, 11743.823842642538, 11992.100592455776, 11200.32798032088, 11493.0, 12027.27836329823, 12130.272183669009, 12210.206336588093, 8488.660453581788, 8522.911886587826, 8584.914150858662, 8650.178233067849, 9067.365284430027, 10257.384556926609, 11679.124065694938, 11894.583689570823, 11922.344271065174, 11956.58151964677], "value": 8954.199813011257, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.5013895275604, 1488.4195163886084, 1623.1478473801253, 1744.720844664854, 1751.3957684598809, 7187.640617969094, 7539.886901696465, 7806.570638614874, 8387.119352467987, 8400.621972011259, 7752.922470775291, 8047.637856296466, 8058.959705201481, 8241.022154682878, 8255.380846436512, 2308.6190778521523, 2342.0397636968846, 2344.2498400511845, 2347.8004369628516, 2348.4598542335275, 2307.976920230801, 2331.6152834782324, 2382.0828980842416, 2389.0, 2394.3774618599114, 2353.470469144437, 2355.811535077198, 2369.7156341239074, 2382.059086660768, 2387.510560335127, 2267.875266860322, 2283.8058765004994, 2300.700908881843, 2308.4113551044543, 2366.6213405854983, 2299.1722979727283, 2312.9421764455856, 2313.375388645073, 2320.6170981787986, 2341.8829058547176, 8123.634436450315, 8206.548639824807, 8213.79465513361, 8220.177982201792, 8254.628541715638, 4773.785179666923, 4944.678595891256, 4969.180085285923, 5027.597792176617, 5111.591072714174, 3187.9537402898836, 3247.8700851966128, 3355.1108956126645, 3369.848356823949, 3379.9155021124425, 1030.1912998296377, 1098.4288170151556, 1100.5817789240118, 1124.859392575928, 1143.0341361549476, 10966.177536684701, 11084.501197446134, 11118.888811111867, 11187.272827266203, 11209.047230985376, 4248.34150706641, 4405.207062728739, 4467.816028752383, 4492.820287188476, 4551.249043907785, 9583.233341332676, 9594.904050959542, 9596.040395960488, 9607.51962401891, 9623.56693948774, 4996.950030499721, 5007.524285192901, 5012.624053196025, 5022.6233032522705, 5075.720835354091, 4406.361077643724, 4583.991521865184, 4594.0, 4624.768761561909, 4629.6990695605355, 3813.4279858020964, 3818.6563209311294, 3897.376419772879, 3988.521377434726, 3994.141259629194, 1303.2636560343376, 1326.2175316563273, 1337.1442276942764, 1340.6246251049722, 1345.8250427444566, 929.8000929800126, 943.0, 946.4747065378643, 948.643439880963, 957.9808403831885, 5403.0, 5522.144067669517, 5612.102063669793, 5612.579056570774, 5690.516306113944, 902.6118768929292, 911.3711539038175, 934.8457504511815, 940.1303793990531, 957.4255446731905, 3747.775133491999, 3780.3006443807985, 3832.463455116286, 3851.364524853424, 3939.9803000985385, 9753.658621948198, 10002.549885255181, 10026.799464010679, 10089.192864570818, 10149.543270552844, 9944.502774861228, 10025.097741203326, 10053.849192262122, 10096.949515252376, 10098.141657959155, 7338.302861228175, 7517.812054698677, 7604.581748003913, 7661.923380766232, 7662.0, 5334.573234141337, 5408.486193811582, 5465.426130256265, 5565.16522521625, 5684.63049901755, 8959.910400895908, 8977.820443591223, 8992.550372481219, 9000.86498702533, 9114.772130696785, 9262.768430789285, 9264.351495395527, 9270.582823772811, 9337.953310233677, 9364.20404265645, 6620.602763834186, 6739.494537909774, 6851.040854280504, 6997.895031574429, 7000.61496617691, 7923.405744569296, 7983.600819959095, 7985.840283194188, 7994.5203287802915, 8004.959975200087, 6647.401733843783, 6688.598684078971, 6699.799006029827, 6772.25505194438, 6925.58446493212, 6484.157059582224, 6643.069970204078, 6768.120144381199, 6819.624920629413, 6835.58986460814, 6100.389961003864, 6106.145139680537, 6158.630482171084, 6245.219347581552, 6265.185525881606, 4770.737609431515, 4873.074115917964, 4906.55840974314, 4937.925931111108, 5042.949570504248, 4836.202026665702, 4871.366722326216, 4879.902401952012, 4949.554540091409, 4965.4041515018425], "value": 4398.356795860273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.0981916267381, 321.8246055899535, 328.7041662503747, 329.95404567520956, 342.8251591688238, 5285.550728188108, 5406.567474602032, 5433.8369848904595, 5460.645058071227, 5465.453454654533, 5247.344081989751, 5331.440198779121, 5366.772789292449, 5394.622376433651, 5409.56723462123, 4236.152769446107, 4243.408721729352, 4249.426327445786, 4254.255505286563, 4263.740217684632, 4144.48193975753, 4218.1563687262515, 4223.873283801491, 4273.166732487166, 4278.9786051069705, 4207.0, 4214.536400995888, 4217.177650358181, 4226.0, 4226.661867050629, 4157.97921010396, 4169.10364271683, 4204.915901681965, 4207.831686732527, 4228.302330115527, 3654.843642251058, 3711.5175027246555, 3731.917743854279, 3743.5507739071486, 3755.8497660093562, 5215.713135777569, 5227.03986005248, 5245.0, 5246.658967167122, 5259.15853463444, 4863.8540843774745, 4889.779959901813, 4890.144224760653, 4893.559579637849, 4915.827946021908, 5351.2240725095035, 5679.318481782171, 5684.0, 5693.971530142364, 5720.283914825577, 4003.15933653933, 4007.979960100181, 4022.5374081980654, 4027.335489644205, 4032.2741906456827, 5897.262842144732, 5899.203607512974, 5911.527077833763, 5920.881582368328, 5933.762649494059, 4022.8994275143355, 4070.6336429720873, 4080.3471444568727, 4098.241825262336, 4107.691923105779, 4131.814068366871, 4148.460700108966, 4150.115669609592, 4152.875413737593, 4163.812628431728, 4741.952580474152, 4762.690425122356, 4763.666543341933, 4765.404324459442, 4792.185328494164, 5543.392416199337, 5677.318721753333, 5688.971555142198, 5698.373178950312, 5706.71466426677, 1433.6917562724063, 1448.5659197394505, 1458.344778676189, 1459.4599998000594, 1467.8605532474398, 894.2890402130322, 918.4581097152712, 924.5654542365078, 925.8379783537854, 934.2992755433424, 4792.520747925179, 4818.831340903052, 4826.758662066883, 4840.128776820206, 4848.75756212195, 5087.31321271631, 5093.439721630618, 5124.948750512522, 5153.974230128825, 5162.74186290684, 4787.281907713871, 4846.39420072491, 4871.756412179377, 4877.561019508261, 5148.536631703089, 3055.495843185894, 3106.7999960040743, 3114.8286844223785, 3118.6725393833776, 3129.8435078246453, 6093.69531523422, 6096.969515152396, 6104.664243466563, 6119.938800612026, 6141.570090093651, 5617.915731264035, 5928.081147422156, 5940.851348785151, 5948.881022379528, 5969.537463321514, 5993.9700301498215, 6005.729742161613, 6008.279006519246, 6044.667543285162, 6054.939450605438, 5624.409437009219, 5797.594168408171, 5817.214676018683, 5837.795677151449, 5853.502452291603, 5751.0, 5789.45000224978, 5789.94210057894, 5793.652380857162, 5802.332731735735, 6095.9390406097145, 6137.815865524041, 6138.662373569497, 6139.416755408229, 6170.580766423658, 4038.818253178673, 4076.775777332275, 4104.343305071175, 4139.4204811327045, 4143.274926887722, 5892.026171232514, 5907.0, 5910.822675319747, 5915.58590898633, 5936.8812623748145, 5551.361593416647, 5743.712814359182, 5760.769569217352, 5785.797497087582, 5797.159411885337, 5611.57913156523, 5650.547956163579, 5666.526703057152, 5702.714864256854, 5720.8283751487525, 5684.0, 5692.719138194039, 5704.857378565569, 5714.485661299842, 5722.141678748221, 5439.48324909133, 5731.254936858182, 5750.539956803362, 5758.481736643722, 5761.740721667451, 5634.352049514195, 5658.632188907708, 5688.63023903445, 5697.7720891165545, 5705.885882282414], "value": 4286.9068561705935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.4988558352405, 690.4407429981713, 738.3945164964728, 748.457368407904, 779.0495595373644, 13070.738585228302, 13521.797173042387, 13568.98232632554, 13616.319184040796, 13628.114172578787, 13378.732425351487, 13587.660308492292, 13596.0, 13607.183568985867, 13613.162223099904, 660.270401206667, 678.3284548297199, 786.1156199275815, 793.1949071692237, 802.229859335039, 818.6725309876037, 818.7216346442209, 819.8975128108957, 820.2904487618197, 820.958952052398, 862.6290695001147, 862.9611667474948, 863.4905405810571, 865.3034307382554, 866.1252135343285, 850.5407080176698, 855.8673405622138, 858.1118542308743, 858.6436628799041, 858.6436628799041, 625.8685676008043, 626.3642402960999, 626.5081910700125, 626.8401557602828, 627.2253766598247, 11672.299662020221, 11771.882281177164, 11804.11469139818, 11831.645050648494, 11988.700282493008, 11942.402879855972, 12100.576479823252, 12389.380530973416, 12480.0, 13668.31658417085, 12118.333491657955, 12192.878071219264, 12322.445489952974, 12378.938105309506, 12379.75240495194, 3928.5874983126932, 3936.5472970608175, 3974.1455587048636, 4017.196560687845, 4163.625273725379, 61626.69186654038, 61719.6914015427, 62311.0, 63162.36837631657, 65350.346496534905, 10756.247062705692, 10837.0, 10882.29265097766, 10886.971820426494, 10964.725881853017, 19012.144453499626, 19155.904220479086, 19221.90389048046, 19256.133473993705, 19305.710414343797, 7793.181715919747, 7816.53100813953, 7925.167857375008, 8147.470414423044, 8195.221453961864, 3791.5829258781514, 3859.208862183246, 3863.826127824255, 3900.6489415952133, 3909.7458665186673, 3030.3787723516625, 3098.3493466372315, 3118.9064328070194, 3153.369326134782, 3276.3447310537986, 648.4909346163239, 655.5116438253436, 658.6136183334013, 662.9933700662932, 669.491186698113, 556.9275994120738, 566.4081035318103, 669.9296573859674, 688.5971706551624, 693.4279219643814, 8291.543965081857, 8339.95830020846, 8389.0, 8596.785080372916, 8626.094260102724, 557.3618207152869, 661.9871596457427, 694.9513534052568, 735.5623404074568, 737.6975440069546, 4340.60934515895, 4404.013431244562, 4617.976910115428, 4631.652626053059, 4668.976655116703, 72892.63553682198, 90031.54984225037, 90210.54894725616, 91534.0, 92959.53520232356, 79280.0, 80210.5989470049, 81216.18783812204, 82407.0, 82725.0, 43745.68762937117, 57068.714656426455, 71147.99999999897, 71373.0, 72075.0, 7439.256074392518, 8807.295416366547, 8933.19601235892, 8973.641054357753, 8980.101989800967, 48005.51994480011, 48406.5159348402, 49021.26468103052, 49813.50186498234, 50286.24570631517, 39997.80001099976, 40796.592034080466, 61612.38387616246, 65667.0, 67393.32606674067, 9540.761480963032, 9584.90415095868, 9660.661876834278, 9749.561269742737, 10686.89313106859, 10812.133316689551, 11006.284591501526, 11018.0, 11095.001449869551, 11300.152488563226, 11203.831942520706, 11231.775364492827, 11270.436478176221, 11498.137639677225, 11502.53989840397, 10348.741281467723, 10509.054185123376, 10611.628592999208, 11108.055815255793, 11224.831627525431, 10176.542055607664, 10306.278560500992, 10448.738781530523, 10852.077573406348, 10959.123270138529, 8317.500949943023, 8906.153915378029, 9077.409968352036, 9267.53662316895, 9632.084951929555, 7962.538587342919, 8371.748847534584, 8725.171108744658, 8918.643254269757, 9487.905120948702], "value": 6658.173199053444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 115.0, 112.0, 114.0, 114.0, 114.0, 113.0, 112.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 128.0, 169.0, 127.0, 126.0, 132.0, 127.0, 166.0, 134.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 168.0, 164.0, 161.0, 163.0, 164.0, 163.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 113.0, 77.0, 78.0, 76.0, 78.0, 104.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 119.0, 83.0, 83.0, 82.0, 104.0, 82.0, 82.0, 125.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 119.0, 119.0, 118.0, 118.0, 120.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 86.0, 87.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 57.0, 52.0, 55.0, 59.0, 53.0, 54.0, 54.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 83.0, 81.0, 84.0, 80.0, 82.0, 82.0, 83.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 155.0, 148.0, 140.0, 132.0, 136.0, 135.0, 133.0, 181.0, 133.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 165.0, 169.0, 167.0, 172.0, 165.0, 174.0, 164.0, 170.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 64.0, 69.0, 69.0, 66.0, 64.0, 64.0, 63.0], "value": 65.3, "unit": "score"}]}]} 23:06:39 INFO - Return code: 0 23:06:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:06:39 ERROR - # TBPL SUCCESS # 23:06:39 INFO - Running post-action listener: _resource_record_post_action 23:06:39 INFO - [mozharness: 2016-11-01 06:06:39.919562Z] Finished run-tests step (success) 23:06:39 INFO - Running post-run listener: _resource_record_post_run 23:06:39 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393015296; Read time: 8; Write time: 236636 23:06:39 INFO - TinderboxPrint: CPU usage
13.4% 23:06:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:06:39 INFO - TinderboxPrint: I/O write bytes / time
393,015,296 / 236,636 23:06:39 INFO - TinderboxPrint: CPU idle
8,256.6 (86.6%) 23:06:39 INFO - TinderboxPrint: CPU user
1,217.5 (12.8%) 23:06:39 INFO - TinderboxPrint: Swap in / out
0 / 0 23:06:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103837696; Read time: 0; Write time: 60424 23:06:40 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289177600; Read time: 0; Write time: 176212 23:06:40 INFO - Running post-run listener: _upload_blobber_files 23:06:40 INFO - Blob upload gear active. 23:06:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:06:40 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 23:06:40 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'] 23:06:40 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 23:06:40 INFO - (blobuploader) - INFO - Open directory for files ... 23:06:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:06:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:44 INFO - (blobuploader) - INFO - Done attempting. 23:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:45 INFO - (blobuploader) - INFO - Done attempting. 23:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:06:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:46 INFO - (blobuploader) - INFO - Done attempting. 23:06:46 INFO - (blobuploader) - INFO - Iteration through files over. 23:06:46 INFO - Return code: 0 23:06:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:06:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:06:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b60ed10b59439259c60d8d9abe3de50fdb915e096e3f2dd6dab5db3d376a0a4ff451e00dbde9440fb764cd4d45a86c5d805a791f6b9a1e44a9092494ad29dab8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0dae136ef8eddf51d0803e4b2a9d338b05bfa01d90c45fd19ac589c4899bffa4e16254ce7ce11af12293c5e820b2e6d7f772e881177e72a22b220d667971b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51a4c42b09699adf1b2f7f9dac98cf6fe039db98930774e8e18b8f66e80ff15b7de6cef7bf4261665ac4116d0549f2ee1d3a84176da7d4902f4ff9a2121bdb27"} 23:06:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:06:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:06:46 INFO - Contents: 23:06:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b60ed10b59439259c60d8d9abe3de50fdb915e096e3f2dd6dab5db3d376a0a4ff451e00dbde9440fb764cd4d45a86c5d805a791f6b9a1e44a9092494ad29dab8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0dae136ef8eddf51d0803e4b2a9d338b05bfa01d90c45fd19ac589c4899bffa4e16254ce7ce11af12293c5e820b2e6d7f772e881177e72a22b220d667971b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51a4c42b09699adf1b2f7f9dac98cf6fe039db98930774e8e18b8f66e80ff15b7de6cef7bf4261665ac4116d0549f2ee1d3a84176da7d4902f4ff9a2121bdb27"} 23:06:46 INFO - Running post-run listener: copy_logs_to_upload_dir 23:06:46 INFO - Copying logs to upload dir... 23:06:46 INFO - mkdir: /builds/slave/test/build/upload/logs 23:06:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.539548 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-31 23:06:45.738197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 23:06:45.741765) ========= 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=232498196343f89f466a4a9a000001c8-1477979164.280565-314372488 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/b60ed10b59439259c60d8d9abe3de50fdb915e096e3f2dd6dab5db3d376a0a4ff451e00dbde9440fb764cd4d45a86c5d805a791f6b9a1e44a9092494ad29dab8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0dae136ef8eddf51d0803e4b2a9d338b05bfa01d90c45fd19ac589c4899bffa4e16254ce7ce11af12293c5e820b2e6d7f772e881177e72a22b220d667971b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51a4c42b09699adf1b2f7f9dac98cf6fe039db98930774e8e18b8f66e80ff15b7de6cef7bf4261665ac4116d0549f2ee1d3a84176da7d4902f4ff9a2121bdb27"} build_url:https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/D7KjWrEBTeeu-VMWvGJZNQ/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/b60ed10b59439259c60d8d9abe3de50fdb915e096e3f2dd6dab5db3d376a0a4ff451e00dbde9440fb764cd4d45a86c5d805a791f6b9a1e44a9092494ad29dab8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e0dae136ef8eddf51d0803e4b2a9d338b05bfa01d90c45fd19ac589c4899bffa4e16254ce7ce11af12293c5e820b2e6d7f772e881177e72a22b220d667971b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51a4c42b09699adf1b2f7f9dac98cf6fe039db98930774e8e18b8f66e80ff15b7de6cef7bf4261665ac4116d0549f2ee1d3a84176da7d4902f4ff9a2121bdb27"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 23:06:45.767199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 23:06:45.767534) ========= 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=232498196343f89f466a4a9a000001c8-1477979164.280565-314372488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 23:06:45.851073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 23:06:45.851403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 23:06:45.851678) ========= ========= Total master_lag: 0.15 =========