builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1467811740.68 results: success (0) buildid: 20160706034022 builduid: f341f2a0f7d34fd592dfd9e2110a5ed0 revision: 6b83c0bda78d8b87c30e49e6aa81007871e8d2bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:00.684208) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:00.684658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:00.684974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:00.740809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:00.741127) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 06:29:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-07-06 06:29:01 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113894 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:00.935866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:00.936147) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018031 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:01.031286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 06:29:01.031591) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6b83c0bda78d8b87c30e49e6aa81007871e8d2bd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6b83c0bda78d8b87c30e49e6aa81007871e8d2bd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 06:29:01,248 truncating revision to first 12 chars 2016-07-06 06:29:01,248 Setting DEBUG logging. 2016-07-06 06:29:01,248 attempt 1/10 2016-07-06 06:29:01,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6b83c0bda78d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 06:29:02,039 unpacking tar archive at: mozilla-aurora-6b83c0bda78d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.136003 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 06:29:02.179255) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:02.179606) ========= script_repo_revision: 6b83c0bda78d8b87c30e49e6aa81007871e8d2bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:02.180037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:02.180364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 06:29:02.187883) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-06 06:29:02.188248) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:29:02 INFO - MultiFileLogger online at 20160706 06:29:02 in /builds/slave/test 06:29:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:29:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:29:02 INFO - {'append_to_log': False, 06:29:02 INFO - 'base_work_dir': '/builds/slave/test', 06:29:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:29:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:29:02 INFO - 'branch': 'Mozilla-Aurora', 06:29:02 INFO - 'buildbot_json_path': 'buildprops.json', 06:29:02 INFO - 'config_files': ('talos/linux_config.py',), 06:29:02 INFO - 'default_actions': ('clobber', 06:29:02 INFO - 'read-buildbot-config', 06:29:02 INFO - 'download-and-extract', 06:29:02 INFO - 'populate-webroot', 06:29:02 INFO - 'create-virtualenv', 06:29:02 INFO - 'install', 06:29:02 INFO - 'run-tests'), 06:29:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:29:02 INFO - 'download_minidump_stackwalk': True, 06:29:02 INFO - 'download_symbols': 'ondemand', 06:29:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:29:02 INFO - 'tooltool.py': '/tools/tooltool.py', 06:29:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:29:02 INFO - '/tools/misc-python/virtualenv.py')}, 06:29:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:29:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:29:02 INFO - 'installer_path': 'installer.exe', 06:29:02 INFO - 'log_level': 'info', 06:29:02 INFO - 'log_name': 'talos', 06:29:02 INFO - 'log_to_console': True, 06:29:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:29:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:29:02 INFO - 'opt_config_files': (), 06:29:02 INFO - 'pip_index': False, 06:29:02 INFO - 'sps_profile': False, 06:29:02 INFO - 'sps_profile_interval': 0, 06:29:02 INFO - 'suite': 'dromaeojs', 06:29:02 INFO - 'system_bits': '32', 06:29:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:29:02 INFO - 'title': 'talos-linux64-ix-047', 06:29:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:29:02 INFO - 'use_talos_json': True, 06:29:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:29:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:29:02 INFO - 'work_dir': 'build'} 06:29:02 INFO - ##### 06:29:02 INFO - ##### Running clobber step. 06:29:02 INFO - ##### 06:29:02 INFO - Running pre-action listener: _resource_record_pre_action 06:29:02 INFO - Running main action method: clobber 06:29:02 INFO - rmtree: /builds/slave/test/build 06:29:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:29:02 INFO - Running post-action listener: _resource_record_post_action 06:29:02 INFO - ##### 06:29:02 INFO - ##### Finished clobber step (success) 06:29:02 INFO - ##### 06:29:02 INFO - ##### 06:29:02 INFO - ##### Running read-buildbot-config step. 06:29:02 INFO - ##### 06:29:02 INFO - Running pre-action listener: _resource_record_pre_action 06:29:02 INFO - Running main action method: read_buildbot_config 06:29:02 INFO - Using buildbot properties: 06:29:02 INFO - { 06:29:02 INFO - "project": "", 06:29:02 INFO - "product": "firefox", 06:29:02 INFO - "script_repo_revision": "production", 06:29:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:29:02 INFO - "repository": "", 06:29:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:29:02 INFO - "buildid": "20160706034022", 06:29:02 INFO - "pgo_build": "True", 06:29:02 INFO - "basedir": "/builds/slave/test", 06:29:02 INFO - "buildnumber": 350, 06:29:02 INFO - "slavename": "talos-linux64-ix-047", 06:29:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:29:02 INFO - "platform": "ubuntu64_hw", 06:29:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:29:02 INFO - "branch": "mozilla-aurora", 06:29:02 INFO - "repo_path": "releases/mozilla-aurora", 06:29:02 INFO - "revision": "6b83c0bda78d8b87c30e49e6aa81007871e8d2bd", 06:29:02 INFO - "stage_platform": "linux64-pgo", 06:29:02 INFO - "builduid": "f341f2a0f7d34fd592dfd9e2110a5ed0", 06:29:02 INFO - "slavebuilddir": "test" 06:29:02 INFO - } 06:29:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:29:02 INFO - Running post-action listener: _resource_record_post_action 06:29:02 INFO - ##### 06:29:02 INFO - ##### Finished read-buildbot-config step (success) 06:29:02 INFO - ##### 06:29:02 INFO - ##### 06:29:02 INFO - ##### Running download-and-extract step. 06:29:02 INFO - ##### 06:29:02 INFO - Running pre-action listener: _resource_record_pre_action 06:29:02 INFO - Running main action method: download_and_extract 06:29:02 INFO - mkdir: /builds/slave/test/build/tests 06:29:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:02 INFO - https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:29:04 INFO - Downloaded 1361 bytes. 06:29:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:29:04 INFO - Using the following test package requirements: 06:29:04 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:29:04 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:29:04 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:29:04 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'jsshell-linux-x86_64.zip'], 06:29:04 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:29:04 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:29:04 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:29:04 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:29:04 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:29:04 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:29:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:29:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:04 INFO - https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:29:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:29:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:29:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:29:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:29:07 INFO - Downloaded 24526733 bytes. 06:29:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:29:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:29:08 INFO - Return code: 0 06:29:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:29:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:08 INFO - https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:29:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:29:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:29:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:29:11 INFO - Downloaded 24526733 bytes. 06:29:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:29:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:29:12 INFO - Return code: 0 06:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:12 INFO - https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:29:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:29:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:29:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:29:14 INFO - Downloaded 10833369 bytes. 06:29:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:29:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:29:14 INFO - Return code: 0 06:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:14 INFO - https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:29:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:29:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:29:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:29:16 INFO - Downloaded 63606812 bytes. 06:29:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:29:16 INFO - mkdir: /builds/slave/test/properties 06:29:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:29:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:29:16 INFO - Contents: 06:29:16 INFO - build_url:https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:29:17 INFO - Running post-action listener: _resource_record_post_action 06:29:17 INFO - Running post-action listener: set_extra_try_arguments 06:29:17 INFO - ##### 06:29:17 INFO - ##### Finished download-and-extract step (success) 06:29:17 INFO - ##### 06:29:17 INFO - ##### 06:29:17 INFO - ##### Running populate-webroot step. 06:29:17 INFO - ##### 06:29:17 INFO - Running pre-action listener: _resource_record_pre_action 06:29:17 INFO - Running main action method: populate_webroot 06:29:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:29:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:29:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:29:17 INFO - '--tppagecycles', 06:29:17 INFO - '7'], 06:29:17 INFO - 'tests': ['tsvgm']}}, 06:29:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:29:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:29:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:29:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:29:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['damp', 'tps']}, 06:29:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'tests': ['damp', 'tps']}, 06:29:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['dromaeo_dom']}, 06:29:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:29:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['a11yr', 06:29:17 INFO - 'ts_paint', 06:29:17 INFO - 'tpaint', 06:29:17 INFO - 'sessionrestore', 06:29:17 INFO - 'sessionrestore_no_auto_restore', 06:29:17 INFO - 'tabpaint']}, 06:29:17 INFO - 'other-e10s': {'tests': ['a11yr', 06:29:17 INFO - 'ts_paint', 06:29:17 INFO - 'tpaint', 06:29:17 INFO - 'sessionrestore', 06:29:17 INFO - 'sessionrestore_no_auto_restore', 06:29:17 INFO - 'tabpaint']}, 06:29:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:29:17 INFO - 'ts_paint', 06:29:17 INFO - 'tpaint', 06:29:17 INFO - 'sessionrestore', 06:29:17 INFO - 'sessionrestore_no_auto_restore', 06:29:17 INFO - 'tabpaint']}, 06:29:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:29:17 INFO - 'ts_paint', 06:29:17 INFO - 'tpaint', 06:29:17 INFO - 'sessionrestore', 06:29:17 INFO - 'sessionrestore_no_auto_restore', 06:29:17 INFO - 'tabpaint']}, 06:29:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['a11yr', 06:29:17 INFO - 'ts_paint', 06:29:17 INFO - 'tpaint', 06:29:17 INFO - 'sessionrestore', 06:29:17 INFO - 'sessionrestore_no_auto_restore', 06:29:17 INFO - 'tabpaint']}, 06:29:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['a11yr', 06:29:17 INFO - 'ts_paint', 06:29:17 INFO - 'tpaint', 06:29:17 INFO - 'sessionrestore', 06:29:17 INFO - 'sessionrestore_no_auto_restore', 06:29:17 INFO - 'tabpaint']}, 06:29:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['tsvgx', 06:29:17 INFO - 'tsvgr_opacity', 06:29:17 INFO - 'tart', 06:29:17 INFO - 'tscrollx', 06:29:17 INFO - 'cart']}, 06:29:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:29:17 INFO - 'tsvgr_opacity', 06:29:17 INFO - 'tart', 06:29:17 INFO - 'tscrollx', 06:29:17 INFO - 'cart']}, 06:29:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'talos_options': ['--disable-e10s'], 06:29:17 INFO - 'tests': ['tp5o']}, 06:29:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'tests': ['tp5o']}, 06:29:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'talos_options': ['--disable-e10s', 06:29:17 INFO - '--xperf_path', 06:29:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:17 INFO - 'tests': ['tp5n']}, 06:29:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:17 INFO - 'talos_options': ['--xperf_path', 06:29:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:17 INFO - 'tests': ['tp5n']}}, 06:29:17 INFO - 'talos.zip': {'path': '', 06:29:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:29:17 INFO - Running post-action listener: _resource_record_post_action 06:29:17 INFO - ##### 06:29:17 INFO - ##### Finished populate-webroot step (success) 06:29:17 INFO - ##### 06:29:17 INFO - ##### 06:29:17 INFO - ##### Running create-virtualenv step. 06:29:17 INFO - ##### 06:29:17 INFO - Running pre-action listener: _resource_record_pre_action 06:29:17 INFO - Running main action method: create_virtualenv 06:29:17 INFO - Creating virtualenv /builds/slave/test/build/venv 06:29:17 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 06:29:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:29:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:29:17 INFO - Using real prefix '/usr' 06:29:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:29:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:29:19 INFO - Installing pip.................done. 06:29:19 INFO - Return code: 0 06:29:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:29:19 INFO - Using env: {'DISPLAY': ':0', 06:29:19 INFO - 'HOME': '/home/cltbld', 06:29:19 INFO - 'LANG': 'en_US.UTF-8', 06:29:19 INFO - 'LANGUAGE': 'en_US:en', 06:29:19 INFO - 'LOGNAME': 'cltbld', 06:29:19 INFO - 'MAIL': '/var/mail/cltbld', 06:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:19 INFO - 'MOZ_NO_REMOTE': '1', 06:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:19 INFO - 'NO_EM_RESTART': '1', 06:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:19 INFO - 'PWD': '/builds/slave/test', 06:29:19 INFO - 'SHELL': '/bin/bash', 06:29:19 INFO - 'SHLVL': '1', 06:29:19 INFO - 'TERM': 'linux', 06:29:19 INFO - 'TMOUT': '86400', 06:29:19 INFO - 'USER': 'cltbld', 06:29:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:19 INFO - '_': '/tools/buildbot/bin/python'} 06:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:20 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 06:29:20 INFO - Cleaning up... 06:29:20 INFO - Return code: 0 06:29:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:29:20 INFO - Using env: {'DISPLAY': ':0', 06:29:20 INFO - 'HOME': '/home/cltbld', 06:29:20 INFO - 'LANG': 'en_US.UTF-8', 06:29:20 INFO - 'LANGUAGE': 'en_US:en', 06:29:20 INFO - 'LOGNAME': 'cltbld', 06:29:20 INFO - 'MAIL': '/var/mail/cltbld', 06:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:20 INFO - 'MOZ_NO_REMOTE': '1', 06:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:20 INFO - 'NO_EM_RESTART': '1', 06:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:20 INFO - 'PWD': '/builds/slave/test', 06:29:20 INFO - 'SHELL': '/bin/bash', 06:29:20 INFO - 'SHLVL': '1', 06:29:20 INFO - 'TERM': 'linux', 06:29:20 INFO - 'TMOUT': '86400', 06:29:20 INFO - 'USER': 'cltbld', 06:29:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:20 INFO - '_': '/tools/buildbot/bin/python'} 06:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:20 INFO - Downloading/unpacking psutil>=3.1.1 06:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:29:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:22 INFO - Installing collected packages: psutil 06:29:22 INFO - Running setup.py install for psutil 06:29:22 INFO - building 'psutil._psutil_linux' extension 06:29:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:29:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:29:22 INFO - building 'psutil._psutil_posix' extension 06:29:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:29:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:29:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:22 INFO - Successfully installed psutil 06:29:22 INFO - Cleaning up... 06:29:22 INFO - Return code: 0 06:29:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:29:22 INFO - Using env: {'DISPLAY': ':0', 06:29:22 INFO - 'HOME': '/home/cltbld', 06:29:22 INFO - 'LANG': 'en_US.UTF-8', 06:29:22 INFO - 'LANGUAGE': 'en_US:en', 06:29:22 INFO - 'LOGNAME': 'cltbld', 06:29:22 INFO - 'MAIL': '/var/mail/cltbld', 06:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:22 INFO - 'MOZ_NO_REMOTE': '1', 06:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:22 INFO - 'NO_EM_RESTART': '1', 06:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:22 INFO - 'PWD': '/builds/slave/test', 06:29:22 INFO - 'SHELL': '/bin/bash', 06:29:22 INFO - 'SHLVL': '1', 06:29:22 INFO - 'TERM': 'linux', 06:29:22 INFO - 'TMOUT': '86400', 06:29:22 INFO - 'USER': 'cltbld', 06:29:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:22 INFO - '_': '/tools/buildbot/bin/python'} 06:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:29:23 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 06:29:23 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 06:29:23 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 06:29:23 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 06:29:23 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 06:29:23 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 06:29:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:29:25 INFO - Installing collected packages: mozsystemmonitor 06:29:25 INFO - Running setup.py install for mozsystemmonitor 06:29:25 INFO - Successfully installed mozsystemmonitor 06:29:25 INFO - Cleaning up... 06:29:25 INFO - Return code: 0 06:29:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:29:25 INFO - Using env: {'DISPLAY': ':0', 06:29:25 INFO - 'HOME': '/home/cltbld', 06:29:25 INFO - 'LANG': 'en_US.UTF-8', 06:29:25 INFO - 'LANGUAGE': 'en_US:en', 06:29:25 INFO - 'LOGNAME': 'cltbld', 06:29:25 INFO - 'MAIL': '/var/mail/cltbld', 06:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:25 INFO - 'MOZ_NO_REMOTE': '1', 06:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:25 INFO - 'NO_EM_RESTART': '1', 06:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:25 INFO - 'PWD': '/builds/slave/test', 06:29:25 INFO - 'SHELL': '/bin/bash', 06:29:25 INFO - 'SHLVL': '1', 06:29:25 INFO - 'TERM': 'linux', 06:29:25 INFO - 'TMOUT': '86400', 06:29:25 INFO - 'USER': 'cltbld', 06:29:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:25 INFO - '_': '/tools/buildbot/bin/python'} 06:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:25 INFO - Downloading/unpacking jsonschema==2.5.1 06:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:29:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:27 INFO - Downloading functools32-3.2.3-2.tar.gz 06:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:29:27 INFO - warning: no files found matching '*.txt' 06:29:27 INFO - no previously-included directories found matching 'build' 06:29:27 INFO - no previously-included directories found matching 'dist' 06:29:27 INFO - no previously-included directories found matching '.git*' 06:29:27 INFO - Installing collected packages: jsonschema, functools32 06:29:27 INFO - Running setup.py install for functools32 06:29:27 INFO - warning: no files found matching '*.txt' 06:29:27 INFO - no previously-included directories found matching 'build' 06:29:27 INFO - no previously-included directories found matching 'dist' 06:29:27 INFO - no previously-included directories found matching '.git*' 06:29:27 INFO - Successfully installed jsonschema functools32 06:29:27 INFO - Cleaning up... 06:29:27 INFO - Return code: 0 06:29:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:29:27 INFO - Using env: {'DISPLAY': ':0', 06:29:27 INFO - 'HOME': '/home/cltbld', 06:29:27 INFO - 'LANG': 'en_US.UTF-8', 06:29:27 INFO - 'LANGUAGE': 'en_US:en', 06:29:27 INFO - 'LOGNAME': 'cltbld', 06:29:27 INFO - 'MAIL': '/var/mail/cltbld', 06:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:27 INFO - 'MOZ_NO_REMOTE': '1', 06:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:27 INFO - 'NO_EM_RESTART': '1', 06:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:27 INFO - 'PWD': '/builds/slave/test', 06:29:27 INFO - 'SHELL': '/bin/bash', 06:29:27 INFO - 'SHLVL': '1', 06:29:27 INFO - 'TERM': 'linux', 06:29:27 INFO - 'TMOUT': '86400', 06:29:27 INFO - 'USER': 'cltbld', 06:29:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:27 INFO - '_': '/tools/buildbot/bin/python'} 06:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:28 INFO - Downloading/unpacking blobuploader==1.2.4 06:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:29:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:29:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:30 INFO - Downloading docopt-0.6.1.tar.gz 06:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:29:30 INFO - Installing collected packages: blobuploader, requests, docopt 06:29:30 INFO - Running setup.py install for blobuploader 06:29:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:29:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:29:30 INFO - Running setup.py install for requests 06:29:31 INFO - Running setup.py install for docopt 06:29:31 INFO - Successfully installed blobuploader requests docopt 06:29:31 INFO - Cleaning up... 06:29:31 INFO - Return code: 0 06:29:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:29:31 INFO - Using env: {'DISPLAY': ':0', 06:29:31 INFO - 'HOME': '/home/cltbld', 06:29:31 INFO - 'LANG': 'en_US.UTF-8', 06:29:31 INFO - 'LANGUAGE': 'en_US:en', 06:29:31 INFO - 'LOGNAME': 'cltbld', 06:29:31 INFO - 'MAIL': '/var/mail/cltbld', 06:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:31 INFO - 'MOZ_NO_REMOTE': '1', 06:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:31 INFO - 'NO_EM_RESTART': '1', 06:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:31 INFO - 'PWD': '/builds/slave/test', 06:29:31 INFO - 'SHELL': '/bin/bash', 06:29:31 INFO - 'SHLVL': '1', 06:29:31 INFO - 'TERM': 'linux', 06:29:31 INFO - 'TMOUT': '86400', 06:29:31 INFO - 'USER': 'cltbld', 06:29:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:31 INFO - '_': '/tools/buildbot/bin/python'} 06:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:31 INFO - Running setup.py (path:/tmp/pip-Qaw_pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:31 INFO - Running setup.py (path:/tmp/pip-mhWMPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:31 INFO - Running setup.py (path:/tmp/pip-53Gidf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:31 INFO - Running setup.py (path:/tmp/pip-k1NNXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:31 INFO - Running setup.py (path:/tmp/pip-H0wH4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:31 INFO - Running setup.py (path:/tmp/pip-x6uDVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:32 INFO - Running setup.py (path:/tmp/pip-ykQPjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:32 INFO - Running setup.py (path:/tmp/pip-QXakew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:32 INFO - Running setup.py (path:/tmp/pip-yTCYZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:32 INFO - Running setup.py (path:/tmp/pip-VuhdFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:32 INFO - Running setup.py (path:/tmp/pip-ea3jRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:32 INFO - Running setup.py (path:/tmp/pip-vZbC2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:32 INFO - Running setup.py (path:/tmp/pip-yqh4LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:32 INFO - Running setup.py (path:/tmp/pip-siPcki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:32 INFO - Running setup.py (path:/tmp/pip-QKH63M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:32 INFO - Running setup.py (path:/tmp/pip-5JdcPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:32 INFO - Running setup.py (path:/tmp/pip-C_lpHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:29:32 INFO - Running setup.py install for manifestparser 06:29:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:29:32 INFO - Running setup.py install for mozcrash 06:29:32 INFO - Running setup.py install for mozdebug 06:29:33 INFO - Running setup.py install for mozdevice 06:29:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Running setup.py install for mozfile 06:29:33 INFO - Running setup.py install for mozhttpd 06:29:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Running setup.py install for mozinfo 06:29:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Running setup.py install for mozInstall 06:29:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Running setup.py install for mozleak 06:29:33 INFO - Running setup.py install for mozlog 06:29:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Running setup.py install for moznetwork 06:29:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:29:33 INFO - Running setup.py install for mozprocess 06:29:34 INFO - Running setup.py install for mozprofile 06:29:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:29:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:29:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:29:34 INFO - Running setup.py install for mozrunner 06:29:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:29:34 INFO - Running setup.py install for mozscreenshot 06:29:34 INFO - Running setup.py install for moztest 06:29:34 INFO - Running setup.py install for mozversion 06:29:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:29:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:29:34 INFO - Cleaning up... 06:29:34 INFO - Return code: 0 06:29:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:29:34 INFO - Using env: {'DISPLAY': ':0', 06:29:34 INFO - 'HOME': '/home/cltbld', 06:29:34 INFO - 'LANG': 'en_US.UTF-8', 06:29:34 INFO - 'LANGUAGE': 'en_US:en', 06:29:34 INFO - 'LOGNAME': 'cltbld', 06:29:34 INFO - 'MAIL': '/var/mail/cltbld', 06:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:34 INFO - 'MOZ_NO_REMOTE': '1', 06:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:34 INFO - 'NO_EM_RESTART': '1', 06:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:34 INFO - 'PWD': '/builds/slave/test', 06:29:34 INFO - 'SHELL': '/bin/bash', 06:29:34 INFO - 'SHLVL': '1', 06:29:34 INFO - 'TERM': 'linux', 06:29:34 INFO - 'TMOUT': '86400', 06:29:34 INFO - 'USER': 'cltbld', 06:29:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:34 INFO - '_': '/tools/buildbot/bin/python'} 06:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:34 INFO - Running setup.py (path:/tmp/pip-lJDQfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:34 INFO - Running setup.py (path:/tmp/pip-2h1y5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:34 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)) 06:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:34 INFO - Running setup.py (path:/tmp/pip-zbz_LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:35 INFO - Running setup.py (path:/tmp/pip-kPH7P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:35 INFO - Running setup.py (path:/tmp/pip-UcjZRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:35 INFO - Running setup.py (path:/tmp/pip-iDXG__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:35 INFO - Running setup.py (path:/tmp/pip-QwgHC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:35 INFO - Running setup.py (path:/tmp/pip-FtsxcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:35 INFO - Running setup.py (path:/tmp/pip-LnWaH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:35 INFO - Running setup.py (path:/tmp/pip-aacHs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:35 INFO - Running setup.py (path:/tmp/pip-bnuNML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:35 INFO - Running setup.py (path:/tmp/pip-Uw0P_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:35 INFO - Running setup.py (path:/tmp/pip-wwXQtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:35 INFO - Running setup.py (path:/tmp/pip-FOiSrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:35 INFO - Running setup.py (path:/tmp/pip-uX1twY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:35 INFO - Running setup.py (path:/tmp/pip-PS5y4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:35 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)) 06:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:35 INFO - Running setup.py (path:/tmp/pip-pZBkuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:37 INFO - Downloading blessings-1.6.tar.gz 06:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:29:38 INFO - Installing collected packages: blessings 06:29:38 INFO - Running setup.py install for blessings 06:29:38 INFO - Successfully installed blessings 06:29:38 INFO - Cleaning up... 06:29:38 INFO - Return code: 0 06:29:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:29:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:38 INFO - Reading from file tmpfile_stdout 06:29:38 INFO - Current package versions: 06:29:38 INFO - argparse == 1.2.1 06:29:38 INFO - blessings == 1.6 06:29:38 INFO - blobuploader == 1.2.4 06:29:38 INFO - docopt == 0.6.1 06:29:38 INFO - functools32 == 3.2.3-2 06:29:38 INFO - jsonschema == 2.5.1 06:29:38 INFO - manifestparser == 1.1 06:29:38 INFO - mozInstall == 1.12 06:29:38 INFO - mozcrash == 0.17 06:29:38 INFO - mozdebug == 0.1 06:29:38 INFO - mozdevice == 0.48 06:29:38 INFO - mozfile == 1.2 06:29:38 INFO - mozhttpd == 0.7 06:29:38 INFO - mozinfo == 0.9 06:29:38 INFO - mozleak == 0.1 06:29:38 INFO - mozlog == 3.2 06:29:38 INFO - moznetwork == 0.27 06:29:38 INFO - mozprocess == 0.22 06:29:38 INFO - mozprofile == 0.28 06:29:38 INFO - mozrunner == 6.11 06:29:38 INFO - mozscreenshot == 0.1 06:29:38 INFO - mozsystemmonitor == 0.3 06:29:38 INFO - moztest == 0.7 06:29:38 INFO - mozversion == 1.4 06:29:38 INFO - psutil == 3.1.1 06:29:38 INFO - requests == 1.2.3 06:29:38 INFO - wsgiref == 0.1.2 06:29:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:29:38 INFO - Using env: {'DISPLAY': ':0', 06:29:38 INFO - 'HOME': '/home/cltbld', 06:29:38 INFO - 'LANG': 'en_US.UTF-8', 06:29:38 INFO - 'LANGUAGE': 'en_US:en', 06:29:38 INFO - 'LOGNAME': 'cltbld', 06:29:38 INFO - 'MAIL': '/var/mail/cltbld', 06:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:38 INFO - 'MOZ_NO_REMOTE': '1', 06:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:38 INFO - 'NO_EM_RESTART': '1', 06:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:38 INFO - 'PWD': '/builds/slave/test', 06:29:38 INFO - 'SHELL': '/bin/bash', 06:29:38 INFO - 'SHLVL': '1', 06:29:38 INFO - 'TERM': 'linux', 06:29:38 INFO - 'TMOUT': '86400', 06:29:38 INFO - 'USER': 'cltbld', 06:29:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:38 INFO - '_': '/tools/buildbot/bin/python'} 06:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:29:38 INFO - Cleaning up... 06:29:38 INFO - Return code: 0 06:29:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:29:38 INFO - Using env: {'DISPLAY': ':0', 06:29:38 INFO - 'HOME': '/home/cltbld', 06:29:38 INFO - 'LANG': 'en_US.UTF-8', 06:29:38 INFO - 'LANGUAGE': 'en_US:en', 06:29:38 INFO - 'LOGNAME': 'cltbld', 06:29:38 INFO - 'MAIL': '/var/mail/cltbld', 06:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:38 INFO - 'MOZ_NO_REMOTE': '1', 06:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:38 INFO - 'NO_EM_RESTART': '1', 06:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:38 INFO - 'PWD': '/builds/slave/test', 06:29:38 INFO - 'SHELL': '/bin/bash', 06:29:38 INFO - 'SHLVL': '1', 06:29:38 INFO - 'TERM': 'linux', 06:29:38 INFO - 'TMOUT': '86400', 06:29:38 INFO - 'USER': 'cltbld', 06:29:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:38 INFO - '_': '/tools/buildbot/bin/python'} 06:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:29:38 INFO - Cleaning up... 06:29:38 INFO - Return code: 0 06:29:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1acfa0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', '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 06:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:29:38 INFO - Using env: {'DISPLAY': ':0', 06:29:38 INFO - 'HOME': '/home/cltbld', 06:29:38 INFO - 'LANG': 'en_US.UTF-8', 06:29:38 INFO - 'LANGUAGE': 'en_US:en', 06:29:38 INFO - 'LOGNAME': 'cltbld', 06:29:38 INFO - 'MAIL': '/var/mail/cltbld', 06:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:38 INFO - 'MOZ_NO_REMOTE': '1', 06:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:38 INFO - 'NO_EM_RESTART': '1', 06:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:38 INFO - 'PWD': '/builds/slave/test', 06:29:38 INFO - 'SHELL': '/bin/bash', 06:29:38 INFO - 'SHLVL': '1', 06:29:38 INFO - 'TERM': 'linux', 06:29:38 INFO - 'TMOUT': '86400', 06:29:38 INFO - 'USER': 'cltbld', 06:29:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:38 INFO - '_': '/tools/buildbot/bin/python'} 06:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:39 INFO - Downloading/unpacking flake8 06:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:29:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:29:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 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 06:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:29:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:29:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:29:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:29:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:29:41 INFO - no previously-included directories found matching 'docs/_build' 06:29:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:29:41 INFO - Running setup.py install for pep8 06:29:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:29:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:29:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:29:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:29:41 INFO - no previously-included directories found matching 'docs/_build' 06:29:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:29:41 INFO - Cleaning up... 06:29:41 INFO - Return code: 0 06:29:41 INFO - Running post-action listener: _resource_record_post_action 06:29:41 INFO - Running post-action listener: _start_resource_monitoring 06:29:41 INFO - Starting resource monitoring. 06:29:41 INFO - ##### 06:29:41 INFO - ##### Finished create-virtualenv step (success) 06:29:41 INFO - ##### 06:29:41 INFO - ##### 06:29:41 INFO - ##### Running install step. 06:29:41 INFO - ##### 06:29:41 INFO - Running pre-action listener: _resource_record_pre_action 06:29:41 INFO - Running main action method: install 06:29:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:42 INFO - Reading from file tmpfile_stdout 06:29:42 INFO - Detecting whether we're running mozinstall >=1.0... 06:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:29:42 INFO - Reading from file tmpfile_stdout 06:29:42 INFO - Output received: 06:29:42 INFO - Usage: mozinstall [options] installer 06:29:42 INFO - Options: 06:29:42 INFO - -h, --help show this help message and exit 06:29:42 INFO - -d DEST, --destination=DEST 06:29:42 INFO - Directory to install application into. [default: 06:29:42 INFO - "/builds/slave/test"] 06:29:42 INFO - --app=APP Application being installed. [default: firefox] 06:29:42 INFO - mkdir: /builds/slave/test/build/application 06:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:29:58 INFO - Reading from file tmpfile_stdout 06:29:58 INFO - Output received: 06:29:58 INFO - /builds/slave/test/build/application/firefox/firefox 06:29:58 INFO - Running post-action listener: _resource_record_post_action 06:29:58 INFO - ##### 06:29:58 INFO - ##### Finished install step (success) 06:29:58 INFO - ##### 06:29:58 INFO - ##### 06:29:58 INFO - ##### Running run-tests step. 06:29:58 INFO - ##### 06:29:58 INFO - Running pre-action listener: _resource_record_pre_action 06:29:58 INFO - Running main action method: run_tests 06:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:29:58 INFO - Python 2.7.3 06:29:58 INFO - Return code: 0 06:29:58 INFO - grabbing minidump binary from tooltool 06:29:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:58 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 0x14851c0>, '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 0x14860c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:29:58 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 06:29:58 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 06:29:58 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 06:29:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:29:58 INFO - Return code: 0 06:29:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:29:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:29:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:29:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:29:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:29:59 INFO - Return code: 0 06:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:29:59 INFO - Using env: {'DISPLAY': ':0', 06:29:59 INFO - 'HOME': '/home/cltbld', 06:29:59 INFO - 'LANG': 'en_US.UTF-8', 06:29:59 INFO - 'LANGUAGE': 'en_US:en', 06:29:59 INFO - 'LOGNAME': 'cltbld', 06:29:59 INFO - 'MAIL': '/var/mail/cltbld', 06:29:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:29:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:59 INFO - 'MOZ_NO_REMOTE': '1', 06:29:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:59 INFO - 'NO_EM_RESTART': '1', 06:29:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:59 INFO - 'PWD': '/builds/slave/test', 06:29:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:29:59 INFO - 'SHELL': '/bin/bash', 06:29:59 INFO - 'SHLVL': '1', 06:29:59 INFO - 'TERM': 'linux', 06:29:59 INFO - 'TMOUT': '86400', 06:29:59 INFO - 'USER': 'cltbld', 06:29:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141', 06:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:59 INFO - '_': '/tools/buildbot/bin/python'} 06:29:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:29:59 INFO - mozversion application_buildid: 20160706034022 06:29:59 INFO - mozversion application_changeset: 6b83c0bda78d8b87c30e49e6aa81007871e8d2bd 06:29:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:29:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:29:59 INFO - mozversion application_name: Firefox 06:29:59 INFO - mozversion application_remotingname: firefox-dev 06:29:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:29:59 INFO - mozversion application_vendor: Mozilla 06:29:59 INFO - mozversion application_version: 49.0a2 06:29:59 INFO - mozversion platform_buildid: 20160706034022 06:29:59 INFO - mozversion platform_changeset: 6b83c0bda78d8b87c30e49e6aa81007871e8d2bd 06:29:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:29:59 INFO - mozversion platform_version: 49.0a2 06:29:59 INFO - using testdate: 1467811799 06:29:59 INFO - actual date: 1467811799 06:29:59 INFO - starting webserver on 'localhost:33646' 06:29:59 INFO - SUITE-START | Running 2 tests 06:29:59 INFO - TEST-START | dromaeo_css 06:29:59 INFO - operating with platform_type : linux_ 06:29:59 INFO - Initialising browser for dromaeo_css test... 06:29:59 INFO - TEST-INFO | started process 18906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUiwFl/profile http://localhost:33646/getInfo.html) 06:30:03 INFO - PROCESS | 18906 | __metrics Screen width/height:1600/1200 06:30:03 INFO - PROCESS | 18906 | colorDepth:24 06:30:03 INFO - PROCESS | 18906 | Browser inner width/height: 1024/697 06:30:03 INFO - PROCESS | 18906 | __metrics 06:30:04 ERROR - PROCESS | 18906 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:30:05 INFO - TEST-INFO | 18906: exit 0 06:30:05 INFO - Browser initialized. 06:30:05 INFO - Running cycle 1/1 for dromaeo_css test... 06:30:05 INFO - TEST-INFO | started process 18998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUiwFl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:16 INFO - PROCESS | 18998 | RSS: Main: 145760256 06:30:16 INFO - PROCESS | 18998 | 06:31:08 INFO - PROCESS | 18998 | 1467811868334 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:33:15 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:33646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33646/tests/dromaeo/cssquery-ext.html) 06:33:16 INFO - PROCESS | 18998 | RSS: Main: 254160896 06:33:16 INFO - PROCESS | 18998 | 06:36:18 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:33646/tests/dromaeo/cssquery-ext.html (next: http://localhost:33646/tests/dromaeo/cssquery-jquery.html) 06:36:19 INFO - PROCESS | 18998 | RSS: Main: 229052416 06:36:19 INFO - PROCESS | 18998 | 06:39:21 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:33646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33646/tests/dromaeo/cssquery-mootools.html) 06:39:22 INFO - PROCESS | 18998 | RSS: Main: 225107968 06:39:22 INFO - PROCESS | 18998 | 06:42:24 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:33646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33646/tests/dromaeo/cssquery-prototype.html) 06:42:24 INFO - PROCESS | 18998 | RSS: Main: 223068160 06:42:24 INFO - PROCESS | 18998 | 06:45:27 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:33646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33646/tests/dromaeo/cssquery-yui.html) 06:45:27 INFO - PROCESS | 18998 | RSS: Main: 216190976 06:45:27 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:33646/tests/dromaeo/cssquery-yui.html (next: http://localhost:33646/tests/dromaeo/cssquery-dojo.html) 06:48:30 INFO - PROCESS | 18998 | RSS: Main: 261677056 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | __start_tp_report 06:48:30 INFO - PROCESS | 18998 | _x_x_mozilla_page_load 06:48:30 INFO - PROCESS | 18998 | _x_x_mozilla_page_load_details 06:48:30 INFO - PROCESS | 18998 | |i|pagename|runs| 06:48:30 INFO - PROCESS | 18998 | |0;dojo.html;3314.718248948839;3326.1352048467397;3328.8002719836827;3355.3624811285868;3370.511275865;5391.164369522726;5464.808731694391;5469.617126801126;5475.561955043597;5519.862003449915;5488.313960754906;5555.694436805974;5573;5573.181682131092;5587.664740115596;4883.438404583483;4956.5043495650325;4976.751162441881;5012.198048312271;5051.595872330223;4854.514548545152;4935.210366341386;4977.153883839738;5008.649394542384;5096.821611243608;4967.925481117786;4992.975035124819;5022.397312322526;5075.796968121271;5087.109755792721;5025.045241404122;5071.290019397287;5082.08522465956;5095.847124586268;5110.565601923841;4842.612590992712;4855.417349918032;4875.95124048762;4892.046051020053;4998.375203099613;5403.459654034605;5469.56243500519;5477.3427188737605;5506.311711036121;5522.806701765419;5977.043673012341;5983.910241346383;5997.430244126801;6004.639721616717;6008.4291992261105;5728.656280623176;5842.912356314659;5894.351621321651;5897.705114744245;6004.909926351064;5598.300212473441;5605.831825045255;5605.831825045255;5608.551315894719;5616.494515493584;5777;6059.48494377974;6069.654712492582;6079.589165642582;6089.858895950708;5686.3744988051285;5755.3381361143165;5755.769769209185;5833.154192642043;5836.212111364996;5902.2327097477055;5922.851928701817;5932.377100404482;5934.584579079509;5938.317093534212;5689.118186681071;5741.368449470555;5855.765769369177;5860.824175274749;5861.70691465425;5737.282839645044;5799.449052340021;5803.245578074823;5804.187413762077;5846.766129354864;4463.66522510813;4488.035072459437;4492.752898590609;4493.28107502798;4517.2772356423475;3983.6813054955533;3990.5610382857863;4017.276890159799;4032.5765794591734;4054.0675644601906;5547.72261386929;5566.860828479321;5573.41479144692;5577.330720313507;5618.297712785902;5901.7639294427745;5913.9112913306335;5919.822405327847;5925.762969481172;5951.672658003851;5470.9452905471235;5471.972640136773;5517.779288828482;5532.640378375393;5566.805161819317;4915.5330243626795;4949.307097006422;4953.90092198154;4957.553820156203;4988.80044798204;6080.665563393967;6122.602030867979;6140.600860944024;6144.631322120687;6149.41580549847;5730.426957304319;5823.301203855395;5885.14665373527;5903.7048147593305;5952.8809423812145;6186;6197.442230199304;6211.472024877936;6215.906761398493;6223.875522489434;5643.52030077448;5849.766009359748;5859.619124756877;5861.736221869941;5870.9412905870395;5811.418858114154;5830.854228644318;5844.4155584442915;5935.376785437639;5935.465808077121;5782.6241294317415;5789.334226563999;5798.304203495608;5798.507126894261;5801.941980580309;5659.094544872801;5690.3456102548735;5767.423257674199;5778.335491418541;5782.335031471434;5611.5230205433;5682.37493875665;5715.142728590578;5716.085426331767;5750.942490575041;5808.651480911159;5817.476427121579;5867.647941123546;5872.471477567039;5872.647641141545;5491.093969494988;5607.43925607436;5649.201829492166;5702.37273899879;5724.713764311851 06:48:30 INFO - PROCESS | 18998 | |1;ext.html;582.7523302596398;644.5230529408237;646.8479907221799;660.6861740673179;663.8041777675585;34155.487667684974;37094.07264818381;37116.44325335122;37174.44238336427;37193;36550.817245913735;37494.8125259374;48471.757641211836;49730;49822.252666210035;9023.639054437816;9153.496557689325;9157.679481218158;9161.816763664723;9165.404248723846;8959.462432254086;9049.819003619923;9055.411398259124;9056.728298151033;9062.954685226565;9119.863202051974;9153.450792952412;9156.771080722969;9158.72523824283;9161.862572061424;9052.04953479885;9080.182783549446;9096.317776166814;9097.363184577081;9102.089791020911;9036.683716069905;9094.954525227398;9104.317176211744;9108.407953483069;9116.772080697969;45114;45296;45329.09341813178;45383.09233815338;45427.31859022117;3481.4429691249534;3598.4962105305276;3620.3845346291196;3695.371786796251;3783.5459744830523;34855.65144348549;35142.64857351419;35199.1200219994;35384;35673.28653426943;4658.34783130362;4789.353437285957;4799.448063472711;4832.516748325174;4893.730844803535;351239;353384;353584;353915;353966;67249.66375168093;67363;67618.66190669015;67726.322736772;67751.66124169348;39490;40072.198556028714;40436.393454098215;42325.36511952323;42338.57661423408;16901.577460563338;16962.830371696124;16964.406245781338;16965.236564354633;16968.40610578624;15020.324085415963;15101.093934363973;15127.39490420393;15130;15134.545963621109;20824.89587552083;20953.26663566768;20954.266600668903;21020.26429074975;21038.684419733716;7213.242609525924;7381.335679788737;7463.4029277657655;7533.8116547085665;7796.337311328487;1048.9895101049044;1168.059711931903;1171.9355435451132;1193.5762804204555;1201.831743555903;34201.48697769536;34556.65443345585;34664;34677.306453870784;34718.65281347154;1161.872194058653;1170.7190274334098;1179.6968488232912;1189.3755778216332;1248.633838875326;17920.820791792175;18086.5478363042;18217.362392316205;18300.26798928028;18301.63396732058;157223;157791;157963;158541;548772;63807.36192638107;64407.67796161083;64421.03368449477;64431;64516.67741661262;1342.3087110138288;1418.7729963205838;1453.280626090071;1453.62932452224;1472.7349077165998;33654.149021804034;34780.304393912484;34902.476462852566;35228;35723.82138089293;53616;53802.461975379745;54083.18875216954;54264.45735542752;54265;417980;419690;420427;420713.79286206746;520005;29916.401671966873;30738.385232294782;30749.92375266855;31848.6815131855;31881.202969925936;51820.481795181564;52226;52660.47339526556;53290.46709532855;53299.46700532945;43433.91204163537;43640.345394819735;44147.337789933816;44481.110377791614;45623.31565026461;42749.145017100105;43244.351334730636;43407.782961084995;43894.12211755811;44817.77591112023;43287.35068973905;44017.77991110152;44287.778561106985;45111.54888451073;45226.54773452355;37650.43524347082;39221.215575687755;39465.40801887916;39679.801600991814;39840.2031959365;29666;29816;29825.91218614676;29922.850385747934;30147.698523015366 06:48:30 INFO - PROCESS | 18998 | |2;jquery.html;401.2356460941906;403.5923717045787;407.5516931375486;411.8784958437263;424.4312621087742;13811.447542098329;18515;19417.708734368996;20299.594008119846;20300.492487687814;14817.703645927075;18917.62164756704;18947.05264736761;19208.71186932197;19500.122494487747;5689.431056894308;5902.3507414184405;5904.439078287577;5906.763729450839;5935.10973353996;5759.539236861062;5805.216295800076;5843.532517398619;5848.853778655546;5869.85325366865;4301.483821941371;4438.112377524508;6215.098810672473;6500.804975850709;6529.444997175246;6440.194975628046;6547.247066587356;6579.243387010507;6600.570962887397;6613.041109039186;5656.434356564352;5851.824445266649;5857.179994800731;5889.499392551638;5899.498542623882;23112.65331020036;23242.65136022961;23850.761492385027;23966.640500392507;23991.64012539813;2686.4627074584964;2762.2541913683194;2781.1656503049207;3157.5421563873338;3163.8734450621946;13644.590662280147;14705.191214483199;14715.705685886329;15163.09021458716;15180.86143539239;1889.093235247089;1981.6234915366178;1996.7404237449184;2037.8777273363646;2082.7188329575615;83273.16726832715;84355;84565.57717211435;85766;87804.56097719535;10783.191260655482;10793.190510711727;10847.511861966073;10858.837117443245;10876.891231087588;14514.637134071732;14562.708745825024;14571;14581.781273280909;14671.33978970949;8100.149484304181;8157.918420815835;8396.454230475;8449.57752112392;8486.19381158789;7954.562499062491;7965.362770978308;7976.880346794803;8057.959710201411;8071.556064416396;4303.1608836277255;4400.339949007611;4879.707217566957;4893.0458560581055;8567.871481927776;3358.899233023013;3443.9827800861335;3508.0528257370365;3620.402633565485;3809.276237514863;935.9953200233955;1040.3133931605105;1042.7018362139186;1053.199029659276;1064.4341456121929;18746.718799218022;18758.624827503372;18766.155523001496;19445.708314375297;19669.40991770249;1036.3937096798456;1058.3279617442824;1059.6185373265619;1072.570971611346;1107.6676996900896;10592.523336449878;10865.45672716361;10867.076298514557;10883.23817332779;10925.562977480971;336968;340514;342767;343018;343813;77714;84461;90869;91647.54176229076;102056.48971755094;1042.9322094063862;1059.7138772531528;1075.2849355178876;1076.682378698286;1084.3439718970067;17151.439448013305;17246;17279.481615551555;17372.565685857953;17545.561360965567;41872.581274186865;42147;42640;44371.77814111038;44585.331220031076;56059.43940560705;56609.433905660415;60472.69763651153;61181;61433;8467.407281490483;8485.95757021211;8590.484570925764;8808.51553164582;8950.68672596456;9096.681616143404;12908.290044047668;13260.07179497426;13595.932020339835;13732.725345493234;11532.423378830857;11978.76042479128;12043.458044388199;12316.026368723971;12413;9145.993940666389;11488.253263537843;12167.634970950885;12308.26150430977;12414.875851241371;11962.10284228669;12251.142420030512;12369.567065153036;12440.626781196579;12533.686657833627;7671.884921726067;8030.478018928751;8276.255137037455;8437.535935523605;9084.818303634023;11788.23376480526;12247.877521224673;12317.876821232032;12396.75206495847;12594.984802431567 06:48:30 INFO - PROCESS | 18998 | |3;mootools.html;1425.0665813891892;1554.6657468644244;1586.6112802363418;1751.929922803087;1882.3882238272556;9153.725388238356;9611.375260608056;9629.807403851919;9913.553890074945;9917.801643967116;9653.17947974423;9850.655227067055;9866.309358344919;9868.407895526274;9870.062344077302;2113.3765539165984;2306.215886598556;2391.820613453989;2442.0842184180933;2486.2168416948693;2434.914777982771;2446.1805295226122;2446.571849926265;2449.3876530867283;2449.4856080223176;2367.3134790910617;2382.9285121446296;2415.6014257647553;2418.008616467249;2418.032786885251;2071.3475255294534;2124.787521247863;2126.5640543688505;2261.1407665087327;2369.7511761265077;2375.5130198309307;2379.9167029153896;2380.1074597026113;2384.892679829412;2388.474535602165;9696.806063878683;9750;9761.07269809367;9768.023197680246;9770.609175633037;5379.327584051994;5509.752061157217;5519.503244707996;5520.944790552124;5525.502704756551;3368.1747971747077;3442.3115376924716;3561.860204734486;3641.1443310821937;3651.922682808551;1211.9515219391214;1218.6892342452707;1252.1297698099825;1273.840769903762;1275.330451512954;14360.497382591559;14387.352569134415;14396.136231826124;14396.424143034266;14405.855941440555;4755.754916941857;4781.904361912742;4796.496367881392;4870.707757534488;4873.19592267279;11713;11791.233569817934;11795.823062654066;11826.5860694877;11827.467763950643;5609.915851262234;5618.85952851182;5628.887422251614;5631.211630371751;5631.549476041907;4499.865004049884;5069.340985671839;5264.5525130363585;5266.605004624668;5280.260763493114;4194.538600753915;4230.894227644272;4265.765382903908;4270.167317373082;4295.463067116611;1266.8099785032318;1319.4194554396036;1321.7686904791815;1335.3590276667255;1336.111485861891;961.4808003677936;1058.2010582010532;1058.402002868377;1067.0290036067142;1071.2019545438698;6526.934730652632;6739.427148692318;6743.494237932175;6795.048693182958;6832.385085342343;479.79608666316676;484.30260424987904;492.2837271769567;492.82751037136717;504.40984048663154;4613.700109492872;4668.136394766979;4703.811847526129;4740.099381117577;4747.430308362949;12157.270563766202;12425.875741242653;12473.251604903553;12519.687007824878;12557.372131393577;11961.282323060645;12395.946344560813;12407.317597532041;12414.565490207799;12885.291308978096;9104.408213466237;9264;9267.443953362685;9267.953660231655;9268.860967085498;6760.830979225362;6983.720651173896;7048.682809273492;7055.2591977841585;7177.677004534913;11295.830562541732;11452.312861228353;11504;11584.536618535165;11708.47311870985;11433.656990290305;11615.709607259887;11736.471858766205;11977.940110299392;12046.578369757017;7829.45193836426;8492.91507084946;8676.609552570275;8809.911900880908;8916.55417229149;9822.901770982484;9832.754181145528;9874.40753554789;9925.851112233178;9925.900740992498;8510.191531804468;8552.486850788973;8614.22471977525;8646.524441155796;8916.86624700617;8407.243348098456;8418.70534531313;8486.448380855225;8518.148185181431;8676.349273804364;7692.153863074946;7781.727639532589;7781.805454863674;7797.883031754414;7801.414893882868;5357.598180136428;5471.261379713687;5498.3127109111365;5593.105103183471;5628.437156284339;5552.888942221214;5748.942510575008;5750.769969201185;5858.326292476419;5949.643021418556 06:48:30 INFO - PROCESS | 18998 | |4;prototype.html;324.9568883882736;336;338.33685975488044;343.8160584087513;351.6501081423982;5350.8127215547465;5390.865228369288;5416.729163541817;5420.783168673253;5421.484958928905;5332.33345831771;5333.599980001506;5340.359156901177;5354.678719276846;5361.785528578862;4024.7383920045177;4067.8576249831262;4203.07532342884;4203.579642035787;4235.639970602487;4177.624013838754;4183.811728472211;4191.0360617058095;4207.137536804963;4215.3044747616605;4064.939025914599;4164.292070348048;4205.201011807747;4213.894652633678;4216.620504154625;4132.876013719593;4183.811728472226;4190.392393102983;4195.181939521794;4197.328427451593;3724.3854763963914;3735.364987952055;3743.850245990157;3745.2883952049024;3768.6419790119894;5133.025013675484;5213.973930130363;5224.772178538078;5235.397929238148;5235.633505654606;4826.589739872115;4871.14754917888;4912.656114072016;4916.631252656065;4925.901481970376;5619.747111379957;5650.1242307442;5660.632058916199;5679.545636349124;5706.400827913051;3898.2593307271527;4017.8593749218635;4188.267053265697;4198.425590403599;4200.138971510833;5775.711214439261;5806.912896306559;5810.070388737781;5838.386969368197;5854.414558544154;4161.417401563784;4164.104717485695;4180.163967206571;4183.247015537172;4221.197972385237;4152.6055024772595;4191.868195587174;4273.658107351404;4282.164977829293;4283.164782867373;4747.715137091785;4789.91638637194;4790.305405716152;4799.952000480021;4800.3279540864305;5692.402297758758;5693.572982026365;5726.198332233491;5732.111522713986;5734.713264336767;1414.2787178538813;1460.8386332865398;1467.530390275123;1469;1470.977935330971;918.228687902152;926.5737760630186;941.8163458125737;948.9466691971905;978.1734434402919;5342.252084708144;5369.4630536946;5369.812056578001;5372.865678358073;5389.353277606712;5650.417882992769;5656.773729050792;5681.57388195887;5704.172894930295;5723.341815691166;5316.521513063843;5418.945810541844;5586.793216679389;5604.103343465026;5612.691301978349;3065.908022759321;3085.5497915979904;3093.6442309134286;3094.8143111413387;3100.255938574771;5726.828195154152;6046.425589568984;6098.817035488943;6098.939010609926;6135.32511423743;5846.766129354778;5899.852503687443;5911.615744976562;5923.318818335946;5953.374895635982;6016.849578760479;6081.023667308054;6099.3900609938655;6110.358412366726;6116.694165291718;5603.943960560506;5773.942260577341;5802.187693722798;5829.737661805314;5842.298924129132;5669.319681638065;5689.487946084872;5726.570507211893;5755.597108202385;5778.335491418541;5894.322152952465;6042.1843051187525;6048.243969503812;6067.211262535842;6101;4147.8963025924595;4166.166766646744;4205.074883525619;4215.241256573846;4218.49378074633;5829.571754920072;5873.76650903298;5876.147958545901;5886.793962211474;5890.882182356415;5505.146702261156;5677.233573467529;5679.744411501575;5691.77232910679;5770;5541.556675466034;5585.385607583244;5599;5661.943380566307;5666.518345940642;5363.973180134074;5385.542228910586;5562.360328562268;5580.916286255629;5598.740283436195;5634.549236061023;5655.802046928502;5686.77252909879;5688.886222275449;5715.371309155907;5413.702246376487;5549.889002220014;5552.722363881709;5558.305211848519;5558.443635781988 06:48:30 INFO - PROCESS | 18998 | |5;yui.html;673.356944118367;673.4107655801174;730.439808471308;872.1017352127307;910.8724778531005;14741;15671.608209794747;17138.742918856227;17170.055646939414;17170.313187472486;14654.267286635679;14724.337404816783;14747.48383806567;14770.63073423165;14883.776743348832;725.2638571849577;831.2809419851845;862.5687156421789;865.091653763549;867.8654808504692;870.5951732444412;873.6330741088758;876.3646356391597;877.298161470824;877.4209022045451;923.875276837625;924.0482303227652;924.4869097650801;925.2921515040999;925.4493576322078;749.913759917611;893.3210759822549;910.39003867409;919.0396036142247;919.269181001099;669.8559809640902;671.7212356871893;671.7850287907871;672.9697163627649;673.0812441018024;15963.281652325673;15983.680326393524;15989.920050399674;16019.599510012227;16037.198140092949;14891.47879824201;15045.548633540902;15045.774313385198;15066.09603423798;15299.15854627995;13163.210207387587;13436.731265374638;13508.797368039488;13588.524401645995;13672.179669219879;4628.120657075145;4646.186917289461;4652.604528615072;4681.578657920803;4723.7874295656775;62764;64666.67666661683;64812.675936620486;73948;74995.6250218751;12131.878681213251;12563.18339307942;12573;12605.873941260654;12646.114771965875;22479.42644014936;22575.548489030454;22576.09695612157;22621.321360358885;22810.42973925665;8577.270931970728;8599.828003440021;8881.866771998426;8893.28853691703;8977.3978240819;4759.143354196278;4769.642276829251;4801.327814106028;4947.233178857283;4948.554630083309;3842.51968503937;3888.3778595424596;3888.863889763845;3933.7443066200603;3945.467361906163;717.246890764695;717.4977515739004;722.1009842745815;726.6439444672178;739.6190961654752;746.3655892491447;768.9000429944183;772.2393442459173;783.1033466680619;790.2334735306744;10660.09389201911;10877.67366978992;11080.445977701083;11087.279326843729;11192.104631629612;660.5343233020805;746.1866565443693;759.8898159766914;763.5075376382314;787.5629025890686;5151.4333423323405;5291.269156538776;5307.283516725192;5308.097623404031;5399.082156033483;75511;77535;77687.61156194183;112814.43592782148;117432.41283793526;64636.67681661656;68122.65938670276;80055.59972200218;81119;99812;85193.57403213068;86835.56582217048;88518;88940.11059889448;90179.54910225407;10117.645882394081;10286.639967601099;10293.74265643365;10356.17150627963;10386.221033422373;53238.73380633072;53433.46566534285;53590.732046339515;53952.730236348565;54363;70948.29051709417;71308;76632.61683691546;77928;79766;12014.579489718168;12334.629961101182;12338.3830808461;12887.226766394046;13475.932620336836;15028.549143525712;15152.696946060796;15352.97536549404;15895;15934.043957362595;14665.266736663338;14879.25603719788;15026.098434093989;15412;15535.533933981998;14241.35913883857;14353.64115897111;15287.388504459697;15513.922430387776;16029.759553606473;12796.232226066466;13578.728425431633;13685.726285474433;14191.64520886986;14384.496542620958;11910.702232444259;12204.694882628006;12206.145569810027;12433.316167610868;12598.370081496072;12173.2696038238;12554.43505042257;12597.874021260037;12838.229706217657;12999.285039322927 06:48:30 INFO - PROCESS | 18998 | __end_tp_report 06:48:30 INFO - PROCESS | 18998 | __start_cc_report 06:48:30 INFO - PROCESS | 18998 | _x_x_mozilla_cycle_collect,879 06:48:30 INFO - PROCESS | 18998 | __end_cc_report 06:48:30 INFO - PROCESS | 18998 | __startTimestamp1467812910728__endTimestamp 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | ------- Summary: start ------- 06:48:30 INFO - PROCESS | 18998 | Number of tests: 6 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | [#0] dojo.html Cycles:165 Average:5473.78 Median:5686.37 stddev:615.86 (10.8%) stddev-sans-first:594.00 06:48:30 INFO - PROCESS | 18998 | Values: 3314.7 3326.1 3328.8 3355.4 3370.5 5391.2 5464.8 5469.6 5475.6 5519.9 5488.3 5555.7 5573.0 5573.2 5587.7 4883.4 4956.5 4976.8 5012.2 5051.6 4854.5 4935.2 4977.2 5008.6 5096.8 4967.9 4993.0 5022.4 5075.8 5087.1 5025.0 5071.3 5082.1 5095.8 5110.6 4842.6 4855.4 4876.0 4892.0 4998.4 5403.5 5469.6 5477.3 5506.3 5522.8 5977.0 5983.9 5997.4 6004.6 6008.4 5728.7 5842.9 5894.4 5897.7 6004.9 5598.3 5605.8 5605.8 5608.6 5616.5 5777.0 6059.5 6069.7 6079.6 6089.9 5686.4 5755.3 5755.8 5833.2 5836.2 5902.2 5922.9 5932.4 5934.6 5938.3 5689.1 5741.4 5855.8 5860.8 5861.7 5737.3 5799.4 5803.2 5804.2 5846.8 4463.7 4488.0 4492.8 4493.3 4517.3 3983.7 3990.6 4017.3 4032.6 4054.1 5547.7 5566.9 5573.4 5577.3 5618.3 5901.8 5913.9 5919.8 5925.8 5951.7 5470.9 5472.0 5517.8 5532.6 5566.8 4915.5 4949.3 4953.9 4957.6 4988.8 6080.7 6122.6 6140.6 6144.6 6149.4 5730.4 5823.3 5885.1 5903.7 5952.9 6186.0 6197.4 6211.5 6215.9 6223.9 5643.5 5849.8 5859.6 5861.7 5870.9 5811.4 5830.9 5844.4 5935.4 5935.5 5782.6 5789.3 5798.3 5798.5 5801.9 5659.1 5690.3 5767.4 5778.3 5782.3 5611.5 5682.4 5715.1 5716.1 5750.9 5808.7 5817.5 5867.6 5872.5 5872.6 5491.1 5607.4 5649.2 5702.4 5724.7 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | [#1] ext.html Cycles:180 Average:53021.82 Median:420058.50 stddev:96715.43 (23.0%) stddev-sans-first:96906.60 06:48:30 INFO - PROCESS | 18998 | Values: 582.8 644.5 646.8 660.7 663.8 34155.5 37094.1 37116.4 37174.4 37193.0 36550.8 37494.8 48471.8 49730.0 49822.3 9023.6 9153.5 9157.7 9161.8 9165.4 8959.5 9049.8 9055.4 9056.7 9063.0 9119.9 9153.5 9156.8 9158.7 9161.9 9052.0 9080.2 9096.3 9097.4 9102.1 9036.7 9095.0 9104.3 9108.4 9116.8 45114.0 45296.0 45329.1 45383.1 45427.3 3481.4 3598.5 3620.4 3695.4 3783.5 34855.7 35142.6 35199.1 35384.0 35673.3 4658.3 4789.4 4799.4 4832.5 4893.7 351239.0 353384.0 353584.0 353915.0 353966.0 67249.7 67363.0 67618.7 67726.3 67751.7 39490.0 40072.2 40436.4 42325.4 42338.6 16901.6 16962.8 16964.4 16965.2 16968.4 15020.3 15101.1 15127.4 15130.0 15134.5 20824.9 20953.3 20954.3 21020.3 21038.7 7213.2 7381.3 7463.4 7533.8 7796.3 1049.0 1168.1 1171.9 1193.6 1201.8 34201.5 34556.7 34664.0 34677.3 34718.7 1161.9 1170.7 1179.7 1189.4 1248.6 17920.8 18086.5 18217.4 18300.3 18301.6 157223.0 157791.0 157963.0 158541.0 548772.0 63807.4 64407.7 64421.0 64431.0 64516.7 1342.3 1418.8 1453.3 1453.6 1472.7 33654.1 34780.3 34902.5 35228.0 35723.8 53616.0 53802.5 54083.2 54264.5 54265.0 417980.0 419690.0 420427.0 420713.8 520005.0 29916.4 30738.4 30749.9 31848.7 31881.2 51820.5 52226.0 52660.5 53290.5 53299.5 43433.9 43640.3 44147.3 44481.1 45623.3 42749.1 43244.4 43407.8 43894.1 44817.8 43287.4 44017.8 44287.8 45111.5 45226.5 37650.4 39221.2 39465.4 39679.8 39840.2 29666.0 29816.0 29825.9 29922.9 30147.7 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | [#2] jquery.html Cycles:180 Average:25193.02 Median:2969.35 stddev:57464.23 (1935.2%) stddev-sans-first:57595.29 06:48:30 INFO - PROCESS | 18998 | Values: 401.2 403.6 407.6 411.9 424.4 13811.4 18515.0 19417.7 20299.6 20300.5 14817.7 18917.6 18947.1 19208.7 19500.1 5689.4 5902.4 5904.4 5906.8 5935.1 5759.5 5805.2 5843.5 5848.9 5869.9 4301.5 4438.1 6215.1 6500.8 6529.4 6440.2 6547.2 6579.2 6600.6 6613.0 5656.4 5851.8 5857.2 5889.5 5899.5 23112.7 23242.7 23850.8 23966.6 23991.6 2686.5 2762.3 2781.2 3157.5 3163.9 13644.6 14705.2 14715.7 15163.1 15180.9 1889.1 1981.6 1996.7 2037.9 2082.7 83273.2 84355.0 84565.6 85766.0 87804.6 10783.2 10793.2 10847.5 10858.8 10876.9 14514.6 14562.7 14571.0 14581.8 14671.3 8100.1 8157.9 8396.5 8449.6 8486.2 7954.6 7965.4 7976.9 8058.0 8071.6 4303.2 4400.3 4879.7 4893.0 8567.9 3358.9 3444.0 3508.1 3620.4 3809.3 936.0 1040.3 1042.7 1053.2 1064.4 18746.7 18758.6 18766.2 19445.7 19669.4 1036.4 1058.3 1059.6 1072.6 1107.7 10592.5 10865.5 10867.1 10883.2 10925.6 336968.0 340514.0 342767.0 343018.0 343813.0 77714.0 84461.0 90869.0 91647.5 102056.5 1042.9 1059.7 1075.3 1076.7 1084.3 17151.4 17246.0 17279.5 17372.6 17545.6 41872.6 42147.0 42640.0 44371.8 44585.3 56059.4 56609.4 60472.7 61181.0 61433.0 8467.4 8486.0 8590.5 8808.5 8950.7 9096.7 12908.3 13260.1 13595.9 13732.7 11532.4 11978.8 12043.5 12316.0 12413.0 9146.0 11488.3 12167.6 12308.3 12414.9 11962.1 12251.1 12369.6 12440.6 12533.7 7671.9 8030.5 8276.3 8437.5 9084.8 11788.2 12247.9 12317.9 12396.8 12595.0 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | [#3] mootools.html Cycles:180 Average:6446.85 Median:4768.83 stddev:3862.28 (81.0%) stddev-sans-first:3854.68 06:48:30 INFO - PROCESS | 18998 | Values: 1425.1 1554.7 1586.6 1751.9 1882.4 9153.7 9611.4 9629.8 9913.6 9917.8 9653.2 9850.7 9866.3 9868.4 9870.1 2113.4 2306.2 2391.8 2442.1 2486.2 2434.9 2446.2 2446.6 2449.4 2449.5 2367.3 2382.9 2415.6 2418.0 2418.0 2071.3 2124.8 2126.6 2261.1 2369.8 2375.5 2379.9 2380.1 2384.9 2388.5 9696.8 9750.0 9761.1 9768.0 9770.6 5379.3 5509.8 5519.5 5520.9 5525.5 3368.2 3442.3 3561.9 3641.1 3651.9 1212.0 1218.7 1252.1 1273.8 1275.3 14360.5 14387.4 14396.1 14396.4 14405.9 4755.8 4781.9 4796.5 4870.7 4873.2 11713.0 11791.2 11795.8 11826.6 11827.5 5609.9 5618.9 5628.9 5631.2 5631.5 4499.9 5069.3 5264.6 5266.6 5280.3 4194.5 4230.9 4265.8 4270.2 4295.5 1266.8 1319.4 1321.8 1335.4 1336.1 961.5 1058.2 1058.4 1067.0 1071.2 6526.9 6739.4 6743.5 6795.0 6832.4 479.8 484.3 492.3 492.8 504.4 4613.7 4668.1 4703.8 4740.1 4747.4 12157.3 12425.9 12473.3 12519.7 12557.4 11961.3 12395.9 12407.3 12414.6 12885.3 9104.4 9264.0 9267.4 9268.0 9268.9 6760.8 6983.7 7048.7 7055.3 7177.7 11295.8 11452.3 11504.0 11584.5 11708.5 11433.7 11615.7 11736.5 11977.9 12046.6 7829.5 8492.9 8676.6 8809.9 8916.6 9822.9 9832.8 9874.4 9925.9 9925.9 8510.2 8552.5 8614.2 8646.5 8916.9 8407.2 8418.7 8486.4 8518.1 8676.3 7692.2 7781.7 7781.8 7797.9 7801.4 5357.6 5471.3 5498.3 5593.1 5628.4 5552.9 5748.9 5750.8 5858.3 5949.6 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | [#4] prototype.html Cycles:180 Average:4770.73 Median:5415.22 stddev:1401.22 (25.9%) stddev-sans-first:1364.84 06:48:30 INFO - PROCESS | 18998 | Values: 325.0 336.0 338.3 343.8 351.7 5350.8 5390.9 5416.7 5420.8 5421.5 5332.3 5333.6 5340.4 5354.7 5361.8 4024.7 4067.9 4203.1 4203.6 4235.6 4177.6 4183.8 4191.0 4207.1 4215.3 4064.9 4164.3 4205.2 4213.9 4216.6 4132.9 4183.8 4190.4 4195.2 4197.3 3724.4 3735.4 3743.9 3745.3 3768.6 5133.0 5214.0 5224.8 5235.4 5235.6 4826.6 4871.1 4912.7 4916.6 4925.9 5619.7 5650.1 5660.6 5679.5 5706.4 3898.3 4017.9 4188.3 4198.4 4200.1 5775.7 5806.9 5810.1 5838.4 5854.4 4161.4 4164.1 4180.2 4183.2 4221.2 4152.6 4191.9 4273.7 4282.2 4283.2 4747.7 4789.9 4790.3 4800.0 4800.3 5692.4 5693.6 5726.2 5732.1 5734.7 1414.3 1460.8 1467.5 1469.0 1471.0 918.2 926.6 941.8 948.9 978.2 5342.3 5369.5 5369.8 5372.9 5389.4 5650.4 5656.8 5681.6 5704.2 5723.3 5316.5 5418.9 5586.8 5604.1 5612.7 3065.9 3085.5 3093.6 3094.8 3100.3 5726.8 6046.4 6098.8 6098.9 6135.3 5846.8 5899.9 5911.6 5923.3 5953.4 6016.8 6081.0 6099.4 6110.4 6116.7 5603.9 5773.9 5802.2 5829.7 5842.3 5669.3 5689.5 5726.6 5755.6 5778.3 5894.3 6042.2 6048.2 6067.2 6101.0 4147.9 4166.2 4205.1 4215.2 4218.5 5829.6 5873.8 5876.1 5886.8 5890.9 5505.1 5677.2 5679.7 5691.8 5770.0 5541.6 5585.4 5599.0 5661.9 5666.5 5364.0 5385.5 5562.4 5580.9 5598.7 5634.5 5655.8 5686.8 5688.9 5715.4 5413.7 5549.9 5552.7 5558.3 5558.4 06:48:30 INFO - PROCESS | 18998 | 06:48:30 INFO - PROCESS | 18998 | [#5] yui.html Cycles:180 Average:19994.25 Median:4702.68 stddev:26623.84 (566.1%) stddev-sans-first:26659.00 06:48:30 INFO - PROCESS | 18998 | Values: 673.4 673.4 730.4 872.1 910.9 14741.0 15671.6 17138.7 17170.1 17170.3 14654.3 14724.3 14747.5 14770.6 14883.8 725.3 831.3 862.6 865.1 867.9 870.6 873.6 876.4 877.3 877.4 923.9 924.0 924.5 925.3 925.4 749.9 893.3 910.4 919.0 919.3 669.9 671.7 671.8 673.0 673.1 15963.3 15983.7 15989.9 16019.6 16037.2 14891.5 15045.5 15045.8 15066.1 15299.2 13163.2 13436.7 13508.8 13588.5 13672.2 4628.1 4646.2 4652.6 4681.6 4723.8 62764.0 64666.7 64812.7 73948.0 74995.6 12131.9 12563.2 12573.0 12605.9 12646.1 22479.4 22575.5 22576.1 22621.3 22810.4 8577.3 8599.8 8881.9 8893.3 8977.4 4759.1 4769.6 4801.3 4947.2 4948.6 3842.5 3888.4 3888.9 3933.7 3945.5 717.2 717.5 722.1 726.6 739.6 746.4 768.9 772.2 783.1 790.2 10660.1 10877.7 11080.4 11087.3 11192.1 660.5 746.2 759.9 763.5 787.6 5151.4 5291.3 5307.3 5308.1 5399.1 75511.0 77535.0 77687.6 112814.4 117432.4 64636.7 68122.7 80055.6 81119.0 99812.0 85193.6 86835.6 88518.0 88940.1 90179.5 10117.6 10286.6 10293.7 10356.2 10386.2 53238.7 53433.5 53590.7 53952.7 54363.0 70948.3 71308.0 76632.6 77928.0 79766.0 12014.6 12334.6 12338.4 12887.2 13475.9 15028.5 15152.7 15353.0 15895.0 15934.0 14665.3 14879.3 15026.1 15412.0 15535.5 14241.4 14353.6 15287.4 15513.9 16029.8 12796.2 13578.7 13685.7 14191.6 14384.5 11910.7 12204.7 12206.1 12433.3 12598.4 12173.3 12554.4 12597.9 12838.2 12999.3 06:48:30 INFO - PROCESS | 18998 | -------- Summary: end -------- 06:48:30 INFO - PROCESS | 18998 | 06:48:31 INFO - TEST-INFO | 18998: exit 0 06:48:31 INFO - TEST-OK | dromaeo_css | took 1112130ms 06:48:31 INFO - TEST-START | kraken 06:48:31 INFO - operating with platform_type : linux_ 06:48:31 INFO - Initialising browser for kraken test... 06:48:31 INFO - TEST-INFO | started process 19203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvR_MP/profile http://localhost:33646/getInfo.html) 06:48:35 INFO - PROCESS | 19203 | __metrics Screen width/height:1600/1200 06:48:35 INFO - PROCESS | 19203 | colorDepth:24 06:48:35 INFO - PROCESS | 19203 | Browser inner width/height: 1024/697 06:48:35 INFO - PROCESS | 19203 | __metrics 06:48:36 ERROR - PROCESS | 19203 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:48:37 INFO - TEST-INFO | 19203: exit 0 06:48:37 INFO - Browser initialized. 06:48:37 INFO - Running cycle 1/1 for kraken test... 06:48:37 INFO - TEST-INFO | started process 19294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvR_MP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:48 INFO - PROCESS | 19294 | RSS: Main: 149266432 06:48:48 INFO - PROCESS | 19294 | 06:48:51 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33646/tests/kraken/driver.html?testName=audio-beat-detection) 06:48:52 INFO - PROCESS | 19294 | RSS: Main: 198410240 06:48:52 INFO - PROCESS | 19294 | 06:48:54 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33646/tests/kraken/driver.html?testName=audio-dft) 06:48:55 INFO - PROCESS | 19294 | RSS: Main: 196034560 06:48:55 INFO - PROCESS | 19294 | 06:48:58 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33646/tests/kraken/driver.html?testName=audio-fft) 06:48:58 INFO - PROCESS | 19294 | RSS: Main: 281387008 06:48:58 INFO - PROCESS | 19294 | 06:49:01 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33646/tests/kraken/driver.html?testName=audio-oscillator) 06:49:01 INFO - PROCESS | 19294 | RSS: Main: 190390272 06:49:01 INFO - PROCESS | 19294 | 06:49:03 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:49:04 INFO - PROCESS | 19294 | RSS: Main: 190947328 06:49:04 INFO - PROCESS | 19294 | 06:49:07 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33646/tests/kraken/driver.html?testName=imaging-darkroom) 06:49:07 INFO - PROCESS | 19294 | RSS: Main: 225296384 06:49:07 INFO - PROCESS | 19294 | 06:49:11 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33646/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:11 INFO - PROCESS | 19294 | RSS: Main: 225824768 06:49:11 INFO - PROCESS | 19294 | 06:49:14 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33646/tests/kraken/driver.html?testName=json-parse-financial) 06:49:15 INFO - PROCESS | 19294 | RSS: Main: 225742848 06:49:15 INFO - PROCESS | 19294 | 06:49:16 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:49:17 INFO - PROCESS | 19294 | RSS: Main: 205053952 06:49:17 INFO - PROCESS | 19294 | 06:49:19 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:49:19 INFO - PROCESS | 19294 | RSS: Main: 205377536 06:49:19 INFO - PROCESS | 19294 | 06:49:21 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:49:22 INFO - PROCESS | 19294 | RSS: Main: 208273408 06:49:22 INFO - PROCESS | 19294 | 06:49:24 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:49:25 INFO - PROCESS | 19294 | RSS: Main: 213950464 06:49:25 INFO - PROCESS | 19294 | 06:49:28 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:49:28 INFO - PROCESS | 19294 | RSS: Main: 212434944 06:49:28 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | Cycle 1(1): loaded http://localhost:33646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33646/tests/kraken/driver.html?testName=ai-astar) 06:49:30 INFO - PROCESS | 19294 | RSS: Main: 255635456 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | __start_tp_report 06:49:30 INFO - PROCESS | 19294 | _x_x_mozilla_page_load 06:49:30 INFO - PROCESS | 19294 | _x_x_mozilla_page_load_details 06:49:30 INFO - PROCESS | 19294 | |i|pagename|runs| 06:49:30 INFO - PROCESS | 19294 | |0;ai-astar;109;104;108;109;110;109;109;110;108;108 06:49:30 INFO - PROCESS | 19294 | |1;audio-beat-detection;153;130;124;183;125;125;155;129;174;127 06:49:30 INFO - PROCESS | 19294 | |2;audio-dft;161;162;161;160;161;159;163;160;162;160 06:49:30 INFO - PROCESS | 19294 | |3;audio-fft;75;75;74;123;74;85;76;75;106;76 06:49:30 INFO - PROCESS | 19294 | |4;audio-oscillator;84;84;115;85;84;84;109;91;84;135 06:49:30 INFO - PROCESS | 19294 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;116;117;117 06:49:30 INFO - PROCESS | 19294 | |6;imaging-darkroom;146;146;145;146;146;146;145;146;147;145 06:49:30 INFO - PROCESS | 19294 | |7;imaging-desaturate;96;95;95;95;96;95;94;95;95;95 06:49:30 INFO - PROCESS | 19294 | |8;json-parse-financial;53;52;52;53;52;52;52;54;54;54 06:49:30 INFO - PROCESS | 19294 | |9;json-stringify-tinderbox;60;61;60;61;60;61;60;61;61;61 06:49:30 INFO - PROCESS | 19294 | |10;stanford-crypto-aes;80;76;87;76;76;76;77;78;108;77 06:49:30 INFO - PROCESS | 19294 | |11;stanford-crypto-ccm;119;118;117;119;117;120;117;124;136;126 06:49:30 INFO - PROCESS | 19294 | |12;stanford-crypto-pbkdf2;154;157;155;156;154;156;151;152;153;151 06:49:30 INFO - PROCESS | 19294 | |13;stanford-crypto-sha256-iterative;63;61;64;62;62;61;62;62;64;63 06:49:30 INFO - PROCESS | 19294 | __end_tp_report 06:49:30 INFO - PROCESS | 19294 | __start_cc_report 06:49:30 INFO - PROCESS | 19294 | _x_x_mozilla_cycle_collect,1576 06:49:30 INFO - PROCESS | 19294 | __end_cc_report 06:49:30 INFO - PROCESS | 19294 | __startTimestamp1467812970585__endTimestamp 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | ------- Summary: start ------- 06:49:30 INFO - PROCESS | 19294 | Number of tests: 14 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:1.71 (1.6%) stddev-sans-first:1.80 06:49:30 INFO - PROCESS | 19294 | Values: 109.0 104.0 108.0 109.0 110.0 109.0 109.0 110.0 108.0 108.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:141.50 stddev:22.19 (15.7%) stddev-sans-first:23.21 06:49:30 INFO - PROCESS | 19294 | Values: 153.0 130.0 124.0 183.0 125.0 125.0 155.0 129.0 174.0 127.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 06:49:30 INFO - PROCESS | 19294 | Values: 161.0 162.0 161.0 160.0 161.0 159.0 163.0 160.0 162.0 160.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:16.92 (22.6%) stddev-sans-first:17.64 06:49:30 INFO - PROCESS | 19294 | Values: 75.0 75.0 74.0 123.0 74.0 85.0 76.0 75.0 106.0 76.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:18.00 (21.4%) stddev-sans-first:18.60 06:49:30 INFO - PROCESS | 19294 | Values: 84.0 84.0 115.0 85.0 84.0 84.0 109.0 91.0 84.0 135.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:49:30 INFO - PROCESS | 19294 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:49:30 INFO - PROCESS | 19294 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 147.0 145.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 06:49:30 INFO - PROCESS | 19294 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 06:49:30 INFO - PROCESS | 19294 | Values: 53.0 52.0 52.0 53.0 52.0 52.0 52.0 54.0 54.0 54.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:49:30 INFO - PROCESS | 19294 | Values: 60.0 61.0 60.0 61.0 60.0 61.0 60.0 61.0 61.0 61.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:77.00 stddev:10.04 (13.0%) stddev-sans-first:10.64 06:49:30 INFO - PROCESS | 19294 | Values: 80.0 76.0 87.0 76.0 76.0 76.0 77.0 78.0 108.0 77.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:119.50 stddev:6.00 (5.0%) stddev-sans-first:6.31 06:49:30 INFO - PROCESS | 19294 | Values: 119.0 118.0 117.0 119.0 117.0 120.0 117.0 124.0 136.0 126.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.50 stddev:2.13 (1.4%) stddev-sans-first:2.26 06:49:30 INFO - PROCESS | 19294 | Values: 154.0 157.0 155.0 156.0 154.0 156.0 151.0 152.0 153.0 151.0 06:49:30 INFO - PROCESS | 19294 | 06:49:30 INFO - PROCESS | 19294 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.07 (1.7%) stddev-sans-first:1.12 06:49:30 INFO - PROCESS | 19294 | Values: 63.0 61.0 64.0 62.0 62.0 61.0 62.0 62.0 64.0 63.0 06:49:30 INFO - PROCESS | 19294 | -------- Summary: end -------- 06:49:30 INFO - PROCESS | 19294 | 06:49:31 INFO - TEST-INFO | 19294: exit 0 06:49:31 INFO - TEST-OK | kraken | took 60089ms 06:49:31 INFO - SUITE-END | took 1172s 06:49:31 INFO - Completed test suite (00:19:32) 06:49:31 INFO - javascript benchmark 06:49:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.718248948839, 3326.1352048467397, 3328.8002719836827, 3355.3624811285868, 3370.511275865, 5391.164369522726, 5464.808731694391, 5469.617126801126, 5475.561955043597, 5519.862003449915, 5488.313960754906, 5555.694436805974, 5573.0, 5573.181682131092, 5587.664740115596, 4883.438404583483, 4956.5043495650325, 4976.751162441881, 5012.198048312271, 5051.595872330223, 4854.514548545152, 4935.210366341386, 4977.153883839738, 5008.649394542384, 5096.821611243608, 4967.925481117786, 4992.975035124819, 5022.397312322526, 5075.796968121271, 5087.109755792721, 5025.045241404122, 5071.290019397287, 5082.08522465956, 5095.847124586268, 5110.565601923841, 4842.612590992712, 4855.417349918032, 4875.95124048762, 4892.046051020053, 4998.375203099613, 5403.459654034605, 5469.56243500519, 5477.3427188737605, 5506.311711036121, 5522.806701765419, 5977.043673012341, 5983.910241346383, 5997.430244126801, 6004.639721616717, 6008.4291992261105, 5728.656280623176, 5842.912356314659, 5894.351621321651, 5897.705114744245, 6004.909926351064, 5598.300212473441, 5605.831825045255, 5605.831825045255, 5608.551315894719, 5616.494515493584, 5777.0, 6059.48494377974, 6069.654712492582, 6079.589165642582, 6089.858895950708, 5686.3744988051285, 5755.3381361143165, 5755.769769209185, 5833.154192642043, 5836.212111364996, 5902.2327097477055, 5922.851928701817, 5932.377100404482, 5934.584579079509, 5938.317093534212, 5689.118186681071, 5741.368449470555, 5855.765769369177, 5860.824175274749, 5861.70691465425, 5737.282839645044, 5799.449052340021, 5803.245578074823, 5804.187413762077, 5846.766129354864, 4463.66522510813, 4488.035072459437, 4492.752898590609, 4493.28107502798, 4517.2772356423475, 3983.6813054955533, 3990.5610382857863, 4017.276890159799, 4032.5765794591734, 4054.0675644601906, 5547.72261386929, 5566.860828479321, 5573.41479144692, 5577.330720313507, 5618.297712785902, 5901.7639294427745, 5913.9112913306335, 5919.822405327847, 5925.762969481172, 5951.672658003851, 5470.9452905471235, 5471.972640136773, 5517.779288828482, 5532.640378375393, 5566.805161819317, 4915.5330243626795, 4949.307097006422, 4953.90092198154, 4957.553820156203, 4988.80044798204, 6080.665563393967, 6122.602030867979, 6140.600860944024, 6144.631322120687, 6149.41580549847, 5730.426957304319, 5823.301203855395, 5885.14665373527, 5903.7048147593305, 5952.8809423812145, 6186.0, 6197.442230199304, 6211.472024877936, 6215.906761398493, 6223.875522489434, 5643.52030077448, 5849.766009359748, 5859.619124756877, 5861.736221869941, 5870.9412905870395, 5811.418858114154, 5830.854228644318, 5844.4155584442915, 5935.376785437639, 5935.465808077121, 5782.6241294317415, 5789.334226563999, 5798.304203495608, 5798.507126894261, 5801.941980580309, 5659.094544872801, 5690.3456102548735, 5767.423257674199, 5778.335491418541, 5782.335031471434, 5611.5230205433, 5682.37493875665, 5715.142728590578, 5716.085426331767, 5750.942490575041, 5808.651480911159, 5817.476427121579, 5867.647941123546, 5872.471477567039, 5872.647641141545, 5491.093969494988, 5607.43925607436, 5649.201829492166, 5702.37273899879, 5724.713764311851], "value": 5433.610666608011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7523302596398, 644.5230529408237, 646.8479907221799, 660.6861740673179, 663.8041777675585, 34155.487667684974, 37094.07264818381, 37116.44325335122, 37174.44238336427, 37193.0, 36550.817245913735, 37494.8125259374, 48471.757641211836, 49730.0, 49822.252666210035, 9023.639054437816, 9153.496557689325, 9157.679481218158, 9161.816763664723, 9165.404248723846, 8959.462432254086, 9049.819003619923, 9055.411398259124, 9056.728298151033, 9062.954685226565, 9119.863202051974, 9153.450792952412, 9156.771080722969, 9158.72523824283, 9161.862572061424, 9052.04953479885, 9080.182783549446, 9096.317776166814, 9097.363184577081, 9102.089791020911, 9036.683716069905, 9094.954525227398, 9104.317176211744, 9108.407953483069, 9116.772080697969, 45114.0, 45296.0, 45329.09341813178, 45383.09233815338, 45427.31859022117, 3481.4429691249534, 3598.4962105305276, 3620.3845346291196, 3695.371786796251, 3783.5459744830523, 34855.65144348549, 35142.64857351419, 35199.1200219994, 35384.0, 35673.28653426943, 4658.34783130362, 4789.353437285957, 4799.448063472711, 4832.516748325174, 4893.730844803535, 351239.0, 353384.0, 353584.0, 353915.0, 353966.0, 67249.66375168093, 67363.0, 67618.66190669015, 67726.322736772, 67751.66124169348, 39490.0, 40072.198556028714, 40436.393454098215, 42325.36511952323, 42338.57661423408, 16901.577460563338, 16962.830371696124, 16964.406245781338, 16965.236564354633, 16968.40610578624, 15020.324085415963, 15101.093934363973, 15127.39490420393, 15130.0, 15134.545963621109, 20824.89587552083, 20953.26663566768, 20954.266600668903, 21020.26429074975, 21038.684419733716, 7213.242609525924, 7381.335679788737, 7463.4029277657655, 7533.8116547085665, 7796.337311328487, 1048.9895101049044, 1168.059711931903, 1171.9355435451132, 1193.5762804204555, 1201.831743555903, 34201.48697769536, 34556.65443345585, 34664.0, 34677.306453870784, 34718.65281347154, 1161.872194058653, 1170.7190274334098, 1179.6968488232912, 1189.3755778216332, 1248.633838875326, 17920.820791792175, 18086.5478363042, 18217.362392316205, 18300.26798928028, 18301.63396732058, 157223.0, 157791.0, 157963.0, 158541.0, 548772.0, 63807.36192638107, 64407.67796161083, 64421.03368449477, 64431.0, 64516.67741661262, 1342.3087110138288, 1418.7729963205838, 1453.280626090071, 1453.62932452224, 1472.7349077165998, 33654.149021804034, 34780.304393912484, 34902.476462852566, 35228.0, 35723.82138089293, 53616.0, 53802.461975379745, 54083.18875216954, 54264.45735542752, 54265.0, 417980.0, 419690.0, 420427.0, 420713.79286206746, 520005.0, 29916.401671966873, 30738.385232294782, 30749.92375266855, 31848.6815131855, 31881.202969925936, 51820.481795181564, 52226.0, 52660.47339526556, 53290.46709532855, 53299.46700532945, 43433.91204163537, 43640.345394819735, 44147.337789933816, 44481.110377791614, 45623.31565026461, 42749.145017100105, 43244.351334730636, 43407.782961084995, 43894.12211755811, 44817.77591112023, 43287.35068973905, 44017.77991110152, 44287.778561106985, 45111.54888451073, 45226.54773452355, 37650.43524347082, 39221.215575687755, 39465.40801887916, 39679.801600991814, 39840.2031959365, 29666.0, 29816.0, 29825.91218614676, 29922.850385747934, 30147.698523015366], "value": 20543.529804756803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.2356460941906, 403.5923717045787, 407.5516931375486, 411.8784958437263, 424.4312621087742, 13811.447542098329, 18515.0, 19417.708734368996, 20299.594008119846, 20300.492487687814, 14817.703645927075, 18917.62164756704, 18947.05264736761, 19208.71186932197, 19500.122494487747, 5689.431056894308, 5902.3507414184405, 5904.439078287577, 5906.763729450839, 5935.10973353996, 5759.539236861062, 5805.216295800076, 5843.532517398619, 5848.853778655546, 5869.85325366865, 4301.483821941371, 4438.112377524508, 6215.098810672473, 6500.804975850709, 6529.444997175246, 6440.194975628046, 6547.247066587356, 6579.243387010507, 6600.570962887397, 6613.041109039186, 5656.434356564352, 5851.824445266649, 5857.179994800731, 5889.499392551638, 5899.498542623882, 23112.65331020036, 23242.65136022961, 23850.761492385027, 23966.640500392507, 23991.64012539813, 2686.4627074584964, 2762.2541913683194, 2781.1656503049207, 3157.5421563873338, 3163.8734450621946, 13644.590662280147, 14705.191214483199, 14715.705685886329, 15163.09021458716, 15180.86143539239, 1889.093235247089, 1981.6234915366178, 1996.7404237449184, 2037.8777273363646, 2082.7188329575615, 83273.16726832715, 84355.0, 84565.57717211435, 85766.0, 87804.56097719535, 10783.191260655482, 10793.190510711727, 10847.511861966073, 10858.837117443245, 10876.891231087588, 14514.637134071732, 14562.708745825024, 14571.0, 14581.781273280909, 14671.33978970949, 8100.149484304181, 8157.918420815835, 8396.454230475, 8449.57752112392, 8486.19381158789, 7954.562499062491, 7965.362770978308, 7976.880346794803, 8057.959710201411, 8071.556064416396, 4303.1608836277255, 4400.339949007611, 4879.707217566957, 4893.0458560581055, 8567.871481927776, 3358.899233023013, 3443.9827800861335, 3508.0528257370365, 3620.402633565485, 3809.276237514863, 935.9953200233955, 1040.3133931605105, 1042.7018362139186, 1053.199029659276, 1064.4341456121929, 18746.718799218022, 18758.624827503372, 18766.155523001496, 19445.708314375297, 19669.40991770249, 1036.3937096798456, 1058.3279617442824, 1059.6185373265619, 1072.570971611346, 1107.6676996900896, 10592.523336449878, 10865.45672716361, 10867.076298514557, 10883.23817332779, 10925.562977480971, 336968.0, 340514.0, 342767.0, 343018.0, 343813.0, 77714.0, 84461.0, 90869.0, 91647.54176229076, 102056.48971755094, 1042.9322094063862, 1059.7138772531528, 1075.2849355178876, 1076.682378698286, 1084.3439718970067, 17151.439448013305, 17246.0, 17279.481615551555, 17372.565685857953, 17545.561360965567, 41872.581274186865, 42147.0, 42640.0, 44371.77814111038, 44585.331220031076, 56059.43940560705, 56609.433905660415, 60472.69763651153, 61181.0, 61433.0, 8467.407281490483, 8485.95757021211, 8590.484570925764, 8808.51553164582, 8950.68672596456, 9096.681616143404, 12908.290044047668, 13260.07179497426, 13595.932020339835, 13732.725345493234, 11532.423378830857, 11978.76042479128, 12043.458044388199, 12316.026368723971, 12413.0, 9145.993940666389, 11488.253263537843, 12167.634970950885, 12308.26150430977, 12414.875851241371, 11962.10284228669, 12251.142420030512, 12369.567065153036, 12440.626781196579, 12533.686657833627, 7671.884921726067, 8030.478018928751, 8276.255137037455, 8437.535935523605, 9084.818303634023, 11788.23376480526, 12247.877521224673, 12317.876821232032, 12396.75206495847, 12594.984802431567], "value": 9583.90755662104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.0665813891892, 1554.6657468644244, 1586.6112802363418, 1751.929922803087, 1882.3882238272556, 9153.725388238356, 9611.375260608056, 9629.807403851919, 9913.553890074945, 9917.801643967116, 9653.17947974423, 9850.655227067055, 9866.309358344919, 9868.407895526274, 9870.062344077302, 2113.3765539165984, 2306.215886598556, 2391.820613453989, 2442.0842184180933, 2486.2168416948693, 2434.914777982771, 2446.1805295226122, 2446.571849926265, 2449.3876530867283, 2449.4856080223176, 2367.3134790910617, 2382.9285121446296, 2415.6014257647553, 2418.008616467249, 2418.032786885251, 2071.3475255294534, 2124.787521247863, 2126.5640543688505, 2261.1407665087327, 2369.7511761265077, 2375.5130198309307, 2379.9167029153896, 2380.1074597026113, 2384.892679829412, 2388.474535602165, 9696.806063878683, 9750.0, 9761.07269809367, 9768.023197680246, 9770.609175633037, 5379.327584051994, 5509.752061157217, 5519.503244707996, 5520.944790552124, 5525.502704756551, 3368.1747971747077, 3442.3115376924716, 3561.860204734486, 3641.1443310821937, 3651.922682808551, 1211.9515219391214, 1218.6892342452707, 1252.1297698099825, 1273.840769903762, 1275.330451512954, 14360.497382591559, 14387.352569134415, 14396.136231826124, 14396.424143034266, 14405.855941440555, 4755.754916941857, 4781.904361912742, 4796.496367881392, 4870.707757534488, 4873.19592267279, 11713.0, 11791.233569817934, 11795.823062654066, 11826.5860694877, 11827.467763950643, 5609.915851262234, 5618.85952851182, 5628.887422251614, 5631.211630371751, 5631.549476041907, 4499.865004049884, 5069.340985671839, 5264.5525130363585, 5266.605004624668, 5280.260763493114, 4194.538600753915, 4230.894227644272, 4265.765382903908, 4270.167317373082, 4295.463067116611, 1266.8099785032318, 1319.4194554396036, 1321.7686904791815, 1335.3590276667255, 1336.111485861891, 961.4808003677936, 1058.2010582010532, 1058.402002868377, 1067.0290036067142, 1071.2019545438698, 6526.934730652632, 6739.427148692318, 6743.494237932175, 6795.048693182958, 6832.385085342343, 479.79608666316676, 484.30260424987904, 492.2837271769567, 492.82751037136717, 504.40984048663154, 4613.700109492872, 4668.136394766979, 4703.811847526129, 4740.099381117577, 4747.430308362949, 12157.270563766202, 12425.875741242653, 12473.251604903553, 12519.687007824878, 12557.372131393577, 11961.282323060645, 12395.946344560813, 12407.317597532041, 12414.565490207799, 12885.291308978096, 9104.408213466237, 9264.0, 9267.443953362685, 9267.953660231655, 9268.860967085498, 6760.830979225362, 6983.720651173896, 7048.682809273492, 7055.2591977841585, 7177.677004534913, 11295.830562541732, 11452.312861228353, 11504.0, 11584.536618535165, 11708.47311870985, 11433.656990290305, 11615.709607259887, 11736.471858766205, 11977.940110299392, 12046.578369757017, 7829.45193836426, 8492.91507084946, 8676.609552570275, 8809.911900880908, 8916.55417229149, 9822.901770982484, 9832.754181145528, 9874.40753554789, 9925.851112233178, 9925.900740992498, 8510.191531804468, 8552.486850788973, 8614.22471977525, 8646.524441155796, 8916.86624700617, 8407.243348098456, 8418.70534531313, 8486.448380855225, 8518.148185181431, 8676.349273804364, 7692.153863074946, 7781.727639532589, 7781.805454863674, 7797.883031754414, 7801.414893882868, 5357.598180136428, 5471.261379713687, 5498.3127109111365, 5593.105103183471, 5628.437156284339, 5552.888942221214, 5748.942510575008, 5750.769969201185, 5858.326292476419, 5949.643021418556], "value": 4968.051935661013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.9568883882736, 336.0, 338.33685975488044, 343.8160584087513, 351.6501081423982, 5350.8127215547465, 5390.865228369288, 5416.729163541817, 5420.783168673253, 5421.484958928905, 5332.33345831771, 5333.599980001506, 5340.359156901177, 5354.678719276846, 5361.785528578862, 4024.7383920045177, 4067.8576249831262, 4203.07532342884, 4203.579642035787, 4235.639970602487, 4177.624013838754, 4183.811728472211, 4191.0360617058095, 4207.137536804963, 4215.3044747616605, 4064.939025914599, 4164.292070348048, 4205.201011807747, 4213.894652633678, 4216.620504154625, 4132.876013719593, 4183.811728472226, 4190.392393102983, 4195.181939521794, 4197.328427451593, 3724.3854763963914, 3735.364987952055, 3743.850245990157, 3745.2883952049024, 3768.6419790119894, 5133.025013675484, 5213.973930130363, 5224.772178538078, 5235.397929238148, 5235.633505654606, 4826.589739872115, 4871.14754917888, 4912.656114072016, 4916.631252656065, 4925.901481970376, 5619.747111379957, 5650.1242307442, 5660.632058916199, 5679.545636349124, 5706.400827913051, 3898.2593307271527, 4017.8593749218635, 4188.267053265697, 4198.425590403599, 4200.138971510833, 5775.711214439261, 5806.912896306559, 5810.070388737781, 5838.386969368197, 5854.414558544154, 4161.417401563784, 4164.104717485695, 4180.163967206571, 4183.247015537172, 4221.197972385237, 4152.6055024772595, 4191.868195587174, 4273.658107351404, 4282.164977829293, 4283.164782867373, 4747.715137091785, 4789.91638637194, 4790.305405716152, 4799.952000480021, 4800.3279540864305, 5692.402297758758, 5693.572982026365, 5726.198332233491, 5732.111522713986, 5734.713264336767, 1414.2787178538813, 1460.8386332865398, 1467.530390275123, 1469.0, 1470.977935330971, 918.228687902152, 926.5737760630186, 941.8163458125737, 948.9466691971905, 978.1734434402919, 5342.252084708144, 5369.4630536946, 5369.812056578001, 5372.865678358073, 5389.353277606712, 5650.417882992769, 5656.773729050792, 5681.57388195887, 5704.172894930295, 5723.341815691166, 5316.521513063843, 5418.945810541844, 5586.793216679389, 5604.103343465026, 5612.691301978349, 3065.908022759321, 3085.5497915979904, 3093.6442309134286, 3094.8143111413387, 3100.255938574771, 5726.828195154152, 6046.425589568984, 6098.817035488943, 6098.939010609926, 6135.32511423743, 5846.766129354778, 5899.852503687443, 5911.615744976562, 5923.318818335946, 5953.374895635982, 6016.849578760479, 6081.023667308054, 6099.3900609938655, 6110.358412366726, 6116.694165291718, 5603.943960560506, 5773.942260577341, 5802.187693722798, 5829.737661805314, 5842.298924129132, 5669.319681638065, 5689.487946084872, 5726.570507211893, 5755.597108202385, 5778.335491418541, 5894.322152952465, 6042.1843051187525, 6048.243969503812, 6067.211262535842, 6101.0, 4147.8963025924595, 4166.166766646744, 4205.074883525619, 4215.241256573846, 4218.49378074633, 5829.571754920072, 5873.76650903298, 5876.147958545901, 5886.793962211474, 5890.882182356415, 5505.146702261156, 5677.233573467529, 5679.744411501575, 5691.77232910679, 5770.0, 5541.556675466034, 5585.385607583244, 5599.0, 5661.943380566307, 5666.518345940642, 5363.973180134074, 5385.542228910586, 5562.360328562268, 5580.916286255629, 5598.740283436195, 5634.549236061023, 5655.802046928502, 5686.77252909879, 5688.886222275449, 5715.371309155907, 5413.702246376487, 5549.889002220014, 5552.722363881709, 5558.305211848519, 5558.443635781988], "value": 4322.547118955096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.356944118367, 673.4107655801174, 730.439808471308, 872.1017352127307, 910.8724778531005, 14741.0, 15671.608209794747, 17138.742918856227, 17170.055646939414, 17170.313187472486, 14654.267286635679, 14724.337404816783, 14747.48383806567, 14770.63073423165, 14883.776743348832, 725.2638571849577, 831.2809419851845, 862.5687156421789, 865.091653763549, 867.8654808504692, 870.5951732444412, 873.6330741088758, 876.3646356391597, 877.298161470824, 877.4209022045451, 923.875276837625, 924.0482303227652, 924.4869097650801, 925.2921515040999, 925.4493576322078, 749.913759917611, 893.3210759822549, 910.39003867409, 919.0396036142247, 919.269181001099, 669.8559809640902, 671.7212356871893, 671.7850287907871, 672.9697163627649, 673.0812441018024, 15963.281652325673, 15983.680326393524, 15989.920050399674, 16019.599510012227, 16037.198140092949, 14891.47879824201, 15045.548633540902, 15045.774313385198, 15066.09603423798, 15299.15854627995, 13163.210207387587, 13436.731265374638, 13508.797368039488, 13588.524401645995, 13672.179669219879, 4628.120657075145, 4646.186917289461, 4652.604528615072, 4681.578657920803, 4723.7874295656775, 62764.0, 64666.67666661683, 64812.675936620486, 73948.0, 74995.6250218751, 12131.878681213251, 12563.18339307942, 12573.0, 12605.873941260654, 12646.114771965875, 22479.42644014936, 22575.548489030454, 22576.09695612157, 22621.321360358885, 22810.42973925665, 8577.270931970728, 8599.828003440021, 8881.866771998426, 8893.28853691703, 8977.3978240819, 4759.143354196278, 4769.642276829251, 4801.327814106028, 4947.233178857283, 4948.554630083309, 3842.51968503937, 3888.3778595424596, 3888.863889763845, 3933.7443066200603, 3945.467361906163, 717.246890764695, 717.4977515739004, 722.1009842745815, 726.6439444672178, 739.6190961654752, 746.3655892491447, 768.9000429944183, 772.2393442459173, 783.1033466680619, 790.2334735306744, 10660.09389201911, 10877.67366978992, 11080.445977701083, 11087.279326843729, 11192.104631629612, 660.5343233020805, 746.1866565443693, 759.8898159766914, 763.5075376382314, 787.5629025890686, 5151.4333423323405, 5291.269156538776, 5307.283516725192, 5308.097623404031, 5399.082156033483, 75511.0, 77535.0, 77687.61156194183, 112814.43592782148, 117432.41283793526, 64636.67681661656, 68122.65938670276, 80055.59972200218, 81119.0, 99812.0, 85193.57403213068, 86835.56582217048, 88518.0, 88940.11059889448, 90179.54910225407, 10117.645882394081, 10286.639967601099, 10293.74265643365, 10356.17150627963, 10386.221033422373, 53238.73380633072, 53433.46566534285, 53590.732046339515, 53952.730236348565, 54363.0, 70948.29051709417, 71308.0, 76632.61683691546, 77928.0, 79766.0, 12014.579489718168, 12334.629961101182, 12338.3830808461, 12887.226766394046, 13475.932620336836, 15028.549143525712, 15152.696946060796, 15352.97536549404, 15895.0, 15934.043957362595, 14665.266736663338, 14879.25603719788, 15026.098434093989, 15412.0, 15535.533933981998, 14241.35913883857, 14353.64115897111, 15287.388504459697, 15513.922430387776, 16029.759553606473, 12796.232226066466, 13578.728425431633, 13685.726285474433, 14191.64520886986, 14384.496542620958, 11910.702232444259, 12204.694882628006, 12206.145569810027, 12433.316167610868, 12598.370081496072, 12173.2696038238, 12554.43505042257, 12597.874021260037, 12838.229706217657, 12999.285039322927], "value": 7914.324164239095, "unit": "score"}], "name": "dromaeo_css", "value": 7526.876777715642, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 108.0, 109.0, 110.0, 109.0, 109.0, 110.0, 108.0, 108.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 124.0, 183.0, 125.0, 125.0, 155.0, 129.0, 174.0, 127.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 159.0, 163.0, 160.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 123.0, 74.0, 85.0, 76.0, 75.0, 106.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 85.0, 84.0, 84.0, 109.0, 91.0, 84.0, 135.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 52.0, 52.0, 52.0, 54.0, 54.0, 54.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 87.0, 76.0, 76.0, 76.0, 77.0, 78.0, 108.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 119.0, 117.0, 120.0, 117.0, 124.0, 136.0, 126.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 155.0, 156.0, 154.0, 156.0, 151.0, 152.0, 153.0, 151.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 64.0, 62.0, 62.0, 61.0, 62.0, 62.0, 64.0, 63.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1480.8000000000002, "alertThreshold": 2.0}]} 06:49:31 INFO - Return code: 0 06:49:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:49:31 ERROR - # TBPL SUCCESS # 06:49:31 INFO - Running post-action listener: _resource_record_post_action 06:49:31 INFO - ##### 06:49:31 INFO - ##### Finished run-tests step (success) 06:49:31 INFO - ##### 06:49:31 INFO - Running post-run listener: _resource_record_post_run 06:49:31 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 290816; Write bytes: 506028032; Read time: 64; Write time: 364992 06:49:31 INFO - TinderboxPrint: CPU usage
13.0% 06:49:31 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 64 06:49:31 INFO - TinderboxPrint: I/O write bytes / time
506,028,032 / 364,992 06:49:31 INFO - TinderboxPrint: CPU idle
8,252.7 (87.0%) 06:49:31 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 06:49:31 INFO - TinderboxPrint: Swap in / out
0 / 0 06:49:31 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252690432; Read time: 0; Write time: 228100 06:49:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253337600; Read time: 48; Write time: 136892 06:49:32 INFO - Running post-run listener: _upload_blobber_files 06:49:32 INFO - Blob upload gear active. 06:49:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:49:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:49:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:49:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:49:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:49:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:36 INFO - (blobuploader) - INFO - Done attempting. 06:49:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:49:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:49:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:37 INFO - (blobuploader) - INFO - Done attempting. 06:49:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:49:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:49:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:38 INFO - (blobuploader) - INFO - Done attempting. 06:49:38 INFO - (blobuploader) - INFO - Iteration through files over. 06:49:38 INFO - Return code: 0 06:49:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:49:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:49:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34672c59fe6d7173d891742e9ce13442aff8f4a07b58b787ff16bdfabc11a26ad8d53b6ba8cb2ea0684ce738ffd01f956694bb83b896d7fd5fb4edf879dfa4c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a395e938093e29ced1ef49a880db4abbf9ec523ab781f63414c5301752c2853703a53249c92f7cca569e0a831ad1ed0266f247186fa42e3fcc70264d09cf6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5092086299c312a2db7507a8f5fb15af8e2c2a8e2fae936b8c3eaae4489f66e6801f3fab07923dbedc316c49ce46b8e564ce3e549c3132f4b7cb713c0a0fb96"} 06:49:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:49:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:49:38 INFO - Contents: 06:49:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34672c59fe6d7173d891742e9ce13442aff8f4a07b58b787ff16bdfabc11a26ad8d53b6ba8cb2ea0684ce738ffd01f956694bb83b896d7fd5fb4edf879dfa4c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a395e938093e29ced1ef49a880db4abbf9ec523ab781f63414c5301752c2853703a53249c92f7cca569e0a831ad1ed0266f247186fa42e3fcc70264d09cf6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5092086299c312a2db7507a8f5fb15af8e2c2a8e2fae936b8c3eaae4489f66e6801f3fab07923dbedc316c49ce46b8e564ce3e549c3132f4b7cb713c0a0fb96"} 06:49:38 INFO - Running post-run listener: copy_logs_to_upload_dir 06:49:38 INFO - Copying logs to upload dir... 06:49:38 INFO - mkdir: /builds/slave/test/build/upload/logs 06:49:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.738025 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-06 06:49:37.954763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 06:49:37.958962) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34672c59fe6d7173d891742e9ce13442aff8f4a07b58b787ff16bdfabc11a26ad8d53b6ba8cb2ea0684ce738ffd01f956694bb83b896d7fd5fb4edf879dfa4c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a395e938093e29ced1ef49a880db4abbf9ec523ab781f63414c5301752c2853703a53249c92f7cca569e0a831ad1ed0266f247186fa42e3fcc70264d09cf6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5092086299c312a2db7507a8f5fb15af8e2c2a8e2fae936b8c3eaae4489f66e6801f3fab07923dbedc316c49ce46b8e564ce3e549c3132f4b7cb713c0a0fb96"} build_url:https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/OwAwMWQLQfqFiuuZX9Be9g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34672c59fe6d7173d891742e9ce13442aff8f4a07b58b787ff16bdfabc11a26ad8d53b6ba8cb2ea0684ce738ffd01f956694bb83b896d7fd5fb4edf879dfa4c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a395e938093e29ced1ef49a880db4abbf9ec523ab781f63414c5301752c2853703a53249c92f7cca569e0a831ad1ed0266f247186fa42e3fcc70264d09cf6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5092086299c312a2db7507a8f5fb15af8e2c2a8e2fae936b8c3eaae4489f66e6801f3fab07923dbedc316c49ce46b8e564ce3e549c3132f4b7cb713c0a0fb96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 06:49:37.984335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:49:37.984687) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467810380.831939-475501141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:49:38.069445) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 06:49:38.069766) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 06:49:38.070040) ========= ========= Total master_lag: 0.29 =========