builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1468605392.1 results: success (0) buildid: 20160714100644 builduid: 5f227be7c97e40baa9830ee7d5231abc revision: a2992d672f629f1e56eb35c220779b77eaf53ba8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.102787) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.103823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.104531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.336417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.337160) ========= 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=df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 10:56:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-07-15 10:56:32 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.435089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.435792) ========= 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=df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.489729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:32.490522) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2992d672f629f1e56eb35c220779b77eaf53ba8 --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 a2992d672f629f1e56eb35c220779b77eaf53ba8 --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=df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 10:56:32,787 truncating revision to first 12 chars 2016-07-15 10:56:32,787 Setting DEBUG logging. 2016-07-15 10:56:32,787 attempt 1/10 2016-07-15 10:56:32,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a2992d672f62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 10:56:33,105 unpacking tar archive at: mozilla-aurora-a2992d672f62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:33.157038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:33.157423) ========= script_repo_revision: a2992d672f629f1e56eb35c220779b77eaf53ba8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:33.157873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:33.158173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:56:33.167428) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-15 10:56:33.167769) ========= /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=df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:33 INFO - MultiFileLogger online at 20160715 10:56:33 in /builds/slave/test 10:56:33 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 10:56:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:56:33 INFO - {'append_to_log': False, 10:56:33 INFO - 'base_work_dir': '/builds/slave/test', 10:56:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:56:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:56:33 INFO - 'branch': 'Mozilla-Aurora', 10:56:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:33 INFO - 'config_files': ('talos/linux_config.py',), 10:56:33 INFO - 'default_actions': ('clobber', 10:56:33 INFO - 'read-buildbot-config', 10:56:33 INFO - 'download-and-extract', 10:56:33 INFO - 'populate-webroot', 10:56:33 INFO - 'create-virtualenv', 10:56:33 INFO - 'install', 10:56:33 INFO - 'run-tests'), 10:56:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:33 INFO - 'download_minidump_stackwalk': True, 10:56:33 INFO - 'download_symbols': 'ondemand', 10:56:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:33 INFO - 'installer_path': 'installer.exe', 10:56:33 INFO - 'log_level': 'info', 10:56:33 INFO - 'log_name': 'talos', 10:56:33 INFO - 'log_to_console': True, 10:56:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:33 INFO - 'opt_config_files': (), 10:56:33 INFO - 'pip_index': False, 10:56:33 INFO - 'sps_profile': False, 10:56:33 INFO - 'sps_profile_interval': 0, 10:56:33 INFO - 'suite': 'dromaeojs', 10:56:33 INFO - 'system_bits': '32', 10:56:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:33 INFO - 'title': 'talos-linux64-ix-021', 10:56:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:33 INFO - 'use_talos_json': True, 10:56:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:56:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:33 INFO - 'work_dir': 'build'} 10:56:33 INFO - ##### 10:56:33 INFO - ##### Running clobber step. 10:56:33 INFO - ##### 10:56:33 INFO - Running pre-action listener: _resource_record_pre_action 10:56:33 INFO - Running main action method: clobber 10:56:33 INFO - rmtree: /builds/slave/test/build 10:56:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:56:34 INFO - Running post-action listener: _resource_record_post_action 10:56:34 INFO - ##### 10:56:34 INFO - ##### Finished clobber step (success) 10:56:34 INFO - ##### 10:56:34 INFO - ##### 10:56:34 INFO - ##### Running read-buildbot-config step. 10:56:34 INFO - ##### 10:56:34 INFO - Running pre-action listener: _resource_record_pre_action 10:56:34 INFO - Running main action method: read_buildbot_config 10:56:34 INFO - Using buildbot properties: 10:56:34 INFO - { 10:56:34 INFO - "project": "", 10:56:34 INFO - "product": "firefox", 10:56:34 INFO - "script_repo_revision": "production", 10:56:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:56:34 INFO - "repository": "", 10:56:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:56:34 INFO - "buildid": "20160714100644", 10:56:34 INFO - "pgo_build": "True", 10:56:34 INFO - "basedir": "/builds/slave/test", 10:56:34 INFO - "buildnumber": 369, 10:56:34 INFO - "slavename": "talos-linux64-ix-021", 10:56:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:56:34 INFO - "platform": "ubuntu64_hw", 10:56:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:56:34 INFO - "branch": "mozilla-aurora", 10:56:34 INFO - "repo_path": "releases/mozilla-aurora", 10:56:34 INFO - "revision": "a2992d672f629f1e56eb35c220779b77eaf53ba8", 10:56:34 INFO - "stage_platform": "linux64-pgo", 10:56:34 INFO - "builduid": "5f227be7c97e40baa9830ee7d5231abc", 10:56:34 INFO - "slavebuilddir": "test" 10:56:34 INFO - } 10:56:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:56:34 INFO - Running post-action listener: _resource_record_post_action 10:56:34 INFO - ##### 10:56:34 INFO - ##### Finished read-buildbot-config step (success) 10:56:34 INFO - ##### 10:56:34 INFO - ##### 10:56:34 INFO - ##### Running download-and-extract step. 10:56:34 INFO - ##### 10:56:34 INFO - Running pre-action listener: _resource_record_pre_action 10:56:34 INFO - Running main action method: download_and_extract 10:56:34 INFO - mkdir: /builds/slave/test/build/tests 10:56: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')]} 10:56:34 INFO - https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:35 INFO - Downloaded 1361 bytes. 10:56:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:56:35 INFO - Using the following test package requirements: 10:56:35 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:56:35 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:35 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:56:35 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'jsshell-linux-x86_64.zip'], 10:56:35 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:35 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:56:35 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:56:35 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:56:35 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:35 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:56:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:56:35 INFO - https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:36 INFO - Downloaded 24489794 bytes. 10:56:36 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'] 10:56:36 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 10:56:37 INFO - Return code: 0 10:56:37 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 10:56: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')]} 10:56:37 INFO - https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:38 INFO - Downloaded 24489794 bytes. 10:56:38 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'] 10:56:38 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 10:56:40 INFO - Return code: 0 10:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:56:40 INFO - https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:41 INFO - Downloaded 10833369 bytes. 10:56:41 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'] 10:56:41 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 10:56:41 INFO - Return code: 0 10:56: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')]} 10:56:41 INFO - https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EE73CyieS_y_ekc48iKIUg/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 10:56:42 INFO - Downloaded 63644030 bytes. 10:56:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:56:42 INFO - mkdir: /builds/slave/test/properties 10:56:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:56:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:56:42 INFO - Contents: 10:56:42 INFO - build_url:https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:56:43 INFO - Running post-action listener: _resource_record_post_action 10:56:43 INFO - Running post-action listener: set_extra_try_arguments 10:56:43 INFO - ##### 10:56:43 INFO - ##### Finished download-and-extract step (success) 10:56:43 INFO - ##### 10:56:43 INFO - ##### 10:56:43 INFO - ##### Running populate-webroot step. 10:56:43 INFO - ##### 10:56:43 INFO - Running pre-action listener: _resource_record_pre_action 10:56:43 INFO - Running main action method: populate_webroot 10:56:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:43 INFO - '--tppagecycles', 10:56:43 INFO - '7'], 10:56:43 INFO - 'tests': ['tsvgm']}}, 10:56:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:56:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:56:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:56:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['damp', 'tps']}, 10:56:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'tests': ['damp', 'tps']}, 10:56:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['dromaeo_dom']}, 10:56:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['a11yr', 10:56:43 INFO - 'ts_paint', 10:56:43 INFO - 'tpaint', 10:56:43 INFO - 'sessionrestore', 10:56:43 INFO - 'sessionrestore_no_auto_restore', 10:56:43 INFO - 'tabpaint']}, 10:56:43 INFO - 'other-e10s': {'tests': ['a11yr', 10:56:43 INFO - 'ts_paint', 10:56:43 INFO - 'tpaint', 10:56:43 INFO - 'sessionrestore', 10:56:43 INFO - 'sessionrestore_no_auto_restore', 10:56:43 INFO - 'tabpaint']}, 10:56:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:56:43 INFO - 'ts_paint', 10:56:43 INFO - 'tpaint', 10:56:43 INFO - 'sessionrestore', 10:56:43 INFO - 'sessionrestore_no_auto_restore', 10:56:43 INFO - 'tabpaint']}, 10:56:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:56:43 INFO - 'ts_paint', 10:56:43 INFO - 'tpaint', 10:56:43 INFO - 'sessionrestore', 10:56:43 INFO - 'sessionrestore_no_auto_restore', 10:56:43 INFO - 'tabpaint']}, 10:56:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['a11yr', 10:56:43 INFO - 'ts_paint', 10:56:43 INFO - 'tpaint', 10:56:43 INFO - 'sessionrestore', 10:56:43 INFO - 'sessionrestore_no_auto_restore', 10:56:43 INFO - 'tabpaint']}, 10:56:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['a11yr', 10:56:43 INFO - 'ts_paint', 10:56:43 INFO - 'tpaint', 10:56:43 INFO - 'sessionrestore', 10:56:43 INFO - 'sessionrestore_no_auto_restore', 10:56:43 INFO - 'tabpaint']}, 10:56:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['tsvgx', 10:56:43 INFO - 'tsvgr_opacity', 10:56:43 INFO - 'tart', 10:56:43 INFO - 'tscrollx', 10:56:43 INFO - 'cart']}, 10:56:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:56:43 INFO - 'tsvgr_opacity', 10:56:43 INFO - 'tart', 10:56:43 INFO - 'tscrollx', 10:56:43 INFO - 'cart']}, 10:56:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'talos_options': ['--disable-e10s'], 10:56:43 INFO - 'tests': ['tp5o']}, 10:56:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'tests': ['tp5o']}, 10:56:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'talos_options': ['--disable-e10s', 10:56:43 INFO - '--xperf_path', 10:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:43 INFO - 'tests': ['tp5n']}, 10:56:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:43 INFO - 'talos_options': ['--xperf_path', 10:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:43 INFO - 'tests': ['tp5n']}}, 10:56:43 INFO - 'talos.zip': {'path': '', 10:56:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:43 INFO - Running post-action listener: _resource_record_post_action 10:56:43 INFO - ##### 10:56:43 INFO - ##### Finished populate-webroot step (success) 10:56:43 INFO - ##### 10:56:43 INFO - ##### 10:56:43 INFO - ##### Running create-virtualenv step. 10:56:43 INFO - ##### 10:56:43 INFO - Running pre-action listener: _resource_record_pre_action 10:56:43 INFO - Running main action method: create_virtualenv 10:56:43 INFO - Creating virtualenv /builds/slave/test/build/venv 10:56:43 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 10:56:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:56:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:43 INFO - Using real prefix '/usr' 10:56:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:56:44 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:46 INFO - Installing pip.................done. 10:56:46 INFO - Return code: 0 10:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:56:46 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')]} 10:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:46 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')]} 10:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:46 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:56:46 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 10:56:46 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 10:56:46 INFO - Using env: {'DISPLAY': ':0', 10:56:46 INFO - 'HOME': '/home/cltbld', 10:56:46 INFO - 'LANG': 'en_US.UTF-8', 10:56:46 INFO - 'LANGUAGE': 'en_US:en', 10:56:46 INFO - 'LOGNAME': 'cltbld', 10:56:46 INFO - 'MAIL': '/var/mail/cltbld', 10:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:46 INFO - 'MOZ_NO_REMOTE': '1', 10:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:46 INFO - 'NO_EM_RESTART': '1', 10:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:46 INFO - 'PWD': '/builds/slave/test', 10:56:46 INFO - 'SHELL': '/bin/bash', 10:56:46 INFO - 'SHLVL': '1', 10:56:46 INFO - 'TERM': 'linux', 10:56:46 INFO - 'TMOUT': '86400', 10:56:46 INFO - 'USER': 'cltbld', 10:56:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:46 INFO - '_': '/tools/buildbot/bin/python'} 10:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:46 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 10:56:46 INFO - Cleaning up... 10:56:46 INFO - Return code: 0 10:56:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:56:46 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')]} 10:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:46 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')]} 10:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:46 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:56:46 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 10:56:46 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 10:56:46 INFO - Using env: {'DISPLAY': ':0', 10:56:46 INFO - 'HOME': '/home/cltbld', 10:56:46 INFO - 'LANG': 'en_US.UTF-8', 10:56:46 INFO - 'LANGUAGE': 'en_US:en', 10:56:46 INFO - 'LOGNAME': 'cltbld', 10:56:46 INFO - 'MAIL': '/var/mail/cltbld', 10:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:46 INFO - 'MOZ_NO_REMOTE': '1', 10:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:46 INFO - 'NO_EM_RESTART': '1', 10:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:46 INFO - 'PWD': '/builds/slave/test', 10:56:46 INFO - 'SHELL': '/bin/bash', 10:56:46 INFO - 'SHLVL': '1', 10:56:46 INFO - 'TERM': 'linux', 10:56:46 INFO - 'TMOUT': '86400', 10:56:46 INFO - 'USER': 'cltbld', 10:56:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:46 INFO - '_': '/tools/buildbot/bin/python'} 10:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:46 INFO - Downloading/unpacking psutil>=3.1.1 10:56:46 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 10:56:46 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 10:56:46 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 10:56:46 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 10:56:46 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 10:56:46 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 10:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:48 INFO - Installing collected packages: psutil 10:56:48 INFO - Running setup.py install for psutil 10:56:48 INFO - building 'psutil._psutil_linux' extension 10:56:48 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 10:56:49 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 10:56:49 INFO - building 'psutil._psutil_posix' extension 10:56:49 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 10:56:49 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 10:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:49 INFO - Successfully installed psutil 10:56:49 INFO - Cleaning up... 10:56:49 INFO - Return code: 0 10:56:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:56:49 INFO - Using env: {'DISPLAY': ':0', 10:56:49 INFO - 'HOME': '/home/cltbld', 10:56:49 INFO - 'LANG': 'en_US.UTF-8', 10:56:49 INFO - 'LANGUAGE': 'en_US:en', 10:56:49 INFO - 'LOGNAME': 'cltbld', 10:56:49 INFO - 'MAIL': '/var/mail/cltbld', 10:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:49 INFO - 'MOZ_NO_REMOTE': '1', 10:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:49 INFO - 'NO_EM_RESTART': '1', 10:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:49 INFO - 'PWD': '/builds/slave/test', 10:56:49 INFO - 'SHELL': '/bin/bash', 10:56:49 INFO - 'SHLVL': '1', 10:56:49 INFO - 'TERM': 'linux', 10:56:49 INFO - 'TMOUT': '86400', 10:56:49 INFO - 'USER': 'cltbld', 10:56:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:49 INFO - '_': '/tools/buildbot/bin/python'} 10:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:56:49 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 10:56:49 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 10:56:49 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 10:56:49 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 10:56:49 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 10:56:49 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 10:56:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:56:51 INFO - Installing collected packages: mozsystemmonitor 10:56:51 INFO - Running setup.py install for mozsystemmonitor 10:56:51 INFO - Successfully installed mozsystemmonitor 10:56:51 INFO - Cleaning up... 10:56:51 INFO - Return code: 0 10:56:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:56:51 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')]} 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:51 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')]} 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:51 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:56:51 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 10:56:51 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 10:56:51 INFO - Using env: {'DISPLAY': ':0', 10:56:51 INFO - 'HOME': '/home/cltbld', 10:56:51 INFO - 'LANG': 'en_US.UTF-8', 10:56:51 INFO - 'LANGUAGE': 'en_US:en', 10:56:51 INFO - 'LOGNAME': 'cltbld', 10:56:51 INFO - 'MAIL': '/var/mail/cltbld', 10:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:51 INFO - 'MOZ_NO_REMOTE': '1', 10:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:51 INFO - 'NO_EM_RESTART': '1', 10:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:51 INFO - 'PWD': '/builds/slave/test', 10:56:51 INFO - 'SHELL': '/bin/bash', 10:56:51 INFO - 'SHLVL': '1', 10:56:51 INFO - 'TERM': 'linux', 10:56:51 INFO - 'TMOUT': '86400', 10:56:51 INFO - 'USER': 'cltbld', 10:56:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:51 INFO - '_': '/tools/buildbot/bin/python'} 10:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:51 INFO - Downloading/unpacking jsonschema==2.5.1 10:56:51 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 10:56:51 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 10:56:51 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 10:56:51 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 10:56:51 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 10:56:51 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 10:56:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:56:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:56:53 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 10:56:53 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 10:56:53 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 10:56:53 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 10:56:53 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 10:56:53 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 10:56:54 INFO - Downloading functools32-3.2.3-2.tar.gz 10:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:56:54 INFO - warning: no files found matching '*.txt' 10:56:54 INFO - no previously-included directories found matching 'build' 10:56:54 INFO - no previously-included directories found matching 'dist' 10:56:54 INFO - no previously-included directories found matching '.git*' 10:56:54 INFO - Installing collected packages: jsonschema, functools32 10:56:54 INFO - Running setup.py install for functools32 10:56:54 INFO - warning: no files found matching '*.txt' 10:56:54 INFO - no previously-included directories found matching 'build' 10:56:54 INFO - no previously-included directories found matching 'dist' 10:56:54 INFO - no previously-included directories found matching '.git*' 10:56:54 INFO - Successfully installed jsonschema functools32 10:56:54 INFO - Cleaning up... 10:56:54 INFO - Return code: 0 10:56:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:56:54 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')]} 10:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:54 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')]} 10:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:54 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:56:54 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 10:56:54 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 10:56:54 INFO - Using env: {'DISPLAY': ':0', 10:56:54 INFO - 'HOME': '/home/cltbld', 10:56:54 INFO - 'LANG': 'en_US.UTF-8', 10:56:54 INFO - 'LANGUAGE': 'en_US:en', 10:56:54 INFO - 'LOGNAME': 'cltbld', 10:56:54 INFO - 'MAIL': '/var/mail/cltbld', 10:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:54 INFO - 'MOZ_NO_REMOTE': '1', 10:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:54 INFO - 'NO_EM_RESTART': '1', 10:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:54 INFO - 'PWD': '/builds/slave/test', 10:56:54 INFO - 'SHELL': '/bin/bash', 10:56:54 INFO - 'SHLVL': '1', 10:56:54 INFO - 'TERM': 'linux', 10:56:54 INFO - 'TMOUT': '86400', 10:56:54 INFO - 'USER': 'cltbld', 10:56:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:54 INFO - '_': '/tools/buildbot/bin/python'} 10:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:56:54 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 10:56:54 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 10:56:54 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 10:56:54 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 10:56:54 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 10:56:54 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 10:56:56 INFO - Downloading blobuploader-1.2.4.tar.gz 10:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:56:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:56:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:57 INFO - Downloading docopt-0.6.1.tar.gz 10:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:57 INFO - Running setup.py install for blobuploader 10:56:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:56:57 INFO - Running setup.py install for requests 10:56:57 INFO - Running setup.py install for docopt 10:56:57 INFO - Successfully installed blobuploader requests docopt 10:56:57 INFO - Cleaning up... 10:56:57 INFO - Return code: 0 10:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:57 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:56:57 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 10:56:57 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 10:56:57 INFO - Using env: {'DISPLAY': ':0', 10:56:57 INFO - 'HOME': '/home/cltbld', 10:56:57 INFO - 'LANG': 'en_US.UTF-8', 10:56:57 INFO - 'LANGUAGE': 'en_US:en', 10:56:57 INFO - 'LOGNAME': 'cltbld', 10:56:57 INFO - 'MAIL': '/var/mail/cltbld', 10:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:57 INFO - 'MOZ_NO_REMOTE': '1', 10:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:57 INFO - 'NO_EM_RESTART': '1', 10:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:57 INFO - 'PWD': '/builds/slave/test', 10:56:57 INFO - 'SHELL': '/bin/bash', 10:56:57 INFO - 'SHLVL': '1', 10:56:57 INFO - 'TERM': 'linux', 10:56:57 INFO - 'TMOUT': '86400', 10:56:57 INFO - 'USER': 'cltbld', 10:56:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:57 INFO - '_': '/tools/buildbot/bin/python'} 10:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:58 INFO - Running setup.py (path:/tmp/pip-94Bfuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:58 INFO - Running setup.py (path:/tmp/pip-rhDBl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:58 INFO - Running setup.py (path:/tmp/pip-Y3C3jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:58 INFO - Running setup.py (path:/tmp/pip-eHH8dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:58 INFO - Running setup.py (path:/tmp/pip-sAlsbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:58 INFO - Running setup.py (path:/tmp/pip-alsIfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:58 INFO - Running setup.py (path:/tmp/pip-FApRnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:58 INFO - Running setup.py (path:/tmp/pip-BmkM0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:58 INFO - Running setup.py (path:/tmp/pip-sM2OQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:58 INFO - Running setup.py (path:/tmp/pip-_FpXTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:58 INFO - Running setup.py (path:/tmp/pip-rwinUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:58 INFO - Running setup.py (path:/tmp/pip-HMQfxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:58 INFO - Running setup.py (path:/tmp/pip-xuBO4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:59 INFO - Running setup.py (path:/tmp/pip-bbok7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:59 INFO - Running setup.py (path:/tmp/pip-NgugBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:59 INFO - Running setup.py (path:/tmp/pip-JBgwI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:59 INFO - Running setup.py (path:/tmp/pip-dKHrOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:59 INFO - Running setup.py install for manifestparser 10:56:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:56:59 INFO - Running setup.py install for mozcrash 10:56:59 INFO - Running setup.py install for mozdebug 10:56:59 INFO - Running setup.py install for mozdevice 10:56:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:56:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:56:59 INFO - Running setup.py install for mozfile 10:56:59 INFO - Running setup.py install for mozhttpd 10:56:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:56:59 INFO - Running setup.py install for mozinfo 10:56:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:56:59 INFO - Running setup.py install for mozInstall 10:57:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Running setup.py install for mozleak 10:57:00 INFO - Running setup.py install for mozlog 10:57:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Running setup.py install for moznetwork 10:57:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Running setup.py install for mozprocess 10:57:00 INFO - Running setup.py install for mozprofile 10:57:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Running setup.py install for mozrunner 10:57:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:00 INFO - Running setup.py install for mozscreenshot 10:57:00 INFO - Running setup.py install for moztest 10:57:00 INFO - Running setup.py install for mozversion 10:57:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:01 INFO - Cleaning up... 10:57:01 INFO - Return code: 0 10:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:01 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:57:01 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 10:57:01 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 10:57:01 INFO - Using env: {'DISPLAY': ':0', 10:57:01 INFO - 'HOME': '/home/cltbld', 10:57:01 INFO - 'LANG': 'en_US.UTF-8', 10:57:01 INFO - 'LANGUAGE': 'en_US:en', 10:57:01 INFO - 'LOGNAME': 'cltbld', 10:57:01 INFO - 'MAIL': '/var/mail/cltbld', 10:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:01 INFO - 'MOZ_NO_REMOTE': '1', 10:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:01 INFO - 'NO_EM_RESTART': '1', 10:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:01 INFO - 'PWD': '/builds/slave/test', 10:57:01 INFO - 'SHELL': '/bin/bash', 10:57:01 INFO - 'SHLVL': '1', 10:57:01 INFO - 'TERM': 'linux', 10:57:01 INFO - 'TMOUT': '86400', 10:57:01 INFO - 'USER': 'cltbld', 10:57:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:01 INFO - '_': '/tools/buildbot/bin/python'} 10:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:01 INFO - Running setup.py (path:/tmp/pip-dSh6N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:01 INFO - Running setup.py (path:/tmp/pip-IadUEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:01 INFO - Running setup.py (path:/tmp/pip-O7Exv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:01 INFO - Running setup.py (path:/tmp/pip-A7vLef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:01 INFO - Running setup.py (path:/tmp/pip-T4r4Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:01 INFO - Running setup.py (path:/tmp/pip-PWLAcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:01 INFO - Running setup.py (path:/tmp/pip-Va3P6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:01 INFO - Running setup.py (path:/tmp/pip-t85Wbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:01 INFO - Running setup.py (path:/tmp/pip-65CZU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:01 INFO - Running setup.py (path:/tmp/pip-W9wD8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:02 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)) 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:02 INFO - Running setup.py (path:/tmp/pip-dN66zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:02 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)) 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:02 INFO - Running setup.py (path:/tmp/pip-GPgVIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:02 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)) 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:02 INFO - Running setup.py (path:/tmp/pip-GLmGcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:02 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)) 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:02 INFO - Running setup.py (path:/tmp/pip-7gscDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:02 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)) 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:02 INFO - Running setup.py (path:/tmp/pip-LCHH62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:02 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)) 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:02 INFO - Running setup.py (path:/tmp/pip-CEGup8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:02 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)) 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:02 INFO - Running setup.py (path:/tmp/pip-FGWevB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:02 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)) 10:57:02 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)) 10:57:02 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)) 10:57:02 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)) 10:57:02 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)) 10:57:02 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)) 10:57:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:02 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 10:57:02 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 10:57:02 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 10:57:02 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 10:57:02 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 10:57:02 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 10:57:04 INFO - Downloading blessings-1.6.tar.gz 10:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:04 INFO - Installing collected packages: blessings 10:57:04 INFO - Running setup.py install for blessings 10:57:04 INFO - Successfully installed blessings 10:57:04 INFO - Cleaning up... 10:57:04 INFO - Return code: 0 10:57:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:04 INFO - Reading from file tmpfile_stdout 10:57:04 INFO - Current package versions: 10:57:04 INFO - argparse == 1.2.1 10:57:04 INFO - blessings == 1.6 10:57:04 INFO - blobuploader == 1.2.4 10:57:04 INFO - docopt == 0.6.1 10:57:04 INFO - functools32 == 3.2.3-2 10:57:04 INFO - jsonschema == 2.5.1 10:57:04 INFO - manifestparser == 1.1 10:57:04 INFO - mozInstall == 1.12 10:57:04 INFO - mozcrash == 0.17 10:57:04 INFO - mozdebug == 0.1 10:57:04 INFO - mozdevice == 0.48 10:57:04 INFO - mozfile == 1.2 10:57:04 INFO - mozhttpd == 0.7 10:57:04 INFO - mozinfo == 0.9 10:57:04 INFO - mozleak == 0.1 10:57:04 INFO - mozlog == 3.2 10:57:04 INFO - moznetwork == 0.27 10:57:04 INFO - mozprocess == 0.23 10:57:04 INFO - mozprofile == 0.28 10:57:04 INFO - mozrunner == 6.12 10:57:04 INFO - mozscreenshot == 0.1 10:57:04 INFO - mozsystemmonitor == 0.3 10:57:04 INFO - moztest == 0.7 10:57:04 INFO - mozversion == 1.4 10:57:04 INFO - psutil == 3.1.1 10:57:04 INFO - requests == 1.2.3 10:57:04 INFO - wsgiref == 0.1.2 10:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:04 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:57:04 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 10:57:04 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 10:57:04 INFO - Using env: {'DISPLAY': ':0', 10:57:04 INFO - 'HOME': '/home/cltbld', 10:57:04 INFO - 'LANG': 'en_US.UTF-8', 10:57:04 INFO - 'LANGUAGE': 'en_US:en', 10:57:04 INFO - 'LOGNAME': 'cltbld', 10:57:04 INFO - 'MAIL': '/var/mail/cltbld', 10:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:04 INFO - 'MOZ_NO_REMOTE': '1', 10:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:04 INFO - 'NO_EM_RESTART': '1', 10:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:04 INFO - 'PWD': '/builds/slave/test', 10:57:04 INFO - 'SHELL': '/bin/bash', 10:57:04 INFO - 'SHLVL': '1', 10:57:04 INFO - 'TERM': 'linux', 10:57:04 INFO - 'TMOUT': '86400', 10:57:04 INFO - 'USER': 'cltbld', 10:57:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:04 INFO - '_': '/tools/buildbot/bin/python'} 10:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 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)) 10:57:05 INFO - Cleaning up... 10:57:05 INFO - Return code: 0 10:57:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:05 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')]} 10:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:05 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')]} 10:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:05 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:57:05 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 10:57:05 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 10:57:05 INFO - Using env: {'DISPLAY': ':0', 10:57:05 INFO - 'HOME': '/home/cltbld', 10:57:05 INFO - 'LANG': 'en_US.UTF-8', 10:57:05 INFO - 'LANGUAGE': 'en_US:en', 10:57:05 INFO - 'LOGNAME': 'cltbld', 10:57:05 INFO - 'MAIL': '/var/mail/cltbld', 10:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:05 INFO - 'MOZ_NO_REMOTE': '1', 10:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:05 INFO - 'NO_EM_RESTART': '1', 10:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:05 INFO - 'PWD': '/builds/slave/test', 10:57:05 INFO - 'SHELL': '/bin/bash', 10:57:05 INFO - 'SHLVL': '1', 10:57:05 INFO - 'TERM': 'linux', 10:57:05 INFO - 'TMOUT': '86400', 10:57:05 INFO - 'USER': 'cltbld', 10:57:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:05 INFO - '_': '/tools/buildbot/bin/python'} 10:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:57:05 INFO - Cleaning up... 10:57:05 INFO - Return code: 0 10:57:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:57:05 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')]} 10:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:05 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')]} 10:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:05 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 0x7f182c105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, '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': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', '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 10:57:05 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 10:57:05 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 10:57:05 INFO - Using env: {'DISPLAY': ':0', 10:57:05 INFO - 'HOME': '/home/cltbld', 10:57:05 INFO - 'LANG': 'en_US.UTF-8', 10:57:05 INFO - 'LANGUAGE': 'en_US:en', 10:57:05 INFO - 'LOGNAME': 'cltbld', 10:57:05 INFO - 'MAIL': '/var/mail/cltbld', 10:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:05 INFO - 'MOZ_NO_REMOTE': '1', 10:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:05 INFO - 'NO_EM_RESTART': '1', 10:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:05 INFO - 'PWD': '/builds/slave/test', 10:57:05 INFO - 'SHELL': '/bin/bash', 10:57:05 INFO - 'SHLVL': '1', 10:57:05 INFO - 'TERM': 'linux', 10:57:05 INFO - 'TMOUT': '86400', 10:57:05 INFO - 'USER': 'cltbld', 10:57:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:05 INFO - '_': '/tools/buildbot/bin/python'} 10:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:05 INFO - Downloading/unpacking flake8 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:08 INFO - no previously-included directories found matching 'docs/_build' 10:57:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:08 INFO - Running setup.py install for pep8 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:08 INFO - no previously-included directories found matching 'docs/_build' 10:57:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:57:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:08 INFO - Cleaning up... 10:57:08 INFO - Return code: 0 10:57:08 INFO - Running post-action listener: _resource_record_post_action 10:57:08 INFO - Running post-action listener: _start_resource_monitoring 10:57:08 INFO - Starting resource monitoring. 10:57:08 INFO - ##### 10:57:08 INFO - ##### Finished create-virtualenv step (success) 10:57:08 INFO - ##### 10:57:08 INFO - ##### 10:57:08 INFO - ##### Running install step. 10:57:08 INFO - ##### 10:57:08 INFO - Running pre-action listener: _resource_record_pre_action 10:57:08 INFO - Running main action method: install 10:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:08 INFO - Reading from file tmpfile_stdout 10:57:08 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:08 INFO - Reading from file tmpfile_stdout 10:57:08 INFO - Output received: 10:57:08 INFO - Usage: mozinstall [options] installer 10:57:08 INFO - Options: 10:57:08 INFO - -h, --help show this help message and exit 10:57:08 INFO - -d DEST, --destination=DEST 10:57:08 INFO - Directory to install application into. [default: 10:57:08 INFO - "/builds/slave/test"] 10:57:08 INFO - --app=APP Application being installed. [default: firefox] 10:57:08 INFO - mkdir: /builds/slave/test/build/application 10:57:08 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'] 10:57:08 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 10:57:26 INFO - Reading from file tmpfile_stdout 10:57:26 INFO - Output received: 10:57:26 INFO - /builds/slave/test/build/application/firefox/firefox 10:57:26 INFO - Running post-action listener: _resource_record_post_action 10:57:26 INFO - ##### 10:57:26 INFO - ##### Finished install step (success) 10:57:26 INFO - ##### 10:57:26 INFO - ##### 10:57:26 INFO - ##### Running run-tests step. 10:57:26 INFO - ##### 10:57:26 INFO - Running pre-action listener: _resource_record_pre_action 10:57:26 INFO - Running main action method: run_tests 10:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:26 INFO - Python 2.7.3 10:57:26 INFO - Return code: 0 10:57:26 INFO - grabbing minidump binary from tooltool 10:57: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')]} 10:57:26 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 0x2b5a1c0>, '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 0x2b5b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:26 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 10:57:26 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 10:57:26 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 10:57:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:26 INFO - Return code: 0 10:57:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:57:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:57:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:57:27 INFO - Return code: 0 10:57:27 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/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:57:27 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/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 10:57:27 INFO - Using env: {'DISPLAY': ':0', 10:57:27 INFO - 'HOME': '/home/cltbld', 10:57:27 INFO - 'LANG': 'en_US.UTF-8', 10:57:27 INFO - 'LANGUAGE': 'en_US:en', 10:57:27 INFO - 'LOGNAME': 'cltbld', 10:57:27 INFO - 'MAIL': '/var/mail/cltbld', 10:57:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:27 INFO - 'MOZ_NO_REMOTE': '1', 10:57:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:27 INFO - 'NO_EM_RESTART': '1', 10:57:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:27 INFO - 'PWD': '/builds/slave/test', 10:57:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:27 INFO - 'SHELL': '/bin/bash', 10:57:27 INFO - 'SHLVL': '1', 10:57:27 INFO - 'TERM': 'linux', 10:57:27 INFO - 'TMOUT': '86400', 10:57:27 INFO - 'USER': 'cltbld', 10:57:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342', 10:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:27 INFO - '_': '/tools/buildbot/bin/python'} 10:57:27 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/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:57:27 INFO - mozversion application_buildid: 20160714100644 10:57:27 INFO - mozversion application_changeset: a2992d672f629f1e56eb35c220779b77eaf53ba8 10:57:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:57:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:27 INFO - mozversion application_name: Firefox 10:57:27 INFO - mozversion application_remotingname: firefox-dev 10:57:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:57:27 INFO - mozversion application_vendor: Mozilla 10:57:27 INFO - mozversion application_version: 49.0a2 10:57:27 INFO - mozversion platform_buildid: 20160714100644 10:57:27 INFO - mozversion platform_changeset: a2992d672f629f1e56eb35c220779b77eaf53ba8 10:57:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:57:27 INFO - mozversion platform_version: 49.0a2 10:57:27 INFO - using testdate: 1468605447 10:57:27 INFO - actual date: 1468605447 10:57:27 INFO - starting webserver on 'localhost:47542' 10:57:27 INFO - SUITE-START | Running 2 tests 10:57:27 INFO - TEST-START | dromaeo_css 10:57:27 INFO - operating with platform_type : linux_ 10:57:27 INFO - Initialising browser for dromaeo_css test... 10:57:27 INFO - TEST-INFO | started process 1898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5hPdOp/profile http://localhost:47542/getInfo.html) 10:57:32 INFO - PROCESS | 1898 | __metrics Screen width/height:1600/1200 10:57:32 INFO - PROCESS | 1898 | colorDepth:24 10:57:32 INFO - PROCESS | 1898 | Browser inner width/height: 1024/697 10:57:32 INFO - PROCESS | 1898 | __metrics 10:57:34 ERROR - PROCESS | 1898 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:57:35 INFO - TEST-INFO | 1898: exit 0 10:57:35 INFO - Browser initialized. 10:57:35 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:35 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5hPdOp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:47 INFO - PROCESS | 1988 | RSS: Main: 145747968 10:57:47 INFO - PROCESS | 1988 | 10:58:38 INFO - PROCESS | 1988 | 1468605518229 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] 11:00:46 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:47542/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47542/tests/dromaeo/cssquery-ext.html) 11:00:47 INFO - PROCESS | 1988 | RSS: Main: 254115840 11:00:47 INFO - PROCESS | 1988 | 11:03:49 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:47542/tests/dromaeo/cssquery-ext.html (next: http://localhost:47542/tests/dromaeo/cssquery-jquery.html) 11:03:50 INFO - PROCESS | 1988 | RSS: Main: 226062336 11:03:50 INFO - PROCESS | 1988 | 11:06:52 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:47542/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47542/tests/dromaeo/cssquery-mootools.html) 11:06:53 INFO - PROCESS | 1988 | RSS: Main: 227299328 11:06:53 INFO - PROCESS | 1988 | 11:09:55 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:47542/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47542/tests/dromaeo/cssquery-prototype.html) 11:09:55 INFO - PROCESS | 1988 | RSS: Main: 224645120 11:09:55 INFO - PROCESS | 1988 | 11:12:58 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:47542/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47542/tests/dromaeo/cssquery-yui.html) 11:12:58 INFO - PROCESS | 1988 | RSS: Main: 213979136 11:12:58 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:47542/tests/dromaeo/cssquery-yui.html (next: http://localhost:47542/tests/dromaeo/cssquery-dojo.html) 11:16:01 INFO - PROCESS | 1988 | RSS: Main: 257892352 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | __start_tp_report 11:16:01 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 11:16:01 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 11:16:01 INFO - PROCESS | 1988 | |i|pagename|runs| 11:16:01 INFO - PROCESS | 1988 | |0;dojo.html;3293.1931676739196;3353.3963886500437;3366.3267346530683;3375.4599264117746;3406.5230867678515;5508.669479831208;5587.636803607773;5593;5594.804181853636;5597.6641401515935;5454.181872719094;5488.231647569343;5507.972460137694;5518.034343989806;5529.0324193266115;4986.9750651246695;5014.42334131575;5025.0703619830265;5029.924551131736;5054.292399064134;5060.038592667382;5136.614753893455;5150.690958542481;5153.561947234471;5154.278401023859;5034.647574669774;5082;5090.134677104883;5124.282600435942;5154.8711282218055;5178.1973794061605;5197.090509160882;5198.324217851693;5201.245819356172;5219;4978.402591688984;5003;5054.9241761373605;5103;5106.872328191787;5385.407605163429;5394.190871369326;5405.054115529806;5420.430854760233;5455.727213639302;5932.139839723216;5978.073398623221;5979.970100149515;5982.760689572412;5983.252093488314;5873.588848780587;5928.258967629046;5960.225170727821;6000.18997435345;6001.399860013964;5564.8330550083565;5605.943940560624;5621.241132447109;5630.465105814941;5632.943670563324;5938.8812223755285;6121.371505986887;6125.7012684027995;6128.877422451526;6130.356312587203;5717.857053573611;5749.885002300014;5766.798162064391;5860.853478663067;5872.119182122716;5903.881922361528;5904.409559044061;5907.763689452374;5933.465988061095;5963.016102343065;5831.241938547962;5868.911966320423;5870.442307980735;5872.911906321408;5872.941270587325;5891.05743081105;5962.850928726816;5965.55258355625;5967.76128954837;6010.248718910137;4577.404937358188;4581.312803079565;4582.473015603248;4585.610223131004;4609.907801843944;4046.291898917678;4047.6357127858632;4084.4281800547947;4123.257813593522;4163.10493243954;5702.372738998707;5710.486056254874;5728.455796699307;5730.426957304319;5752.884942301131;6008.24896887889;6029.57792954489;6030.909536356959;6031.819045428644;6053.757849685963;5508.03609368367;5595.63628364155;5685.147227915846;5694;5704.543636509069;5113.948860511422;5134.127198376285;5139.691618502902;5140.30605868203;5142.61430392722;6092.573519853568;6092.695365231721;6096.786612468631;6104.481119104926;6120.44915957566;5828.59199856006;5883.55873309512;5936.1986131871645;5962.403759624003;5984.491318237824;6126.785562505291;6140.5701600887505;6141.8464538385115;6152.507799376129;6158.753649854135;5816.331121920864;5882.676452795137;5883.235179426818;5885.911711324419;5888.793892213752;5907.527397808251;5945.821625351246;5984.281886173687;6034.39656034393;6040.395960403925;5816.854578635568;5848.707564621837;5860.238169037998;5863.589548731547;5880.676562789087;5686.431356864446;5704.1443783432815;5805.477507024388;5855.121731740273;5871.823845284648;5663.348714897839;5749.367569567428;5752.511036561939;5756.079027355603;5783.681897495678;5857.648541087548;5862.472377486047;5888.116782482491;5890.882182356243;5895;5520.503154715934;5617.410171931889;5676.20533125371;5681.034224181816;5722.62802917809 11:16:01 INFO - PROCESS | 1988 | |1;ext.html;597.1669521018177;653.6176336842947;656.9934300656992;658.2660333727895;666.7666316789124;32710;46149.76925115374;46999.0600187996;47328.76335618317;47338.289925651145;48270.75864620681;48568.2714759278;48571.75714121433;48656;48734.75632621832;8325.83348333033;8971.147740964614;9122.768426262435;9123.315751318678;10816.188785841054;10553.155747540179;10667.14662826972;10995.890041099567;11005.61480348188;11054.834177487344;11110.055645270162;11215.663530094069;11216.439178041106;11218.27081239721;11220.046296064844;8335.499870007789;10769.407682577455;10986.890131098666;11028.062614677761;11035.72410689731;10862.891371086267;10930.289531180448;10948.726281842937;10955.50700218492;10958.342499450058;46228;46723.53276467226;46728;46732.53267467316;46735;3770.3213421584105;3874.728768986172;4008.5390180129366;4267.1892340455215;4476.836022634138;36411.4538281926;37030.25939481222;37126.62873371259;37219.813900930596;37423;4801.879953001168;4812.711237325737;4824.2040063389495;4922.901541969176;4954.578860796837;396929;538956;547745;549107;549211.999999996;70799.29200707928;71143.28856711471;71565;71632.2836771636;71709;40524.39213411801;41460;75452.62273688597;76278.61860690772;76378;18779.624407511772;18980.43058708241;19035.333763318216;19040.333588324618;19041.7143742844;13210.603681889559;14267.571972840831;14641;14651.780223296659;15012.549623511311;22877.656835147485;23010.65484017741;23132.76867231306;23190.53618927612;23318.067277309055;8109.675612975533;8136.959315203504;8326.417150799385;8343.874841877378;8361.958190209132;928.4568527411404;945.9716208513755;976.8339382305026;985.5417230987625;992.533509250651;32698;34525.827370862986;34880.65119348825;35073.82463087719;35363.4695479568;1193.1945936492832;1197.694587880085;1206.330486579939;1262.280500114944;1263.0211586020723;18161.182746776427;18165.455036348932;18247;18330.63338733218;18353.17410716521;619767;620483;622653.3204003887;625367;626824;65420;65810.34189658138;66220.66889665618;66298.33701663018;66356.33643663501;1350.3653282956996;1451.1075688451526;1462.1227263641729;1476.8301645310926;1492.5373134328393;33570.832145839115;34323.82838085893;34507.48238776471;34808.82595587107;35268.64731352653;54285.185722214985;54959.72520137374;54990.725046374515;55017;55044.0734574288;423662;428885;430332;430862;432258;26967.325816854736;27690.3077423058;28259.858700706365;31404.214894626904;31909.840450797597;52805;53510.4648953521;53753;54111.72944135254;54741.452585473635;40089.39865901956;40872.59127408807;41029.79485102555;41086.79456602818;42246.366304506075;43151;43730.562694372646;43977.78011109924;44132.558674412845;45404;44251;44847.55152448434;45087.32369014402;45113.548864510936;45361;37715.245695086494;40524.39213411742;41051;41189.79405102955;41427.58572414358;30369.544456832722;30539.847300763355;30699.465710166936;30857;30921.8453907729 11:16:01 INFO - PROCESS | 1988 | |2;jquery.html;401.4901075633947;402.4446264155465;403.519811424405;414.6869113819067;423.07557985801026;15010.849891501082;19290;20785.896070519662;20834.583308333844;21435.249766258185;20732.378028659128;20900.581988360223;21157.365279041616;21174;21242.150313987462;5594.160875868622;5772.480476757091;5795.797147099853;5799.2750906136735;5830.30036395631;4191.497020357561;5715.3141623005295;5721.513671337942;5755.971220143893;5765.077587585987;6040.003399439087;6342.556021078503;6358;6449.097126402307;6457.741690332405;6281.277653069909;6301;6345.555811093225;6349.269833969107;6400.9359906400805;5552.694601796899;5656.802011929604;5694.544436445074;5698.857528561778;5729.054705973509;24119.155829546056;24582.385440363956;25124.24627261185;25135.748642513525;25136.24591262265;2567.640530325737;2575.703794063669;2811.5079861024237;2879.510483217858;2936.4714351416737;14458.49395271171;14838.258087095603;14936.775948360782;15370.385184592604;15779.763303550455;2033.095272603692;2056.856020078595;2078;2123.2568600989684;2156.7519735230494;79188.60405697934;81487.5925620374;82513;82536;82785.78595483847;10727.195460340507;10761.78476430467;10811.6215932442;11005.614803482;11231.21381503287;15473.690526189414;15481.303341349667;15550.533483995498;15611.375544978073;15617.765733514007;8745.956270218609;9048.366614336934;9101.362904596615;9119.498427586414;9227.400218985744;8955.238804701674;9004.234640055669;9056.954715226513;9111.498867562215;9142.3600347975;6943.652817359111;6956.582605043714;6983.89524157138;7047.859042819217;7065.858682826418;1925.528245579842;1925.6052509235574;1938.4959910423393;1966.5771859050374;2008.2167954497756;1034.9223808214415;1073.7315671082229;1117.8826223246604;1141.577616281981;1171.8886705762939;20421.591568168555;20975.265865694626;21019.264325748525;21065.78934210669;21097.578048438947;1117.7485065860278;1118.0999295566985;1121.2095472691733;1134.5405110929921;1168.8831116888414;11606.76786464266;11968.162228644085;12134.757304853854;12152.513899443924;12222.572209972608;459509;461532;469543;503838;504725;53598;54615.45384546183;71103.64448177726;73540;73906;1103.2883789955433;1106.280917403694;1122.887711228887;1132.5186795611833;1137.9203455758184;18749.906250469205;18803.247870085044;18807.623847523246;18858.905705471385;19044.523886902938;39708.404373934995;39734.20531589294;40856.591434085276;40897.795511022254;40946.59053409428;52040.21939670832;54973;55193;55415.44584554103;55528;8955.552222388724;8955.776105597412;8981.191692747683;9072.818543628959;9319.534023298944;8634.78413039679;13713.108647937852;13960;14027;14089;12201.633950981484;12212.877871221173;12278.324692142018;12297.56958506448;12454.564090256797;12087.516499339928;12100.576479823163;12117.333546655018;12236.44935977901;12372.566960156351;12203.450844712186;12347.69130771738;12398.318092504998;12426.813597796221;12439.191452555555;7437.665305061177;7607.896854956111;8925.241354484682;9155.404898681565;9222.95388523053;11818.763624727286;11958.70103247391;12102.455389507317;12227.327496987395;12376.504939802307 11:16:01 INFO - PROCESS | 1988 | |3;mootools.html;1407.162738170788;1531.219078270082;1560.4538411555957;1753.307443559794;1888.2447021191522;8658.307335413168;8978.416402933814;9008.819823603524;9294.628214871396;9310.813783724321;9038.231750301216;9163.083691630834;9224.308176886743;9227.446353218811;9229.261659067259;2067.5658111796542;2135.5195081106704;2140.2937030779885;2370.7392186859433;2415.45652228249;2374.5844477216506;2444.291155564884;2447.5349683560157;2460.753924607543;2467.6668649732237;2325.8720770357622;2349.89425475854;2351.670766092748;2353.105819788478;2393.365758074112;2053.2300387354744;2131.4245153808383;2375.061850569024;2406.987965060181;2410.4576470294132;2060.1141509151057;2290.7594702556157;2361.645753137026;2372.4899146683547;2399.2802159352123;8880.555972201364;8886.200241978187;8901.287896968228;8963.148500892405;8981.056989016124;5041.966396888629;5130.384353877521;5134.358205224347;5139;5139.74301284938;3340.7494437917253;3385.119868834121;3460.9826950865086;3484.564429446319;3494.405950988338;1139.9772004559863;1151.8099513580248;1153.1466714631197;1170.373849990251;1174.0724827386355;12521.12352135351;12541.56104536346;12549.937250313782;12640.431180596896;12654.746905061938;4539.682222244412;4680.578747912636;4738.099761045391;4759.762011899391;4839.322494850724;10561.577536898438;10611;10634.096101831276;10641.627543035956;10649.307794993301;5279.498447647467;5334.386545547234;5340.759665815048;5352.090144675414;5354.3574771027725;4387.451568553931;4817.78319975602;4941.678790878582;4943;4951.183054795991;4094.119764250641;4102;4123.422720819088;4136.544980052192;4207.84284321814;1303.680598253434;1306.4839388441703;1351.0880155894731;1355.4645914863574;1369.4385302026321;1044.7440377107657;1045.3675526306474;1071.9678409647722;1099.9780004399868;1102.6416414665266;6419.743210271537;6591.835204119935;6599.175103112111;6621.9006714899315;6666.466682665375;402.3662731198316;414.20886107534466;417.61996583109226;447.0344056837281;450.2211174667843;4486.955130448654;4519.728816271035;4522.615577675869;4526.95473045272;4559.293309537027;11267.098632109411;11659.242149260272;11669.183157179086;11689.824652630217;11693.415329233674;10841.18691098155;11300.321980681185;11307.265027773168;11546.94226528862;11577.884221157849;8589.656413743505;8693.913060869438;8693.956530217434;8725.869111963199;8777.341699372444;6510.902336464862;6618.536702430783;6641.634710090992;6721.092652491851;6721.260661327152;10418.583256669648;10573.788524229627;10713.410762408143;10721.892781072089;10811.56753729842;10667.453219283316;10892.292001019909;10902.345859248471;10994.34033957965;11026.558937642405;7453.627318634155;7597.506162099446;7598.544087354777;8234.176582341717;8428.957855210685;8498.107698691796;8644.524551149496;8882.333824963283;8920.643174272956;9144.314176436927;8062.798430039296;8295.751127466187;8357.331413486785;8447.831043379221;8456.069832318562;7767.495112817649;7848.9215107848195;8221.465604735673;8298.21166989135;8331.125231850569;7583.431242656712;7586;7688.423368247292;7706.422018348534;7708.2677145673315;5561.805336813192;5749.511291540266;5780.913286300793;5798.94201057984;5922.052471604523;5838.766449341979;5868.530517558671;5879.706014699163;5920.963831329586;5929.202662090929 11:16:01 INFO - PROCESS | 1988 | |4;prototype.html;347.4371518140612;353.4397979202963;354.964503549645;357.64593052877626;362.34234863722344;5496;5550.195221692858;5568.136938774496;5576.776928922838;5598.328200615932;5448.202093309208;5471.863203419916;5492.148716948879;5520.1443776214755;5526.309211348582;3852.6900853709735;4077.694172937034;4241.639460645849;4289.849855255066;4310.836074259948;4254.6170844623975;4285.35719642053;4289.806958686867;4291.742495450283;4307.440032795732;4098.774567398792;4268.7225330353585;4286.678499112563;4308.0737641407095;4314.935275970863;4193.777298032048;4281.31498960168;4296.892577685583;4297.871063868089;4319.157764235975;3820.5797362290127;3855.556610989716;3858.5369755629504;3861.3242682530445;3863.613638636142;5207.791688332462;5245.8459138989365;5268.947310526884;5294.708791016493;5329.626926115174;4980.2280646499485;4991.151504244287;4996.25056241563;4997.625178111656;5000.224965130411;5505.3393592768725;5553.194786755897;5758.395368486291;5761.596688231825;5762.423757624246;4152.418661387408;4237.0466645004935;4239.936400953958;4246.7876606169875;4253.702620700685;5824.970875145597;5920.815836832608;5922.3781502942;5923;5928.644281343133;4236.68224883135;4349.19539885116;4358.934615980763;4360.561014865087;4376.474823021194;4405.10580450403;4433.268510695699;4436.82252709888;4448.110377924428;4454.265046267395;4789.4971028041555;4932.692836398357;4937.580305674058;4968;5017;5734.111212762028;5749.913751293734;5798.217240672539;5805.709714514257;5819.359870414251;1516.2721893491187;1531.2496876530643;1537.669401078751;1537.8615924566618;1543.521508332398;954.5609019850947;984.8670429491926;994.6220436234329;998.7553049502918;1008.5511947183579;4968;4969.503049695074;4970.801167953314;5011.799528018912;5019.3474848270225;5182.663126896739;5202.895942081137;5246.265522826731;5281.366236051698;5286.735663216824;5021.719461537357;5026.974865125651;5035.84892453227;5207.479252074762;5633.957717822216;3104.959838454098;3124.375124975014;3150.212446888278;3151.353972435645;3152.5586417901513;6107.267127944675;6149;6161.106639537332;6168.136460895478;6177.776000639766;5807.651540907559;6092.116643086728;6099.3900609938655;6105.664188469588;6111.57218994675;5833.562482813806;5891.941080589225;6051.636901785907;6064.818055458431;6106.435297175197;5871.588988770916;5931.970340148272;5936;5946.791862284799;5950.166976623363;5720.227769251098;5887.087501437284;5905.527557795452;5908.645481271137;5959.404059594006;6141.232345956755;6152.384761523812;6165.198524191826;6169.876602468015;6179.752809887555;4254.765987870573;4255.553166917429;4258.318669013067;4268.652241267228;4280.571942805695;5761.884762304814;5890.646561206341;5896.734646940812;5910.202122713378;5977.880442391215;5730.799422020209;5753.3958934311295;5772.134179873053;5774.451427114417;5783.450572195635;5528.640638358494;5692.288463942007;5713.200151978809;5793.739281732248;5803;5670.716464176692;5702.8289151325525;5703.230063941481;5709.200711900255;5718.770464350185;5839.678817664899;5857.58996870215;5864.765409383577;5874.618149820248;5883.411658834082;5415.864603384947;5653.349864765604;5672.943270567406;5732.57005724564;5734.197212390185 11:16:01 INFO - PROCESS | 1988 | |5;yui.html;822.6791551294996;841.5623875584696;855.0765173612497;891.7770557360659;908.5230254116592;14944.476943306987;15771.60570985726;15813.367465301402;16354.59113522161;16416.917915410406;15238.085714857116;15394.307256173472;15438;15459.149746763924;15901.204939753025;729.657061181244;864.2222000199807;887.0552861202831;887.9822403551925;888.2627419242046;878.4246318661255;882.5410786391072;885.9069797671249;886.8403687336277;888.0586578227068;928.907109289069;929.5631053404888;930.9115634014792;931.2363861633463;931.4364809290383;775.3332134364442;905.9003509613938;927.3647551427293;930.2697382554729;932.9970281946867;681.0431343961692;686.3891136888174;686.8317262270725;687.3744892148121;687.381356778903;14524.201168935704;14559.70880582393;14567.70864582713;14578.927105364512;14581.781273280909;15073.246337683182;15284.388624455009;15305.693886122215;15327.923360383127;15462.149581772997;13370.39833207508;13911.582652520441;14006.649833754136;14008.789868151986;14017.088889222168;4641.814327426899;4681.5318468153255;4719.197736384788;4759.571638552512;4764.380630518045;77375.6131219346;78304.60847695782;78450;78943;79168;11619.419029048682;11674;11749.765004699859;11815.645530634094;12625.747485050248;22686.432839178822;22909.312720618407;22962.65556016661;22966.770332296797;22974.19590314331;8472.788180295542;8551.743447696455;8674.913250867537;8920.375573709778;8966.820663586823;5016.347874776256;5050.343455350854;5097.541221290102;5133.691978481228;5142.254373115878;3615.258871931248;3714.981425092911;3719.6652301293016;3724.0131365188245;3725.8882233533036;613.9201903752484;624.2696045626627;628.3716283716284;662.3045801907978;662.827664807144;666.2504682232488;827.3215962910356;832.2842355574202;841.284907828341;851.7019043334783;11030.889691103146;11111.38887361203;11159.665210043711;11297.943510282395;11693.590724324778;685.540687739216;712.868119397913;782.710397153057;800.9399295052895;810.3274282345639;5178.585713142939;5207.973960130175;5257.710825904535;5396.568274538027;5396.703181324986;122022.38988805177;126504;132494;132664;133183.33408332895;109237.45381273043;110602.44698776455;111665.44167279112;112591;114405.42797286127;97775.51112244393;99944;99958.5002074985;100122;100353;9857.704268871945;10136.695899123039;10140.956918800932;10610.840837387292;11179.55281788752;41045.38431923464;49539;49763;49946.500534994186;56257;76348.61825690836;78132;80088.59955700184;81950;84151;12378.81431778506;13458.25979571133;13792.862071379157;13980.091294065853;14081.295935203403;11800.70498237551;12642.683932901751;14635.414583416545;16363.509094727176;16691.332346705996;14783.704325913637;15184.392624294904;15417.383304668136;15729.68540629158;15734.21328933526;14206.92896535552;14502.782458263346;14540.345684444013;14699.412023519368;15161.772573411186;14883.776743349075;14920.477783277533;15087.622809429851;15484.5354639361;16012.599685007503;10192.796144077225;10276.22928280397;10281.280310378203;10385.221108416748;10568.788624227625;10192.082712555906;10468.895311046792;10550.366977981346;10567.313124646873;10792.892071079188 11:16:01 INFO - PROCESS | 1988 | __end_tp_report 11:16:01 INFO - PROCESS | 1988 | __start_cc_report 11:16:01 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,939 11:16:01 INFO - PROCESS | 1988 | __end_cc_report 11:16:01 INFO - PROCESS | 1988 | __startTimestamp1468606561559__endTimestamp 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | ------- Summary: start ------- 11:16:01 INFO - PROCESS | 1988 | Number of tests: 6 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | [#0] dojo.html Cycles:165 Average:5534.43 Median:5730.43 stddev:601.72 (10.5%) stddev-sans-first:577.31 11:16:01 INFO - PROCESS | 1988 | Values: 3293.2 3353.4 3366.3 3375.5 3406.5 5508.7 5587.6 5593.0 5594.8 5597.7 5454.2 5488.2 5508.0 5518.0 5529.0 4987.0 5014.4 5025.1 5029.9 5054.3 5060.0 5136.6 5150.7 5153.6 5154.3 5034.6 5082.0 5090.1 5124.3 5154.9 5178.2 5197.1 5198.3 5201.2 5219.0 4978.4 5003.0 5054.9 5103.0 5106.9 5385.4 5394.2 5405.1 5420.4 5455.7 5932.1 5978.1 5980.0 5982.8 5983.3 5873.6 5928.3 5960.2 6000.2 6001.4 5564.8 5605.9 5621.2 5630.5 5632.9 5938.9 6121.4 6125.7 6128.9 6130.4 5717.9 5749.9 5766.8 5860.9 5872.1 5903.9 5904.4 5907.8 5933.5 5963.0 5831.2 5868.9 5870.4 5872.9 5872.9 5891.1 5962.9 5965.6 5967.8 6010.2 4577.4 4581.3 4582.5 4585.6 4609.9 4046.3 4047.6 4084.4 4123.3 4163.1 5702.4 5710.5 5728.5 5730.4 5752.9 6008.2 6029.6 6030.9 6031.8 6053.8 5508.0 5595.6 5685.1 5694.0 5704.5 5113.9 5134.1 5139.7 5140.3 5142.6 6092.6 6092.7 6096.8 6104.5 6120.4 5828.6 5883.6 5936.2 5962.4 5984.5 6126.8 6140.6 6141.8 6152.5 6158.8 5816.3 5882.7 5883.2 5885.9 5888.8 5907.5 5945.8 5984.3 6034.4 6040.4 5816.9 5848.7 5860.2 5863.6 5880.7 5686.4 5704.1 5805.5 5855.1 5871.8 5663.3 5749.4 5752.5 5756.1 5783.7 5857.6 5862.5 5888.1 5890.9 5895.0 5520.5 5617.4 5676.2 5681.0 5722.6 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | [#1] ext.html Cycles:180 Average:69478.95 Median:41853.18 stddev:140806.58 (336.4%) stddev-sans-first:141106.60 11:16:01 INFO - PROCESS | 1988 | Values: 597.2 653.6 657.0 658.3 666.8 32710.0 46149.8 46999.1 47328.8 47338.3 48270.8 48568.3 48571.8 48656.0 48734.8 8325.8 8971.1 9122.8 9123.3 10816.2 10553.2 10667.1 10995.9 11005.6 11054.8 11110.1 11215.7 11216.4 11218.3 11220.0 8335.5 10769.4 10986.9 11028.1 11035.7 10862.9 10930.3 10948.7 10955.5 10958.3 46228.0 46723.5 46728.0 46732.5 46735.0 3770.3 3874.7 4008.5 4267.2 4476.8 36411.5 37030.3 37126.6 37219.8 37423.0 4801.9 4812.7 4824.2 4922.9 4954.6 396929.0 538956.0 547745.0 549107.0 549212.0 70799.3 71143.3 71565.0 71632.3 71709.0 40524.4 41460.0 75452.6 76278.6 76378.0 18779.6 18980.4 19035.3 19040.3 19041.7 13210.6 14267.6 14641.0 14651.8 15012.5 22877.7 23010.7 23132.8 23190.5 23318.1 8109.7 8137.0 8326.4 8343.9 8362.0 928.5 946.0 976.8 985.5 992.5 32698.0 34525.8 34880.7 35073.8 35363.5 1193.2 1197.7 1206.3 1262.3 1263.0 18161.2 18165.5 18247.0 18330.6 18353.2 619767.0 620483.0 622653.3 625367.0 626824.0 65420.0 65810.3 66220.7 66298.3 66356.3 1350.4 1451.1 1462.1 1476.8 1492.5 33570.8 34323.8 34507.5 34808.8 35268.6 54285.2 54959.7 54990.7 55017.0 55044.1 423662.0 428885.0 430332.0 430862.0 432258.0 26967.3 27690.3 28259.9 31404.2 31909.8 52805.0 53510.5 53753.0 54111.7 54741.5 40089.4 40872.6 41029.8 41086.8 42246.4 43151.0 43730.6 43977.8 44132.6 45404.0 44251.0 44847.6 45087.3 45113.5 45361.0 37715.2 40524.4 41051.0 41189.8 41427.6 30369.5 30539.8 30699.5 30857.0 30921.8 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | [#2] jquery.html Cycles:180 Average:28475.65 Median:24853.32 stddev:78642.51 (316.4%) stddev-sans-first:78834.87 11:16:01 INFO - PROCESS | 1988 | Values: 401.5 402.4 403.5 414.7 423.1 15010.8 19290.0 20785.9 20834.6 21435.2 20732.4 20900.6 21157.4 21174.0 21242.2 5594.2 5772.5 5795.8 5799.3 5830.3 4191.5 5715.3 5721.5 5756.0 5765.1 6040.0 6342.6 6358.0 6449.1 6457.7 6281.3 6301.0 6345.6 6349.3 6400.9 5552.7 5656.8 5694.5 5698.9 5729.1 24119.2 24582.4 25124.2 25135.7 25136.2 2567.6 2575.7 2811.5 2879.5 2936.5 14458.5 14838.3 14936.8 15370.4 15779.8 2033.1 2056.9 2078.0 2123.3 2156.8 79188.6 81487.6 82513.0 82536.0 82785.8 10727.2 10761.8 10811.6 11005.6 11231.2 15473.7 15481.3 15550.5 15611.4 15617.8 8746.0 9048.4 9101.4 9119.5 9227.4 8955.2 9004.2 9057.0 9111.5 9142.4 6943.7 6956.6 6983.9 7047.9 7065.9 1925.5 1925.6 1938.5 1966.6 2008.2 1034.9 1073.7 1117.9 1141.6 1171.9 20421.6 20975.3 21019.3 21065.8 21097.6 1117.7 1118.1 1121.2 1134.5 1168.9 11606.8 11968.2 12134.8 12152.5 12222.6 459509.0 461532.0 469543.0 503838.0 504725.0 53598.0 54615.5 71103.6 73540.0 73906.0 1103.3 1106.3 1122.9 1132.5 1137.9 18749.9 18803.2 18807.6 18858.9 19044.5 39708.4 39734.2 40856.6 40897.8 40946.6 52040.2 54973.0 55193.0 55415.4 55528.0 8955.6 8955.8 8981.2 9072.8 9319.5 8634.8 13713.1 13960.0 14027.0 14089.0 12201.6 12212.9 12278.3 12297.6 12454.6 12087.5 12100.6 12117.3 12236.4 12372.6 12203.5 12347.7 12398.3 12426.8 12439.2 7437.7 7607.9 8925.2 9155.4 9223.0 11818.8 11958.7 12102.5 12227.3 12376.5 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | [#3] mootools.html Cycles:180 Average:6066.63 Median:2468.59 stddev:3482.85 (141.1%) stddev-sans-first:3475.02 11:16:01 INFO - PROCESS | 1988 | Values: 1407.2 1531.2 1560.5 1753.3 1888.2 8658.3 8978.4 9008.8 9294.6 9310.8 9038.2 9163.1 9224.3 9227.4 9229.3 2067.6 2135.5 2140.3 2370.7 2415.5 2374.6 2444.3 2447.5 2460.8 2467.7 2325.9 2349.9 2351.7 2353.1 2393.4 2053.2 2131.4 2375.1 2407.0 2410.5 2060.1 2290.8 2361.6 2372.5 2399.3 8880.6 8886.2 8901.3 8963.1 8981.1 5042.0 5130.4 5134.4 5139.0 5139.7 3340.7 3385.1 3461.0 3484.6 3494.4 1140.0 1151.8 1153.1 1170.4 1174.1 12521.1 12541.6 12549.9 12640.4 12654.7 4539.7 4680.6 4738.1 4759.8 4839.3 10561.6 10611.0 10634.1 10641.6 10649.3 5279.5 5334.4 5340.8 5352.1 5354.4 4387.5 4817.8 4941.7 4943.0 4951.2 4094.1 4102.0 4123.4 4136.5 4207.8 1303.7 1306.5 1351.1 1355.5 1369.4 1044.7 1045.4 1072.0 1100.0 1102.6 6419.7 6591.8 6599.2 6621.9 6666.5 402.4 414.2 417.6 447.0 450.2 4487.0 4519.7 4522.6 4527.0 4559.3 11267.1 11659.2 11669.2 11689.8 11693.4 10841.2 11300.3 11307.3 11546.9 11577.9 8589.7 8693.9 8694.0 8725.9 8777.3 6510.9 6618.5 6641.6 6721.1 6721.3 10418.6 10573.8 10713.4 10721.9 10811.6 10667.5 10892.3 10902.3 10994.3 11026.6 7453.6 7597.5 7598.5 8234.2 8429.0 8498.1 8644.5 8882.3 8920.6 9144.3 8062.8 8295.8 8357.3 8447.8 8456.1 7767.5 7848.9 8221.5 8298.2 8331.1 7583.4 7586.0 7688.4 7706.4 7708.3 5561.8 5749.5 5780.9 5798.9 5922.1 5838.8 5868.5 5879.7 5921.0 5929.2 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | [#4] prototype.html Cycles:180 Average:4828.39 Median:5432.03 stddev:1401.27 (25.8%) stddev-sans-first:1364.24 11:16:01 INFO - PROCESS | 1988 | Values: 347.4 353.4 355.0 357.6 362.3 5496.0 5550.2 5568.1 5576.8 5598.3 5448.2 5471.9 5492.1 5520.1 5526.3 3852.7 4077.7 4241.6 4289.8 4310.8 4254.6 4285.4 4289.8 4291.7 4307.4 4098.8 4268.7 4286.7 4308.1 4314.9 4193.8 4281.3 4296.9 4297.9 4319.2 3820.6 3855.6 3858.5 3861.3 3863.6 5207.8 5245.8 5268.9 5294.7 5329.6 4980.2 4991.2 4996.3 4997.6 5000.2 5505.3 5553.2 5758.4 5761.6 5762.4 4152.4 4237.0 4239.9 4246.8 4253.7 5825.0 5920.8 5922.4 5923.0 5928.6 4236.7 4349.2 4358.9 4360.6 4376.5 4405.1 4433.3 4436.8 4448.1 4454.3 4789.5 4932.7 4937.6 4968.0 5017.0 5734.1 5749.9 5798.2 5805.7 5819.4 1516.3 1531.2 1537.7 1537.9 1543.5 954.6 984.9 994.6 998.8 1008.6 4968.0 4969.5 4970.8 5011.8 5019.3 5182.7 5202.9 5246.3 5281.4 5286.7 5021.7 5027.0 5035.8 5207.5 5634.0 3105.0 3124.4 3150.2 3151.4 3152.6 6107.3 6149.0 6161.1 6168.1 6177.8 5807.7 6092.1 6099.4 6105.7 6111.6 5833.6 5891.9 6051.6 6064.8 6106.4 5871.6 5932.0 5936.0 5946.8 5950.2 5720.2 5887.1 5905.5 5908.6 5959.4 6141.2 6152.4 6165.2 6169.9 6179.8 4254.8 4255.6 4258.3 4268.7 4280.6 5761.9 5890.6 5896.7 5910.2 5977.9 5730.8 5753.4 5772.1 5774.5 5783.5 5528.6 5692.3 5713.2 5793.7 5803.0 5670.7 5702.8 5703.2 5709.2 5718.8 5839.7 5857.6 5864.8 5874.6 5883.4 5415.9 5653.3 5672.9 5732.6 5734.2 11:16:01 INFO - PROCESS | 1988 | 11:16:01 INFO - PROCESS | 1988 | [#5] yui.html Cycles:180 Average:22472.42 Median:13294.73 stddev:33225.96 (249.9%) stddev-sans-first:33279.40 11:16:01 INFO - PROCESS | 1988 | Values: 822.7 841.6 855.1 891.8 908.5 14944.5 15771.6 15813.4 16354.6 16416.9 15238.1 15394.3 15438.0 15459.1 15901.2 729.7 864.2 887.1 888.0 888.3 878.4 882.5 885.9 886.8 888.1 928.9 929.6 930.9 931.2 931.4 775.3 905.9 927.4 930.3 933.0 681.0 686.4 686.8 687.4 687.4 14524.2 14559.7 14567.7 14578.9 14581.8 15073.2 15284.4 15305.7 15327.9 15462.1 13370.4 13911.6 14006.6 14008.8 14017.1 4641.8 4681.5 4719.2 4759.6 4764.4 77375.6 78304.6 78450.0 78943.0 79168.0 11619.4 11674.0 11749.8 11815.6 12625.7 22686.4 22909.3 22962.7 22966.8 22974.2 8472.8 8551.7 8674.9 8920.4 8966.8 5016.3 5050.3 5097.5 5133.7 5142.3 3615.3 3715.0 3719.7 3724.0 3725.9 613.9 624.3 628.4 662.3 662.8 666.3 827.3 832.3 841.3 851.7 11030.9 11111.4 11159.7 11297.9 11693.6 685.5 712.9 782.7 800.9 810.3 5178.6 5208.0 5257.7 5396.6 5396.7 122022.4 126504.0 132494.0 132664.0 133183.3 109237.5 110602.4 111665.4 112591.0 114405.4 97775.5 99944.0 99958.5 100122.0 100353.0 9857.7 10136.7 10141.0 10610.8 11179.6 41045.4 49539.0 49763.0 49946.5 56257.0 76348.6 78132.0 80088.6 81950.0 84151.0 12378.8 13458.3 13792.9 13980.1 14081.3 11800.7 12642.7 14635.4 16363.5 16691.3 14783.7 15184.4 15417.4 15729.7 15734.2 14206.9 14502.8 14540.3 14699.4 15161.8 14883.8 14920.5 15087.6 15484.5 16012.6 10192.8 10276.2 10281.3 10385.2 10568.8 10192.1 10468.9 10550.4 10567.3 10792.9 11:16:01 INFO - PROCESS | 1988 | -------- Summary: end -------- 11:16:01 INFO - PROCESS | 1988 | 11:16:02 INFO - TEST-INFO | 1988: exit 0 11:16:02 INFO - TEST-OK | dromaeo_css | took 1114888ms 11:16:02 INFO - TEST-START | kraken 11:16:02 INFO - operating with platform_type : linux_ 11:16:02 INFO - Initialising browser for kraken test... 11:16:02 INFO - TEST-INFO | started process 2183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUzo7r/profile http://localhost:47542/getInfo.html) 11:16:06 INFO - PROCESS | 2183 | __metrics Screen width/height:1600/1200 11:16:06 INFO - PROCESS | 2183 | colorDepth:24 11:16:06 INFO - PROCESS | 2183 | Browser inner width/height: 1024/697 11:16:06 INFO - PROCESS | 2183 | __metrics 11:16:08 ERROR - PROCESS | 2183 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:16:09 INFO - TEST-INFO | 2183: exit 0 11:16:09 INFO - Browser initialized. 11:16:09 INFO - Running cycle 1/1 for kraken test... 11:16:09 INFO - TEST-INFO | started process 2276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUzo7r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:21 INFO - PROCESS | 2276 | RSS: Main: 149041152 11:16:21 INFO - PROCESS | 2276 | 11:16:23 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47542/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:24 INFO - PROCESS | 2276 | RSS: Main: 198369280 11:16:24 INFO - PROCESS | 2276 | 11:16:26 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47542/tests/kraken/driver.html?testName=audio-dft) 11:16:27 INFO - PROCESS | 2276 | RSS: Main: 196829184 11:16:27 INFO - PROCESS | 2276 | 11:16:30 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47542/tests/kraken/driver.html?testName=audio-fft) 11:16:30 INFO - PROCESS | 2276 | RSS: Main: 282693632 11:16:30 INFO - PROCESS | 2276 | 11:16:33 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47542/tests/kraken/driver.html?testName=audio-oscillator) 11:16:33 INFO - PROCESS | 2276 | RSS: Main: 190951424 11:16:33 INFO - PROCESS | 2276 | 11:16:35 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47542/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:36 INFO - PROCESS | 2276 | RSS: Main: 192167936 11:16:36 INFO - PROCESS | 2276 | 11:16:39 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47542/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:39 INFO - PROCESS | 2276 | RSS: Main: 226627584 11:16:39 INFO - PROCESS | 2276 | 11:16:43 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47542/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:43 INFO - PROCESS | 2276 | RSS: Main: 224952320 11:16:43 INFO - PROCESS | 2276 | 11:16:46 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47542/tests/kraken/driver.html?testName=json-parse-financial) 11:16:47 INFO - PROCESS | 2276 | RSS: Main: 224874496 11:16:47 INFO - PROCESS | 2276 | 11:16:48 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47542/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:49 INFO - PROCESS | 2276 | RSS: Main: 203595776 11:16:49 INFO - PROCESS | 2276 | 11:16:51 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:51 INFO - PROCESS | 2276 | RSS: Main: 204107776 11:16:51 INFO - PROCESS | 2276 | 11:16:53 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:54 INFO - PROCESS | 2276 | RSS: Main: 209031168 11:16:54 INFO - PROCESS | 2276 | 11:16:56 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:57 INFO - PROCESS | 2276 | RSS: Main: 215502848 11:16:57 INFO - PROCESS | 2276 | 11:17:00 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:00 INFO - PROCESS | 2276 | RSS: Main: 216064000 11:17:00 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | Cycle 1(1): loaded http://localhost:47542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47542/tests/kraken/driver.html?testName=ai-astar) 11:17:02 INFO - PROCESS | 2276 | RSS: Main: 257757184 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | __start_tp_report 11:17:02 INFO - PROCESS | 2276 | _x_x_mozilla_page_load 11:17:02 INFO - PROCESS | 2276 | _x_x_mozilla_page_load_details 11:17:02 INFO - PROCESS | 2276 | |i|pagename|runs| 11:17:02 INFO - PROCESS | 2276 | |0;ai-astar;110;105;110;108;111;109;109;111;108;110 11:17:02 INFO - PROCESS | 2276 | |1;audio-beat-detection;158;131;128;172;128;127;157;130;154;125 11:17:02 INFO - PROCESS | 2276 | |2;audio-dft;161;160;161;160;160;160;160;159;161;161 11:17:02 INFO - PROCESS | 2276 | |3;audio-fft;74;73;74;131;75;77;75;74;97;75 11:17:02 INFO - PROCESS | 2276 | |4;audio-oscillator;85;86;115;84;84;83;117;82;85;136 11:17:02 INFO - PROCESS | 2276 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;117;117;116 11:17:02 INFO - PROCESS | 2276 | |6;imaging-darkroom;147;146;145;146;147;146;145;146;148;146 11:17:02 INFO - PROCESS | 2276 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 11:17:02 INFO - PROCESS | 2276 | |8;json-parse-financial;51;50;51;51;51;51;52;53;53;51 11:17:02 INFO - PROCESS | 2276 | |9;json-stringify-tinderbox;60;59;60;60;60;59;60;59;59;59 11:17:02 INFO - PROCESS | 2276 | |10;stanford-crypto-aes;75;76;75;79;76;78;77;77;112;77 11:17:02 INFO - PROCESS | 2276 | |11;stanford-crypto-ccm;126;127;127;114;114;117;113;122;129;124 11:17:02 INFO - PROCESS | 2276 | |12;stanford-crypto-pbkdf2;158;156;152;154;151;153;155;151;156;153 11:17:02 INFO - PROCESS | 2276 | |13;stanford-crypto-sha256-iterative;65;62;63;62;60;62;63;62;62;60 11:17:02 INFO - PROCESS | 2276 | __end_tp_report 11:17:02 INFO - PROCESS | 2276 | __start_cc_report 11:17:02 INFO - PROCESS | 2276 | _x_x_mozilla_cycle_collect,1587 11:17:02 INFO - PROCESS | 2276 | __end_cc_report 11:17:02 INFO - PROCESS | 2276 | __startTimestamp1468606622504__endTimestamp 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | ------- Summary: start ------- 11:17:02 INFO - PROCESS | 2276 | Number of tests: 14 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.79 (1.6%) stddev-sans-first:1.87 11:17:02 INFO - PROCESS | 2276 | Values: 110.0 105.0 110.0 108.0 111.0 109.0 109.0 111.0 108.0 110.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:142.50 stddev:17.28 (12.1%) stddev-sans-first:17.19 11:17:02 INFO - PROCESS | 2276 | Values: 158.0 131.0 128.0 172.0 128.0 127.0 157.0 130.0 154.0 125.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 11:17:02 INFO - PROCESS | 2276 | Values: 161.0 160.0 161.0 160.0 160.0 160.0 160.0 159.0 161.0 161.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:18.46 (24.6%) stddev-sans-first:19.33 11:17:02 INFO - PROCESS | 2276 | Values: 74.0 73.0 74.0 131.0 75.0 77.0 75.0 74.0 97.0 75.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:19.43 (23.1%) stddev-sans-first:20.21 11:17:02 INFO - PROCESS | 2276 | Values: 85.0 86.0 115.0 84.0 84.0 83.0 117.0 82.0 85.0 136.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:17:02 INFO - PROCESS | 2276 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 11:17:02 INFO - PROCESS | 2276 | Values: 147.0 146.0 145.0 146.0 147.0 146.0 145.0 146.0 148.0 146.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:17:02 INFO - PROCESS | 2276 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 11:17:02 INFO - PROCESS | 2276 | Values: 51.0 50.0 51.0 51.0 51.0 51.0 52.0 53.0 53.0 51.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:17:02 INFO - PROCESS | 2276 | Values: 60.0 59.0 60.0 60.0 60.0 59.0 60.0 59.0 59.0 59.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:77.00 stddev:11.24 (14.6%) stddev-sans-first:11.77 11:17:02 INFO - PROCESS | 2276 | Values: 75.0 76.0 75.0 79.0 76.0 78.0 77.0 77.0 112.0 77.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:125.00 stddev:6.22 (5.0%) stddev-sans-first:6.36 11:17:02 INFO - PROCESS | 2276 | Values: 126.0 127.0 127.0 114.0 114.0 117.0 113.0 122.0 129.0 124.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.50 stddev:2.33 (1.5%) stddev-sans-first:1.94 11:17:02 INFO - PROCESS | 2276 | Values: 158.0 156.0 152.0 154.0 151.0 153.0 155.0 151.0 156.0 153.0 11:17:02 INFO - PROCESS | 2276 | 11:17:02 INFO - PROCESS | 2276 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.09 11:17:02 INFO - PROCESS | 2276 | Values: 65.0 62.0 63.0 62.0 60.0 62.0 63.0 62.0 62.0 60.0 11:17:02 INFO - PROCESS | 2276 | -------- Summary: end -------- 11:17:02 INFO - PROCESS | 2276 | 11:17:03 INFO - TEST-INFO | 2276: exit 0 11:17:03 INFO - TEST-OK | kraken | took 61182ms 11:17:03 INFO - SUITE-END | took 1176s 11:17:03 INFO - Completed test suite (00:19:36) 11:17:03 INFO - javascript benchmark 11:17:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.1931676739196, 3353.3963886500437, 3366.3267346530683, 3375.4599264117746, 3406.5230867678515, 5508.669479831208, 5587.636803607773, 5593.0, 5594.804181853636, 5597.6641401515935, 5454.181872719094, 5488.231647569343, 5507.972460137694, 5518.034343989806, 5529.0324193266115, 4986.9750651246695, 5014.42334131575, 5025.0703619830265, 5029.924551131736, 5054.292399064134, 5060.038592667382, 5136.614753893455, 5150.690958542481, 5153.561947234471, 5154.278401023859, 5034.647574669774, 5082.0, 5090.134677104883, 5124.282600435942, 5154.8711282218055, 5178.1973794061605, 5197.090509160882, 5198.324217851693, 5201.245819356172, 5219.0, 4978.402591688984, 5003.0, 5054.9241761373605, 5103.0, 5106.872328191787, 5385.407605163429, 5394.190871369326, 5405.054115529806, 5420.430854760233, 5455.727213639302, 5932.139839723216, 5978.073398623221, 5979.970100149515, 5982.760689572412, 5983.252093488314, 5873.588848780587, 5928.258967629046, 5960.225170727821, 6000.18997435345, 6001.399860013964, 5564.8330550083565, 5605.943940560624, 5621.241132447109, 5630.465105814941, 5632.943670563324, 5938.8812223755285, 6121.371505986887, 6125.7012684027995, 6128.877422451526, 6130.356312587203, 5717.857053573611, 5749.885002300014, 5766.798162064391, 5860.853478663067, 5872.119182122716, 5903.881922361528, 5904.409559044061, 5907.763689452374, 5933.465988061095, 5963.016102343065, 5831.241938547962, 5868.911966320423, 5870.442307980735, 5872.911906321408, 5872.941270587325, 5891.05743081105, 5962.850928726816, 5965.55258355625, 5967.76128954837, 6010.248718910137, 4577.404937358188, 4581.312803079565, 4582.473015603248, 4585.610223131004, 4609.907801843944, 4046.291898917678, 4047.6357127858632, 4084.4281800547947, 4123.257813593522, 4163.10493243954, 5702.372738998707, 5710.486056254874, 5728.455796699307, 5730.426957304319, 5752.884942301131, 6008.24896887889, 6029.57792954489, 6030.909536356959, 6031.819045428644, 6053.757849685963, 5508.03609368367, 5595.63628364155, 5685.147227915846, 5694.0, 5704.543636509069, 5113.948860511422, 5134.127198376285, 5139.691618502902, 5140.30605868203, 5142.61430392722, 6092.573519853568, 6092.695365231721, 6096.786612468631, 6104.481119104926, 6120.44915957566, 5828.59199856006, 5883.55873309512, 5936.1986131871645, 5962.403759624003, 5984.491318237824, 6126.785562505291, 6140.5701600887505, 6141.8464538385115, 6152.507799376129, 6158.753649854135, 5816.331121920864, 5882.676452795137, 5883.235179426818, 5885.911711324419, 5888.793892213752, 5907.527397808251, 5945.821625351246, 5984.281886173687, 6034.39656034393, 6040.395960403925, 5816.854578635568, 5848.707564621837, 5860.238169037998, 5863.589548731547, 5880.676562789087, 5686.431356864446, 5704.1443783432815, 5805.477507024388, 5855.121731740273, 5871.823845284648, 5663.348714897839, 5749.367569567428, 5752.511036561939, 5756.079027355603, 5783.681897495678, 5857.648541087548, 5862.472377486047, 5888.116782482491, 5890.882182356243, 5895.0, 5520.503154715934, 5617.410171931889, 5676.20533125371, 5681.034224181816, 5722.62802917809], "value": 5496.028182272488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1669521018177, 653.6176336842947, 656.9934300656992, 658.2660333727895, 666.7666316789124, 32710.0, 46149.76925115374, 46999.0600187996, 47328.76335618317, 47338.289925651145, 48270.75864620681, 48568.2714759278, 48571.75714121433, 48656.0, 48734.75632621832, 8325.83348333033, 8971.147740964614, 9122.768426262435, 9123.315751318678, 10816.188785841054, 10553.155747540179, 10667.14662826972, 10995.890041099567, 11005.61480348188, 11054.834177487344, 11110.055645270162, 11215.663530094069, 11216.439178041106, 11218.27081239721, 11220.046296064844, 8335.499870007789, 10769.407682577455, 10986.890131098666, 11028.062614677761, 11035.72410689731, 10862.891371086267, 10930.289531180448, 10948.726281842937, 10955.50700218492, 10958.342499450058, 46228.0, 46723.53276467226, 46728.0, 46732.53267467316, 46735.0, 3770.3213421584105, 3874.728768986172, 4008.5390180129366, 4267.1892340455215, 4476.836022634138, 36411.4538281926, 37030.25939481222, 37126.62873371259, 37219.813900930596, 37423.0, 4801.879953001168, 4812.711237325737, 4824.2040063389495, 4922.901541969176, 4954.578860796837, 396929.0, 538956.0, 547745.0, 549107.0, 549211.999999996, 70799.29200707928, 71143.28856711471, 71565.0, 71632.2836771636, 71709.0, 40524.39213411801, 41460.0, 75452.62273688597, 76278.61860690772, 76378.0, 18779.624407511772, 18980.43058708241, 19035.333763318216, 19040.333588324618, 19041.7143742844, 13210.603681889559, 14267.571972840831, 14641.0, 14651.780223296659, 15012.549623511311, 22877.656835147485, 23010.65484017741, 23132.76867231306, 23190.53618927612, 23318.067277309055, 8109.675612975533, 8136.959315203504, 8326.417150799385, 8343.874841877378, 8361.958190209132, 928.4568527411404, 945.9716208513755, 976.8339382305026, 985.5417230987625, 992.533509250651, 32698.0, 34525.827370862986, 34880.65119348825, 35073.82463087719, 35363.4695479568, 1193.1945936492832, 1197.694587880085, 1206.330486579939, 1262.280500114944, 1263.0211586020723, 18161.182746776427, 18165.455036348932, 18247.0, 18330.63338733218, 18353.17410716521, 619767.0, 620483.0, 622653.3204003887, 625367.0, 626824.0, 65420.0, 65810.34189658138, 66220.66889665618, 66298.33701663018, 66356.33643663501, 1350.3653282956996, 1451.1075688451526, 1462.1227263641729, 1476.8301645310926, 1492.5373134328393, 33570.832145839115, 34323.82838085893, 34507.48238776471, 34808.82595587107, 35268.64731352653, 54285.185722214985, 54959.72520137374, 54990.725046374515, 55017.0, 55044.0734574288, 423662.0, 428885.0, 430332.0, 430862.0, 432258.0, 26967.325816854736, 27690.3077423058, 28259.858700706365, 31404.214894626904, 31909.840450797597, 52805.0, 53510.4648953521, 53753.0, 54111.72944135254, 54741.452585473635, 40089.39865901956, 40872.59127408807, 41029.79485102555, 41086.79456602818, 42246.366304506075, 43151.0, 43730.562694372646, 43977.78011109924, 44132.558674412845, 45404.0, 44251.0, 44847.55152448434, 45087.32369014402, 45113.548864510936, 45361.0, 37715.245695086494, 40524.39213411742, 41051.0, 41189.79405102955, 41427.58572414358, 30369.544456832722, 30539.847300763355, 30699.465710166936, 30857.0, 30921.8453907729], "value": 22412.9928331051, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.4901075633947, 402.4446264155465, 403.519811424405, 414.6869113819067, 423.07557985801026, 15010.849891501082, 19290.0, 20785.896070519662, 20834.583308333844, 21435.249766258185, 20732.378028659128, 20900.581988360223, 21157.365279041616, 21174.0, 21242.150313987462, 5594.160875868622, 5772.480476757091, 5795.797147099853, 5799.2750906136735, 5830.30036395631, 4191.497020357561, 5715.3141623005295, 5721.513671337942, 5755.971220143893, 5765.077587585987, 6040.003399439087, 6342.556021078503, 6358.0, 6449.097126402307, 6457.741690332405, 6281.277653069909, 6301.0, 6345.555811093225, 6349.269833969107, 6400.9359906400805, 5552.694601796899, 5656.802011929604, 5694.544436445074, 5698.857528561778, 5729.054705973509, 24119.155829546056, 24582.385440363956, 25124.24627261185, 25135.748642513525, 25136.24591262265, 2567.640530325737, 2575.703794063669, 2811.5079861024237, 2879.510483217858, 2936.4714351416737, 14458.49395271171, 14838.258087095603, 14936.775948360782, 15370.385184592604, 15779.763303550455, 2033.095272603692, 2056.856020078595, 2078.0, 2123.2568600989684, 2156.7519735230494, 79188.60405697934, 81487.5925620374, 82513.0, 82536.0, 82785.78595483847, 10727.195460340507, 10761.78476430467, 10811.6215932442, 11005.614803482, 11231.21381503287, 15473.690526189414, 15481.303341349667, 15550.533483995498, 15611.375544978073, 15617.765733514007, 8745.956270218609, 9048.366614336934, 9101.362904596615, 9119.498427586414, 9227.400218985744, 8955.238804701674, 9004.234640055669, 9056.954715226513, 9111.498867562215, 9142.3600347975, 6943.652817359111, 6956.582605043714, 6983.89524157138, 7047.859042819217, 7065.858682826418, 1925.528245579842, 1925.6052509235574, 1938.4959910423393, 1966.5771859050374, 2008.2167954497756, 1034.9223808214415, 1073.7315671082229, 1117.8826223246604, 1141.577616281981, 1171.8886705762939, 20421.591568168555, 20975.265865694626, 21019.264325748525, 21065.78934210669, 21097.578048438947, 1117.7485065860278, 1118.0999295566985, 1121.2095472691733, 1134.5405110929921, 1168.8831116888414, 11606.76786464266, 11968.162228644085, 12134.757304853854, 12152.513899443924, 12222.572209972608, 459509.0, 461532.0, 469543.0, 503838.0, 504725.0, 53598.0, 54615.45384546183, 71103.64448177726, 73540.0, 73906.0, 1103.2883789955433, 1106.280917403694, 1122.887711228887, 1132.5186795611833, 1137.9203455758184, 18749.906250469205, 18803.247870085044, 18807.623847523246, 18858.905705471385, 19044.523886902938, 39708.404373934995, 39734.20531589294, 40856.591434085276, 40897.795511022254, 40946.59053409428, 52040.21939670832, 54973.0, 55193.0, 55415.44584554103, 55528.0, 8955.552222388724, 8955.776105597412, 8981.191692747683, 9072.818543628959, 9319.534023298944, 8634.78413039679, 13713.108647937852, 13960.0, 14027.0, 14089.0, 12201.633950981484, 12212.877871221173, 12278.324692142018, 12297.56958506448, 12454.564090256797, 12087.516499339928, 12100.576479823163, 12117.333546655018, 12236.44935977901, 12372.566960156351, 12203.450844712186, 12347.69130771738, 12398.318092504998, 12426.813597796221, 12439.191452555555, 7437.665305061177, 7607.896854956111, 8925.241354484682, 9155.404898681565, 9222.95388523053, 11818.763624727286, 11958.70103247391, 12102.455389507317, 12227.327496987395, 12376.504939802307], "value": 9754.24818853912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.162738170788, 1531.219078270082, 1560.4538411555957, 1753.307443559794, 1888.2447021191522, 8658.307335413168, 8978.416402933814, 9008.819823603524, 9294.628214871396, 9310.813783724321, 9038.231750301216, 9163.083691630834, 9224.308176886743, 9227.446353218811, 9229.261659067259, 2067.5658111796542, 2135.5195081106704, 2140.2937030779885, 2370.7392186859433, 2415.45652228249, 2374.5844477216506, 2444.291155564884, 2447.5349683560157, 2460.753924607543, 2467.6668649732237, 2325.8720770357622, 2349.89425475854, 2351.670766092748, 2353.105819788478, 2393.365758074112, 2053.2300387354744, 2131.4245153808383, 2375.061850569024, 2406.987965060181, 2410.4576470294132, 2060.1141509151057, 2290.7594702556157, 2361.645753137026, 2372.4899146683547, 2399.2802159352123, 8880.555972201364, 8886.200241978187, 8901.287896968228, 8963.148500892405, 8981.056989016124, 5041.966396888629, 5130.384353877521, 5134.358205224347, 5139.0, 5139.74301284938, 3340.7494437917253, 3385.119868834121, 3460.9826950865086, 3484.564429446319, 3494.405950988338, 1139.9772004559863, 1151.8099513580248, 1153.1466714631197, 1170.373849990251, 1174.0724827386355, 12521.12352135351, 12541.56104536346, 12549.937250313782, 12640.431180596896, 12654.746905061938, 4539.682222244412, 4680.578747912636, 4738.099761045391, 4759.762011899391, 4839.322494850724, 10561.577536898438, 10611.0, 10634.096101831276, 10641.627543035956, 10649.307794993301, 5279.498447647467, 5334.386545547234, 5340.759665815048, 5352.090144675414, 5354.3574771027725, 4387.451568553931, 4817.78319975602, 4941.678790878582, 4943.0, 4951.183054795991, 4094.119764250641, 4102.0, 4123.422720819088, 4136.544980052192, 4207.84284321814, 1303.680598253434, 1306.4839388441703, 1351.0880155894731, 1355.4645914863574, 1369.4385302026321, 1044.7440377107657, 1045.3675526306474, 1071.9678409647722, 1099.9780004399868, 1102.6416414665266, 6419.743210271537, 6591.835204119935, 6599.175103112111, 6621.9006714899315, 6666.466682665375, 402.3662731198316, 414.20886107534466, 417.61996583109226, 447.0344056837281, 450.2211174667843, 4486.955130448654, 4519.728816271035, 4522.615577675869, 4526.95473045272, 4559.293309537027, 11267.098632109411, 11659.242149260272, 11669.183157179086, 11689.824652630217, 11693.415329233674, 10841.18691098155, 11300.321980681185, 11307.265027773168, 11546.94226528862, 11577.884221157849, 8589.656413743505, 8693.913060869438, 8693.956530217434, 8725.869111963199, 8777.341699372444, 6510.902336464862, 6618.536702430783, 6641.634710090992, 6721.092652491851, 6721.260661327152, 10418.583256669648, 10573.788524229627, 10713.410762408143, 10721.892781072089, 10811.56753729842, 10667.453219283316, 10892.292001019909, 10902.345859248471, 10994.34033957965, 11026.558937642405, 7453.627318634155, 7597.506162099446, 7598.544087354777, 8234.176582341717, 8428.957855210685, 8498.107698691796, 8644.524551149496, 8882.333824963283, 8920.643174272956, 9144.314176436927, 8062.798430039296, 8295.751127466187, 8357.331413486785, 8447.831043379221, 8456.069832318562, 7767.495112817649, 7848.9215107848195, 8221.465604735673, 8298.21166989135, 8331.125231850569, 7583.431242656712, 7586.0, 7688.423368247292, 7706.422018348534, 7708.2677145673315, 5561.805336813192, 5749.511291540266, 5780.913286300793, 5798.94201057984, 5922.052471604523, 5838.766449341979, 5868.530517558671, 5879.706014699163, 5920.963831329586, 5929.202662090929], "value": 4740.209798043619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.4371518140612, 353.4397979202963, 354.964503549645, 357.64593052877626, 362.34234863722344, 5496.0, 5550.195221692858, 5568.136938774496, 5576.776928922838, 5598.328200615932, 5448.202093309208, 5471.863203419916, 5492.148716948879, 5520.1443776214755, 5526.309211348582, 3852.6900853709735, 4077.694172937034, 4241.639460645849, 4289.849855255066, 4310.836074259948, 4254.6170844623975, 4285.35719642053, 4289.806958686867, 4291.742495450283, 4307.440032795732, 4098.774567398792, 4268.7225330353585, 4286.678499112563, 4308.0737641407095, 4314.935275970863, 4193.777298032048, 4281.31498960168, 4296.892577685583, 4297.871063868089, 4319.157764235975, 3820.5797362290127, 3855.556610989716, 3858.5369755629504, 3861.3242682530445, 3863.613638636142, 5207.791688332462, 5245.8459138989365, 5268.947310526884, 5294.708791016493, 5329.626926115174, 4980.2280646499485, 4991.151504244287, 4996.25056241563, 4997.625178111656, 5000.224965130411, 5505.3393592768725, 5553.194786755897, 5758.395368486291, 5761.596688231825, 5762.423757624246, 4152.418661387408, 4237.0466645004935, 4239.936400953958, 4246.7876606169875, 4253.702620700685, 5824.970875145597, 5920.815836832608, 5922.3781502942, 5923.0, 5928.644281343133, 4236.68224883135, 4349.19539885116, 4358.934615980763, 4360.561014865087, 4376.474823021194, 4405.10580450403, 4433.268510695699, 4436.82252709888, 4448.110377924428, 4454.265046267395, 4789.4971028041555, 4932.692836398357, 4937.580305674058, 4968.0, 5017.0, 5734.111212762028, 5749.913751293734, 5798.217240672539, 5805.709714514257, 5819.359870414251, 1516.2721893491187, 1531.2496876530643, 1537.669401078751, 1537.8615924566618, 1543.521508332398, 954.5609019850947, 984.8670429491926, 994.6220436234329, 998.7553049502918, 1008.5511947183579, 4968.0, 4969.503049695074, 4970.801167953314, 5011.799528018912, 5019.3474848270225, 5182.663126896739, 5202.895942081137, 5246.265522826731, 5281.366236051698, 5286.735663216824, 5021.719461537357, 5026.974865125651, 5035.84892453227, 5207.479252074762, 5633.957717822216, 3104.959838454098, 3124.375124975014, 3150.212446888278, 3151.353972435645, 3152.5586417901513, 6107.267127944675, 6149.0, 6161.106639537332, 6168.136460895478, 6177.776000639766, 5807.651540907559, 6092.116643086728, 6099.3900609938655, 6105.664188469588, 6111.57218994675, 5833.562482813806, 5891.941080589225, 6051.636901785907, 6064.818055458431, 6106.435297175197, 5871.588988770916, 5931.970340148272, 5936.0, 5946.791862284799, 5950.166976623363, 5720.227769251098, 5887.087501437284, 5905.527557795452, 5908.645481271137, 5959.404059594006, 6141.232345956755, 6152.384761523812, 6165.198524191826, 6169.876602468015, 6179.752809887555, 4254.765987870573, 4255.553166917429, 4258.318669013067, 4268.652241267228, 4280.571942805695, 5761.884762304814, 5890.646561206341, 5896.734646940812, 5910.202122713378, 5977.880442391215, 5730.799422020209, 5753.3958934311295, 5772.134179873053, 5774.451427114417, 5783.450572195635, 5528.640638358494, 5692.288463942007, 5713.200151978809, 5793.739281732248, 5803.0, 5670.716464176692, 5702.8289151325525, 5703.230063941481, 5709.200711900255, 5718.770464350185, 5839.678817664899, 5857.58996870215, 5864.765409383577, 5874.618149820248, 5883.411658834082, 5415.864603384947, 5653.349864765604, 5672.943270567406, 5732.57005724564, 5734.197212390185], "value": 4388.338217096158, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.6791551294996, 841.5623875584696, 855.0765173612497, 891.7770557360659, 908.5230254116592, 14944.476943306987, 15771.60570985726, 15813.367465301402, 16354.59113522161, 16416.917915410406, 15238.085714857116, 15394.307256173472, 15438.0, 15459.149746763924, 15901.204939753025, 729.657061181244, 864.2222000199807, 887.0552861202831, 887.9822403551925, 888.2627419242046, 878.4246318661255, 882.5410786391072, 885.9069797671249, 886.8403687336277, 888.0586578227068, 928.907109289069, 929.5631053404888, 930.9115634014792, 931.2363861633463, 931.4364809290383, 775.3332134364442, 905.9003509613938, 927.3647551427293, 930.2697382554729, 932.9970281946867, 681.0431343961692, 686.3891136888174, 686.8317262270725, 687.3744892148121, 687.381356778903, 14524.201168935704, 14559.70880582393, 14567.70864582713, 14578.927105364512, 14581.781273280909, 15073.246337683182, 15284.388624455009, 15305.693886122215, 15327.923360383127, 15462.149581772997, 13370.39833207508, 13911.582652520441, 14006.649833754136, 14008.789868151986, 14017.088889222168, 4641.814327426899, 4681.5318468153255, 4719.197736384788, 4759.571638552512, 4764.380630518045, 77375.6131219346, 78304.60847695782, 78450.0, 78943.0, 79168.0, 11619.419029048682, 11674.0, 11749.765004699859, 11815.645530634094, 12625.747485050248, 22686.432839178822, 22909.312720618407, 22962.65556016661, 22966.770332296797, 22974.19590314331, 8472.788180295542, 8551.743447696455, 8674.913250867537, 8920.375573709778, 8966.820663586823, 5016.347874776256, 5050.343455350854, 5097.541221290102, 5133.691978481228, 5142.254373115878, 3615.258871931248, 3714.981425092911, 3719.6652301293016, 3724.0131365188245, 3725.8882233533036, 613.9201903752484, 624.2696045626627, 628.3716283716284, 662.3045801907978, 662.827664807144, 666.2504682232488, 827.3215962910356, 832.2842355574202, 841.284907828341, 851.7019043334783, 11030.889691103146, 11111.38887361203, 11159.665210043711, 11297.943510282395, 11693.590724324778, 685.540687739216, 712.868119397913, 782.710397153057, 800.9399295052895, 810.3274282345639, 5178.585713142939, 5207.973960130175, 5257.710825904535, 5396.568274538027, 5396.703181324986, 122022.38988805177, 126504.0, 132494.0, 132664.0, 133183.33408332895, 109237.45381273043, 110602.44698776455, 111665.44167279112, 112591.0, 114405.42797286127, 97775.51112244393, 99944.0, 99958.5002074985, 100122.0, 100353.0, 9857.704268871945, 10136.695899123039, 10140.956918800932, 10610.840837387292, 11179.55281788752, 41045.38431923464, 49539.0, 49763.0, 49946.500534994186, 56257.0, 76348.61825690836, 78132.0, 80088.59955700184, 81950.0, 84151.0, 12378.81431778506, 13458.25979571133, 13792.862071379157, 13980.091294065853, 14081.295935203403, 11800.70498237551, 12642.683932901751, 14635.414583416545, 16363.509094727176, 16691.332346705996, 14783.704325913637, 15184.392624294904, 15417.383304668136, 15729.68540629158, 15734.21328933526, 14206.92896535552, 14502.782458263346, 14540.345684444013, 14699.412023519368, 15161.772573411186, 14883.776743349075, 14920.477783277533, 15087.622809429851, 15484.5354639361, 16012.599685007503, 10192.796144077225, 10276.22928280397, 10281.280310378203, 10385.221108416748, 10568.788624227625, 10192.082712555906, 10468.895311046792, 10550.366977981346, 10567.313124646873, 10792.892071079188], "value": 8082.049621080391, "unit": "score"}], "name": "dromaeo_css", "value": 7660.106446124337, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 108.0, 111.0, 109.0, 109.0, 111.0, 108.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 128.0, 172.0, 128.0, 127.0, 157.0, 130.0, 154.0, 125.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 159.0, 161.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 131.0, 75.0, 77.0, 75.0, 74.0, 97.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 115.0, 84.0, 84.0, 83.0, 117.0, 82.0, 85.0, 136.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 148.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 51.0, 51.0, 52.0, 53.0, 53.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 79.0, 76.0, 78.0, 77.0, 77.0, 112.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 127.0, 114.0, 114.0, 117.0, 113.0, 122.0, 129.0, 124.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 152.0, 154.0, 151.0, 153.0, 155.0, 151.0, 156.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 62.0, 60.0, 62.0, 63.0, 62.0, 62.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1474.7, "alertThreshold": 2.0}]} 11:17:03 INFO - Return code: 0 11:17:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:17:03 ERROR - # TBPL SUCCESS # 11:17:03 INFO - Running post-action listener: _resource_record_post_action 11:17:03 INFO - ##### 11:17:03 INFO - ##### Finished run-tests step (success) 11:17:03 INFO - ##### 11:17:03 INFO - Running post-run listener: _resource_record_post_run 11:17:03 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 505516032; Read time: 20; Write time: 1791472 11:17:03 INFO - TinderboxPrint: CPU usage
13.2% 11:17:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 11:17:03 INFO - TinderboxPrint: I/O write bytes / time
505,516,032 / 1,791,472 11:17:03 INFO - TinderboxPrint: CPU idle
8,280.8 (86.8%) 11:17:03 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 11:17:03 INFO - TinderboxPrint: Swap in / out
0 / 0 11:17:03 INFO - install - Wall time: 18s; CPU: 19.0%; Read bytes: 0; Write bytes: 253726720; Read time: 0; Write time: 1329980 11:17:03 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 251789312; Read time: 20; Write time: 461492 11:17:04 INFO - Running post-run listener: _upload_blobber_files 11:17:04 INFO - Blob upload gear active. 11:17:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:04 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 11:17:04 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'] 11:17:04 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 11:17:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:17:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:08 INFO - (blobuploader) - INFO - Done attempting. 11:17:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:17:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:17:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:09 INFO - (blobuploader) - INFO - Done attempting. 11:17:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:17:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:10 INFO - (blobuploader) - INFO - Done attempting. 11:17:10 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:10 INFO - Return code: 0 11:17:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ba0c9b987d07fc857f3bfb29355ed05fa2e960cbf2ca3794a30e176d06ec54df91db528692cbfb443e6dd8bfecda02d72df5c3393b3e972cc19fbb8bb43423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/564ac4be7c45b3c3c51fc64ad5b27c5a0ce3d366535817cd718fb2d38f1a277dd7030905d1111addbf4d46d21826992315fcbba083a6892d2397316f8576e043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e172c35d509662210a6aed473884f0960e19a41b0088bbfbfa9b2cd44467ec399603b32ce92a84b4759ef1be5d472b7ea31a7f643bb31a7eb8936aa4566680"} 11:17:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:10 INFO - Contents: 11:17:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ba0c9b987d07fc857f3bfb29355ed05fa2e960cbf2ca3794a30e176d06ec54df91db528692cbfb443e6dd8bfecda02d72df5c3393b3e972cc19fbb8bb43423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/564ac4be7c45b3c3c51fc64ad5b27c5a0ce3d366535817cd718fb2d38f1a277dd7030905d1111addbf4d46d21826992315fcbba083a6892d2397316f8576e043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e172c35d509662210a6aed473884f0960e19a41b0088bbfbfa9b2cd44467ec399603b32ce92a84b4759ef1be5d472b7ea31a7f643bb31a7eb8936aa4566680"} 11:17:10 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:10 INFO - Copying logs to upload dir... 11:17:10 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.836570 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-15 11:17:10.019906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:17:10.023777) ========= 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=df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342 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/45ba0c9b987d07fc857f3bfb29355ed05fa2e960cbf2ca3794a30e176d06ec54df91db528692cbfb443e6dd8bfecda02d72df5c3393b3e972cc19fbb8bb43423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/564ac4be7c45b3c3c51fc64ad5b27c5a0ce3d366535817cd718fb2d38f1a277dd7030905d1111addbf4d46d21826992315fcbba083a6892d2397316f8576e043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e172c35d509662210a6aed473884f0960e19a41b0088bbfbfa9b2cd44467ec399603b32ce92a84b4759ef1be5d472b7ea31a7f643bb31a7eb8936aa4566680"} build_url:https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/EE73CyieS_y_ekc48iKIUg/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/45ba0c9b987d07fc857f3bfb29355ed05fa2e960cbf2ca3794a30e176d06ec54df91db528692cbfb443e6dd8bfecda02d72df5c3393b3e972cc19fbb8bb43423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/564ac4be7c45b3c3c51fc64ad5b27c5a0ce3d366535817cd718fb2d38f1a277dd7030905d1111addbf4d46d21826992315fcbba083a6892d2397316f8576e043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e172c35d509662210a6aed473884f0960e19a41b0088bbfbfa9b2cd44467ec399603b32ce92a84b4759ef1be5d472b7ea31a7f643bb31a7eb8936aa4566680"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:17:10.049477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:17:10.049808) ========= 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=df17445c3590ff7897617a0e00000225-1468605390.751031-1949531342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:17:10.133687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:17:10.134005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:17:10.134344) ========= ========= Total master_lag: 0.18 =========