builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1468680898.16 results: success (0) buildid: 20160716052752 builduid: 31c5f612cea846a2ab81f452a421b442 revision: a88bc35e32b1334b0aac964d53ae36b1e4600b7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.156712) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.157064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.157333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.191193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.191458) ========= 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=1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 07:54:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-07-16 07:54:58 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.337571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.337847) ========= 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=1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014694 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:58.388178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 07:54:58.388488) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a88bc35e32b1334b0aac964d53ae36b1e4600b7d --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 a88bc35e32b1334b0aac964d53ae36b1e4600b7d --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=1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 07:54:58,683 truncating revision to first 12 chars 2016-07-16 07:54:58,683 Setting DEBUG logging. 2016-07-16 07:54:58,684 attempt 1/10 2016-07-16 07:54:58,684 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a88bc35e32b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 07:54:59,775 unpacking tar archive at: mozilla-aurora-a88bc35e32b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435061 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 07:54:59.836597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:59.836896) ========= script_repo_revision: a88bc35e32b1334b0aac964d53ae36b1e4600b7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:59.837278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:59.837557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 07:54:59.846423) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-16 07:54:59.846685) ========= /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=1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:55:00 INFO - MultiFileLogger online at 20160716 07:55:00 in /builds/slave/test 07:55:00 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 07:55:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:55:00 INFO - {'append_to_log': False, 07:55:00 INFO - 'base_work_dir': '/builds/slave/test', 07:55:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:55:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:55:00 INFO - 'branch': 'Mozilla-Aurora', 07:55:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:55:00 INFO - 'config_files': ('talos/linux_config.py',), 07:55:00 INFO - 'default_actions': ('clobber', 07:55:00 INFO - 'read-buildbot-config', 07:55:00 INFO - 'download-and-extract', 07:55:00 INFO - 'populate-webroot', 07:55:00 INFO - 'create-virtualenv', 07:55:00 INFO - 'install', 07:55:00 INFO - 'run-tests'), 07:55:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:55:00 INFO - 'download_minidump_stackwalk': True, 07:55:00 INFO - 'download_symbols': 'ondemand', 07:55:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:55:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:55:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:55:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:55:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:55:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:55:00 INFO - 'installer_path': 'installer.exe', 07:55:00 INFO - 'log_level': 'info', 07:55:00 INFO - 'log_name': 'talos', 07:55:00 INFO - 'log_to_console': True, 07:55:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:55:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:55:00 INFO - 'opt_config_files': (), 07:55:00 INFO - 'pip_index': False, 07:55:00 INFO - 'sps_profile': False, 07:55:00 INFO - 'sps_profile_interval': 0, 07:55:00 INFO - 'suite': 'dromaeojs', 07:55:00 INFO - 'system_bits': '32', 07:55:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:55:00 INFO - 'title': 'talos-linux64-ix-027', 07:55:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:55:00 INFO - 'use_talos_json': True, 07:55:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:55:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:55:00 INFO - 'work_dir': 'build'} 07:55:00 INFO - ##### 07:55:00 INFO - ##### Running clobber step. 07:55:00 INFO - ##### 07:55:00 INFO - Running pre-action listener: _resource_record_pre_action 07:55:00 INFO - Running main action method: clobber 07:55:00 INFO - rmtree: /builds/slave/test/build 07:55:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:55:01 INFO - Running post-action listener: _resource_record_post_action 07:55:01 INFO - ##### 07:55:01 INFO - ##### Finished clobber step (success) 07:55:01 INFO - ##### 07:55:01 INFO - ##### 07:55:01 INFO - ##### Running read-buildbot-config step. 07:55:01 INFO - ##### 07:55:01 INFO - Running pre-action listener: _resource_record_pre_action 07:55:01 INFO - Running main action method: read_buildbot_config 07:55:01 INFO - Using buildbot properties: 07:55:01 INFO - { 07:55:01 INFO - "project": "", 07:55:01 INFO - "product": "firefox", 07:55:01 INFO - "script_repo_revision": "production", 07:55:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:55:01 INFO - "repository": "", 07:55:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:55:01 INFO - "buildid": "20160716052752", 07:55:01 INFO - "pgo_build": "True", 07:55:01 INFO - "basedir": "/builds/slave/test", 07:55:01 INFO - "buildnumber": 612, 07:55:01 INFO - "slavename": "talos-linux64-ix-027", 07:55:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:55:01 INFO - "platform": "ubuntu64_hw", 07:55:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:55:01 INFO - "branch": "mozilla-aurora", 07:55:01 INFO - "repo_path": "releases/mozilla-aurora", 07:55:01 INFO - "revision": "a88bc35e32b1334b0aac964d53ae36b1e4600b7d", 07:55:01 INFO - "stage_platform": "linux64-pgo", 07:55:01 INFO - "builduid": "31c5f612cea846a2ab81f452a421b442", 07:55:01 INFO - "slavebuilddir": "test" 07:55:01 INFO - } 07:55:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 07:55:01 INFO - Running post-action listener: _resource_record_post_action 07:55:01 INFO - ##### 07:55:01 INFO - ##### Finished read-buildbot-config step (success) 07:55:01 INFO - ##### 07:55:01 INFO - ##### 07:55:01 INFO - ##### Running download-and-extract step. 07:55:01 INFO - ##### 07:55:01 INFO - Running pre-action listener: _resource_record_pre_action 07:55:01 INFO - Running main action method: download_and_extract 07:55:01 INFO - mkdir: /builds/slave/test/build/tests 07:55:01 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')]} 07:55:01 INFO - https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:55:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:55:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:55:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:04 INFO - Downloaded 1361 bytes. 07:55:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:55:04 INFO - Using the following test package requirements: 07:55:04 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:55:04 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:55:04 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:55:04 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'jsshell-linux-x86_64.zip'], 07:55:04 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:55:04 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:55:04 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:55:04 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:55:04 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:55:04 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:55:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:55:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:55: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')]} 07:55:04 INFO - https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:55:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:55:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:10 INFO - Downloaded 24489278 bytes. 07:55:10 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'] 07:55:10 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 07:55:11 INFO - Return code: 0 07:55:11 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 07:55:11 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')]} 07:55:11 INFO - https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:55:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:55:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:15 INFO - Downloaded 24489278 bytes. 07:55:15 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'] 07:55:15 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 07:55:16 INFO - Return code: 0 07:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:16 INFO - https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:55:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:55:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:55:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:18 INFO - Downloaded 10833369 bytes. 07:55:18 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'] 07:55:18 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 07:55:18 INFO - Return code: 0 07:55:18 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')]} 07:55:18 INFO - https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:55:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:55:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:55:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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 07:55:19 INFO - Downloaded 63639442 bytes. 07:55:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:55:19 INFO - mkdir: /builds/slave/test/properties 07:55:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:55:19 INFO - Writing to file /builds/slave/test/properties/build_url 07:55:19 INFO - Contents: 07:55:19 INFO - build_url:https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:55:20 INFO - Running post-action listener: _resource_record_post_action 07:55:20 INFO - Running post-action listener: set_extra_try_arguments 07:55:20 INFO - ##### 07:55:20 INFO - ##### Finished download-and-extract step (success) 07:55:20 INFO - ##### 07:55:20 INFO - ##### 07:55:20 INFO - ##### Running populate-webroot step. 07:55:20 INFO - ##### 07:55:20 INFO - Running pre-action listener: _resource_record_pre_action 07:55:20 INFO - Running main action method: populate_webroot 07:55:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:55:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:55:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:55:20 INFO - '--tppagecycles', 07:55:20 INFO - '7'], 07:55:20 INFO - 'tests': ['tsvgm']}}, 07:55:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:55:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:55:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:55:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:55:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['damp', 'tps']}, 07:55:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'tests': ['damp', 'tps']}, 07:55:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['dromaeo_dom']}, 07:55:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:55:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['a11yr', 07:55:20 INFO - 'ts_paint', 07:55:20 INFO - 'tpaint', 07:55:20 INFO - 'sessionrestore', 07:55:20 INFO - 'sessionrestore_no_auto_restore', 07:55:20 INFO - 'tabpaint']}, 07:55:20 INFO - 'other-e10s': {'tests': ['a11yr', 07:55:20 INFO - 'ts_paint', 07:55:20 INFO - 'tpaint', 07:55:20 INFO - 'sessionrestore', 07:55:20 INFO - 'sessionrestore_no_auto_restore', 07:55:20 INFO - 'tabpaint']}, 07:55:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:55:20 INFO - 'ts_paint', 07:55:20 INFO - 'tpaint', 07:55:20 INFO - 'sessionrestore', 07:55:20 INFO - 'sessionrestore_no_auto_restore', 07:55:20 INFO - 'tabpaint']}, 07:55:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:55:20 INFO - 'ts_paint', 07:55:20 INFO - 'tpaint', 07:55:20 INFO - 'sessionrestore', 07:55:20 INFO - 'sessionrestore_no_auto_restore', 07:55:20 INFO - 'tabpaint']}, 07:55:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['a11yr', 07:55:20 INFO - 'ts_paint', 07:55:20 INFO - 'tpaint', 07:55:20 INFO - 'sessionrestore', 07:55:20 INFO - 'sessionrestore_no_auto_restore', 07:55:20 INFO - 'tabpaint']}, 07:55:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['a11yr', 07:55:20 INFO - 'ts_paint', 07:55:20 INFO - 'tpaint', 07:55:20 INFO - 'sessionrestore', 07:55:20 INFO - 'sessionrestore_no_auto_restore', 07:55:20 INFO - 'tabpaint']}, 07:55:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['tsvgx', 07:55:20 INFO - 'tsvgr_opacity', 07:55:20 INFO - 'tart', 07:55:20 INFO - 'tscrollx', 07:55:20 INFO - 'cart']}, 07:55:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:55:20 INFO - 'tsvgr_opacity', 07:55:20 INFO - 'tart', 07:55:20 INFO - 'tscrollx', 07:55:20 INFO - 'cart']}, 07:55:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'talos_options': ['--disable-e10s'], 07:55:20 INFO - 'tests': ['tp5o']}, 07:55:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'tests': ['tp5o']}, 07:55:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'talos_options': ['--disable-e10s', 07:55:20 INFO - '--xperf_path', 07:55:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:20 INFO - 'tests': ['tp5n']}, 07:55:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:20 INFO - 'talos_options': ['--xperf_path', 07:55:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:20 INFO - 'tests': ['tp5n']}}, 07:55:20 INFO - 'talos.zip': {'path': '', 07:55:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:55:20 INFO - Running post-action listener: _resource_record_post_action 07:55:20 INFO - ##### 07:55:20 INFO - ##### Finished populate-webroot step (success) 07:55:20 INFO - ##### 07:55:20 INFO - ##### 07:55:20 INFO - ##### Running create-virtualenv step. 07:55:20 INFO - ##### 07:55:20 INFO - Running pre-action listener: _resource_record_pre_action 07:55:20 INFO - Running main action method: create_virtualenv 07:55:20 INFO - Creating virtualenv /builds/slave/test/build/venv 07:55:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:55:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:55:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:55:20 INFO - Using real prefix '/usr' 07:55:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:55:21 INFO - Installing distribute.............................................................................................................................................................................................done. 07:55:23 INFO - Installing pip.................done. 07:55:23 INFO - Return code: 0 07:55:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:55:23 INFO - Using env: {'DISPLAY': ':0', 07:55:23 INFO - 'HOME': '/home/cltbld', 07:55:23 INFO - 'LANG': 'en_US.UTF-8', 07:55:23 INFO - 'LANGUAGE': 'en_US:en', 07:55:23 INFO - 'LOGNAME': 'cltbld', 07:55:23 INFO - 'MAIL': '/var/mail/cltbld', 07:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:23 INFO - 'MOZ_NO_REMOTE': '1', 07:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:23 INFO - 'NO_EM_RESTART': '1', 07:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:23 INFO - 'PWD': '/builds/slave/test', 07:55:23 INFO - 'SHELL': '/bin/bash', 07:55:23 INFO - 'SHLVL': '1', 07:55:23 INFO - 'TERM': 'linux', 07:55:23 INFO - 'TMOUT': '86400', 07:55:23 INFO - 'USER': 'cltbld', 07:55:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:23 INFO - '_': '/tools/buildbot/bin/python'} 07:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:55:23 INFO - Cleaning up... 07:55:23 INFO - Return code: 0 07:55:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:55:23 INFO - Using env: {'DISPLAY': ':0', 07:55:23 INFO - 'HOME': '/home/cltbld', 07:55:23 INFO - 'LANG': 'en_US.UTF-8', 07:55:23 INFO - 'LANGUAGE': 'en_US:en', 07:55:23 INFO - 'LOGNAME': 'cltbld', 07:55:23 INFO - 'MAIL': '/var/mail/cltbld', 07:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:23 INFO - 'MOZ_NO_REMOTE': '1', 07:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:23 INFO - 'NO_EM_RESTART': '1', 07:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:23 INFO - 'PWD': '/builds/slave/test', 07:55:23 INFO - 'SHELL': '/bin/bash', 07:55:23 INFO - 'SHLVL': '1', 07:55:23 INFO - 'TERM': 'linux', 07:55:23 INFO - 'TMOUT': '86400', 07:55:23 INFO - 'USER': 'cltbld', 07:55:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:23 INFO - '_': '/tools/buildbot/bin/python'} 07:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:23 INFO - Downloading/unpacking psutil>=3.1.1 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:25 INFO - Installing collected packages: psutil 07:55:25 INFO - Running setup.py install for psutil 07:55:25 INFO - building 'psutil._psutil_linux' extension 07:55:25 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 07:55:25 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 07:55:25 INFO - building 'psutil._psutil_posix' extension 07:55:25 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 07:55:25 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 07:55:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:25 INFO - Successfully installed psutil 07:55:25 INFO - Cleaning up... 07:55:26 INFO - Return code: 0 07:55:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:55:26 INFO - Using env: {'DISPLAY': ':0', 07:55:26 INFO - 'HOME': '/home/cltbld', 07:55:26 INFO - 'LANG': 'en_US.UTF-8', 07:55:26 INFO - 'LANGUAGE': 'en_US:en', 07:55:26 INFO - 'LOGNAME': 'cltbld', 07:55:26 INFO - 'MAIL': '/var/mail/cltbld', 07:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:26 INFO - 'MOZ_NO_REMOTE': '1', 07:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:26 INFO - 'NO_EM_RESTART': '1', 07:55:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:26 INFO - 'PWD': '/builds/slave/test', 07:55:26 INFO - 'SHELL': '/bin/bash', 07:55:26 INFO - 'SHLVL': '1', 07:55:26 INFO - 'TERM': 'linux', 07:55:26 INFO - 'TMOUT': '86400', 07:55:26 INFO - 'USER': 'cltbld', 07:55:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:26 INFO - '_': '/tools/buildbot/bin/python'} 07:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:55:28 INFO - Installing collected packages: mozsystemmonitor 07:55:28 INFO - Running setup.py install for mozsystemmonitor 07:55:28 INFO - Successfully installed mozsystemmonitor 07:55:28 INFO - Cleaning up... 07:55:28 INFO - Return code: 0 07:55:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:55:28 INFO - Using env: {'DISPLAY': ':0', 07:55:28 INFO - 'HOME': '/home/cltbld', 07:55:28 INFO - 'LANG': 'en_US.UTF-8', 07:55:28 INFO - 'LANGUAGE': 'en_US:en', 07:55:28 INFO - 'LOGNAME': 'cltbld', 07:55:28 INFO - 'MAIL': '/var/mail/cltbld', 07:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:28 INFO - 'MOZ_NO_REMOTE': '1', 07:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:28 INFO - 'NO_EM_RESTART': '1', 07:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:28 INFO - 'PWD': '/builds/slave/test', 07:55:28 INFO - 'SHELL': '/bin/bash', 07:55:28 INFO - 'SHLVL': '1', 07:55:28 INFO - 'TERM': 'linux', 07:55:28 INFO - 'TMOUT': '86400', 07:55:28 INFO - 'USER': 'cltbld', 07:55:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:28 INFO - '_': '/tools/buildbot/bin/python'} 07:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:28 INFO - Downloading/unpacking jsonschema==2.5.1 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55:30 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:30 INFO - warning: no files found matching '*.txt' 07:55:30 INFO - no previously-included directories found matching 'build' 07:55:30 INFO - no previously-included directories found matching 'dist' 07:55:30 INFO - no previously-included directories found matching '.git*' 07:55:30 INFO - Installing collected packages: jsonschema, functools32 07:55:30 INFO - Running setup.py install for functools32 07:55:30 INFO - warning: no files found matching '*.txt' 07:55:30 INFO - no previously-included directories found matching 'build' 07:55:30 INFO - no previously-included directories found matching 'dist' 07:55:30 INFO - no previously-included directories found matching '.git*' 07:55:30 INFO - Successfully installed jsonschema functools32 07:55:30 INFO - Cleaning up... 07:55:30 INFO - Return code: 0 07:55:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:55:30 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')]} 07:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:30 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')]} 07:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:30 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 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:30 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 07:55:30 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 07:55:30 INFO - Using env: {'DISPLAY': ':0', 07:55:30 INFO - 'HOME': '/home/cltbld', 07:55:30 INFO - 'LANG': 'en_US.UTF-8', 07:55:30 INFO - 'LANGUAGE': 'en_US:en', 07:55:30 INFO - 'LOGNAME': 'cltbld', 07:55:30 INFO - 'MAIL': '/var/mail/cltbld', 07:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:30 INFO - 'MOZ_NO_REMOTE': '1', 07:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:30 INFO - 'NO_EM_RESTART': '1', 07:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:30 INFO - 'PWD': '/builds/slave/test', 07:55:30 INFO - 'SHELL': '/bin/bash', 07:55:30 INFO - 'SHLVL': '1', 07:55:30 INFO - 'TERM': 'linux', 07:55:30 INFO - 'TMOUT': '86400', 07:55:30 INFO - 'USER': 'cltbld', 07:55:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:30 INFO - '_': '/tools/buildbot/bin/python'} 07:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:31 INFO - Downloading/unpacking blobuploader==1.2.4 07:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:33 INFO - Downloading blobuploader-1.2.4.tar.gz 07:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:55:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:55:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:33 INFO - Downloading docopt-0.6.1.tar.gz 07:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:33 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:33 INFO - Running setup.py install for blobuploader 07:55:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:55:33 INFO - Running setup.py install for requests 07:55:34 INFO - Running setup.py install for docopt 07:55:34 INFO - Successfully installed blobuploader requests docopt 07:55:34 INFO - Cleaning up... 07:55:34 INFO - Return code: 0 07:55:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55: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')]} 07:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:34 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 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:34 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 07:55:34 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 07:55:34 INFO - Using env: {'DISPLAY': ':0', 07:55:34 INFO - 'HOME': '/home/cltbld', 07:55:34 INFO - 'LANG': 'en_US.UTF-8', 07:55:34 INFO - 'LANGUAGE': 'en_US:en', 07:55:34 INFO - 'LOGNAME': 'cltbld', 07:55:34 INFO - 'MAIL': '/var/mail/cltbld', 07:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:34 INFO - 'MOZ_NO_REMOTE': '1', 07:55:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:34 INFO - 'NO_EM_RESTART': '1', 07:55:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:34 INFO - 'PWD': '/builds/slave/test', 07:55:34 INFO - 'SHELL': '/bin/bash', 07:55:34 INFO - 'SHLVL': '1', 07:55:34 INFO - 'TERM': 'linux', 07:55:34 INFO - 'TMOUT': '86400', 07:55:34 INFO - 'USER': 'cltbld', 07:55:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:34 INFO - '_': '/tools/buildbot/bin/python'} 07:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:34 INFO - Running setup.py (path:/tmp/pip-ND8CNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:34 INFO - Running setup.py (path:/tmp/pip-foxoxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:34 INFO - Running setup.py (path:/tmp/pip-ZSLJHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:34 INFO - Running setup.py (path:/tmp/pip-m5kWva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:34 INFO - Running setup.py (path:/tmp/pip-PIMJ9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:34 INFO - Running setup.py (path:/tmp/pip-3AE2ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:35 INFO - Running setup.py (path:/tmp/pip-O8fUyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:35 INFO - Running setup.py (path:/tmp/pip-xbClwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:35 INFO - Running setup.py (path:/tmp/pip-VQeK4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:35 INFO - Running setup.py (path:/tmp/pip-dB3NQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:35 INFO - Running setup.py (path:/tmp/pip-jJQetG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:35 INFO - Running setup.py (path:/tmp/pip-h3YjjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:35 INFO - Running setup.py (path:/tmp/pip-hBwqCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:35 INFO - Running setup.py (path:/tmp/pip-go5Z1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:35 INFO - Running setup.py (path:/tmp/pip-dg9wCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:35 INFO - Running setup.py (path:/tmp/pip-9XBqw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:35 INFO - Running setup.py (path:/tmp/pip-onFFoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:35 INFO - Running setup.py install for manifestparser 07:55:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:55:35 INFO - Running setup.py install for mozcrash 07:55:36 INFO - Running setup.py install for mozdebug 07:55:36 INFO - Running setup.py install for mozdevice 07:55:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Running setup.py install for mozfile 07:55:36 INFO - Running setup.py install for mozhttpd 07:55:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Running setup.py install for mozinfo 07:55:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Running setup.py install for mozInstall 07:55:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Running setup.py install for mozleak 07:55:36 INFO - Running setup.py install for mozlog 07:55:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Running setup.py install for moznetwork 07:55:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:55:36 INFO - Running setup.py install for mozprocess 07:55:37 INFO - Running setup.py install for mozprofile 07:55:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:55:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:55:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:55:37 INFO - Running setup.py install for mozrunner 07:55:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:55:37 INFO - Running setup.py install for mozscreenshot 07:55:37 INFO - Running setup.py install for moztest 07:55:37 INFO - Running setup.py install for mozversion 07:55:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:55:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:55:37 INFO - Cleaning up... 07:55:37 INFO - Return code: 0 07:55:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:37 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 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:37 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 07:55:37 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 07:55:37 INFO - Using env: {'DISPLAY': ':0', 07:55:37 INFO - 'HOME': '/home/cltbld', 07:55:37 INFO - 'LANG': 'en_US.UTF-8', 07:55:37 INFO - 'LANGUAGE': 'en_US:en', 07:55:37 INFO - 'LOGNAME': 'cltbld', 07:55:37 INFO - 'MAIL': '/var/mail/cltbld', 07:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:37 INFO - 'MOZ_NO_REMOTE': '1', 07:55:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:37 INFO - 'NO_EM_RESTART': '1', 07:55:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:37 INFO - 'PWD': '/builds/slave/test', 07:55:37 INFO - 'SHELL': '/bin/bash', 07:55:37 INFO - 'SHLVL': '1', 07:55:37 INFO - 'TERM': 'linux', 07:55:37 INFO - 'TMOUT': '86400', 07:55:37 INFO - 'USER': 'cltbld', 07:55:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:37 INFO - '_': '/tools/buildbot/bin/python'} 07:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:37 INFO - Running setup.py (path:/tmp/pip-_RQH9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:37 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)) 07:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:37 INFO - Running setup.py (path:/tmp/pip-kgG0Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:37 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)) 07:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:37 INFO - Running setup.py (path:/tmp/pip-Tgwk8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:38 INFO - Running setup.py (path:/tmp/pip-jxvyfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:38 INFO - Running setup.py (path:/tmp/pip-5h1fKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:38 INFO - Running setup.py (path:/tmp/pip-2DFxIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:38 INFO - Running setup.py (path:/tmp/pip-g5xmm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:38 INFO - Running setup.py (path:/tmp/pip-L16J9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:38 INFO - Running setup.py (path:/tmp/pip-xy0ky1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:38 INFO - Running setup.py (path:/tmp/pip-duxAIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:38 INFO - Running setup.py (path:/tmp/pip-Zxwaxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:38 INFO - Running setup.py (path:/tmp/pip-iW6VT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:38 INFO - Running setup.py (path:/tmp/pip-KreY2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:38 INFO - Running setup.py (path:/tmp/pip-_7Swrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:38 INFO - Running setup.py (path:/tmp/pip-4v_UWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:38 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)) 07:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:38 INFO - Running setup.py (path:/tmp/pip-EYvpZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:39 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)) 07:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:39 INFO - Running setup.py (path:/tmp/pip-8hJGVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:39 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)) 07:55:39 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)) 07:55:39 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)) 07:55:39 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)) 07:55:39 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)) 07:55:39 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)) 07:55:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55:40 INFO - Downloading blessings-1.6.tar.gz 07:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:41 INFO - Installing collected packages: blessings 07:55:41 INFO - Running setup.py install for blessings 07:55:41 INFO - Successfully installed blessings 07:55:41 INFO - Cleaning up... 07:55:41 INFO - Return code: 0 07:55:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:55:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:41 INFO - Reading from file tmpfile_stdout 07:55:41 INFO - Current package versions: 07:55:41 INFO - argparse == 1.2.1 07:55:41 INFO - blessings == 1.6 07:55:41 INFO - blobuploader == 1.2.4 07:55:41 INFO - docopt == 0.6.1 07:55:41 INFO - functools32 == 3.2.3-2 07:55:41 INFO - jsonschema == 2.5.1 07:55:41 INFO - manifestparser == 1.1 07:55:41 INFO - mozInstall == 1.12 07:55:41 INFO - mozcrash == 0.17 07:55:41 INFO - mozdebug == 0.1 07:55:41 INFO - mozdevice == 0.48 07:55:41 INFO - mozfile == 1.2 07:55:41 INFO - mozhttpd == 0.7 07:55:41 INFO - mozinfo == 0.9 07:55:41 INFO - mozleak == 0.1 07:55:41 INFO - mozlog == 3.2 07:55:41 INFO - moznetwork == 0.27 07:55:41 INFO - mozprocess == 0.23 07:55:41 INFO - mozprofile == 0.28 07:55:41 INFO - mozrunner == 6.12 07:55:41 INFO - mozscreenshot == 0.1 07:55:41 INFO - mozsystemmonitor == 0.3 07:55:41 INFO - moztest == 0.7 07:55:41 INFO - mozversion == 1.4 07:55:41 INFO - psutil == 3.1.1 07:55:41 INFO - requests == 1.2.3 07:55:41 INFO - wsgiref == 0.1.2 07:55:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:41 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')]} 07:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:41 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')]} 07:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:41 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 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:41 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 07:55:41 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 07:55:41 INFO - Using env: {'DISPLAY': ':0', 07:55:41 INFO - 'HOME': '/home/cltbld', 07:55:41 INFO - 'LANG': 'en_US.UTF-8', 07:55:41 INFO - 'LANGUAGE': 'en_US:en', 07:55:41 INFO - 'LOGNAME': 'cltbld', 07:55:41 INFO - 'MAIL': '/var/mail/cltbld', 07:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:41 INFO - 'MOZ_NO_REMOTE': '1', 07:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:41 INFO - 'NO_EM_RESTART': '1', 07:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:41 INFO - 'PWD': '/builds/slave/test', 07:55:41 INFO - 'SHELL': '/bin/bash', 07:55:41 INFO - 'SHLVL': '1', 07:55:41 INFO - 'TERM': 'linux', 07:55:41 INFO - 'TMOUT': '86400', 07:55:41 INFO - 'USER': 'cltbld', 07:55:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:41 INFO - '_': '/tools/buildbot/bin/python'} 07:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 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)) 07:55:41 INFO - Cleaning up... 07:55:41 INFO - Return code: 0 07:55:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:55:41 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')]} 07:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:41 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')]} 07:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:41 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 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:41 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 07:55:41 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 07:55:41 INFO - Using env: {'DISPLAY': ':0', 07:55:41 INFO - 'HOME': '/home/cltbld', 07:55:41 INFO - 'LANG': 'en_US.UTF-8', 07:55:41 INFO - 'LANGUAGE': 'en_US:en', 07:55:41 INFO - 'LOGNAME': 'cltbld', 07:55:41 INFO - 'MAIL': '/var/mail/cltbld', 07:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:41 INFO - 'MOZ_NO_REMOTE': '1', 07:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:41 INFO - 'NO_EM_RESTART': '1', 07:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:41 INFO - 'PWD': '/builds/slave/test', 07:55:41 INFO - 'SHELL': '/bin/bash', 07:55:41 INFO - 'SHLVL': '1', 07:55:41 INFO - 'TERM': 'linux', 07:55:41 INFO - 'TMOUT': '86400', 07:55:41 INFO - 'USER': 'cltbld', 07:55:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:41 INFO - '_': '/tools/buildbot/bin/python'} 07:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:55:41 INFO - Cleaning up... 07:55:41 INFO - Return code: 0 07:55:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:55:41 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')]} 07:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:41 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')]} 07:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:41 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 0x7f84e3332f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, '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': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', '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 07:55:41 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 07:55:41 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 07:55:41 INFO - Using env: {'DISPLAY': ':0', 07:55:41 INFO - 'HOME': '/home/cltbld', 07:55:41 INFO - 'LANG': 'en_US.UTF-8', 07:55:41 INFO - 'LANGUAGE': 'en_US:en', 07:55:41 INFO - 'LOGNAME': 'cltbld', 07:55:41 INFO - 'MAIL': '/var/mail/cltbld', 07:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:41 INFO - 'MOZ_NO_REMOTE': '1', 07:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:41 INFO - 'NO_EM_RESTART': '1', 07:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:41 INFO - 'PWD': '/builds/slave/test', 07:55:41 INFO - 'SHELL': '/bin/bash', 07:55:41 INFO - 'SHLVL': '1', 07:55:41 INFO - 'TERM': 'linux', 07:55:41 INFO - 'TMOUT': '86400', 07:55:41 INFO - 'USER': 'cltbld', 07:55:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:41 INFO - '_': '/tools/buildbot/bin/python'} 07:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:42 INFO - Downloading/unpacking flake8 07:55:42 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 07:55:42 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 07:55:42 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 07:55:42 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 07:55:42 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 07:55:42 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 07:55:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:55:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:55:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 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 07:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:55:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:44 INFO - no previously-included directories found matching 'docs/_build' 07:55:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:55:45 INFO - Running setup.py install for pep8 07:55:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:45 INFO - no previously-included directories found matching 'docs/_build' 07:55:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:55:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:55:45 INFO - Cleaning up... 07:55:45 INFO - Return code: 0 07:55:45 INFO - Running post-action listener: _resource_record_post_action 07:55:45 INFO - Running post-action listener: _start_resource_monitoring 07:55:45 INFO - Starting resource monitoring. 07:55:45 INFO - ##### 07:55:45 INFO - ##### Finished create-virtualenv step (success) 07:55:45 INFO - ##### 07:55:45 INFO - ##### 07:55:45 INFO - ##### Running install step. 07:55:45 INFO - ##### 07:55:45 INFO - Running pre-action listener: _resource_record_pre_action 07:55:45 INFO - Running main action method: install 07:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:45 INFO - Reading from file tmpfile_stdout 07:55:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:55:45 INFO - Reading from file tmpfile_stdout 07:55:45 INFO - Output received: 07:55:45 INFO - Usage: mozinstall [options] installer 07:55:45 INFO - Options: 07:55:45 INFO - -h, --help show this help message and exit 07:55:45 INFO - -d DEST, --destination=DEST 07:55:45 INFO - Directory to install application into. [default: 07:55:45 INFO - "/builds/slave/test"] 07:55:45 INFO - --app=APP Application being installed. [default: firefox] 07:55:45 INFO - mkdir: /builds/slave/test/build/application 07:55:45 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'] 07:55:45 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 07:56:01 INFO - Reading from file tmpfile_stdout 07:56:01 INFO - Output received: 07:56:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:56:01 INFO - Running post-action listener: _resource_record_post_action 07:56:01 INFO - ##### 07:56:01 INFO - ##### Finished install step (success) 07:56:01 INFO - ##### 07:56:01 INFO - ##### 07:56:01 INFO - ##### Running run-tests step. 07:56:01 INFO - ##### 07:56:01 INFO - Running pre-action listener: _resource_record_pre_action 07:56:01 INFO - Running main action method: run_tests 07:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:56:01 INFO - Python 2.7.3 07:56:01 INFO - Return code: 0 07:56:01 INFO - grabbing minidump binary from tooltool 07:56:01 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')]} 07:56:01 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 0x13a01c0>, '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 0x13a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:56:01 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 07:56:01 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 07:56:01 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 07:56:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:01 INFO - Return code: 0 07:56:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:56:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:56:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:56:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:56:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:56:02 INFO - Return code: 0 07:56:02 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/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 07:56:02 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/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 07:56:02 INFO - Using env: {'DISPLAY': ':0', 07:56:02 INFO - 'HOME': '/home/cltbld', 07:56:02 INFO - 'LANG': 'en_US.UTF-8', 07:56:02 INFO - 'LANGUAGE': 'en_US:en', 07:56:02 INFO - 'LOGNAME': 'cltbld', 07:56:02 INFO - 'MAIL': '/var/mail/cltbld', 07:56:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:56:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:02 INFO - 'MOZ_NO_REMOTE': '1', 07:56:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:02 INFO - 'NO_EM_RESTART': '1', 07:56:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:02 INFO - 'PWD': '/builds/slave/test', 07:56:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:56:02 INFO - 'SHELL': '/bin/bash', 07:56:02 INFO - 'SHLVL': '1', 07:56:02 INFO - 'TERM': 'linux', 07:56:02 INFO - 'TMOUT': '86400', 07:56:02 INFO - 'USER': 'cltbld', 07:56:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054', 07:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:02 INFO - '_': '/tools/buildbot/bin/python'} 07:56:02 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/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 07:56:02 INFO - mozversion application_buildid: 20160716052752 07:56:02 INFO - mozversion application_changeset: a88bc35e32b1334b0aac964d53ae36b1e4600b7d 07:56:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:56:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:56:02 INFO - mozversion application_name: Firefox 07:56:02 INFO - mozversion application_remotingname: firefox-dev 07:56:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:56:02 INFO - mozversion application_vendor: Mozilla 07:56:02 INFO - mozversion application_version: 49.0a2 07:56:02 INFO - mozversion platform_buildid: 20160716052752 07:56:02 INFO - mozversion platform_changeset: a88bc35e32b1334b0aac964d53ae36b1e4600b7d 07:56:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:56:02 INFO - mozversion platform_version: 49.0a2 07:56:02 INFO - using testdate: 1468680962 07:56:02 INFO - actual date: 1468680962 07:56:02 INFO - starting webserver on 'localhost:58734' 07:56:02 INFO - SUITE-START | Running 2 tests 07:56:02 INFO - TEST-START | dromaeo_css 07:56:02 INFO - operating with platform_type : linux_ 07:56:02 INFO - Initialising browser for dromaeo_css test... 07:56:02 INFO - TEST-INFO | started process 32745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp23XZ_s/profile http://localhost:58734/getInfo.html) 07:56:06 INFO - PROCESS | 32745 | __metrics Screen width/height:1600/1200 07:56:06 INFO - PROCESS | 32745 | colorDepth:24 07:56:06 INFO - PROCESS | 32745 | Browser inner width/height: 1024/697 07:56:06 INFO - PROCESS | 32745 | __metrics 07:56:07 INFO - PROCESS | 32745 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:56:07 ERROR - PROCESS | 32745 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:56:08 INFO - TEST-INFO | 32745: exit 0 07:56:08 INFO - Browser initialized. 07:56:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:56:08 INFO - TEST-INFO | started process 377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp23XZ_s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:19 INFO - PROCESS | 377 | RSS: Main: 145281024 07:56:19 INFO - PROCESS | 377 | 07:57:11 INFO - PROCESS | 377 | 1468681031064 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] 07:59:19 INFO - PROCESS | 377 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58734/tests/dromaeo/cssquery-ext.html) 07:59:20 INFO - PROCESS | 377 | RSS: Main: 248438784 07:59:20 INFO - PROCESS | 377 | 08:02:22 INFO - PROCESS | 377 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-ext.html (next: http://localhost:58734/tests/dromaeo/cssquery-jquery.html) 08:02:23 INFO - PROCESS | 377 | RSS: Main: 230694912 08:02:23 INFO - PROCESS | 377 | 08:05:25 INFO - PROCESS | 377 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58734/tests/dromaeo/cssquery-mootools.html) 08:05:25 INFO - PROCESS | 377 | RSS: Main: 230612992 08:05:25 INFO - PROCESS | 377 | 08:08:27 INFO - PROCESS | 377 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58734/tests/dromaeo/cssquery-prototype.html) 08:08:28 INFO - PROCESS | 377 | RSS: Main: 223240192 08:08:28 INFO - PROCESS | 377 | 08:11:31 INFO - PROCESS | 377 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58734/tests/dromaeo/cssquery-yui.html) 08:11:31 INFO - PROCESS | 377 | RSS: Main: 215748608 08:11:31 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-yui.html (next: http://localhost:58734/tests/dromaeo/cssquery-dojo.html) 08:14:34 INFO - PROCESS | 377 | RSS: Main: 255627264 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | __start_tp_report 08:14:34 INFO - PROCESS | 377 | _x_x_mozilla_page_load 08:14:34 INFO - PROCESS | 377 | _x_x_mozilla_page_load_details 08:14:34 INFO - PROCESS | 377 | |i|pagename|runs| 08:14:34 INFO - PROCESS | 377 | |0;dojo.html;3349.5310656508095;3369.5282660427542;3370.2248482848945;3374.6119196292434;3417.521546983421;5501.697406642633;5595.944040559593;5598.1602759586085;5599.1041433370665;5639.182318563806;5478;5500.779968801243;5508.091164957787;5508.586855985797;5544.500994910457;4944.406671199461;4972.32873562069;4993.950060499403;5036.546710796028;5078.746062696869;4926.0394223126505;5067.822626208083;5105.821296254632;5109.974450127745;5112.233165025239;5018.34761481007;5058.4435712071645;5074.619403544731;5095.464976177504;5103.489651034885;5152.098382783035;5174.094533456668;5175.560077393445;5176.55999240065;5200.7399630018535;4990.850274491771;5010.72441015744;5027.899442011139;5086.694798312076;5100.336956195708;5456.972715136439;5503.504684578367;5522.282103326582;5544.528715059225;5551.944480555224;6057.636541807506;6075.362086980892;6077.513798896122;6077.908831367533;6080.30076541199;5949.345571987078;6006.459418652343;6022.909656355115;6069.453749162597;6070.791092195466;5638.182463542763;5681.715914204273;5692.772289108472;5694.316681998187;5695.829125126253;5947.762089516371;6170.660613666201;6182.196314479179;6182.381761823872;6184.845378865564;5860.970695146497;5870.207521984563;5885.970570147208;5985.40145985398;5997.790077347272;6051.880402125621;6054.939450605438;6081.422264884829;6083.330833608299;6085.543584231112;5714.657120572779;5911.349751527328;5949.0481522956115;5981.940180598225;6004.0093384591055;5973.402659733992;6008.789692360834;6032.758689652364;6046.2139921809885;6078.300995385587;4638.165130276515;4639.350490931272;4639.86080417588;4642.234031384851;4668.159731248408;4034.495688038995;4035.7174997749876;4036.7779772112817;4138.689598280081;4155;5685.573581981368;5712.257406537124;5713.314402271754;5717.942820571741;5740.598158128891;5952.9107063394085;5997.430244126801;6008;6018.729157187937;6044.969775151096;5536.916946245809;5593.664380137124;5636.520895723909;5641.26663533738;5718.51392631631;5164.406093299243;5164.509371609691;5169.224616307584;5177.741112944338;5195.662281951737;6192.411720886508;6199.969000155061;6203.100550420164;6204.844878877974;6205.193324867739;5912.763489460545;5955.285365756137;5959.910601340896;5982.282126144716;6022.397760223943;6196.194494715658;6270.028145637433;6270.4670103039925;6272.905906411499;6278.6546739929745;5925.911111333247;5926.2295901532525;5934.554908381802;5937.762489500545;5966.313873904556;5731.455511726379;5860.472557469848;5912.674802885883;5915.142304365757;5996.5502587305255;5753.108268218432;5771.653700777967;5796.275465566804;5796.913046304393;5821.185034095315;5756.079027355603;5783.901058798815;5794.942050579609;5802.47777700009;5803.564732644984;5576.832695019156;5585.078462053716;5606.24315717373;5621.184928185472;5632.127020311858;5742.483176513967;5743.59794814359;5767.077267637158;5773.769049238152;5776.913346299725;5589.888202236014;5617.662940223599;5622.353429355513;5630.0147474191035;5646.830595082154 08:14:34 INFO - PROCESS | 377 | |1;ext.html;598.4075764992656;627.7865525721255;645.2676212498816;652.5660435810184;658.3613894522312;33480.66519334806;36724.81637591808;36789.26421471569;45122;46164;47928;48337.75831120848;48418.51581484184;48448;48513;9020.548972551363;9186.954065229698;9192.540372981357;9193.816123677523;9195.724128276162;8180.059293181301;10753.462326883664;10989.61536346228;10997;11443.084553235722;10932.836007459895;11011.61459348923;11019.724506887353;11026.062784663312;11034.724131896686;8348.874766878502;10997.230193886431;11069.114470842313;11141.832872506919;11150.052245559138;10602.151827853753;10674.893251067468;11064.17018723599;11080.168987325982;11099.667009989713;46060.76969615131;46379;46483.767581161876;46673.766631166625;46702.53297467016;3704.3147017801793;3749.4750734897134;3750.2312026034597;3785.356489396809;3896.1428485733095;35754.821225893706;36094.278114437824;36159.81920090409;36225.45661815075;36321.273574528364;4647.88380290492;4666.440027196724;4708.74101924394;4718.268668356376;4793.257045158006;423131;424552.9999999969;424731;424983;429900;38490.422643660364;39872.40191397131;70195.29804701888;71121;71125;42033;42075.7896210517;42159;42216;42297.788511057246;15639.452619158275;15665.451709190123;15689.137097459521;15693.058416495047;15702.68594628101;11848.940755296167;13584.388702508213;13604.455821767217;13639.931800341134;13814.861851381558;9507.904920950701;9525;9551.188149007274;9588.137067663944;9615.471149086867;3505.859765609347;3637.181634132352;3670.853165873335;3671.5594128704724;3676.76101053436;1126.222906194723;1159.211736019498;1202.5310129049678;1209.770143672717;1212.6907638552113;33877.83061084679;34769.30461390808;34892.65107348894;34970.82514587411;35519.64480355215;1104.8066588347008;1169.6900321414832;1190.077689790402;1244.3156264054915;1250.206119114369;16658.417450342196;17170.656586868194;17441.912790435967;17582.824171758373;17594.736078958827;688809;689020;691207;691525;695045;61607.691961540804;62544;62610.68694656497;62630.68684656548;62671.373286267466;1363.9931800340935;1421.4243231491262;1454.4400405843614;1471.720373129102;1475.3066058952274;32534.511982320757;36759.448608271436;37099.44350834793;37312.253754925296;37359.25281494409;52466;52746.73626631996;53372.73313633562;53394;53506.197407039705;455628;460387;463888;465344;465441;26927.730722693304;30005.849970750005;30803.383932321678;30924.84537577388;31034.379312413173;51069.74465127799;51239;51311.74344128255;51375.743121284155;52500.73749631227;41046.1790764189;41649.1670166601;42671.3599296017;43156.13687726291;43223.56776432195;35445.82277088701;35461;35849.64150358463;36047.639523604426;36372.27255454929;42462.57537424586;42599.7870010648;46451.76774116108;46471.76764116293;48075.27887081627;37530.437043444916;40194;40910.59089409187;41237.79381103075;41585.792071039454;30364.544531831598;30532.542011869395;30585.54121688221;30616.234594135323;30964.380712385177 08:14:34 INFO - PROCESS | 377 | |2;jquery.html;395.2667801228721;425.3768229543718;426.0966750488964;431.30344493642775;439.65706748736;18896.811031889676;19654;20507.17971281147;20578.176872925083;20655.483612909684;19365.90317048413;19503.804961950376;19714.507137321572;20154.093065812038;20268.39194824154;5646.407127251631;5915.822525324247;5957.731902064417;5963.522918166558;5968.224130862982;4290.656747460212;4421.314696222074;5892.057270836667;5949.405059494059;6635.071090047397;6578.93421065788;6595.208574970986;6602.966985165068;6604.570702904296;6611.305812889649;6478.708458119396;6516.185476815398;6585.440237579812;6633.369829866179;6637.269900310962;3971.980140099281;4153.418521407006;4177.644900183488;5898.321693005317;5915.911261331084;22356.55286894253;23118.1908633197;23388.415289617726;24858;25060.248192554252;2473.6165894286414;2508.5986242201343;2682.973170268292;2783.73554512321;2962.525995840677;14152.36314365856;15002.699946001128;15106.244687765568;15161.518040903922;15247.23763811805;2071.658176400892;2078.833693304532;2097.8216851567636;2180.2805074325433;2202.427368884086;53591.19613205805;66624.6668766653;80077.59961200214;80990.59504702498;83506.16493835044;11580.594679186188;11619.477123529461;11773.823392649118;11810.645680629596;11826.113041521749;15766.290516926765;16305.184740763152;16308;16315;16484.83515164833;7949.125596184415;8026.518408895485;8113.634886430124;8186.959065204635;8205.671773129008;7324.707011719578;7730.072391313079;7734.5359278443475;7775.339096176888;7796.727114550963;6957.478189135733;7003.8599228015155;7095.964520177469;7132.893006604905;7205.855882882418;2046;2075.2529089527757;2076.8338532917332;2082.083883091435;2110.5884352551107;1040.7242080848582;1066.653337665262;1134.971625709364;1136.2160109524566;1161.4134861894859;19878.801211987986;20645.483862903246;20847.687284690437;20848.895755521124;20854;1117.636768050387;1136.085451211766;1168.1472525056756;1180.7697498987786;1190.2679851891198;11239.943800280946;11855.762884742257;12018.33899135556;12032.699182520508;12083.395830208454;465967.6911308156;500811;504696;507363;512824;85174.57412712897;87052;87455;88257.55871220602;88541.55729221313;1099.7745462180235;1111.1777284809184;1114.8717897441736;1115.4311301236428;1141.7088642396136;17498.82501174972;17809.554761131076;17856.196471158568;18111.72832407541;18407.355742548945;38255.42616860805;38310.61689383182;38572;40268;40670.59329406668;55485;57392.71303643455;57549.712251438476;57713;57770;9160.770980725269;9188.678396256098;9319.673811416567;9345.299102567198;9379.968203497747;13205.603831885059;13257.270850103338;13269.86730132725;13545.187288762705;14096.50662226817;11584.420778961186;11910.583129590423;12006.519739210335;12299;12732.23606583608;11104.888951110708;11759.118066144902;11957.521699132285;11966.880331196577;11993.760124797629;11660.65018049426;12375.62873113808;12407.44166512491;12546.30995295231;12746.553870614483;9090.36367454272;9113.316501262565;9170.67902623405;9252;9423;12161.817572736592;12249.510019599473;12301.692457688629;12717.55488557896;12886.67783305425 08:14:34 INFO - PROCESS | 377 | |3;mootools.html;1432.8065711128995;1570.356153976869;1598.4165779490486;1774.520879362572;1917.1947781931588;8991.235744961677;9328.486933218663;9342.299327550436;9635.084666956645;9637.662681806138;9393.76515587109;9574.52127393631;9576.47329396883;9584.137427631511;9585.760355991104;2134.5624147049816;2196.374033400481;2413.8189635777385;2454.815888808342;2497.912573059943;2460.778529932306;2481.10680155144;2481.8138639602103;2484.068474322129;2484.1181380609896;2470.888810003554;2532.936676583082;2532.9493410131877;2534.556452620793;2535.6069809179517;2070.9896450517726;2409.325388891096;2422.079609748293;2505.023041014006;2511.7864981476596;2423.3941514621347;2448.461338505526;2470.925872223836;2473.183849329717;2485.2295788305682;9356.298277629137;9383.155516003593;9398.67104651334;9448.244140468745;9453.52732363379;5514.531264842493;5711.143328500717;5712.685802280873;5715.428457154293;5716.971415142939;3697.574778900434;3800.4489349044234;3840.519935008124;3849.0377405648587;3868.6905047596124;1192.8627709125033;1227.846519185102;1242.0374209987242;1242.3788105947026;1259.3514340114848;13190.142640728418;13438.059335846494;13450.394732237171;13459.528916487876;13475.258860762655;4952.232403977389;4973.378327709036;5164.586833053347;5217.895642087213;5224.791008359623;11268.54925802975;11285.887141128484;11317.94341028306;11382.975532202141;11384.260023098472;5879.147523609138;5880.323762767251;5885.970570147122;5886.205362276038;5886.8822623547285;4616.884577885579;5229.50319719626;5356.4107948125675;5365.463453654604;5459.890802183934;4364.803583838735;4423.314386270134;4440.289553671397;4453.421055262795;4484.215262329079;1356.9253691047088;1401.831780186384;1411.7388283167647;1419.9574012779633;1420.8366037905773;1078.3799315393524;1082.7076689293847;1084.3439718970067;1092.257265059751;1108.922375433712;6393.520485963571;6550.7707230246715;6562.409383155539;6630.204375474974;6984.860302794017;471.5687887262143;478.6481935777201;478.74626447982627;480.0590841949817;488.3407400010029;4446.799894004777;4501.909961800746;4521.547845215452;4527.524609915911;4542.432195975503;11707.473163707653;11953.521859125538;12039.939800300943;12067.87932120685;12144.210626309261;11372.715682107848;11779.646610601696;11831.881681183078;11900.880991189977;11951.940240298743;8425.157484251526;8461.873071903803;8544.487330760174;8581.313494920392;8603.139686031473;6740.427063699641;6878.65606719672;6914.343137401939;6966.1988871280455;7031.894521582282;10581.93652237837;10656.840147397641;10873.184511161537;11048.392338421143;11093.389863557582;10985.01134897831;11094.057005154329;11112.944435277772;11198.04816590599;11210.159238057342;7907.051153861574;8291.129431409856;8458.111898250596;8512.70205542803;8551.871721924052;9302.395344302598;9399.624015039322;9408.106229908148;9435.245180385415;9483.525823708926;8244.711435099744;8267.62795674184;8324.292435143081;8491.532965686947;8572.485650860968;7844.372450204084;7884.053913530413;7918.564478953713;7936.325412340016;7995.360371170409;6996.860062798613;7032.718691252498;7087.184973727881;7105.6447177639875;7141.714331426685;5448.431277513235;5455.454454554671;5493.176023596492;5526.696031718294;5663.320401551676;5415.6479828811;5520.558355331644;5527.170924361378;5543.833684989457;5570.2201691762375 08:14:34 INFO - PROCESS | 377 | |4;prototype.html;351;354.53201773658765;356.934550367154;360.4269211952994;360.4305197787496;5536.557075433966;5544.223808666785;5571.9721401393035;5572.86067848304;5590.248288954392;5502.642328248661;5505.834824955247;5514.310711161105;5524.723763811803;5525.287160980099;3858.839050131935;4083.714140010193;4285.185814695214;4293.677974151936;4309.353596960465;4275.123599662062;4300.397944287803;4314.158739045887;4338.240807858628;4340.913181736363;4133.359329303963;4302.515632106918;4313.2020576193345;4328.458942632171;4355.499117601469;4176;4234.089670720809;4264.87205383839;4266.8293268269235;4272.401863739079;3778.7543809652284;3785.2051069275485;3786.072412258987;3790.9431358529646;3797.39241721326;5260.736963151865;5308.787648494055;5329.22726204702;5342.893142137135;5388;4925.758779755202;4948.975255123737;4961.3798275215595;4962.727050012248;4966.776495057695;5534.972325138348;5588.273524441796;5634.492895639371;5669.659820410789;5778.219940308047;4043.2519983802795;4070.8371665133654;4154.91690166198;4176.812043458051;4177.91644167118;5863.5016023638045;5886.470217680429;5888.322842873082;5900.881982360329;5949.839781242659;4037.8384864605673;4195.790210489463;4205.222033923734;4217.768022758778;4223.556526564728;4234.237837189274;4256.87229383119;4258.787060646955;4262.42457268271;4268.637165840876;4871.707697538159;4880.853574392774;4908.607311415079;4911.115999120193;4913.754312284443;5547.805826796123;5752.482276595127;5761.164631128463;5763.538916886639;5798.304203495523;1464.8388677245493;1477.4929571836667;1484.6288427893028;1486.7956954866593;1491.0457307323322;929.5770424456856;941.4492521874643;944.5135755086136;963.3978763272954;968.6319198704447;5014.824481143142;5031.974840125776;5121.948780512222;5134.486551344836;5135.845924622267;5210.488958202155;5250.9235606701295;5321.32378300834;5385.299911011543;5389.407165211824;5167.354080739908;5181.715005674724;5185.637005409585;5259.552938000236;5763.423657634203;3170.9048728538182;3187.426263272633;3190.1865024418626;3190.6171259449015;3203.238218979552;6103.1455596216565;6218.471429928507;6224.37756224374;6241.251049874044;6277.435030847246;5947.49446297061;6034.5172386209;6047.1858442467965;6090.878182436415;6128.4790792783115;5997.950358687212;6096.116063170815;6191.876162476815;6241;6269.686515674198;5974.40255974399;5978.4021597839865;5978.701064946648;6035.517158627387;6040.607360521552;5667.910988511188;5809.8547536311935;5860.941390586039;5937.554683398849;5997.760089596367;6146.846328841814;6169.167162433194;6174.845628859314;6229.750809967551;6281.675779961443;4253.383259427427;4287.485501739811;4298.5271620122385;4309.633681137138;4310.181065597527;5748.195252664546;5920.437558431942;5927.40725927421;5935.34711181761;6099.817005489843;5768.971155144198;5775.8556036099435;5789.073748200268;5800.941990580209;5801.419858014165;5604.579656525859;5761.567882408753;5805.477507024388;5839.912401314069;5861.3845546217035;5728.450839376605;5750.597458177887;5754.309482862083;5759.337676167127;5767.221425107557;5872.29532456108;5888.793892213752;5900.173975643327;5930.199423077829;5938.703064846654;5500.5247638562005;5630.85922851932;5686.914696279642;5694.544436444991;5716.79991200306 08:14:34 INFO - PROCESS | 377 | |5;yui.html;718.8382613911871;740.7703611880318;873.7073080518026;886.1537231943495;912.6121398405676;14156.646083847896;14439.63900902478;14463.710725785491;14552.927235363808;14567.125972441647;14107.717845643081;14200.502982395617;14575.489857854976;14647.780283295759;14664.193469359181;732.1287667675449;864.0452300208274;875.916787905148;884.5444596033049;888.4225253585157;850.1540966738104;857.7040920882285;859.5788063848701;859.9269062129727;861.0485413617956;906.959186836594;910.3718434280358;918.4213945214506;919.0901008002097;919.4988731141544;766.2988365645427;891.8528442806929;911.8723378726984;912.1015799437548;912.3750231091724;677.1975209376905;677.6374639567857;677.8339306869799;677.8712044711489;678.4335080208032;13398.53105141325;13470.124441911245;13473.393697283645;13501.324933753272;13516.729665406736;11754.23597466162;11952.70118247042;12395.690107747288;12686.492540298377;12921.67695807603;13164.736705265841;13168.27574483403;13171.538996135088;13227.603171904859;13523.59429217125;4719.268513380432;4772.069446457942;4793.3049707792525;4820.517948205186;4927.063857866994;67918.66040669814;68694;69471.65264173698;69923;77360.83958740567;11852.822207666892;12736.426860791287;12802.16785908913;12891.677708057374;12984.805227921588;24219.636705449433;24297.271081867573;24312.27063188107;24317.878410608188;24326.51346973086;8991.370604057653;9064.864027039599;9100.681476148304;9149.268058555299;9257.537123143817;4854.514548545118;4865.197242454955;4910.06708725341;4937.40751109862;4971.925421118686;3926.5877082906454;4046.656034237064;4049.3318602430268;4049.331860243086;4050.8379664813665;686.4782765098461;695.8295217671703;696.1124566178062;700.7862601906365;702.1293595941098;678.4538446550574;713.1299814226635;731.4514114414189;795.5664163031162;800.5596921693162;10514.73713157162;10700.30448020876;10854.34873907568;10906.563737450413;10955.83566246507;726.46604745512;727.4507746651244;732.4726197138052;813.3493205435627;828.8135169586915;4997.875053123701;5026.949730502648;5267;5330.680159190461;5468.26178465902;126615;131618;132368.3381583086;133020;135128.32435837956;108565;109476;109804;109934;110780;95351;97783.51108244556;98641.65395087193;100065.49967250117;103046;9655.179309758469;9757.707268781947;9965.25260605472;10059.094681478702;10073.244506662177;49536;53732.46267537274;54841;55190;56697.71651141718;65024;67518.32481675317;68121.31878681149;81661;82919;13700.45198192061;13792.103513271606;13803.2408217549;14302.499412520929;14722.190279534729;15162.924185379003;15251.694966100395;15355;15676.137812420426;15940.68118637644;12567.87432125667;12797.865030919078;12872.420741066488;14446.061006034573;14588.124712517283;14904.701905961603;14987.40050397972;15108.471203507825;15260.923695381452;15635.530934071996;14242.928785356007;14297.499587514387;14371.13773173613;14650.853491465376;15306.311215995529;11389.145814064144;11757.529698811952;11893.345865977455;12208.389580520761;12760.170588911691;11508.654740357802;11797.174197806415;11831.52673893069;11855.703607409883;12227.205231659913 08:14:34 INFO - PROCESS | 377 | __end_tp_report 08:14:34 INFO - PROCESS | 377 | __start_cc_report 08:14:34 INFO - PROCESS | 377 | _x_x_mozilla_cycle_collect,848 08:14:34 INFO - PROCESS | 377 | __end_cc_report 08:14:34 INFO - PROCESS | 377 | __startTimestamp1468682074751__endTimestamp 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | ------- Summary: start ------- 08:14:34 INFO - PROCESS | 377 | Number of tests: 6 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | [#0] dojo.html Cycles:165 Average:5552.78 Median:5714.66 stddev:616.33 (10.8%) stddev-sans-first:593.49 08:14:34 INFO - PROCESS | 377 | Values: 3349.5 3369.5 3370.2 3374.6 3417.5 5501.7 5595.9 5598.2 5599.1 5639.2 5478.0 5500.8 5508.1 5508.6 5544.5 4944.4 4972.3 4994.0 5036.5 5078.7 4926.0 5067.8 5105.8 5110.0 5112.2 5018.3 5058.4 5074.6 5095.5 5103.5 5152.1 5174.1 5175.6 5176.6 5200.7 4990.9 5010.7 5027.9 5086.7 5100.3 5457.0 5503.5 5522.3 5544.5 5551.9 6057.6 6075.4 6077.5 6077.9 6080.3 5949.3 6006.5 6022.9 6069.5 6070.8 5638.2 5681.7 5692.8 5694.3 5695.8 5947.8 6170.7 6182.2 6182.4 6184.8 5861.0 5870.2 5886.0 5985.4 5997.8 6051.9 6054.9 6081.4 6083.3 6085.5 5714.7 5911.3 5949.0 5981.9 6004.0 5973.4 6008.8 6032.8 6046.2 6078.3 4638.2 4639.4 4639.9 4642.2 4668.2 4034.5 4035.7 4036.8 4138.7 4155.0 5685.6 5712.3 5713.3 5717.9 5740.6 5952.9 5997.4 6008.0 6018.7 6045.0 5536.9 5593.7 5636.5 5641.3 5718.5 5164.4 5164.5 5169.2 5177.7 5195.7 6192.4 6200.0 6203.1 6204.8 6205.2 5912.8 5955.3 5959.9 5982.3 6022.4 6196.2 6270.0 6270.5 6272.9 6278.7 5925.9 5926.2 5934.6 5937.8 5966.3 5731.5 5860.5 5912.7 5915.1 5996.6 5753.1 5771.7 5796.3 5796.9 5821.2 5756.1 5783.9 5794.9 5802.5 5803.6 5576.8 5585.1 5606.2 5621.2 5632.1 5742.5 5743.6 5767.1 5773.8 5776.9 5589.9 5617.7 5622.4 5630.0 5646.8 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | [#1] ext.html Cycles:180 Average:67675.83 Median:21137.89 stddev:143973.45 (681.1%) stddev-sans-first:144289.24 08:14:34 INFO - PROCESS | 377 | Values: 598.4 627.8 645.3 652.6 658.4 33480.7 36724.8 36789.3 45122.0 46164.0 47928.0 48337.8 48418.5 48448.0 48513.0 9020.5 9187.0 9192.5 9193.8 9195.7 8180.1 10753.5 10989.6 10997.0 11443.1 10932.8 11011.6 11019.7 11026.1 11034.7 8348.9 10997.2 11069.1 11141.8 11150.1 10602.2 10674.9 11064.2 11080.2 11099.7 46060.8 46379.0 46483.8 46673.8 46702.5 3704.3 3749.5 3750.2 3785.4 3896.1 35754.8 36094.3 36159.8 36225.5 36321.3 4647.9 4666.4 4708.7 4718.3 4793.3 423131.0 424553.0 424731.0 424983.0 429900.0 38490.4 39872.4 70195.3 71121.0 71125.0 42033.0 42075.8 42159.0 42216.0 42297.8 15639.5 15665.5 15689.1 15693.1 15702.7 11848.9 13584.4 13604.5 13639.9 13814.9 9507.9 9525.0 9551.2 9588.1 9615.5 3505.9 3637.2 3670.9 3671.6 3676.8 1126.2 1159.2 1202.5 1209.8 1212.7 33877.8 34769.3 34892.7 34970.8 35519.6 1104.8 1169.7 1190.1 1244.3 1250.2 16658.4 17170.7 17441.9 17582.8 17594.7 688809.0 689020.0 691207.0 691525.0 695045.0 61607.7 62544.0 62610.7 62630.7 62671.4 1364.0 1421.4 1454.4 1471.7 1475.3 32534.5 36759.4 37099.4 37312.3 37359.3 52466.0 52746.7 53372.7 53394.0 53506.2 455628.0 460387.0 463888.0 465344.0 465441.0 26927.7 30005.8 30803.4 30924.8 31034.4 51069.7 51239.0 51311.7 51375.7 52500.7 41046.2 41649.2 42671.4 43156.1 43223.6 35445.8 35461.0 35849.6 36047.6 36372.3 42462.6 42599.8 46451.8 46471.8 48075.3 37530.4 40194.0 40910.6 41237.8 41585.8 30364.5 30532.5 30585.5 30616.2 30964.4 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | [#2] jquery.html Cycles:180 Average:29316.35 Median:22737.37 stddev:81833.58 (359.9%) stddev-sans-first:82034.33 08:14:34 INFO - PROCESS | 377 | Values: 395.3 425.4 426.1 431.3 439.7 18896.8 19654.0 20507.2 20578.2 20655.5 19365.9 19503.8 19714.5 20154.1 20268.4 5646.4 5915.8 5957.7 5963.5 5968.2 4290.7 4421.3 5892.1 5949.4 6635.1 6578.9 6595.2 6603.0 6604.6 6611.3 6478.7 6516.2 6585.4 6633.4 6637.3 3972.0 4153.4 4177.6 5898.3 5915.9 22356.6 23118.2 23388.4 24858.0 25060.2 2473.6 2508.6 2683.0 2783.7 2962.5 14152.4 15002.7 15106.2 15161.5 15247.2 2071.7 2078.8 2097.8 2180.3 2202.4 53591.2 66624.7 80077.6 80990.6 83506.2 11580.6 11619.5 11773.8 11810.6 11826.1 15766.3 16305.2 16308.0 16315.0 16484.8 7949.1 8026.5 8113.6 8187.0 8205.7 7324.7 7730.1 7734.5 7775.3 7796.7 6957.5 7003.9 7096.0 7132.9 7205.9 2046.0 2075.3 2076.8 2082.1 2110.6 1040.7 1066.7 1135.0 1136.2 1161.4 19878.8 20645.5 20847.7 20848.9 20854.0 1117.6 1136.1 1168.1 1180.8 1190.3 11239.9 11855.8 12018.3 12032.7 12083.4 465967.7 500811.0 504696.0 507363.0 512824.0 85174.6 87052.0 87455.0 88257.6 88541.6 1099.8 1111.2 1114.9 1115.4 1141.7 17498.8 17809.6 17856.2 18111.7 18407.4 38255.4 38310.6 38572.0 40268.0 40670.6 55485.0 57392.7 57549.7 57713.0 57770.0 9160.8 9188.7 9319.7 9345.3 9380.0 13205.6 13257.3 13269.9 13545.2 14096.5 11584.4 11910.6 12006.5 12299.0 12732.2 11104.9 11759.1 11957.5 11966.9 11993.8 11660.7 12375.6 12407.4 12546.3 12746.6 9090.4 9113.3 9170.7 9252.0 9423.0 12161.8 12249.5 12301.7 12717.6 12886.7 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | [#3] mootools.html Cycles:180 Average:6268.42 Median:2544.23 stddev:3596.32 (141.4%) stddev-sans-first:3588.04 08:14:34 INFO - PROCESS | 377 | Values: 1432.8 1570.4 1598.4 1774.5 1917.2 8991.2 9328.5 9342.3 9635.1 9637.7 9393.8 9574.5 9576.5 9584.1 9585.8 2134.6 2196.4 2413.8 2454.8 2497.9 2460.8 2481.1 2481.8 2484.1 2484.1 2470.9 2532.9 2532.9 2534.6 2535.6 2071.0 2409.3 2422.1 2505.0 2511.8 2423.4 2448.5 2470.9 2473.2 2485.2 9356.3 9383.2 9398.7 9448.2 9453.5 5514.5 5711.1 5712.7 5715.4 5717.0 3697.6 3800.4 3840.5 3849.0 3868.7 1192.9 1227.8 1242.0 1242.4 1259.4 13190.1 13438.1 13450.4 13459.5 13475.3 4952.2 4973.4 5164.6 5217.9 5224.8 11268.5 11285.9 11317.9 11383.0 11384.3 5879.1 5880.3 5886.0 5886.2 5886.9 4616.9 5229.5 5356.4 5365.5 5459.9 4364.8 4423.3 4440.3 4453.4 4484.2 1356.9 1401.8 1411.7 1420.0 1420.8 1078.4 1082.7 1084.3 1092.3 1108.9 6393.5 6550.8 6562.4 6630.2 6984.9 471.6 478.6 478.7 480.1 488.3 4446.8 4501.9 4521.5 4527.5 4542.4 11707.5 11953.5 12039.9 12067.9 12144.2 11372.7 11779.6 11831.9 11900.9 11951.9 8425.2 8461.9 8544.5 8581.3 8603.1 6740.4 6878.7 6914.3 6966.2 7031.9 10581.9 10656.8 10873.2 11048.4 11093.4 10985.0 11094.1 11112.9 11198.0 11210.2 7907.1 8291.1 8458.1 8512.7 8551.9 9302.4 9399.6 9408.1 9435.2 9483.5 8244.7 8267.6 8324.3 8491.5 8572.5 7844.4 7884.1 7918.6 7936.3 7995.4 6996.9 7032.7 7087.2 7105.6 7141.7 5448.4 5455.5 5493.2 5526.7 5663.3 5415.6 5520.6 5527.2 5543.8 5570.2 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | [#4] prototype.html Cycles:180 Average:4836.69 Median:5504.24 stddev:1424.99 (25.9%) stddev-sans-first:1388.64 08:14:34 INFO - PROCESS | 377 | Values: 351.0 354.5 356.9 360.4 360.4 5536.6 5544.2 5572.0 5572.9 5590.2 5502.6 5505.8 5514.3 5524.7 5525.3 3858.8 4083.7 4285.2 4293.7 4309.4 4275.1 4300.4 4314.2 4338.2 4340.9 4133.4 4302.5 4313.2 4328.5 4355.5 4176.0 4234.1 4264.9 4266.8 4272.4 3778.8 3785.2 3786.1 3790.9 3797.4 5260.7 5308.8 5329.2 5342.9 5388.0 4925.8 4949.0 4961.4 4962.7 4966.8 5535.0 5588.3 5634.5 5669.7 5778.2 4043.3 4070.8 4154.9 4176.8 4177.9 5863.5 5886.5 5888.3 5900.9 5949.8 4037.8 4195.8 4205.2 4217.8 4223.6 4234.2 4256.9 4258.8 4262.4 4268.6 4871.7 4880.9 4908.6 4911.1 4913.8 5547.8 5752.5 5761.2 5763.5 5798.3 1464.8 1477.5 1484.6 1486.8 1491.0 929.6 941.4 944.5 963.4 968.6 5014.8 5032.0 5121.9 5134.5 5135.8 5210.5 5250.9 5321.3 5385.3 5389.4 5167.4 5181.7 5185.6 5259.6 5763.4 3170.9 3187.4 3190.2 3190.6 3203.2 6103.1 6218.5 6224.4 6241.3 6277.4 5947.5 6034.5 6047.2 6090.9 6128.5 5998.0 6096.1 6191.9 6241.0 6269.7 5974.4 5978.4 5978.7 6035.5 6040.6 5667.9 5809.9 5860.9 5937.6 5997.8 6146.8 6169.2 6174.8 6229.8 6281.7 4253.4 4287.5 4298.5 4309.6 4310.2 5748.2 5920.4 5927.4 5935.3 6099.8 5769.0 5775.9 5789.1 5800.9 5801.4 5604.6 5761.6 5805.5 5839.9 5861.4 5728.5 5750.6 5754.3 5759.3 5767.2 5872.3 5888.8 5900.2 5930.2 5938.7 5500.5 5630.9 5686.9 5694.5 5716.8 08:14:34 INFO - PROCESS | 377 | 08:14:34 INFO - PROCESS | 377 | [#5] yui.html Cycles:180 Average:22100.37 Median:4047.99 stddev:32735.40 (808.7%) stddev-sans-first:32787.86 08:14:34 INFO - PROCESS | 377 | Values: 718.8 740.8 873.7 886.2 912.6 14156.6 14439.6 14463.7 14552.9 14567.1 14107.7 14200.5 14575.5 14647.8 14664.2 732.1 864.0 875.9 884.5 888.4 850.2 857.7 859.6 859.9 861.0 907.0 910.4 918.4 919.1 919.5 766.3 891.9 911.9 912.1 912.4 677.2 677.6 677.8 677.9 678.4 13398.5 13470.1 13473.4 13501.3 13516.7 11754.2 11952.7 12395.7 12686.5 12921.7 13164.7 13168.3 13171.5 13227.6 13523.6 4719.3 4772.1 4793.3 4820.5 4927.1 67918.7 68694.0 69471.7 69923.0 77360.8 11852.8 12736.4 12802.2 12891.7 12984.8 24219.6 24297.3 24312.3 24317.9 24326.5 8991.4 9064.9 9100.7 9149.3 9257.5 4854.5 4865.2 4910.1 4937.4 4971.9 3926.6 4046.7 4049.3 4049.3 4050.8 686.5 695.8 696.1 700.8 702.1 678.5 713.1 731.5 795.6 800.6 10514.7 10700.3 10854.3 10906.6 10955.8 726.5 727.5 732.5 813.3 828.8 4997.9 5026.9 5267.0 5330.7 5468.3 126615.0 131618.0 132368.3 133020.0 135128.3 108565.0 109476.0 109804.0 109934.0 110780.0 95351.0 97783.5 98641.7 100065.5 103046.0 9655.2 9757.7 9965.3 10059.1 10073.2 49536.0 53732.5 54841.0 55190.0 56697.7 65024.0 67518.3 68121.3 81661.0 82919.0 13700.5 13792.1 13803.2 14302.5 14722.2 15162.9 15251.7 15355.0 15676.1 15940.7 12567.9 12797.9 12872.4 14446.1 14588.1 14904.7 14987.4 15108.5 15260.9 15635.5 14242.9 14297.5 14371.1 14650.9 15306.3 11389.1 11757.5 11893.3 12208.4 12760.2 11508.7 11797.2 11831.5 11855.7 12227.2 08:14:34 INFO - PROCESS | 377 | -------- Summary: end -------- 08:14:34 INFO - PROCESS | 377 | 08:14:35 INFO - TEST-INFO | 377: exit 0 08:14:35 INFO - TEST-OK | dromaeo_css | took 1112803ms 08:14:35 INFO - TEST-START | kraken 08:14:35 INFO - operating with platform_type : linux_ 08:14:35 INFO - Initialising browser for kraken test... 08:14:35 INFO - TEST-INFO | started process 568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJHFb_N/profile http://localhost:58734/getInfo.html) 08:14:39 INFO - PROCESS | 568 | __metrics Screen width/height:1600/1200 08:14:39 INFO - PROCESS | 568 | colorDepth:24 08:14:39 INFO - PROCESS | 568 | Browser inner width/height: 1024/697 08:14:39 INFO - PROCESS | 568 | __metrics 08:14:39 INFO - PROCESS | 568 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:14:39 ERROR - PROCESS | 568 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:14:40 INFO - TEST-INFO | 568: exit 0 08:14:40 INFO - Browser initialized. 08:14:40 INFO - Running cycle 1/1 for kraken test... 08:14:40 INFO - TEST-INFO | started process 659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJHFb_N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:52 INFO - PROCESS | 659 | RSS: Main: 145575936 08:14:52 INFO - PROCESS | 659 | 08:14:54 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:55 INFO - PROCESS | 659 | RSS: Main: 194535424 08:14:55 INFO - PROCESS | 659 | 08:14:58 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-dft) 08:14:58 INFO - PROCESS | 659 | RSS: Main: 193257472 08:14:58 INFO - PROCESS | 659 | 08:15:01 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-fft) 08:15:02 INFO - PROCESS | 659 | RSS: Main: 279089152 08:15:02 INFO - PROCESS | 659 | 08:15:04 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-oscillator) 08:15:04 INFO - PROCESS | 659 | RSS: Main: 187285504 08:15:04 INFO - PROCESS | 659 | 08:15:07 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:15:07 INFO - PROCESS | 659 | RSS: Main: 188592128 08:15:07 INFO - PROCESS | 659 | 08:15:10 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58734/tests/kraken/driver.html?testName=imaging-darkroom) 08:15:11 INFO - PROCESS | 659 | RSS: Main: 223035392 08:15:11 INFO - PROCESS | 659 | 08:15:14 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58734/tests/kraken/driver.html?testName=imaging-desaturate) 08:15:15 INFO - PROCESS | 659 | RSS: Main: 222466048 08:15:15 INFO - PROCESS | 659 | 08:15:17 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58734/tests/kraken/driver.html?testName=json-parse-financial) 08:15:18 INFO - PROCESS | 659 | RSS: Main: 222384128 08:15:18 INFO - PROCESS | 659 | 08:15:20 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:15:20 INFO - PROCESS | 659 | RSS: Main: 201097216 08:15:20 INFO - PROCESS | 659 | 08:15:22 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:15:22 INFO - PROCESS | 659 | RSS: Main: 201756672 08:15:22 INFO - PROCESS | 659 | 08:15:24 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:15:25 INFO - PROCESS | 659 | RSS: Main: 209166336 08:15:25 INFO - PROCESS | 659 | 08:15:28 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:28 INFO - PROCESS | 659 | RSS: Main: 214257664 08:15:28 INFO - PROCESS | 659 | 08:15:31 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:31 INFO - PROCESS | 659 | RSS: Main: 213389312 08:15:31 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58734/tests/kraken/driver.html?testName=ai-astar) 08:15:33 INFO - PROCESS | 659 | RSS: Main: 256499712 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | __start_tp_report 08:15:33 INFO - PROCESS | 659 | _x_x_mozilla_page_load 08:15:33 INFO - PROCESS | 659 | _x_x_mozilla_page_load_details 08:15:33 INFO - PROCESS | 659 | |i|pagename|runs| 08:15:33 INFO - PROCESS | 659 | |0;ai-astar;110;104;109;108;109;109;109;110;110;108 08:15:33 INFO - PROCESS | 659 | |1;audio-beat-detection;148;125;124;184;126;126;145;122;162;124 08:15:33 INFO - PROCESS | 659 | |2;audio-dft;160;161;160;161;162;160;161;160;159;162 08:15:33 INFO - PROCESS | 659 | |3;audio-fft;74;75;75;132;76;75;75;76;98;75 08:15:33 INFO - PROCESS | 659 | |4;audio-oscillator;83;84;121;84;85;85;112;83;84;127 08:15:33 INFO - PROCESS | 659 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 08:15:33 INFO - PROCESS | 659 | |6;imaging-darkroom;145;145;145;145;146;145;146;145;145;145 08:15:33 INFO - PROCESS | 659 | |7;imaging-desaturate;94;95;94;94;95;94;95;94;94;95 08:15:33 INFO - PROCESS | 659 | |8;json-parse-financial;51;50;51;53;51;52;52;52;51;52 08:15:33 INFO - PROCESS | 659 | |9;json-stringify-tinderbox;60;60;60;60;60;60;60;60;61;60 08:15:33 INFO - PROCESS | 659 | |10;stanford-crypto-aes;82;76;77;76;78;80;78;76;112;80 08:15:33 INFO - PROCESS | 659 | |11;stanford-crypto-ccm;122;129;120;131;114;121;115;122;123;120 08:15:33 INFO - PROCESS | 659 | |12;stanford-crypto-pbkdf2;154;155;159;155;153;156;153;153;158;152 08:15:33 INFO - PROCESS | 659 | |13;stanford-crypto-sha256-iterative;64;60;64;61;60;62;68;60;60;60 08:15:33 INFO - PROCESS | 659 | __end_tp_report 08:15:33 INFO - PROCESS | 659 | __start_cc_report 08:15:33 INFO - PROCESS | 659 | _x_x_mozilla_cycle_collect,1550 08:15:33 INFO - PROCESS | 659 | __end_cc_report 08:15:33 INFO - PROCESS | 659 | __startTimestamp1468682133881__endTimestamp 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | ------- Summary: start ------- 08:15:33 INFO - PROCESS | 659 | Number of tests: 14 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:1.78 (1.6%) stddev-sans-first:1.81 08:15:33 INFO - PROCESS | 659 | Values: 110.0 104.0 109.0 108.0 109.0 109.0 109.0 110.0 110.0 108.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:135.50 stddev:20.93 (15.4%) stddev-sans-first:21.92 08:15:33 INFO - PROCESS | 659 | Values: 148.0 125.0 124.0 184.0 126.0 126.0 145.0 122.0 162.0 124.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 08:15:33 INFO - PROCESS | 659 | Values: 160.0 161.0 160.0 161.0 162.0 160.0 161.0 160.0 159.0 162.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:18.63 (24.8%) stddev-sans-first:19.47 08:15:33 INFO - PROCESS | 659 | Values: 74.0 75.0 75.0 132.0 76.0 75.0 75.0 76.0 98.0 75.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:17.76 (21.1%) stddev-sans-first:18.32 08:15:33 INFO - PROCESS | 659 | Values: 83.0 84.0 121.0 84.0 85.0 85.0 112.0 83.0 84.0 127.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:15:33 INFO - PROCESS | 659 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:15:33 INFO - PROCESS | 659 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:15:33 INFO - PROCESS | 659 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 08:15:33 INFO - PROCESS | 659 | Values: 51.0 50.0 51.0 53.0 51.0 52.0 52.0 52.0 51.0 52.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 08:15:33 INFO - PROCESS | 659 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:78.00 stddev:10.91 (14.0%) stddev-sans-first:11.57 08:15:33 INFO - PROCESS | 659 | Values: 82.0 76.0 77.0 76.0 78.0 80.0 78.0 76.0 112.0 80.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.00 stddev:5.29 (4.3%) stddev-sans-first:5.61 08:15:33 INFO - PROCESS | 659 | Values: 122.0 129.0 120.0 131.0 114.0 121.0 115.0 122.0 123.0 120.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:2.30 (1.5%) stddev-sans-first:2.42 08:15:33 INFO - PROCESS | 659 | Values: 154.0 155.0 159.0 155.0 153.0 156.0 153.0 153.0 158.0 152.0 08:15:33 INFO - PROCESS | 659 | 08:15:33 INFO - PROCESS | 659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.50 stddev:2.69 (4.4%) stddev-sans-first:2.74 08:15:33 INFO - PROCESS | 659 | Values: 64.0 60.0 64.0 61.0 60.0 62.0 68.0 60.0 60.0 60.0 08:15:33 INFO - PROCESS | 659 | -------- Summary: end -------- 08:15:33 INFO - PROCESS | 659 | 08:15:34 INFO - TEST-INFO | 659: exit 0 08:15:34 INFO - TEST-OK | kraken | took 59492ms 08:15:34 INFO - SUITE-END | took 1172s 08:15:35 INFO - Completed test suite (00:19:32) 08:15:35 INFO - javascript benchmark 08:15:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.5310656508095, 3369.5282660427542, 3370.2248482848945, 3374.6119196292434, 3417.521546983421, 5501.697406642633, 5595.944040559593, 5598.1602759586085, 5599.1041433370665, 5639.182318563806, 5478.0, 5500.779968801243, 5508.091164957787, 5508.586855985797, 5544.500994910457, 4944.406671199461, 4972.32873562069, 4993.950060499403, 5036.546710796028, 5078.746062696869, 4926.0394223126505, 5067.822626208083, 5105.821296254632, 5109.974450127745, 5112.233165025239, 5018.34761481007, 5058.4435712071645, 5074.619403544731, 5095.464976177504, 5103.489651034885, 5152.098382783035, 5174.094533456668, 5175.560077393445, 5176.55999240065, 5200.7399630018535, 4990.850274491771, 5010.72441015744, 5027.899442011139, 5086.694798312076, 5100.336956195708, 5456.972715136439, 5503.504684578367, 5522.282103326582, 5544.528715059225, 5551.944480555224, 6057.636541807506, 6075.362086980892, 6077.513798896122, 6077.908831367533, 6080.30076541199, 5949.345571987078, 6006.459418652343, 6022.909656355115, 6069.453749162597, 6070.791092195466, 5638.182463542763, 5681.715914204273, 5692.772289108472, 5694.316681998187, 5695.829125126253, 5947.762089516371, 6170.660613666201, 6182.196314479179, 6182.381761823872, 6184.845378865564, 5860.970695146497, 5870.207521984563, 5885.970570147208, 5985.40145985398, 5997.790077347272, 6051.880402125621, 6054.939450605438, 6081.422264884829, 6083.330833608299, 6085.543584231112, 5714.657120572779, 5911.349751527328, 5949.0481522956115, 5981.940180598225, 6004.0093384591055, 5973.402659733992, 6008.789692360834, 6032.758689652364, 6046.2139921809885, 6078.300995385587, 4638.165130276515, 4639.350490931272, 4639.86080417588, 4642.234031384851, 4668.159731248408, 4034.495688038995, 4035.7174997749876, 4036.7779772112817, 4138.689598280081, 4155.0, 5685.573581981368, 5712.257406537124, 5713.314402271754, 5717.942820571741, 5740.598158128891, 5952.9107063394085, 5997.430244126801, 6008.0, 6018.729157187937, 6044.969775151096, 5536.916946245809, 5593.664380137124, 5636.520895723909, 5641.26663533738, 5718.51392631631, 5164.406093299243, 5164.509371609691, 5169.224616307584, 5177.741112944338, 5195.662281951737, 6192.411720886508, 6199.969000155061, 6203.100550420164, 6204.844878877974, 6205.193324867739, 5912.763489460545, 5955.285365756137, 5959.910601340896, 5982.282126144716, 6022.397760223943, 6196.194494715658, 6270.028145637433, 6270.4670103039925, 6272.905906411499, 6278.6546739929745, 5925.911111333247, 5926.2295901532525, 5934.554908381802, 5937.762489500545, 5966.313873904556, 5731.455511726379, 5860.472557469848, 5912.674802885883, 5915.142304365757, 5996.5502587305255, 5753.108268218432, 5771.653700777967, 5796.275465566804, 5796.913046304393, 5821.185034095315, 5756.079027355603, 5783.901058798815, 5794.942050579609, 5802.47777700009, 5803.564732644984, 5576.832695019156, 5585.078462053716, 5606.24315717373, 5621.184928185472, 5632.127020311858, 5742.483176513967, 5743.59794814359, 5767.077267637158, 5773.769049238152, 5776.913346299725, 5589.888202236014, 5617.662940223599, 5622.353429355513, 5630.0147474191035, 5646.830595082154], "value": 5512.976552003252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.4075764992656, 627.7865525721255, 645.2676212498816, 652.5660435810184, 658.3613894522312, 33480.66519334806, 36724.81637591808, 36789.26421471569, 45122.0, 46164.0, 47928.0, 48337.75831120848, 48418.51581484184, 48448.0, 48513.0, 9020.548972551363, 9186.954065229698, 9192.540372981357, 9193.816123677523, 9195.724128276162, 8180.059293181301, 10753.462326883664, 10989.61536346228, 10997.0, 11443.084553235722, 10932.836007459895, 11011.61459348923, 11019.724506887353, 11026.062784663312, 11034.724131896686, 8348.874766878502, 10997.230193886431, 11069.114470842313, 11141.832872506919, 11150.052245559138, 10602.151827853753, 10674.893251067468, 11064.17018723599, 11080.168987325982, 11099.667009989713, 46060.76969615131, 46379.0, 46483.767581161876, 46673.766631166625, 46702.53297467016, 3704.3147017801793, 3749.4750734897134, 3750.2312026034597, 3785.356489396809, 3896.1428485733095, 35754.821225893706, 36094.278114437824, 36159.81920090409, 36225.45661815075, 36321.273574528364, 4647.88380290492, 4666.440027196724, 4708.74101924394, 4718.268668356376, 4793.257045158006, 423131.0, 424552.9999999969, 424731.0, 424983.0, 429900.0, 38490.422643660364, 39872.40191397131, 70195.29804701888, 71121.0, 71125.0, 42033.0, 42075.7896210517, 42159.0, 42216.0, 42297.788511057246, 15639.452619158275, 15665.451709190123, 15689.137097459521, 15693.058416495047, 15702.68594628101, 11848.940755296167, 13584.388702508213, 13604.455821767217, 13639.931800341134, 13814.861851381558, 9507.904920950701, 9525.0, 9551.188149007274, 9588.137067663944, 9615.471149086867, 3505.859765609347, 3637.181634132352, 3670.853165873335, 3671.5594128704724, 3676.76101053436, 1126.222906194723, 1159.211736019498, 1202.5310129049678, 1209.770143672717, 1212.6907638552113, 33877.83061084679, 34769.30461390808, 34892.65107348894, 34970.82514587411, 35519.64480355215, 1104.8066588347008, 1169.6900321414832, 1190.077689790402, 1244.3156264054915, 1250.206119114369, 16658.417450342196, 17170.656586868194, 17441.912790435967, 17582.824171758373, 17594.736078958827, 688809.0, 689020.0, 691207.0, 691525.0, 695045.0, 61607.691961540804, 62544.0, 62610.68694656497, 62630.68684656548, 62671.373286267466, 1363.9931800340935, 1421.4243231491262, 1454.4400405843614, 1471.720373129102, 1475.3066058952274, 32534.511982320757, 36759.448608271436, 37099.44350834793, 37312.253754925296, 37359.25281494409, 52466.0, 52746.73626631996, 53372.73313633562, 53394.0, 53506.197407039705, 455628.0, 460387.0, 463888.0, 465344.0, 465441.0, 26927.730722693304, 30005.849970750005, 30803.383932321678, 30924.84537577388, 31034.379312413173, 51069.74465127799, 51239.0, 51311.74344128255, 51375.743121284155, 52500.73749631227, 41046.1790764189, 41649.1670166601, 42671.3599296017, 43156.13687726291, 43223.56776432195, 35445.82277088701, 35461.0, 35849.64150358463, 36047.639523604426, 36372.27255454929, 42462.57537424586, 42599.7870010648, 46451.76774116108, 46471.76764116293, 48075.27887081627, 37530.437043444916, 40194.0, 40910.59089409187, 41237.79381103075, 41585.792071039454, 30364.544531831598, 30532.542011869395, 30585.54121688221, 30616.234594135323, 30964.380712385177], "value": 20613.718055301702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.2667801228721, 425.3768229543718, 426.0966750488964, 431.30344493642775, 439.65706748736, 18896.811031889676, 19654.0, 20507.17971281147, 20578.176872925083, 20655.483612909684, 19365.90317048413, 19503.804961950376, 19714.507137321572, 20154.093065812038, 20268.39194824154, 5646.407127251631, 5915.822525324247, 5957.731902064417, 5963.522918166558, 5968.224130862982, 4290.656747460212, 4421.314696222074, 5892.057270836667, 5949.405059494059, 6635.071090047397, 6578.93421065788, 6595.208574970986, 6602.966985165068, 6604.570702904296, 6611.305812889649, 6478.708458119396, 6516.185476815398, 6585.440237579812, 6633.369829866179, 6637.269900310962, 3971.980140099281, 4153.418521407006, 4177.644900183488, 5898.321693005317, 5915.911261331084, 22356.55286894253, 23118.1908633197, 23388.415289617726, 24858.0, 25060.248192554252, 2473.6165894286414, 2508.5986242201343, 2682.973170268292, 2783.73554512321, 2962.525995840677, 14152.36314365856, 15002.699946001128, 15106.244687765568, 15161.518040903922, 15247.23763811805, 2071.658176400892, 2078.833693304532, 2097.8216851567636, 2180.2805074325433, 2202.427368884086, 53591.19613205805, 66624.6668766653, 80077.59961200214, 80990.59504702498, 83506.16493835044, 11580.594679186188, 11619.477123529461, 11773.823392649118, 11810.645680629596, 11826.113041521749, 15766.290516926765, 16305.184740763152, 16308.0, 16315.0, 16484.83515164833, 7949.125596184415, 8026.518408895485, 8113.634886430124, 8186.959065204635, 8205.671773129008, 7324.707011719578, 7730.072391313079, 7734.5359278443475, 7775.339096176888, 7796.727114550963, 6957.478189135733, 7003.8599228015155, 7095.964520177469, 7132.893006604905, 7205.855882882418, 2046.0, 2075.2529089527757, 2076.8338532917332, 2082.083883091435, 2110.5884352551107, 1040.7242080848582, 1066.653337665262, 1134.971625709364, 1136.2160109524566, 1161.4134861894859, 19878.801211987986, 20645.483862903246, 20847.687284690437, 20848.895755521124, 20854.0, 1117.636768050387, 1136.085451211766, 1168.1472525056756, 1180.7697498987786, 1190.2679851891198, 11239.943800280946, 11855.762884742257, 12018.33899135556, 12032.699182520508, 12083.395830208454, 465967.6911308156, 500811.0, 504696.0, 507363.0, 512824.0, 85174.57412712897, 87052.0, 87455.0, 88257.55871220602, 88541.55729221313, 1099.7745462180235, 1111.1777284809184, 1114.8717897441736, 1115.4311301236428, 1141.7088642396136, 17498.82501174972, 17809.554761131076, 17856.196471158568, 18111.72832407541, 18407.355742548945, 38255.42616860805, 38310.61689383182, 38572.0, 40268.0, 40670.59329406668, 55485.0, 57392.71303643455, 57549.712251438476, 57713.0, 57770.0, 9160.770980725269, 9188.678396256098, 9319.673811416567, 9345.299102567198, 9379.968203497747, 13205.603831885059, 13257.270850103338, 13269.86730132725, 13545.187288762705, 14096.50662226817, 11584.420778961186, 11910.583129590423, 12006.519739210335, 12299.0, 12732.23606583608, 11104.888951110708, 11759.118066144902, 11957.521699132285, 11966.880331196577, 11993.760124797629, 11660.65018049426, 12375.62873113808, 12407.44166512491, 12546.30995295231, 12746.553870614483, 9090.36367454272, 9113.316501262565, 9170.67902623405, 9252.0, 9423.0, 12161.817572736592, 12249.510019599473, 12301.692457688629, 12717.55488557896, 12886.67783305425], "value": 9780.147532296694, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.8065711128995, 1570.356153976869, 1598.4165779490486, 1774.520879362572, 1917.1947781931588, 8991.235744961677, 9328.486933218663, 9342.299327550436, 9635.084666956645, 9637.662681806138, 9393.76515587109, 9574.52127393631, 9576.47329396883, 9584.137427631511, 9585.760355991104, 2134.5624147049816, 2196.374033400481, 2413.8189635777385, 2454.815888808342, 2497.912573059943, 2460.778529932306, 2481.10680155144, 2481.8138639602103, 2484.068474322129, 2484.1181380609896, 2470.888810003554, 2532.936676583082, 2532.9493410131877, 2534.556452620793, 2535.6069809179517, 2070.9896450517726, 2409.325388891096, 2422.079609748293, 2505.023041014006, 2511.7864981476596, 2423.3941514621347, 2448.461338505526, 2470.925872223836, 2473.183849329717, 2485.2295788305682, 9356.298277629137, 9383.155516003593, 9398.67104651334, 9448.244140468745, 9453.52732363379, 5514.531264842493, 5711.143328500717, 5712.685802280873, 5715.428457154293, 5716.971415142939, 3697.574778900434, 3800.4489349044234, 3840.519935008124, 3849.0377405648587, 3868.6905047596124, 1192.8627709125033, 1227.846519185102, 1242.0374209987242, 1242.3788105947026, 1259.3514340114848, 13190.142640728418, 13438.059335846494, 13450.394732237171, 13459.528916487876, 13475.258860762655, 4952.232403977389, 4973.378327709036, 5164.586833053347, 5217.895642087213, 5224.791008359623, 11268.54925802975, 11285.887141128484, 11317.94341028306, 11382.975532202141, 11384.260023098472, 5879.147523609138, 5880.323762767251, 5885.970570147122, 5886.205362276038, 5886.8822623547285, 4616.884577885579, 5229.50319719626, 5356.4107948125675, 5365.463453654604, 5459.890802183934, 4364.803583838735, 4423.314386270134, 4440.289553671397, 4453.421055262795, 4484.215262329079, 1356.9253691047088, 1401.831780186384, 1411.7388283167647, 1419.9574012779633, 1420.8366037905773, 1078.3799315393524, 1082.7076689293847, 1084.3439718970067, 1092.257265059751, 1108.922375433712, 6393.520485963571, 6550.7707230246715, 6562.409383155539, 6630.204375474974, 6984.860302794017, 471.5687887262143, 478.6481935777201, 478.74626447982627, 480.0590841949817, 488.3407400010029, 4446.799894004777, 4501.909961800746, 4521.547845215452, 4527.524609915911, 4542.432195975503, 11707.473163707653, 11953.521859125538, 12039.939800300943, 12067.87932120685, 12144.210626309261, 11372.715682107848, 11779.646610601696, 11831.881681183078, 11900.880991189977, 11951.940240298743, 8425.157484251526, 8461.873071903803, 8544.487330760174, 8581.313494920392, 8603.139686031473, 6740.427063699641, 6878.65606719672, 6914.343137401939, 6966.1988871280455, 7031.894521582282, 10581.93652237837, 10656.840147397641, 10873.184511161537, 11048.392338421143, 11093.389863557582, 10985.01134897831, 11094.057005154329, 11112.944435277772, 11198.04816590599, 11210.159238057342, 7907.051153861574, 8291.129431409856, 8458.111898250596, 8512.70205542803, 8551.871721924052, 9302.395344302598, 9399.624015039322, 9408.106229908148, 9435.245180385415, 9483.525823708926, 8244.711435099744, 8267.62795674184, 8324.292435143081, 8491.532965686947, 8572.485650860968, 7844.372450204084, 7884.053913530413, 7918.564478953713, 7936.325412340016, 7995.360371170409, 6996.860062798613, 7032.718691252498, 7087.184973727881, 7105.6447177639875, 7141.714331426685, 5448.431277513235, 5455.454454554671, 5493.176023596492, 5526.696031718294, 5663.320401551676, 5415.6479828811, 5520.558355331644, 5527.170924361378, 5543.833684989457, 5570.2201691762375], "value": 4922.392771758911, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.0, 354.53201773658765, 356.934550367154, 360.4269211952994, 360.4305197787496, 5536.557075433966, 5544.223808666785, 5571.9721401393035, 5572.86067848304, 5590.248288954392, 5502.642328248661, 5505.834824955247, 5514.310711161105, 5524.723763811803, 5525.287160980099, 3858.839050131935, 4083.714140010193, 4285.185814695214, 4293.677974151936, 4309.353596960465, 4275.123599662062, 4300.397944287803, 4314.158739045887, 4338.240807858628, 4340.913181736363, 4133.359329303963, 4302.515632106918, 4313.2020576193345, 4328.458942632171, 4355.499117601469, 4176.0, 4234.089670720809, 4264.87205383839, 4266.8293268269235, 4272.401863739079, 3778.7543809652284, 3785.2051069275485, 3786.072412258987, 3790.9431358529646, 3797.39241721326, 5260.736963151865, 5308.787648494055, 5329.22726204702, 5342.893142137135, 5388.0, 4925.758779755202, 4948.975255123737, 4961.3798275215595, 4962.727050012248, 4966.776495057695, 5534.972325138348, 5588.273524441796, 5634.492895639371, 5669.659820410789, 5778.219940308047, 4043.2519983802795, 4070.8371665133654, 4154.91690166198, 4176.812043458051, 4177.91644167118, 5863.5016023638045, 5886.470217680429, 5888.322842873082, 5900.881982360329, 5949.839781242659, 4037.8384864605673, 4195.790210489463, 4205.222033923734, 4217.768022758778, 4223.556526564728, 4234.237837189274, 4256.87229383119, 4258.787060646955, 4262.42457268271, 4268.637165840876, 4871.707697538159, 4880.853574392774, 4908.607311415079, 4911.115999120193, 4913.754312284443, 5547.805826796123, 5752.482276595127, 5761.164631128463, 5763.538916886639, 5798.304203495523, 1464.8388677245493, 1477.4929571836667, 1484.6288427893028, 1486.7956954866593, 1491.0457307323322, 929.5770424456856, 941.4492521874643, 944.5135755086136, 963.3978763272954, 968.6319198704447, 5014.824481143142, 5031.974840125776, 5121.948780512222, 5134.486551344836, 5135.845924622267, 5210.488958202155, 5250.9235606701295, 5321.32378300834, 5385.299911011543, 5389.407165211824, 5167.354080739908, 5181.715005674724, 5185.637005409585, 5259.552938000236, 5763.423657634203, 3170.9048728538182, 3187.426263272633, 3190.1865024418626, 3190.6171259449015, 3203.238218979552, 6103.1455596216565, 6218.471429928507, 6224.37756224374, 6241.251049874044, 6277.435030847246, 5947.49446297061, 6034.5172386209, 6047.1858442467965, 6090.878182436415, 6128.4790792783115, 5997.950358687212, 6096.116063170815, 6191.876162476815, 6241.0, 6269.686515674198, 5974.40255974399, 5978.4021597839865, 5978.701064946648, 6035.517158627387, 6040.607360521552, 5667.910988511188, 5809.8547536311935, 5860.941390586039, 5937.554683398849, 5997.760089596367, 6146.846328841814, 6169.167162433194, 6174.845628859314, 6229.750809967551, 6281.675779961443, 4253.383259427427, 4287.485501739811, 4298.5271620122385, 4309.633681137138, 4310.181065597527, 5748.195252664546, 5920.437558431942, 5927.40725927421, 5935.34711181761, 6099.817005489843, 5768.971155144198, 5775.8556036099435, 5789.073748200268, 5800.941990580209, 5801.419858014165, 5604.579656525859, 5761.567882408753, 5805.477507024388, 5839.912401314069, 5861.3845546217035, 5728.450839376605, 5750.597458177887, 5754.309482862083, 5759.337676167127, 5767.221425107557, 5872.29532456108, 5888.793892213752, 5900.173975643327, 5930.199423077829, 5938.703064846654, 5500.5247638562005, 5630.85922851932, 5686.914696279642, 5694.544436444991, 5716.79991200306], "value": 4385.560666954612, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.8382613911871, 740.7703611880318, 873.7073080518026, 886.1537231943495, 912.6121398405676, 14156.646083847896, 14439.63900902478, 14463.710725785491, 14552.927235363808, 14567.125972441647, 14107.717845643081, 14200.502982395617, 14575.489857854976, 14647.780283295759, 14664.193469359181, 732.1287667675449, 864.0452300208274, 875.916787905148, 884.5444596033049, 888.4225253585157, 850.1540966738104, 857.7040920882285, 859.5788063848701, 859.9269062129727, 861.0485413617956, 906.959186836594, 910.3718434280358, 918.4213945214506, 919.0901008002097, 919.4988731141544, 766.2988365645427, 891.8528442806929, 911.8723378726984, 912.1015799437548, 912.3750231091724, 677.1975209376905, 677.6374639567857, 677.8339306869799, 677.8712044711489, 678.4335080208032, 13398.53105141325, 13470.124441911245, 13473.393697283645, 13501.324933753272, 13516.729665406736, 11754.23597466162, 11952.70118247042, 12395.690107747288, 12686.492540298377, 12921.67695807603, 13164.736705265841, 13168.27574483403, 13171.538996135088, 13227.603171904859, 13523.59429217125, 4719.268513380432, 4772.069446457942, 4793.3049707792525, 4820.517948205186, 4927.063857866994, 67918.66040669814, 68694.0, 69471.65264173698, 69923.0, 77360.83958740567, 11852.822207666892, 12736.426860791287, 12802.16785908913, 12891.677708057374, 12984.805227921588, 24219.636705449433, 24297.271081867573, 24312.27063188107, 24317.878410608188, 24326.51346973086, 8991.370604057653, 9064.864027039599, 9100.681476148304, 9149.268058555299, 9257.537123143817, 4854.514548545118, 4865.197242454955, 4910.06708725341, 4937.40751109862, 4971.925421118686, 3926.5877082906454, 4046.656034237064, 4049.3318602430268, 4049.331860243086, 4050.8379664813665, 686.4782765098461, 695.8295217671703, 696.1124566178062, 700.7862601906365, 702.1293595941098, 678.4538446550574, 713.1299814226635, 731.4514114414189, 795.5664163031162, 800.5596921693162, 10514.73713157162, 10700.30448020876, 10854.34873907568, 10906.563737450413, 10955.83566246507, 726.46604745512, 727.4507746651244, 732.4726197138052, 813.3493205435627, 828.8135169586915, 4997.875053123701, 5026.949730502648, 5267.0, 5330.680159190461, 5468.26178465902, 126615.0, 131618.0, 132368.3381583086, 133020.0, 135128.32435837956, 108565.0, 109476.0, 109804.0, 109934.0, 110780.0, 95351.0, 97783.51108244556, 98641.65395087193, 100065.49967250117, 103046.0, 9655.179309758469, 9757.707268781947, 9965.25260605472, 10059.094681478702, 10073.244506662177, 49536.0, 53732.46267537274, 54841.0, 55190.0, 56697.71651141718, 65024.0, 67518.32481675317, 68121.31878681149, 81661.0, 82919.0, 13700.45198192061, 13792.103513271606, 13803.2408217549, 14302.499412520929, 14722.190279534729, 15162.924185379003, 15251.694966100395, 15355.0, 15676.137812420426, 15940.68118637644, 12567.87432125667, 12797.865030919078, 12872.420741066488, 14446.061006034573, 14588.124712517283, 14904.701905961603, 14987.40050397972, 15108.471203507825, 15260.923695381452, 15635.530934071996, 14242.928785356007, 14297.499587514387, 14371.13773173613, 14650.853491465376, 15306.311215995529, 11389.145814064144, 11757.529698811952, 11893.345865977455, 12208.389580520761, 12760.170588911691, 11508.654740357802, 11797.174197806415, 11831.52673893069, 11855.703607409883, 12227.205231659913], "value": 8002.498717320221, "unit": "score"}], "name": "dromaeo_css", "value": 7595.556481567083, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 108.0, 109.0, 109.0, 109.0, 110.0, 110.0, 108.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 124.0, 184.0, 126.0, 126.0, 145.0, 122.0, 162.0, 124.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0, 160.0, 159.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 132.0, 76.0, 75.0, 75.0, 76.0, 98.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 121.0, 84.0, 85.0, 85.0, 112.0, 83.0, 84.0, 127.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 53.0, 51.0, 52.0, 52.0, 52.0, 51.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 77.0, 76.0, 78.0, 80.0, 78.0, 76.0, 112.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 129.0, 120.0, 131.0, 114.0, 121.0, 115.0, 122.0, 123.0, 120.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 159.0, 155.0, 153.0, 156.0, 153.0, 153.0, 158.0, 152.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 64.0, 61.0, 60.0, 62.0, 68.0, 60.0, 60.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1473.5, "alertThreshold": 2.0}]} 08:15:35 INFO - Return code: 0 08:15:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:15:35 ERROR - # TBPL SUCCESS # 08:15:35 INFO - Running post-action listener: _resource_record_post_action 08:15:35 INFO - ##### 08:15:35 INFO - ##### Finished run-tests step (success) 08:15:35 INFO - ##### 08:15:35 INFO - Running post-run listener: _resource_record_post_run 08:15:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 496164864; Read time: 0; Write time: 359960 08:15:35 INFO - TinderboxPrint: CPU usage
13.1% 08:15:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:15:35 INFO - TinderboxPrint: I/O write bytes / time
496,164,864 / 359,960 08:15:35 INFO - TinderboxPrint: CPU idle
8,248.9 (86.9%) 08:15:35 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 08:15:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:15:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252092416; Read time: 0; Write time: 238364 08:15:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 243572736; Read time: 0; Write time: 121564 08:15:35 INFO - Running post-run listener: _upload_blobber_files 08:15:35 INFO - Blob upload gear active. 08:15:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:15:35 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 08:15:35 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'] 08:15:35 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 08:15:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:15:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:15:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:15:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:39 INFO - (blobuploader) - INFO - Done attempting. 08:15:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:15:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:15:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:40 INFO - (blobuploader) - INFO - Done attempting. 08:15:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:15:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:41 INFO - (blobuploader) - INFO - Done attempting. 08:15:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:15:41 INFO - Return code: 0 08:15:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:15:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:15:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4326e817468360ef7ca62f5246416e4ec8463ac5a2217ab914d44c0bfaf0bcb62bc28f01e3661a4cdb54d159511da131af379b673718ce3c5ab3a6552a87b558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80fb460573c7c8c9d2f870fcb36a65b12c3468870c79430ff1c9f4168e48ae4b9a37027e6d48b645c9edc3e39eb32053376fb0ff3f2ad858efff672d77030d18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b58433eda25245b2ebfeda323adbb39d1be24dfd24c84b772003dbe6733092a1119453caff93e786fa60cdaf8a03ecbdf3dde587e48f74567a7abefd0ebde0"} 08:15:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:15:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:15:41 INFO - Contents: 08:15:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4326e817468360ef7ca62f5246416e4ec8463ac5a2217ab914d44c0bfaf0bcb62bc28f01e3661a4cdb54d159511da131af379b673718ce3c5ab3a6552a87b558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80fb460573c7c8c9d2f870fcb36a65b12c3468870c79430ff1c9f4168e48ae4b9a37027e6d48b645c9edc3e39eb32053376fb0ff3f2ad858efff672d77030d18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b58433eda25245b2ebfeda323adbb39d1be24dfd24c84b772003dbe6733092a1119453caff93e786fa60cdaf8a03ecbdf3dde587e48f74567a7abefd0ebde0"} 08:15:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:15:41 INFO - Copying logs to upload dir... 08:15:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:15:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.522894 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-16 08:15:41.398935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 08:15:41.406782) ========= 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=1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054 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/4326e817468360ef7ca62f5246416e4ec8463ac5a2217ab914d44c0bfaf0bcb62bc28f01e3661a4cdb54d159511da131af379b673718ce3c5ab3a6552a87b558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80fb460573c7c8c9d2f870fcb36a65b12c3468870c79430ff1c9f4168e48ae4b9a37027e6d48b645c9edc3e39eb32053376fb0ff3f2ad858efff672d77030d18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b58433eda25245b2ebfeda323adbb39d1be24dfd24c84b772003dbe6733092a1119453caff93e786fa60cdaf8a03ecbdf3dde587e48f74567a7abefd0ebde0"} build_url:https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/JyKmqHsMTKGqV1v8sJD5sg/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/4326e817468360ef7ca62f5246416e4ec8463ac5a2217ab914d44c0bfaf0bcb62bc28f01e3661a4cdb54d159511da131af379b673718ce3c5ab3a6552a87b558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80fb460573c7c8c9d2f870fcb36a65b12c3468870c79430ff1c9f4168e48ae4b9a37027e6d48b645c9edc3e39eb32053376fb0ff3f2ad858efff672d77030d18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b58433eda25245b2ebfeda323adbb39d1be24dfd24c84b772003dbe6733092a1119453caff93e786fa60cdaf8a03ecbdf3dde587e48f74567a7abefd0ebde0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 08:15:41.432365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 08:15:41.432704) ========= 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=1f5564757af27664ca02d71f000001b0-1468679912.430571-710853054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 08:15:41.482081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 08:15:41.485430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 08:15:41.485725) ========= ========= Total master_lag: 0.16 =========