builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1457669759.11 results: success (0) buildid: 20160310193139 builduid: 1bbf1a0498be4dbe85facbbbb61b2fc0 revision: 79256f612a533ea5b5556ed7ff79ed854803ecc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.107366) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.107824) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.108173) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.145476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.145764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.198997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.199258) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.291341) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.291606) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.291952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.292229) ========= 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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-10 20:15:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-03-10 20:15:59 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.459347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.459653) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018311 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.513019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:15:59.513336) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 79256f612a533ea5b5556ed7ff79ed854803ecc7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 79256f612a533ea5b5556ed7ff79ed854803ecc7 --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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 20:15:59,626 truncating revision to first 12 chars 2016-03-10 20:15:59,626 Setting DEBUG logging. 2016-03-10 20:15:59,626 attempt 1/10 2016-03-10 20:15:59,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/79256f612a53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 20:16:00,012 unpacking tar archive at: fx-team-79256f612a53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:16:00.227313) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 20:16:00.227660) ========= echo 79256f612a533ea5b5556ed7ff79ed854803ecc7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'79256f612a533ea5b5556ed7ff79ed854803ecc7'] 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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 79256f612a533ea5b5556ed7ff79ed854803ecc7 program finished with exit code 0 elapsedTime=0.003906 script_repo_revision: '79256f612a533ea5b5556ed7ff79ed854803ecc7' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 20:16:00.275232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 20:16:00.275510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 20:16:00.287818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-10 20:16:00.288150) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:16:00 INFO - MultiFileLogger online at 20160310 20:16:00 in /builds/slave/test 20:16:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:16:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:00 INFO - {'append_to_log': False, 20:16:00 INFO - 'base_work_dir': '/builds/slave/test', 20:16:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:16:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:00 INFO - 'branch': 'Fx-Team-Non-PGO', 20:16:00 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:00 INFO - 'config_files': ('talos/linux_config.py',), 20:16:00 INFO - 'default_actions': ('clobber', 20:16:00 INFO - 'read-buildbot-config', 20:16:00 INFO - 'download-and-extract', 20:16:00 INFO - 'populate-webroot', 20:16:00 INFO - 'create-virtualenv', 20:16:00 INFO - 'install', 20:16:00 INFO - 'run-tests'), 20:16:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:00 INFO - 'download_minidump_stackwalk': True, 20:16:00 INFO - 'download_symbols': 'ondemand', 20:16:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:00 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:00 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:00 INFO - 'installer_path': 'installer.exe', 20:16:00 INFO - 'log_level': 'info', 20:16:00 INFO - 'log_name': 'talos', 20:16:00 INFO - 'log_to_console': True, 20:16:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:16:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:16:00 INFO - 'opt_config_files': (), 20:16:00 INFO - 'pip_index': False, 20:16:00 INFO - 'sps_profile': False, 20:16:00 INFO - 'sps_profile_interval': 0, 20:16:00 INFO - 'suite': 'dromaeojs', 20:16:00 INFO - 'system_bits': '32', 20:16:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:00 INFO - 'title': 'talos-linux64-ix-008', 20:16:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:00 INFO - 'use_talos_json': True, 20:16:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:00 INFO - 'work_dir': 'build'} 20:16:00 INFO - ##### 20:16:00 INFO - ##### Running clobber step. 20:16:00 INFO - ##### 20:16:00 INFO - Running pre-action listener: _resource_record_pre_action 20:16:00 INFO - Running main action method: clobber 20:16:00 INFO - rmtree: /builds/slave/test/build 20:16:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:01 INFO - Running post-action listener: _resource_record_post_action 20:16:01 INFO - ##### 20:16:01 INFO - ##### Running read-buildbot-config step. 20:16:01 INFO - ##### 20:16:01 INFO - Running pre-action listener: _resource_record_pre_action 20:16:01 INFO - Running main action method: read_buildbot_config 20:16:01 INFO - Using buildbot properties: 20:16:01 INFO - { 20:16:01 INFO - "project": "", 20:16:01 INFO - "product": "firefox", 20:16:01 INFO - "script_repo_revision": "production", 20:16:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:16:01 INFO - "repository": "", 20:16:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:16:01 INFO - "buildid": "20160310193139", 20:16:01 INFO - "pgo_build": "False", 20:16:01 INFO - "basedir": "/builds/slave/test", 20:16:01 INFO - "buildnumber": 1436, 20:16:01 INFO - "slavename": "talos-linux64-ix-008", 20:16:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:16:01 INFO - "platform": "ubuntu64_hw", 20:16:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:16:01 INFO - "branch": "fx-team", 20:16:01 INFO - "repo_path": "integration/fx-team", 20:16:01 INFO - "revision": "79256f612a533ea5b5556ed7ff79ed854803ecc7", 20:16:01 INFO - "stage_platform": "linux64", 20:16:01 INFO - "builduid": "1bbf1a0498be4dbe85facbbbb61b2fc0", 20:16:01 INFO - "slavebuilddir": "test" 20:16:01 INFO - } 20:16:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:16:01 INFO - Running post-action listener: _resource_record_post_action 20:16:01 INFO - ##### 20:16:01 INFO - ##### Running download-and-extract step. 20:16:01 INFO - ##### 20:16:01 INFO - Running pre-action listener: _resource_record_pre_action 20:16:01 INFO - Running main action method: download_and_extract 20:16:01 INFO - mkdir: /builds/slave/test/build/tests 20:16: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')]} 20:16:01 INFO - https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:16:07 INFO - Downloaded 1361 bytes. 20:16:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:16:07 INFO - Using the following test package requirements: 20:16:07 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:07 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:16:07 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:16:07 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'jsshell-linux-x86_64.zip'], 20:16:07 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:16:07 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:07 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:16:07 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:16:07 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:16:07 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:16:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:16:07 INFO - https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:16:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:16:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:16:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:11 INFO - Downloaded 22093190 bytes. 20:16:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:16:12 INFO - Return code: 0 20:16:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:12 INFO - https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:16:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:16:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:16:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:15 INFO - Downloaded 22093190 bytes. 20:16:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:16:17 INFO - Return code: 0 20:16:17 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')]} 20:16:17 INFO - https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:16:18 INFO - Downloaded 10845161 bytes. 20:16:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:16:18 INFO - Return code: 0 20:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:18 INFO - https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:16:20 INFO - Downloaded 54453068 bytes. 20:16:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:16:20 INFO - mkdir: /builds/slave/test/properties 20:16:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:20 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:20 INFO - Contents: 20:16:20 INFO - build_url:https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:16:21 INFO - Running post-action listener: _resource_record_post_action 20:16:21 INFO - Running post-action listener: set_extra_try_arguments 20:16:21 INFO - ##### 20:16:21 INFO - ##### Running populate-webroot step. 20:16:21 INFO - ##### 20:16:21 INFO - Running pre-action listener: _resource_record_pre_action 20:16:21 INFO - Running main action method: populate_webroot 20:16:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:21 INFO - '--tppagecycles', 20:16:21 INFO - '7'], 20:16:21 INFO - 'tests': ['tsvgm']}}, 20:16:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:16:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:16:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'tests': ['damp', 'tps']}, 20:16:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['damp', 'tps']}, 20:16:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:16:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:21 INFO - 'other': {'tests': ['a11yr', 20:16:21 INFO - 'ts_paint', 20:16:21 INFO - 'tpaint', 20:16:21 INFO - 'sessionrestore', 20:16:21 INFO - 'sessionrestore_no_auto_restore', 20:16:21 INFO - 'tabpaint']}, 20:16:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['a11yr', 20:16:21 INFO - 'ts_paint', 20:16:21 INFO - 'tpaint', 20:16:21 INFO - 'sessionrestore', 20:16:21 INFO - 'sessionrestore_no_auto_restore', 20:16:21 INFO - 'tabpaint']}, 20:16:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['a11yr', 20:16:21 INFO - 'ts_paint', 20:16:21 INFO - 'tpaint', 20:16:21 INFO - 'sessionrestore', 20:16:21 INFO - 'sessionrestore_no_auto_restore', 20:16:21 INFO - 'tabpaint']}, 20:16:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['a11yr', 20:16:21 INFO - 'ts_paint', 20:16:21 INFO - 'tpaint', 20:16:21 INFO - 'sessionrestore', 20:16:21 INFO - 'sessionrestore_no_auto_restore', 20:16:21 INFO - 'tabpaint']}, 20:16:21 INFO - 'other_l64': {'tests': ['a11yr', 20:16:21 INFO - 'ts_paint', 20:16:21 INFO - 'tpaint', 20:16:21 INFO - 'sessionrestore', 20:16:21 INFO - 'sessionrestore_no_auto_restore', 20:16:21 INFO - 'tabpaint']}, 20:16:21 INFO - 'other_nol64': {'tests': ['a11yr', 20:16:21 INFO - 'ts_paint', 20:16:21 INFO - 'tpaint', 20:16:21 INFO - 'sessionrestore', 20:16:21 INFO - 'sessionrestore_no_auto_restore', 20:16:21 INFO - 'tabpaint']}, 20:16:21 INFO - 'svgr': {'tests': ['tsvgx', 20:16:21 INFO - 'tsvgr_opacity', 20:16:21 INFO - 'tart', 20:16:21 INFO - 'tscrollx', 20:16:21 INFO - 'cart']}, 20:16:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['tsvgx', 20:16:21 INFO - 'tsvgr_opacity', 20:16:21 INFO - 'tart', 20:16:21 INFO - 'tscrollx', 20:16:21 INFO - 'cart']}, 20:16:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'tests': ['tp5o']}, 20:16:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'talos_options': ['--e10s'], 20:16:21 INFO - 'tests': ['tp5o']}, 20:16:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'talos_options': ['--xperf_path', 20:16:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:21 INFO - 'tests': ['tp5n']}, 20:16:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:21 INFO - 'talos_options': ['--e10s', 20:16:21 INFO - '--xperf_path', 20:16:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:21 INFO - 'tests': ['tp5n']}}, 20:16:21 INFO - 'talos.zip': {'path': '', 20:16:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:21 INFO - Running post-action listener: _resource_record_post_action 20:16:21 INFO - ##### 20:16:21 INFO - ##### Running create-virtualenv step. 20:16:21 INFO - ##### 20:16:21 INFO - Running pre-action listener: _resource_record_pre_action 20:16:21 INFO - Running main action method: create_virtualenv 20:16:21 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:21 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 20:16:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:21 INFO - Using real prefix '/usr' 20:16:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:21 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:23 INFO - Installing pip.................done. 20:16:23 INFO - Return code: 0 20:16:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:16:23 INFO - Using env: {'DISPLAY': ':0', 20:16:23 INFO - 'HOME': '/home/cltbld', 20:16:23 INFO - 'LANG': 'en_US.UTF-8', 20:16:23 INFO - 'LANGUAGE': 'en_US:en', 20:16:23 INFO - 'LOGNAME': 'cltbld', 20:16:23 INFO - 'MAIL': '/var/mail/cltbld', 20:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:23 INFO - 'MOZ_NO_REMOTE': '1', 20:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:23 INFO - 'NO_EM_RESTART': '1', 20:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:23 INFO - 'PWD': '/builds/slave/test', 20:16:23 INFO - 'SHELL': '/bin/bash', 20:16:23 INFO - 'SHLVL': '1', 20:16:23 INFO - 'TERM': 'linux', 20:16:23 INFO - 'TMOUT': '86400', 20:16:23 INFO - 'USER': 'cltbld', 20:16:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:23 INFO - '_': '/tools/buildbot/bin/python'} 20:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:16:23 INFO - Cleaning up... 20:16:23 INFO - Return code: 0 20:16:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:16:23 INFO - Using env: {'DISPLAY': ':0', 20:16:23 INFO - 'HOME': '/home/cltbld', 20:16:23 INFO - 'LANG': 'en_US.UTF-8', 20:16:23 INFO - 'LANGUAGE': 'en_US:en', 20:16:23 INFO - 'LOGNAME': 'cltbld', 20:16:23 INFO - 'MAIL': '/var/mail/cltbld', 20:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:23 INFO - 'MOZ_NO_REMOTE': '1', 20:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:23 INFO - 'NO_EM_RESTART': '1', 20:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:23 INFO - 'PWD': '/builds/slave/test', 20:16:23 INFO - 'SHELL': '/bin/bash', 20:16:23 INFO - 'SHLVL': '1', 20:16:23 INFO - 'TERM': 'linux', 20:16:23 INFO - 'TMOUT': '86400', 20:16:23 INFO - 'USER': 'cltbld', 20:16:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:23 INFO - '_': '/tools/buildbot/bin/python'} 20:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:24 INFO - Downloading/unpacking psutil>=0.7.1 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:26 INFO - Installing collected packages: psutil 20:16:26 INFO - Running setup.py install for psutil 20:16:26 INFO - building 'psutil._psutil_linux' extension 20:16:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:16:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:16:26 INFO - building 'psutil._psutil_posix' extension 20:16:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:16:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:16:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:26 INFO - Successfully installed psutil 20:16:26 INFO - Cleaning up... 20:16:26 INFO - Return code: 0 20:16:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:16:26 INFO - Using env: {'DISPLAY': ':0', 20:16:26 INFO - 'HOME': '/home/cltbld', 20:16:26 INFO - 'LANG': 'en_US.UTF-8', 20:16:26 INFO - 'LANGUAGE': 'en_US:en', 20:16:26 INFO - 'LOGNAME': 'cltbld', 20:16:26 INFO - 'MAIL': '/var/mail/cltbld', 20:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:26 INFO - 'MOZ_NO_REMOTE': '1', 20:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:26 INFO - 'NO_EM_RESTART': '1', 20:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:26 INFO - 'PWD': '/builds/slave/test', 20:16:26 INFO - 'SHELL': '/bin/bash', 20:16:26 INFO - 'SHLVL': '1', 20:16:26 INFO - 'TERM': 'linux', 20:16:26 INFO - 'TMOUT': '86400', 20:16:26 INFO - 'USER': 'cltbld', 20:16:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:26 INFO - '_': '/tools/buildbot/bin/python'} 20:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:16:28 INFO - Installing collected packages: mozsystemmonitor 20:16:28 INFO - Running setup.py install for mozsystemmonitor 20:16:28 INFO - Successfully installed mozsystemmonitor 20:16:28 INFO - Cleaning up... 20:16:28 INFO - Return code: 0 20:16:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:16:28 INFO - Using env: {'DISPLAY': ':0', 20:16:28 INFO - 'HOME': '/home/cltbld', 20:16:28 INFO - 'LANG': 'en_US.UTF-8', 20:16:28 INFO - 'LANGUAGE': 'en_US:en', 20:16:28 INFO - 'LOGNAME': 'cltbld', 20:16:28 INFO - 'MAIL': '/var/mail/cltbld', 20:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:28 INFO - 'MOZ_NO_REMOTE': '1', 20:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:28 INFO - 'NO_EM_RESTART': '1', 20:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:28 INFO - 'PWD': '/builds/slave/test', 20:16:28 INFO - 'SHELL': '/bin/bash', 20:16:28 INFO - 'SHLVL': '1', 20:16:28 INFO - 'TERM': 'linux', 20:16:28 INFO - 'TMOUT': '86400', 20:16:28 INFO - 'USER': 'cltbld', 20:16:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:28 INFO - '_': '/tools/buildbot/bin/python'} 20:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:29 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:30 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:31 INFO - Downloading docopt-0.6.1.tar.gz 20:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:31 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:31 INFO - Running setup.py install for blobuploader 20:16:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:31 INFO - Running setup.py install for requests 20:16:32 INFO - Running setup.py install for docopt 20:16:32 INFO - Successfully installed blobuploader requests docopt 20:16:32 INFO - Cleaning up... 20:16:32 INFO - Return code: 0 20:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:32 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')]} 20:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:32 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')]} 20:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:32 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 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:32 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 20:16:32 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 20:16:32 INFO - Using env: {'DISPLAY': ':0', 20:16:32 INFO - 'HOME': '/home/cltbld', 20:16:32 INFO - 'LANG': 'en_US.UTF-8', 20:16:32 INFO - 'LANGUAGE': 'en_US:en', 20:16:32 INFO - 'LOGNAME': 'cltbld', 20:16:32 INFO - 'MAIL': '/var/mail/cltbld', 20:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:32 INFO - 'MOZ_NO_REMOTE': '1', 20:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:32 INFO - 'NO_EM_RESTART': '1', 20:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:32 INFO - 'PWD': '/builds/slave/test', 20:16:32 INFO - 'SHELL': '/bin/bash', 20:16:32 INFO - 'SHLVL': '1', 20:16:32 INFO - 'TERM': 'linux', 20:16:32 INFO - 'TMOUT': '86400', 20:16:32 INFO - 'USER': 'cltbld', 20:16:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:32 INFO - '_': '/tools/buildbot/bin/python'} 20:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:32 INFO - Running setup.py (path:/tmp/pip-qhcWJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:32 INFO - Running setup.py (path:/tmp/pip-rgUm5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:32 INFO - Running setup.py (path:/tmp/pip-dyHlaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:32 INFO - Running setup.py (path:/tmp/pip-dW1jtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:32 INFO - Running setup.py (path:/tmp/pip-5RXatD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:32 INFO - Running setup.py (path:/tmp/pip-HE7RDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:32 INFO - Running setup.py (path:/tmp/pip-PHKeQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:32 INFO - Running setup.py (path:/tmp/pip-Pl9Ioi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:33 INFO - Running setup.py (path:/tmp/pip-l9zGpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:33 INFO - Running setup.py (path:/tmp/pip-6lG7jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:33 INFO - Running setup.py (path:/tmp/pip-idwZav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:33 INFO - Running setup.py (path:/tmp/pip-c072dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:33 INFO - Running setup.py (path:/tmp/pip-qJIyNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:33 INFO - Running setup.py (path:/tmp/pip-gyitsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:33 INFO - Running setup.py (path:/tmp/pip-fTx4qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:33 INFO - Running setup.py (path:/tmp/pip-0t_pjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:33 INFO - Running setup.py (path:/tmp/pip-FbUPW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:33 INFO - Running setup.py install for manifestparser 20:16:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:33 INFO - Running setup.py install for mozcrash 20:16:33 INFO - Running setup.py install for mozdebug 20:16:33 INFO - Running setup.py install for mozdevice 20:16:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Running setup.py install for mozfile 20:16:34 INFO - Running setup.py install for mozhttpd 20:16:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Running setup.py install for mozinfo 20:16:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Running setup.py install for mozInstall 20:16:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Running setup.py install for mozleak 20:16:34 INFO - Running setup.py install for mozlog 20:16:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Running setup.py install for moznetwork 20:16:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:34 INFO - Running setup.py install for mozprocess 20:16:34 INFO - Running setup.py install for mozprofile 20:16:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:35 INFO - Running setup.py install for mozrunner 20:16:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:35 INFO - Running setup.py install for mozscreenshot 20:16:35 INFO - Running setup.py install for moztest 20:16:35 INFO - Running setup.py install for mozversion 20:16:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:35 INFO - Cleaning up... 20:16:35 INFO - Return code: 0 20:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:35 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 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:35 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 20:16:35 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 20:16:35 INFO - Using env: {'DISPLAY': ':0', 20:16:35 INFO - 'HOME': '/home/cltbld', 20:16:35 INFO - 'LANG': 'en_US.UTF-8', 20:16:35 INFO - 'LANGUAGE': 'en_US:en', 20:16:35 INFO - 'LOGNAME': 'cltbld', 20:16:35 INFO - 'MAIL': '/var/mail/cltbld', 20:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:35 INFO - 'MOZ_NO_REMOTE': '1', 20:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:35 INFO - 'NO_EM_RESTART': '1', 20:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:35 INFO - 'PWD': '/builds/slave/test', 20:16:35 INFO - 'SHELL': '/bin/bash', 20:16:35 INFO - 'SHLVL': '1', 20:16:35 INFO - 'TERM': 'linux', 20:16:35 INFO - 'TMOUT': '86400', 20:16:35 INFO - 'USER': 'cltbld', 20:16:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:35 INFO - '_': '/tools/buildbot/bin/python'} 20:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:35 INFO - Running setup.py (path:/tmp/pip-gOFcsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:35 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)) 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:35 INFO - Running setup.py (path:/tmp/pip-55VHoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:35 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)) 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:35 INFO - Running setup.py (path:/tmp/pip-5kVjfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:35 INFO - Running setup.py (path:/tmp/pip-OM5w89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:35 INFO - Running setup.py (path:/tmp/pip-sSGH5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:36 INFO - Running setup.py (path:/tmp/pip-fFaEwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:36 INFO - Running setup.py (path:/tmp/pip-bzicRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:36 INFO - Running setup.py (path:/tmp/pip-7nQ2HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:36 INFO - Running setup.py (path:/tmp/pip-gUBDvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:36 INFO - Running setup.py (path:/tmp/pip-njOJpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:36 INFO - Running setup.py (path:/tmp/pip-OdFPRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:36 INFO - Running setup.py (path:/tmp/pip-fELKuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:36 INFO - Running setup.py (path:/tmp/pip-s5LjfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:36 INFO - Running setup.py (path:/tmp/pip-KZ6gEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:36 INFO - Running setup.py (path:/tmp/pip-5pZ9WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:36 INFO - Running setup.py (path:/tmp/pip-mZz3gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:36 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)) 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:36 INFO - Running setup.py (path:/tmp/pip-8Ps4r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:38 INFO - Downloading blessings-1.6.tar.gz 20:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:16:38 INFO - Installing collected packages: blessings 20:16:38 INFO - Running setup.py install for blessings 20:16:38 INFO - Successfully installed blessings 20:16:38 INFO - Cleaning up... 20:16:39 INFO - Return code: 0 20:16:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:39 INFO - Reading from file tmpfile_stdout 20:16:39 INFO - Current package versions: 20:16:39 INFO - argparse == 1.2.1 20:16:39 INFO - blessings == 1.6 20:16:39 INFO - blobuploader == 1.2.4 20:16:39 INFO - docopt == 0.6.1 20:16:39 INFO - manifestparser == 1.1 20:16:39 INFO - mozInstall == 1.12 20:16:39 INFO - mozcrash == 0.17 20:16:39 INFO - mozdebug == 0.1 20:16:39 INFO - mozdevice == 0.48 20:16:39 INFO - mozfile == 1.2 20:16:39 INFO - mozhttpd == 0.7 20:16:39 INFO - mozinfo == 0.9 20:16:39 INFO - mozleak == 0.1 20:16:39 INFO - mozlog == 3.1 20:16:39 INFO - moznetwork == 0.27 20:16:39 INFO - mozprocess == 0.22 20:16:39 INFO - mozprofile == 0.28 20:16:39 INFO - mozrunner == 6.11 20:16:39 INFO - mozscreenshot == 0.1 20:16:39 INFO - mozsystemmonitor == 0.0 20:16:39 INFO - moztest == 0.7 20:16:39 INFO - mozversion == 1.4 20:16:39 INFO - psutil == 3.1.1 20:16:39 INFO - requests == 1.2.3 20:16:39 INFO - wsgiref == 0.1.2 20:16:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:39 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')]} 20:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:39 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')]} 20:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:39 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 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:39 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 20:16:39 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 20:16:39 INFO - Using env: {'DISPLAY': ':0', 20:16:39 INFO - 'HOME': '/home/cltbld', 20:16:39 INFO - 'LANG': 'en_US.UTF-8', 20:16:39 INFO - 'LANGUAGE': 'en_US:en', 20:16:39 INFO - 'LOGNAME': 'cltbld', 20:16:39 INFO - 'MAIL': '/var/mail/cltbld', 20:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:39 INFO - 'MOZ_NO_REMOTE': '1', 20:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:39 INFO - 'NO_EM_RESTART': '1', 20:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:39 INFO - 'PWD': '/builds/slave/test', 20:16:39 INFO - 'SHELL': '/bin/bash', 20:16:39 INFO - 'SHLVL': '1', 20:16:39 INFO - 'TERM': 'linux', 20:16:39 INFO - 'TMOUT': '86400', 20:16:39 INFO - 'USER': 'cltbld', 20:16:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:39 INFO - '_': '/tools/buildbot/bin/python'} 20:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 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)) 20:16:39 INFO - Cleaning up... 20:16:39 INFO - Return code: 0 20:16:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:16:39 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')]} 20:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:39 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')]} 20:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:39 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 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:39 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 20:16:39 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 20:16:39 INFO - Using env: {'DISPLAY': ':0', 20:16:39 INFO - 'HOME': '/home/cltbld', 20:16:39 INFO - 'LANG': 'en_US.UTF-8', 20:16:39 INFO - 'LANGUAGE': 'en_US:en', 20:16:39 INFO - 'LOGNAME': 'cltbld', 20:16:39 INFO - 'MAIL': '/var/mail/cltbld', 20:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:39 INFO - 'MOZ_NO_REMOTE': '1', 20:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:39 INFO - 'NO_EM_RESTART': '1', 20:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:39 INFO - 'PWD': '/builds/slave/test', 20:16:39 INFO - 'SHELL': '/bin/bash', 20:16:39 INFO - 'SHLVL': '1', 20:16:39 INFO - 'TERM': 'linux', 20:16:39 INFO - 'TMOUT': '86400', 20:16:39 INFO - 'USER': 'cltbld', 20:16:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:39 INFO - '_': '/tools/buildbot/bin/python'} 20:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:39 INFO - Downloading/unpacking jsonschema 20:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:16:42 INFO - Downloading/unpacking functools32 (from jsonschema) 20:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:42 INFO - Downloading functools32-3.2.3-2.tar.gz 20:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:16:42 INFO - warning: no files found matching '*.txt' 20:16:42 INFO - no previously-included directories found matching 'build' 20:16:42 INFO - no previously-included directories found matching 'dist' 20:16:42 INFO - no previously-included directories found matching '.git*' 20:16:42 INFO - Installing collected packages: jsonschema, functools32 20:16:42 INFO - Running setup.py install for functools32 20:16:42 INFO - warning: no files found matching '*.txt' 20:16:42 INFO - no previously-included directories found matching 'build' 20:16:42 INFO - no previously-included directories found matching 'dist' 20:16:42 INFO - no previously-included directories found matching '.git*' 20:16:42 INFO - Successfully installed jsonschema functools32 20:16:42 INFO - Cleaning up... 20:16:42 INFO - Return code: 0 20:16:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ac87d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, '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': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', '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 20:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:16:42 INFO - Using env: {'DISPLAY': ':0', 20:16:42 INFO - 'HOME': '/home/cltbld', 20:16:42 INFO - 'LANG': 'en_US.UTF-8', 20:16:42 INFO - 'LANGUAGE': 'en_US:en', 20:16:42 INFO - 'LOGNAME': 'cltbld', 20:16:42 INFO - 'MAIL': '/var/mail/cltbld', 20:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:42 INFO - 'MOZ_NO_REMOTE': '1', 20:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:42 INFO - 'NO_EM_RESTART': '1', 20:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:42 INFO - 'PWD': '/builds/slave/test', 20:16:42 INFO - 'SHELL': '/bin/bash', 20:16:42 INFO - 'SHLVL': '1', 20:16:42 INFO - 'TERM': 'linux', 20:16:42 INFO - 'TMOUT': '86400', 20:16:42 INFO - 'USER': 'cltbld', 20:16:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:42 INFO - '_': '/tools/buildbot/bin/python'} 20:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:43 INFO - Downloading/unpacking flake8 20:16:43 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 20:16:43 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 20:16:43 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 20:16:43 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 20:16:43 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 20:16:43 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 20:16:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:16:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:16:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 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 20:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:16:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:16:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:16:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:16:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:16:45 INFO - no previously-included directories found matching 'docs/_build' 20:16:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:16:45 INFO - Running setup.py install for pep8 20:16:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:16:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:16:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:16:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:16:45 INFO - no previously-included directories found matching 'docs/_build' 20:16:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:16:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:16:45 INFO - Cleaning up... 20:16:45 INFO - Return code: 0 20:16:45 INFO - Running post-action listener: _resource_record_post_action 20:16:45 INFO - Running post-action listener: _start_resource_monitoring 20:16:45 INFO - Starting resource monitoring. 20:16:45 INFO - ##### 20:16:45 INFO - ##### Running install step. 20:16:45 INFO - ##### 20:16:45 INFO - Running pre-action listener: _resource_record_pre_action 20:16:45 INFO - Running main action method: install 20:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:46 INFO - Reading from file tmpfile_stdout 20:16:46 INFO - Detecting whether we're running mozinstall >=1.0... 20:16:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:16:46 INFO - Reading from file tmpfile_stdout 20:16:46 INFO - Output received: 20:16:46 INFO - Usage: mozinstall [options] installer 20:16:46 INFO - Options: 20:16:46 INFO - -h, --help show this help message and exit 20:16:46 INFO - -d DEST, --destination=DEST 20:16:46 INFO - Directory to install application into. [default: 20:16:46 INFO - "/builds/slave/test"] 20:16:46 INFO - --app=APP Application being installed. [default: firefox] 20:16:46 INFO - mkdir: /builds/slave/test/build/application 20:16:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:17:02 INFO - Reading from file tmpfile_stdout 20:17:02 INFO - Output received: 20:17:02 INFO - /builds/slave/test/build/application/firefox/firefox 20:17:02 INFO - Running post-action listener: _resource_record_post_action 20:17:02 INFO - ##### 20:17:02 INFO - ##### Running run-tests step. 20:17:02 INFO - ##### 20:17:02 INFO - Running pre-action listener: _resource_record_pre_action 20:17:02 INFO - Running main action method: run_tests 20:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:17:02 INFO - Python 2.7.3 20:17:02 INFO - Return code: 0 20:17:02 INFO - grabbing minidump binary from tooltool 20:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:02 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b160>, '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 0x1e0c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:17:02 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 20:17:02 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 20:17:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:17:02 INFO - Return code: 0 20:17:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:17:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:17:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:17:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:17:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:17:03 INFO - Return code: 0 20:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 20:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 20:17:03 INFO - Using env: {'DISPLAY': ':0', 20:17:03 INFO - 'HOME': '/home/cltbld', 20:17:03 INFO - 'LANG': 'en_US.UTF-8', 20:17:03 INFO - 'LANGUAGE': 'en_US:en', 20:17:03 INFO - 'LOGNAME': 'cltbld', 20:17:03 INFO - 'MAIL': '/var/mail/cltbld', 20:17:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:17:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:03 INFO - 'MOZ_NO_REMOTE': '1', 20:17:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:03 INFO - 'NO_EM_RESTART': '1', 20:17:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:03 INFO - 'PWD': '/builds/slave/test', 20:17:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:17:03 INFO - 'SHELL': '/bin/bash', 20:17:03 INFO - 'SHLVL': '1', 20:17:03 INFO - 'TERM': 'linux', 20:17:03 INFO - 'TMOUT': '86400', 20:17:03 INFO - 'USER': 'cltbld', 20:17:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002', 20:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:03 INFO - '_': '/tools/buildbot/bin/python'} 20:17:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 20:17:03 INFO - mozversion application_buildid: 20160310193139 20:17:03 INFO - mozversion application_changeset: 79256f612a533ea5b5556ed7ff79ed854803ecc7 20:17:03 INFO - mozversion application_display_name: Nightly 20:17:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:17:03 INFO - mozversion application_name: Firefox 20:17:03 INFO - mozversion application_remotingname: firefox 20:17:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:17:03 INFO - mozversion application_vendor: Mozilla 20:17:03 INFO - mozversion application_version: 48.0a1 20:17:03 INFO - mozversion platform_buildid: 20160310193139 20:17:03 INFO - mozversion platform_changeset: 79256f612a533ea5b5556ed7ff79ed854803ecc7 20:17:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:17:03 INFO - mozversion platform_version: 48.0a1 20:17:03 INFO - using testdate: 1457669823 20:17:03 INFO - actual date: 1457669823 20:17:03 INFO - starting webserver on 'localhost:39429' 20:17:03 INFO - SUITE-START | Running 2 tests 20:17:03 INFO - TEST-START | dromaeo_css 20:17:03 INFO - operating with platform_type : linux_ 20:17:03 INFO - Initialising browser for dromaeo_css test... 20:17:03 INFO - TEST-INFO | started process 11800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVspqUl/profile http://localhost:39429/getInfo.html) 20:17:07 INFO - PROCESS | 11800 | __metrics Screen width/height:1600/1200 20:17:07 INFO - PROCESS | 11800 | colorDepth:24 20:17:07 INFO - PROCESS | 11800 | Browser inner width/height: 1024/697 20:17:07 INFO - PROCESS | 11800 | __metrics 20:17:08 ERROR - PROCESS | 11800 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:17:09 INFO - TEST-INFO | 11800: exit 0 20:17:09 INFO - Browser initialized. 20:17:09 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:09 INFO - TEST-INFO | started process 11893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVspqUl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:21 INFO - PROCESS | 11893 | RSS: Main: 153960448 20:17:21 INFO - PROCESS | 11893 | 20:18:12 INFO - PROCESS | 11893 | 1457669892626 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] 20:20:23 INFO - PROCESS | 11893 | Cycle 1(1): loaded http://localhost:39429/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39429/tests/dromaeo/cssquery-ext.html) 20:20:24 INFO - PROCESS | 11893 | RSS: Main: 241778688 20:20:24 INFO - PROCESS | 11893 | 20:23:27 INFO - PROCESS | 11893 | Cycle 1(1): loaded http://localhost:39429/tests/dromaeo/cssquery-ext.html (next: http://localhost:39429/tests/dromaeo/cssquery-jquery.html) 20:23:27 INFO - PROCESS | 11893 | RSS: Main: 235491328 20:23:27 INFO - PROCESS | 11893 | 20:26:29 INFO - PROCESS | 11893 | Cycle 1(1): loaded http://localhost:39429/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39429/tests/dromaeo/cssquery-mootools.html) 20:26:30 INFO - PROCESS | 11893 | RSS: Main: 232738816 20:26:30 INFO - PROCESS | 11893 | 20:29:32 INFO - PROCESS | 11893 | Cycle 1(1): loaded http://localhost:39429/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39429/tests/dromaeo/cssquery-prototype.html) 20:29:32 INFO - PROCESS | 11893 | RSS: Main: 219463680 20:29:32 INFO - PROCESS | 11893 | 20:32:35 INFO - PROCESS | 11893 | Cycle 1(1): loaded http://localhost:39429/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39429/tests/dromaeo/cssquery-yui.html) 20:32:36 INFO - PROCESS | 11893 | RSS: Main: 197935104 20:32:36 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | Cycle 1(1): loaded http://localhost:39429/tests/dromaeo/cssquery-yui.html (next: http://localhost:39429/tests/dromaeo/cssquery-dojo.html) 20:35:38 INFO - PROCESS | 11893 | RSS: Main: 265175040 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | __start_tp_report 20:35:38 INFO - PROCESS | 11893 | _x_x_mozilla_page_load 20:35:38 INFO - PROCESS | 11893 | _x_x_mozilla_page_load_details 20:35:38 INFO - PROCESS | 11893 | |i|pagename|runs| 20:35:38 INFO - PROCESS | 11893 | |0;dojo.html;2572.7041390240124;2647.6425682532863;2665.320343312455;2673.893044278229;2690.1929421173645;4380.62764665003;4488.4838243602;4507.729536227825;4521.570450807177;4537.546245375461;4451.5993560579545;4456.220161471738;4504.954950450495;4512.390827238321;4566.634669226462;4134.7312424692445;4142.337226043834;4172.207280616681;4270.0605866709275;4304.289792184286;4066.2680717470844;4239.130978149487;4295.699301048928;4323.870283891472;4329.242382583051;4142.772147531869;4180.26845302074;4187.958120418787;4229.97885010576;4241.618254357123;4186.28833098371;4187.958120418818;4199.97900010498;4203.222403855266;4227.027783609757;4069.2268468990796;4145.647619952308;4166.541680415152;4188.874333769962;4228;4421.9336709949375;4451.732896026248;4476.977615111936;4517.277235642315;4518.164139634178;4764.737939413331;4785.688930219525;4787;4793.065352256312;4810.302506136591;4696.084263568606;4763.761811909425;4804.543568361;4837.201861692816;4858.7570621468785;4470.977645111819;4480.507144214133;4484.035932274544;4485.439320084989;4513.210188217049;4899.069176856386;4902.41171059468;4905.9264111038365;4906.1414252505665;4941.160002799533;4526.185286648369;4683.063387322549;4764.023375208074;4777.283407488904;4780.689255198401;4721.5986641135205;4732.148213321566;4733.5266473352385;4737.194676904935;4778.617710583145;4700.45944716362;4701.2242979908615;4705.576498115186;4705.764711764398;4738.360321356573;4598.471175814824;4688.437387513521;4739.9763001185465;4763.3807605011125;4785.665003449794;4028.939565906514;4034.8991275218355;4051.068254301468;4087.325591277406;4088.6320231178743;3431.6225215226304;3570.2145527983803;3584.605693373727;3598.082488965297;3610.530631017951;4100.6719462443525;4138.234426631083;4186.895327616834;4229.302165142717;4229.725067870579;4788.784504697297;4797.808087676453;4816.735079570587;4818.951810481921;4868.659193856467;4077.347624380144;4174.3112386456505;4176.2900306947895;4177.4569305990635;4199.790010499462;4263.296556068276;4297.634701050446;4312.525622181557;4322.481302243688;4342.392065110887;4542.091581683677;4554.157480866051;4560.612347950461;4561.178987782231;4586.564276393738;4665.906681866276;4808.35087263229;4809.735464549343;4811.061842940593;4845.515448455127;4482.125985432809;4540.182767101954;4543.068670922386;4574.085182963354;4588.105319462673;4740.699462143526;4782.2826576012485;4782.354382158364;4784.521547845187;4825.469198388245;4693.296005599187;4801.159797035574;4847.636427268039;4849.078675051729;4871.707697538159;4602.056578401352;4627.028324051987;4633.142868569325;4635.953640463687;4682.461516925461;4604.493505714436;4635.884102897455;4638.8608341749805;4667.743274119956;4684.7891844867745;4370.803313850948;4524.0951809637545;4559.521250268674;4563.201439748097;4594.0582180653555;4643.071385722937;4654.557817007379;4658.627309815139;4686.133065382915;4706.670533062653;4517.6837621366185;4525.389072475174;4540.50054494012;4549.3176023596725;4570.223062079388 20:35:38 INFO - PROCESS | 11893 | |1;ext.html;491.86227856200276;493.9259111133332;513.4121430961549;520.7760662914948;536.0244355273403;24869.129580464687;33603.66396336036;34023.489647655246;34038.14904627386;34064.31871362571;35985.2802943941;36891.81554092226;36934.63065369346;36937;36978.630213697856;6674.16572928384;7504.287092726182;7693.576853273068;9555.283353748497;9740.123388894997;9660.5169741513;9763.658271960483;9771.657991970282;9774.755631109243;9796.902030979705;9764.804703905918;9840.70477885661;9863.358881672668;9868.802623947517;9869.407835529855;9750.707478775612;9866.506674666238;9869.851952220723;9872.210223182128;9879.06148915852;9882.160016398615;10046.748831279203;10049.296549241555;10055.145312648434;10058.89941100587;37060.44409333862;37533.81233093845;37541.812290938644;37612.43581346282;37661.623383766084;2818.4926713191617;2888.942221155565;3039.559263906743;3054.1601059708537;3120.89076882308;28083.29791755202;28453.715462845314;28572.142835714963;29150.979715709847;29738.70261297381;3443.8450269737923;3459.619441861393;3499.195185107414;3500.702440292578;3515.91210219744;214070;237178;239056.99999999825;241753;244185;51050;51547.48452515502;51726;51817.48182518127;51846.74076629668;60079;61232.69383653053;61373.693131534055;61457;61488.69255653693;13244.20534767917;14387.78418323726;14440.277986100864;14541.709165816836;14726;10256.53845576936;10287.331323464101;10288.742781430525;10289.30226512632;10311.329763565343;18850.43448696514;18992.145353459127;19057.71413428772;19071.52321191981;19076;7475.70097196117;7917.485363451357;8065.9596702016115;8074.717384891501;8078.23256790604;753.8040109571551;788.621461698388;817.4931542443722;857.7684025313255;875.2647775868301;26300;26761.866190668923;26921.192364229104;27214.863925680642;27221.727782722315;895.9148880856309;907.7594437474074;969.4086607169621;1038.3510306058713;1040.54216144896;13918.164910105426;13999.650008749659;14109.576712698636;14173.625927557707;14330.928345358207;257697;260419;262063;262139;262793;45497;45848;45947.540524594995;46144.3078353825;46167.30749038767;930.4417349590192;1148.133159464599;1149.4712432281078;1150;1183.5679976808403;24520.621157102312;26873;27141.72858271471;27150.72849271482;27273.86363068172;35989.64010359863;36700.26599467942;37751.62248377591;37792.62207378001;37868.43197352097;188876;190206;192216;192971.03514482337;193129;31793.841030794698;32579.674203257666;32582.674173257965;35536;36488;36329.81835090808;37966.81016594899;38007.2398552033;39141;39180.80409598048;29967.70032299649;30820.845895770377;30892;31876.68123318737;33602.66397336093;35590;35667.46498802468;35716.107097322776;35763.46354804732;36207.45688814722;34715.13212169716;35499;35827.92516224518;35893.461598075526;35917;31448.68551314549;32105.357892841545;32236.516452253705;32359.893480147064;32509.67490325161;24874;25252.873735631205;25300.620490692287;25421.87289063543;25588.104416345337 20:35:38 INFO - PROCESS | 11893 | |2;jquery.html;329.7675139026986;334.5216340632894;334.9184816366283;337.22774845603567;338.3655645664379;14940.701185976273;15478.380864765395;15531;16423.917880410612;16843.073630950323;14767.409303627843;14983.700325993474;14989.62525936852;15621.375144994186;15862.682746345095;4823.686460380073;4851.757412129397;4903.681260718042;4904.5340692634145;4971.825986090487;4780.900362961;4799.760011999403;4902.289168070628;4903.607711383099;4905.117078925792;4865.19724245499;4889.535494128052;4901.460839307673;4907.950920490803;4913.017396520692;4727.338172655848;4854.247591623304;4861.708297502126;4888.755562221892;4891.6331275154325;4299.226139294926;4302.290122129876;4305.935410968838;4319.092990472004;4330.13397320534;18555.814441855542;19071;19081.90459047696;19293.131809068625;19306.87624361319;1765.2409463930505;1799.091458813291;1899.9525011874814;2154.7737487563895;2261.8190544756544;11931.40342982856;12016.399180040962;12214.877851221463;12383.62849114528;12449.813252801216;1696.6352234269568;1741.1642411642356;1756.8331008554167;1757.6396838648047;1761.1898526677744;55539.444605554236;55572;55944;56504.717476412356;57271.427285727026;8959.462432254086;9028.277737780962;9269.212116970133;9300.20948219409;9442.716718498456;11919.940400297943;11927.403629818475;11964;11995.340256285988;12000.63998080059;6695.430888374445;6780.491463140284;6807.625580593016;6841.486888483284;6983.790486285419;6656.600603963778;6715.4291885190305;6800.183977922582;6814.1482314710665;6852.006459063408;5493.560515158778;5589.860253493695;5596.468335508121;5618.578606604521;5657.9434205658235;1529.350026238844;1586.643005323816;1642.8439298266646;1679.554917946745;1689.0963334615922;804.4047404920434;826;869.5912920927154;878.6617152396374;898.9370744047985;14778.778318325234;15863.444779432895;16007;16123.919380403024;16136.919315403347;860.492309537376;861.543382007537;887.0685779931047;889.564113584339;910.1762904571374;9256.305777066747;9402.858957115648;9486.573104210327;9489.715308540755;9636.518174091267;268727;273887;274207;369127;373238;58411.707941460874;59788.40211597915;63744.362556373846;64948;65180.34819651743;881.9294456443469;893.7854914820526;899.604174163366;913.7076135636665;915.2769312243254;13733.244671543162;14202.573922782332;14215.573532794033;14597.635059123606;14627.70744585081;30305;30792;31794.6820531801;32039.519407209376;32422.189445263113;44280.778596106815;44598.77700611476;44951.775241123585;44981.32528012148;44990;6885.345892140239;6905.585664860125;7129.857402852018;7197.676104575202;7304.050473438419;9427.292953028687;10758.838617420588;10942.726431839268;10968.122550196125;11211.60759373418;7001.50989430735;8863.955680221557;9215.953920230357;9226.123518265755;9364.672236471963;9378.812423751624;9422.481763503074;9595.568199430903;9724.611015559298;9887.901120988698;9465.47939863314;9465.574049167666;9490.525473726148;9839.065288797552;10002.399856008662;6962.23415424313;6984.930150698428;7235;7254.238304977901;7358.1538123116525;8228.382871284557;9174.119305542214;9236.815263694823;9280.814383712423;9343.953280233556 20:35:38 INFO - PROCESS | 11893 | |3;mootools.html;1132.4620805117574;1359.2727890578542;1380.682443038101;1496.4537943650564;1722.6813039587685;7122.786316410509;7272.381847542959;7275.854482910338;7287.890681639779;7292.8906066409045;7142.607156606385;7281.1262648482125;7291.817704557388;7298.343149116578;7307.963460182705;1811.2030706489168;2100.9264675736354;2126.2345555599973;2149.1940522304135;2150.4623844038993;2168.522924956515;2175.2495389090736;2175.2930297653247;2175.423512769117;2175.8150557202657;2019.7879222681627;2058.5677007828376;2063.731714877071;2069.379186244128;2077.1379877350882;2101.485136141647;2102.6425507663735;2121.0349291072525;2122.702821604969;2123.416060583344;2099.359695292935;2111.1133324003954;2115.9788402115937;2119.872807631547;2121.2681624839406;7412.59230742309;7502.287282708188;7505.249475052506;7505.286997735207;7506.136794268675;4211.263028969948;4309.461317335333;4345.739255644671;4347.0653809430805;4356.411884395629;2788.623535822658;2816.436712657456;2862.1985843963726;2864.2266588021325;2935.398243360106;888.6756333938131;906.6146887572821;924.8427767279578;925.8611208318739;1682.2682133272067;9461.479618620973;9565.856512152322;9580.13778759915;9582.808343833154;9589.952050239774;3670.284294562535;3774.471573979645;3784.2242340320167;3873.96126038736;3874.5737968823405;7864.331531819859;7872.803179920548;7892.210778922062;7898.407619428566;7901.091374491892;3725.6460636239512;4216.177845320133;4218.8312467500955;4226.302660061056;4228.873133805991;3456.4469684850305;3463.982680086634;3491.825408729553;3803.4675145479655;3929.8035098244973;3163.8576264068174;3225.451673215559;3275.8853440129483;3280.393127271415;3298.7855789373616;922.280621115531;949.8432758594754;951.8191543606692;957.1003256938455;957.4781743949565;1119.6025410979148;1141.6004398460473;1145.2155273637584;1148.4659633270403;1176.4000359816555;6628.966855165693;6707.832304192337;6735.494837887178;6736.360045795642;6788;1025.0841784383583;1026.553449249564;1027.8920713324994;1033.121846430543;1059.0521483272428;5446.2647542582035;5481.068218402801;5510.6969116698165;5535.142052981794;5536.252605898233;8639.092895246034;8838.337124715672;9010.414323068979;9038.774030649287;9137.725868223964;8836.469811811312;8918.73243802687;8929.687460938836;9036.277097832157;9040.547972601344;6850.794476165723;6953.826154346182;6989.405900498413;7049.083619129583;7077.256888026786;6737;6744.662766861736;6752.493562982698;6790.7623233186605;6794.72821087151;7815.981694095401;7905.32804711583;8008.479448835807;8156.796080098045;8181.427300088937;8078.23256790604;8223.712170074019;8270.958645206736;8344.666213351398;8349.499030058216;4991.900161996812;5483.945160548503;5545.057340252248;5553.111502159635;5583;6811.148606424197;6933.0986971693355;6947.687354068978;6950.443964482931;6974.965125174342;5898.734556944862;6242.875142497034;6262.718177682106;6316.084167795736;6352.269489008823;5863.501602363847;6004.699765011645;6038.51691864641;6120.969395152996;6230.563860529901;6404.935950640434;6576.934230657632;6581.2102547694585;6583.670816459062;6600.9009864851105;6072.332043475126;6080.69596520181;6081.057436097412;6096.847578810565;6104.542159337979;6163.876722465436;6184.443400094013;6258.655773932477;6270.372962703693;6275.121482992476 20:35:38 INFO - PROCESS | 11893 | |4;prototype.html;298.7833820480152;298.85057471264366;300.2149379372939;303.989360372387;307.68923387378754;5155.432902380744;5258.079836028694;5310.76101575429;5324.866878328039;5327.094393953028;5230.816921407752;5256.894862102756;5287.365516138059;5289.973550132244;5290.153575427932;3851.1912498375373;3932.2135572885536;4022.5172979242534;4040.0505881117915;4055.0673345130635;3983.9601603984024;4019.799010049486;4025.335819589764;4029.798510074499;4029.818658160375;3929.842806287745;3971.761694298337;3985.4221137934983;3989.4414781930554;4001.779902105383;3786.4131059685656;3897.298486272484;3988.1824226033596;3992.3811809169624;4003.3794761811964;3470.0804286864;3475.6176820549717;3477.982610086933;3480.738944579167;3492.388831954398;5024.874378140539;5042.319286896259;5047.87380315495;5050;5053.0399224147295;4572.245579479382;4573.588377046049;4574.1080489304595;4578.610818080467;4584.977075114636;5459.017376872162;5462.453754624546;5464.808731694372;5465.781368745245;5468.152436372368;3788.1287303920253;3789.1853251550774;3789.3936970084656;3789.5263092113487;3791.639794219572;5579.804706835282;5684.914726279109;5777.884442311214;5784.566157538159;5800.100984347433;3867;3880.6507414332846;3901.941470877939;3903.941440878389;3906.1015966327905;3956.0703234739813;3960.2475529649273;3960.8415663373717;3966.1076257841755;3966.3058964681063;4564.452265728134;4568.977155114203;4573.977130114328;4586.72479651222;4587.839425620154;5520.309961254843;5526.47498487643;5530.391656917735;5532.30846144232;5537.556995440355;1365.8907287416982;1380.0960370957039;1381.4336122189854;1384.4531410092957;1384.5223397927698;878.1789027259533;889.1508609278123;931.59475628102;940.0176815228103;941.3081385181886;4646.7444290564345;4769.689970151929;4851.902961940741;4860.8298709545;4865.756712164449;5666.801661941812;5705;5750.712464376765;5776.3068431787615;5778.422157784188;4896.853094407174;4899.951000490021;4905.3132561441425;4908.9754551227015;4910.361652985089;3051.4659934511815;3080.522519009557;3080.8767649294227;3084.552739852709;3085.151583314562;5424.321959755031;5426.240326354314;5428.538574221236;5434.456554344613;5436.483534064337;5739.65562066269;5925.081612350093;5925.733341999534;5928.170056192136;5932.7330270137945;5402.35171779389;5418.864528386822;5419.593530485229;5429.511343978982;5433.701146436826;5762.193292939076;5764.193012978102;5767.596268261182;5769.336526299529;5770.567207459373;5647.463490968352;5656.5757568181725;5658.03813351723;5659.236003139688;5660.886782264414;5423.050966080841;5425.83722488326;5426.104692725656;5430.185472179205;5433.483819037185;3744.6629803317833;3883.6893048555485;3890.630390112935;3894.1822217334675;3898.1813819098306;5633.521150702072;5647.350554686263;5647.7176141193595;5650.237217975685;5656.490915817596;5444.3194600674915;5447.727613619382;5447.836564903059;5452.672839629635;5453.945460545344;5384.488473595002;5406.7296635167295;5426.511613954763;5439.700816454974;5447.700376479332;5369.838904832861;5389.326334208224;5397.460253974728;5398.406175320633;5401.567874570103;5323.334583177103;5498.532624726943;5508.614396992332;5511.614187006871;5531.2532808072;5271.7891284349735;5311.256424100552;5345.812896548602;5371.194320851903;5371.919421208607 20:35:38 INFO - PROCESS | 11893 | |5;yui.html;545.9563234941203;632.5462972171941;657.3065415986133;658.6344578758788;665.7536711416775;11411.771764564704;11649.825252621218;11650.708732281697;11652.766944661102;11679.766404671913;11667.12496562759;11697.883021169786;12035.338056406894;12149.149559530837;12172;615.2893408113614;776.041588638033;795.2047952047952;797.5732982854174;819.3486178488087;809.8420807942424;812.0945146162046;812.4191203289647;812.5287333346674;812.5774597209447;843.1905370843997;843.4264700004026;851.1360968616859;851.7572491839827;852.2372476633409;641.935806419359;658.2791842931982;841.1840514700731;843.2495079379327;858.5278097046662;627.425905296653;630.6468377708497;630.9652969086699;630.9842253943642;631.09753053134;12200.328981905992;12325.876741232563;12345.13584049117;12359.505619775198;12377.814332785016;11735.530578776925;11830.704232394173;11999.340036298001;12188.146829721923;12427.44076516559;9572.282078844115;9652.324337296392;9719.951400243024;9764.121229089345;9945.80108397828;3286.3098749262685;3324.501324801275;3362.327534493111;3375.9831200844083;3376.206591451007;39418.60581394178;39522.80238598789;39774.20451590952;39851.40222896659;40697;9962.103410693073;9971.601135954481;10028.197744180448;10178.796424071477;10202.795944081077;16990.150492475328;17036.829631703524;17051.829481705023;17177.742333865;17188.828111718973;6621.9006714899315;6653.933460665428;6675.165604299463;6744.291849355747;6801.727930882808;3616.782993020427;3643.526341575578;3649.3613617617343;3702.66675999156;3761;2816.6479190101236;2839.5314773062214;2854.0866922584573;2855.157728470106;2855.6573211214786;501.005504074412;505.15386727232476;506.8732816795801;515.9767810448539;522.1619301021881;485.5675756518285;576.4264556766045;599.3048064245454;599.6881621556767;606.9423404776539;7528.373643704802;7592.8481430372185;7623.390128789683;7806.4925779824125;7850.136484986647;561.5563704673344;562.749576438481;568.6076607141142;583.4165834165834;593.8930992421319;3446.138465383654;3499.2476617527354;3506.8772592959635;3580.785152890835;3594;45287.547124528995;46204.306935395995;47565.28652070222;47747.28379074317;47764.5223547767;43074.35388469176;43266.567334326886;43384.56615433868;43928.56071439308;44216;38245.42631860524;39030.80484597559;39082.60917390903;39193.80403098023;39915.2016959665;7327.596982166032;7346.52247603904;7358.484906056525;7390.03929489163;7420.257974202536;28976.565351520167;30818.537721934637;31578.842105789325;31695.52456713105;31903.521447177845;37872.81063594665;38154.236915262096;38185.80907095447;39166.21667566576;39180;10238.385696858213;10394.428306442916;10441.843372349573;10487;10509.684709458728;10841.295315804447;10876.564937402416;11067.280626759235;11195.60815371458;11219;8459.323254139532;10126.89873101289;10384.896151038392;10518.158547316043;10617.893821062;9254;9619.903800961902;9678.322517423712;9728.854067188857;10280.485975701335;10336.948315258376;10420.895791041992;10485.161187105166;10625;10781.460926953465;8101.230383113595;8119.715809946623;8248.175182481704;8290.834183316421;8335.208155225244;8270.586470676562;8410.915890841257;8543.24870368352;8563.100874408097;8610.870836937325 20:35:38 INFO - PROCESS | 11893 | __end_tp_report 20:35:38 INFO - PROCESS | 11893 | __start_cc_report 20:35:38 INFO - PROCESS | 11893 | _x_x_mozilla_cycle_collect,826 20:35:38 INFO - PROCESS | 11893 | __end_cc_report 20:35:38 INFO - PROCESS | 11893 | __startTimestamp1457670938884__endTimestamp 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | ------- Summary: start ------- 20:35:38 INFO - PROCESS | 11893 | Number of tests: 6 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | [#0] dojo.html Cycles:165 Average:4441.28 Median:4542.09 stddev:432.48 (9.5%) stddev-sans-first:408.21 20:35:38 INFO - PROCESS | 11893 | Values: 2572.7 2647.6 2665.3 2673.9 2690.2 4380.6 4488.5 4507.7 4521.6 4537.5 4451.6 4456.2 4505.0 4512.4 4566.6 4134.7 4142.3 4172.2 4270.1 4304.3 4066.3 4239.1 4295.7 4323.9 4329.2 4142.8 4180.3 4188.0 4230.0 4241.6 4186.3 4188.0 4200.0 4203.2 4227.0 4069.2 4145.6 4166.5 4188.9 4228.0 4421.9 4451.7 4477.0 4517.3 4518.2 4764.7 4785.7 4787.0 4793.1 4810.3 4696.1 4763.8 4804.5 4837.2 4858.8 4471.0 4480.5 4484.0 4485.4 4513.2 4899.1 4902.4 4905.9 4906.1 4941.2 4526.2 4683.1 4764.0 4777.3 4780.7 4721.6 4732.1 4733.5 4737.2 4778.6 4700.5 4701.2 4705.6 4705.8 4738.4 4598.5 4688.4 4740.0 4763.4 4785.7 4028.9 4034.9 4051.1 4087.3 4088.6 3431.6 3570.2 3584.6 3598.1 3610.5 4100.7 4138.2 4186.9 4229.3 4229.7 4788.8 4797.8 4816.7 4819.0 4868.7 4077.3 4174.3 4176.3 4177.5 4199.8 4263.3 4297.6 4312.5 4322.5 4342.4 4542.1 4554.2 4560.6 4561.2 4586.6 4665.9 4808.4 4809.7 4811.1 4845.5 4482.1 4540.2 4543.1 4574.1 4588.1 4740.7 4782.3 4782.4 4784.5 4825.5 4693.3 4801.2 4847.6 4849.1 4871.7 4602.1 4627.0 4633.1 4636.0 4682.5 4604.5 4635.9 4638.9 4667.7 4684.8 4370.8 4524.1 4559.5 4563.2 4594.1 4643.1 4654.6 4658.6 4686.1 4706.7 4517.7 4525.4 4540.5 4549.3 4570.2 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | [#1] ext.html Cycles:180 Average:39653.86 Median:19107.16 stddev:59989.32 (314.0%) stddev-sans-first:60085.54 20:35:38 INFO - PROCESS | 11893 | Values: 491.9 493.9 513.4 520.8 536.0 24869.1 33603.7 34023.5 34038.1 34064.3 35985.3 36891.8 36934.6 36937.0 36978.6 6674.2 7504.3 7693.6 9555.3 9740.1 9660.5 9763.7 9771.7 9774.8 9796.9 9764.8 9840.7 9863.4 9868.8 9869.4 9750.7 9866.5 9869.9 9872.2 9879.1 9882.2 10046.7 10049.3 10055.1 10058.9 37060.4 37533.8 37541.8 37612.4 37661.6 2818.5 2888.9 3039.6 3054.2 3120.9 28083.3 28453.7 28572.1 29151.0 29738.7 3443.8 3459.6 3499.2 3500.7 3515.9 214070.0 237178.0 239057.0 241753.0 244185.0 51050.0 51547.5 51726.0 51817.5 51846.7 60079.0 61232.7 61373.7 61457.0 61488.7 13244.2 14387.8 14440.3 14541.7 14726.0 10256.5 10287.3 10288.7 10289.3 10311.3 18850.4 18992.1 19057.7 19071.5 19076.0 7475.7 7917.5 8066.0 8074.7 8078.2 753.8 788.6 817.5 857.8 875.3 26300.0 26761.9 26921.2 27214.9 27221.7 895.9 907.8 969.4 1038.4 1040.5 13918.2 13999.7 14109.6 14173.6 14330.9 257697.0 260419.0 262063.0 262139.0 262793.0 45497.0 45848.0 45947.5 46144.3 46167.3 930.4 1148.1 1149.5 1150.0 1183.6 24520.6 26873.0 27141.7 27150.7 27273.9 35989.6 36700.3 37751.6 37792.6 37868.4 188876.0 190206.0 192216.0 192971.0 193129.0 31793.8 32579.7 32582.7 35536.0 36488.0 36329.8 37966.8 38007.2 39141.0 39180.8 29967.7 30820.8 30892.0 31876.7 33602.7 35590.0 35667.5 35716.1 35763.5 36207.5 34715.1 35499.0 35827.9 35893.5 35917.0 31448.7 32105.4 32236.5 32359.9 32509.7 24874.0 25252.9 25300.6 25421.9 25588.1 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | [#2] jquery.html Cycles:180 Average:20636.61 Median:4896.55 stddev:52024.31 (1062.5%) stddev-sans-first:52147.91 20:35:38 INFO - PROCESS | 11893 | Values: 329.8 334.5 334.9 337.2 338.4 14940.7 15478.4 15531.0 16423.9 16843.1 14767.4 14983.7 14989.6 15621.4 15862.7 4823.7 4851.8 4903.7 4904.5 4971.8 4780.9 4799.8 4902.3 4903.6 4905.1 4865.2 4889.5 4901.5 4908.0 4913.0 4727.3 4854.2 4861.7 4888.8 4891.6 4299.2 4302.3 4305.9 4319.1 4330.1 18555.8 19071.0 19081.9 19293.1 19306.9 1765.2 1799.1 1900.0 2154.8 2261.8 11931.4 12016.4 12214.9 12383.6 12449.8 1696.6 1741.2 1756.8 1757.6 1761.2 55539.4 55572.0 55944.0 56504.7 57271.4 8959.5 9028.3 9269.2 9300.2 9442.7 11919.9 11927.4 11964.0 11995.3 12000.6 6695.4 6780.5 6807.6 6841.5 6983.8 6656.6 6715.4 6800.2 6814.1 6852.0 5493.6 5589.9 5596.5 5618.6 5657.9 1529.4 1586.6 1642.8 1679.6 1689.1 804.4 826.0 869.6 878.7 898.9 14778.8 15863.4 16007.0 16123.9 16136.9 860.5 861.5 887.1 889.6 910.2 9256.3 9402.9 9486.6 9489.7 9636.5 268727.0 273887.0 274207.0 369127.0 373238.0 58411.7 59788.4 63744.4 64948.0 65180.3 881.9 893.8 899.6 913.7 915.3 13733.2 14202.6 14215.6 14597.6 14627.7 30305.0 30792.0 31794.7 32039.5 32422.2 44280.8 44598.8 44951.8 44981.3 44990.0 6885.3 6905.6 7129.9 7197.7 7304.1 9427.3 10758.8 10942.7 10968.1 11211.6 7001.5 8864.0 9216.0 9226.1 9364.7 9378.8 9422.5 9595.6 9724.6 9887.9 9465.5 9465.6 9490.5 9839.1 10002.4 6962.2 6984.9 7235.0 7254.2 7358.2 8228.4 9174.1 9236.8 9280.8 9344.0 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | [#3] mootools.html Cycles:180 Average:5032.11 Median:6142.42 stddev:2631.36 (42.8%) stddev-sans-first:2622.41 20:35:38 INFO - PROCESS | 11893 | Values: 1132.5 1359.3 1380.7 1496.5 1722.7 7122.8 7272.4 7275.9 7287.9 7292.9 7142.6 7281.1 7291.8 7298.3 7308.0 1811.2 2100.9 2126.2 2149.2 2150.5 2168.5 2175.2 2175.3 2175.4 2175.8 2019.8 2058.6 2063.7 2069.4 2077.1 2101.5 2102.6 2121.0 2122.7 2123.4 2099.4 2111.1 2116.0 2119.9 2121.3 7412.6 7502.3 7505.2 7505.3 7506.1 4211.3 4309.5 4345.7 4347.1 4356.4 2788.6 2816.4 2862.2 2864.2 2935.4 888.7 906.6 924.8 925.9 1682.3 9461.5 9565.9 9580.1 9582.8 9590.0 3670.3 3774.5 3784.2 3874.0 3874.6 7864.3 7872.8 7892.2 7898.4 7901.1 3725.6 4216.2 4218.8 4226.3 4228.9 3456.4 3464.0 3491.8 3803.5 3929.8 3163.9 3225.5 3275.9 3280.4 3298.8 922.3 949.8 951.8 957.1 957.5 1119.6 1141.6 1145.2 1148.5 1176.4 6629.0 6707.8 6735.5 6736.4 6788.0 1025.1 1026.6 1027.9 1033.1 1059.1 5446.3 5481.1 5510.7 5535.1 5536.3 8639.1 8838.3 9010.4 9038.8 9137.7 8836.5 8918.7 8929.7 9036.3 9040.5 6850.8 6953.8 6989.4 7049.1 7077.3 6737.0 6744.7 6752.5 6790.8 6794.7 7816.0 7905.3 8008.5 8156.8 8181.4 8078.2 8223.7 8271.0 8344.7 8349.5 4991.9 5483.9 5545.1 5553.1 5583.0 6811.1 6933.1 6947.7 6950.4 6975.0 5898.7 6242.9 6262.7 6316.1 6352.3 5863.5 6004.7 6038.5 6121.0 6230.6 6404.9 6576.9 6581.2 6583.7 6600.9 6072.3 6080.7 6081.1 6096.8 6104.5 6163.9 6184.4 6258.7 6270.4 6275.1 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | [#4] prototype.html Cycles:180 Average:4549.34 Median:5288.67 stddev:1354.05 (25.6%) stddev-sans-first:1319.73 20:35:38 INFO - PROCESS | 11893 | Values: 298.8 298.9 300.2 304.0 307.7 5155.4 5258.1 5310.8 5324.9 5327.1 5230.8 5256.9 5287.4 5290.0 5290.2 3851.2 3932.2 4022.5 4040.1 4055.1 3984.0 4019.8 4025.3 4029.8 4029.8 3929.8 3971.8 3985.4 3989.4 4001.8 3786.4 3897.3 3988.2 3992.4 4003.4 3470.1 3475.6 3478.0 3480.7 3492.4 5024.9 5042.3 5047.9 5050.0 5053.0 4572.2 4573.6 4574.1 4578.6 4585.0 5459.0 5462.5 5464.8 5465.8 5468.2 3788.1 3789.2 3789.4 3789.5 3791.6 5579.8 5684.9 5777.9 5784.6 5800.1 3867.0 3880.7 3901.9 3903.9 3906.1 3956.1 3960.2 3960.8 3966.1 3966.3 4564.5 4569.0 4574.0 4586.7 4587.8 5520.3 5526.5 5530.4 5532.3 5537.6 1365.9 1380.1 1381.4 1384.5 1384.5 878.2 889.2 931.6 940.0 941.3 4646.7 4769.7 4851.9 4860.8 4865.8 5666.8 5705.0 5750.7 5776.3 5778.4 4896.9 4900.0 4905.3 4909.0 4910.4 3051.5 3080.5 3080.9 3084.6 3085.2 5424.3 5426.2 5428.5 5434.5 5436.5 5739.7 5925.1 5925.7 5928.2 5932.7 5402.4 5418.9 5419.6 5429.5 5433.7 5762.2 5764.2 5767.6 5769.3 5770.6 5647.5 5656.6 5658.0 5659.2 5660.9 5423.1 5425.8 5426.1 5430.2 5433.5 3744.7 3883.7 3890.6 3894.2 3898.2 5633.5 5647.4 5647.7 5650.2 5656.5 5444.3 5447.7 5447.8 5452.7 5453.9 5384.5 5406.7 5426.5 5439.7 5447.7 5369.8 5389.3 5397.5 5398.4 5401.6 5323.3 5498.5 5508.6 5511.6 5531.3 5271.8 5311.3 5345.8 5371.2 5371.9 20:35:38 INFO - PROCESS | 11893 | 20:35:38 INFO - PROCESS | 11893 | [#5] yui.html Cycles:180 Average:12039.01 Median:43656.56 stddev:13361.83 (30.6%) stddev-sans-first:13371.44 20:35:38 INFO - PROCESS | 11893 | Values: 546.0 632.5 657.3 658.6 665.8 11411.8 11649.8 11650.7 11652.8 11679.8 11667.1 11697.9 12035.3 12149.1 12172.0 615.3 776.0 795.2 797.6 819.3 809.8 812.1 812.4 812.5 812.6 843.2 843.4 851.1 851.8 852.2 641.9 658.3 841.2 843.2 858.5 627.4 630.6 631.0 631.0 631.1 12200.3 12325.9 12345.1 12359.5 12377.8 11735.5 11830.7 11999.3 12188.1 12427.4 9572.3 9652.3 9720.0 9764.1 9945.8 3286.3 3324.5 3362.3 3376.0 3376.2 39418.6 39522.8 39774.2 39851.4 40697.0 9962.1 9971.6 10028.2 10178.8 10202.8 16990.2 17036.8 17051.8 17177.7 17188.8 6621.9 6653.9 6675.2 6744.3 6801.7 3616.8 3643.5 3649.4 3702.7 3761.0 2816.6 2839.5 2854.1 2855.2 2855.7 501.0 505.2 506.9 516.0 522.2 485.6 576.4 599.3 599.7 606.9 7528.4 7592.8 7623.4 7806.5 7850.1 561.6 562.7 568.6 583.4 593.9 3446.1 3499.2 3506.9 3580.8 3594.0 45287.5 46204.3 47565.3 47747.3 47764.5 43074.4 43266.6 43384.6 43928.6 44216.0 38245.4 39030.8 39082.6 39193.8 39915.2 7327.6 7346.5 7358.5 7390.0 7420.3 28976.6 30818.5 31578.8 31695.5 31903.5 37872.8 38154.2 38185.8 39166.2 39180.0 10238.4 10394.4 10441.8 10487.0 10509.7 10841.3 10876.6 11067.3 11195.6 11219.0 8459.3 10126.9 10384.9 10518.2 10617.9 9254.0 9619.9 9678.3 9728.9 10280.5 10336.9 10420.9 10485.2 10625.0 10781.5 8101.2 8119.7 8248.2 8290.8 8335.2 8270.6 8410.9 8543.2 8563.1 8610.9 20:35:38 INFO - PROCESS | 11893 | -------- Summary: end -------- 20:35:38 INFO - PROCESS | 11893 | 20:35:39 INFO - TEST-INFO | 11893: exit 0 20:35:39 INFO - TEST-OK | dromaeo_css | took 1116395ms 20:35:39 INFO - TEST-START | kraken 20:35:39 INFO - operating with platform_type : linux_ 20:35:39 INFO - Initialising browser for kraken test... 20:35:39 INFO - TEST-INFO | started process 12072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSx_oxo/profile http://localhost:39429/getInfo.html) 20:35:44 INFO - PROCESS | 12072 | __metrics Screen width/height:1600/1200 20:35:44 INFO - PROCESS | 12072 | colorDepth:24 20:35:44 INFO - PROCESS | 12072 | Browser inner width/height: 1024/697 20:35:44 INFO - PROCESS | 12072 | __metrics 20:35:45 ERROR - PROCESS | 12072 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:35:45 INFO - PROCESS | 12072 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:35:45 INFO - TEST-INFO | 12072: exit 0 20:35:45 INFO - Browser initialized. 20:35:45 INFO - Running cycle 1/1 for kraken test... 20:35:45 INFO - TEST-INFO | started process 12153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSx_oxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:57 INFO - PROCESS | 12153 | RSS: Main: 155119616 20:35:57 INFO - PROCESS | 12153 | 20:36:00 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39429/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:01 INFO - PROCESS | 12153 | RSS: Main: 196218880 20:36:01 INFO - PROCESS | 12153 | 20:36:03 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39429/tests/kraken/driver.html?testName=audio-dft) 20:36:04 INFO - PROCESS | 12153 | RSS: Main: 185413632 20:36:04 INFO - PROCESS | 12153 | 20:36:07 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39429/tests/kraken/driver.html?testName=audio-fft) 20:36:08 INFO - PROCESS | 12153 | RSS: Main: 172064768 20:36:08 INFO - PROCESS | 12153 | 20:36:10 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39429/tests/kraken/driver.html?testName=audio-oscillator) 20:36:10 INFO - PROCESS | 12153 | RSS: Main: 173400064 20:36:10 INFO - PROCESS | 12153 | 20:36:13 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39429/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:13 INFO - PROCESS | 12153 | RSS: Main: 176283648 20:36:13 INFO - PROCESS | 12153 | 20:36:16 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39429/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:17 INFO - PROCESS | 12153 | RSS: Main: 176480256 20:36:17 INFO - PROCESS | 12153 | 20:36:20 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39429/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:21 INFO - PROCESS | 12153 | RSS: Main: 174665728 20:36:21 INFO - PROCESS | 12153 | 20:36:24 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39429/tests/kraken/driver.html?testName=json-parse-financial) 20:36:25 INFO - PROCESS | 12153 | RSS: Main: 175935488 20:36:25 INFO - PROCESS | 12153 | 20:36:26 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39429/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:27 INFO - PROCESS | 12153 | RSS: Main: 186413056 20:36:27 INFO - PROCESS | 12153 | 20:36:29 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:29 INFO - PROCESS | 12153 | RSS: Main: 182833152 20:36:29 INFO - PROCESS | 12153 | 20:36:31 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:36:32 INFO - PROCESS | 12153 | RSS: Main: 194142208 20:36:32 INFO - PROCESS | 12153 | 20:36:35 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:36:35 INFO - PROCESS | 12153 | RSS: Main: 197136384 20:36:35 INFO - PROCESS | 12153 | 20:36:38 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:36:38 INFO - PROCESS | 12153 | RSS: Main: 196124672 20:36:38 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | Cycle 1(1): loaded http://localhost:39429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39429/tests/kraken/driver.html?testName=ai-astar) 20:36:40 INFO - PROCESS | 12153 | RSS: Main: 258093056 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | __start_tp_report 20:36:40 INFO - PROCESS | 12153 | _x_x_mozilla_page_load 20:36:40 INFO - PROCESS | 12153 | _x_x_mozilla_page_load_details 20:36:40 INFO - PROCESS | 12153 | |i|pagename|runs| 20:36:40 INFO - PROCESS | 12153 | |0;ai-astar;112;115;109;113;114;113;104;112;112;113 20:36:40 INFO - PROCESS | 12153 | |1;audio-beat-detection;157;136;154;180;141;159;157;130;175;130 20:36:40 INFO - PROCESS | 12153 | |2;audio-dft;162;160;160;160;160;160;163;161;161;161 20:36:40 INFO - PROCESS | 12153 | |3;audio-fft;73;77;98;93;74;73;74;113;103;74 20:36:40 INFO - PROCESS | 12153 | |4;audio-oscillator;95;94;144;94;95;95;139;94;94;145 20:36:40 INFO - PROCESS | 12153 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 20:36:40 INFO - PROCESS | 12153 | |6;imaging-darkroom;148;146;149;147;147;147;146;147;146;146 20:36:40 INFO - PROCESS | 12153 | |7;imaging-desaturate;95;96;96;95;95;96;95;96;95;95 20:36:40 INFO - PROCESS | 12153 | |8;json-parse-financial;68;65;67;67;66;74;67;75;64;64 20:36:40 INFO - PROCESS | 12153 | |9;json-stringify-tinderbox;70;70;69;70;70;69;70;70;72;70 20:36:40 INFO - PROCESS | 12153 | |10;stanford-crypto-aes;84;82;86;83;84;84;83;82;85;84 20:36:40 INFO - PROCESS | 12153 | |11;stanford-crypto-ccm;122;122;120;138;126;124;123;119;127;120 20:36:40 INFO - PROCESS | 12153 | |12;stanford-crypto-pbkdf2;148;137;150;150;147;138;148;149;148;143 20:36:40 INFO - PROCESS | 12153 | |13;stanford-crypto-sha256-iterative;70;72;72;71;71;70;71;73;70;69 20:36:40 INFO - PROCESS | 12153 | __end_tp_report 20:36:40 INFO - PROCESS | 12153 | __start_cc_report 20:36:40 INFO - PROCESS | 12153 | _x_x_mozilla_cycle_collect,1147 20:36:40 INFO - PROCESS | 12153 | __end_cc_report 20:36:40 INFO - PROCESS | 12153 | __startTimestamp1457671000970__endTimestamp 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | ------- Summary: start ------- 20:36:40 INFO - PROCESS | 12153 | Number of tests: 14 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.13 (2.8%) stddev-sans-first:3.32 20:36:40 INFO - PROCESS | 12153 | Values: 112.0 115.0 109.0 113.0 114.0 113.0 104.0 112.0 112.0 113.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:157.00 stddev:17.51 (11.2%) stddev-sans-first:18.48 20:36:40 INFO - PROCESS | 12153 | Values: 157.0 136.0 154.0 180.0 141.0 159.0 157.0 130.0 175.0 130.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 20:36:40 INFO - PROCESS | 12153 | Values: 162.0 160.0 160.0 160.0 160.0 160.0 163.0 161.0 161.0 161.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#3] audio-fft Cycles:10 Average:85.20 Median:74.00 stddev:15.11 (20.4%) stddev-sans-first:15.37 20:36:40 INFO - PROCESS | 12153 | Values: 73.0 77.0 98.0 93.0 74.0 73.0 74.0 113.0 103.0 74.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:94.00 stddev:23.35 (24.8%) stddev-sans-first:24.22 20:36:40 INFO - PROCESS | 12153 | Values: 95.0 94.0 144.0 94.0 95.0 95.0 139.0 94.0 94.0 145.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:36:40 INFO - PROCESS | 12153 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 20:36:40 INFO - PROCESS | 12153 | Values: 148.0 146.0 149.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:36:40 INFO - PROCESS | 12153 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:67.00 stddev:3.83 (5.7%) stddev-sans-first:4.06 20:36:40 INFO - PROCESS | 12153 | Values: 68.0 65.0 67.0 67.0 66.0 74.0 67.0 75.0 64.0 64.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 20:36:40 INFO - PROCESS | 12153 | Values: 70.0 70.0 69.0 70.0 70.0 69.0 70.0 70.0 72.0 70.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 20:36:40 INFO - PROCESS | 12153 | Values: 84.0 82.0 86.0 83.0 84.0 84.0 83.0 82.0 85.0 84.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:123.50 stddev:5.53 (4.5%) stddev-sans-first:5.81 20:36:40 INFO - PROCESS | 12153 | Values: 122.0 122.0 120.0 138.0 126.0 124.0 123.0 119.0 127.0 120.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:148.00 stddev:4.80 (3.2%) stddev-sans-first:5.03 20:36:40 INFO - PROCESS | 12153 | Values: 148.0 137.0 150.0 150.0 147.0 138.0 148.0 149.0 148.0 143.0 20:36:40 INFO - PROCESS | 12153 | 20:36:40 INFO - PROCESS | 12153 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.20 (1.7%) stddev-sans-first:1.22 20:36:40 INFO - PROCESS | 12153 | Values: 70.0 72.0 72.0 71.0 71.0 70.0 71.0 73.0 70.0 69.0 20:36:40 INFO - PROCESS | 12153 | -------- Summary: end -------- 20:36:40 INFO - PROCESS | 12153 | 20:36:41 INFO - TEST-INFO | 12153: exit 0 20:36:41 INFO - TEST-OK | kraken | took 62305ms 20:36:41 INFO - SUITE-END | took 1178s 20:36:42 INFO - Completed test suite (00:19:38) 20:36:42 INFO - javascript benchmark 20:36:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2572.7041390240124, 2647.6425682532863, 2665.320343312455, 2673.893044278229, 2690.1929421173645, 4380.62764665003, 4488.4838243602, 4507.729536227825, 4521.570450807177, 4537.546245375461, 4451.5993560579545, 4456.220161471738, 4504.954950450495, 4512.390827238321, 4566.634669226462, 4134.7312424692445, 4142.337226043834, 4172.207280616681, 4270.0605866709275, 4304.289792184286, 4066.2680717470844, 4239.130978149487, 4295.699301048928, 4323.870283891472, 4329.242382583051, 4142.772147531869, 4180.26845302074, 4187.958120418787, 4229.97885010576, 4241.618254357123, 4186.28833098371, 4187.958120418818, 4199.97900010498, 4203.222403855266, 4227.027783609757, 4069.2268468990796, 4145.647619952308, 4166.541680415152, 4188.874333769962, 4228.0, 4421.9336709949375, 4451.732896026248, 4476.977615111936, 4517.277235642315, 4518.164139634178, 4764.737939413331, 4785.688930219525, 4787.0, 4793.065352256312, 4810.302506136591, 4696.084263568606, 4763.761811909425, 4804.543568361, 4837.201861692816, 4858.7570621468785, 4470.977645111819, 4480.507144214133, 4484.035932274544, 4485.439320084989, 4513.210188217049, 4899.069176856386, 4902.41171059468, 4905.9264111038365, 4906.1414252505665, 4941.160002799533, 4526.185286648369, 4683.063387322549, 4764.023375208074, 4777.283407488904, 4780.689255198401, 4721.5986641135205, 4732.148213321566, 4733.5266473352385, 4737.194676904935, 4778.617710583145, 4700.45944716362, 4701.2242979908615, 4705.576498115186, 4705.764711764398, 4738.360321356573, 4598.471175814824, 4688.437387513521, 4739.9763001185465, 4763.3807605011125, 4785.665003449794, 4028.939565906514, 4034.8991275218355, 4051.068254301468, 4087.325591277406, 4088.6320231178743, 3431.6225215226304, 3570.2145527983803, 3584.605693373727, 3598.082488965297, 3610.530631017951, 4100.6719462443525, 4138.234426631083, 4186.895327616834, 4229.302165142717, 4229.725067870579, 4788.784504697297, 4797.808087676453, 4816.735079570587, 4818.951810481921, 4868.659193856467, 4077.347624380144, 4174.3112386456505, 4176.2900306947895, 4177.4569305990635, 4199.790010499462, 4263.296556068276, 4297.634701050446, 4312.525622181557, 4322.481302243688, 4342.392065110887, 4542.091581683677, 4554.157480866051, 4560.612347950461, 4561.178987782231, 4586.564276393738, 4665.906681866276, 4808.35087263229, 4809.735464549343, 4811.061842940593, 4845.515448455127, 4482.125985432809, 4540.182767101954, 4543.068670922386, 4574.085182963354, 4588.105319462673, 4740.699462143526, 4782.2826576012485, 4782.354382158364, 4784.521547845187, 4825.469198388245, 4693.296005599187, 4801.159797035574, 4847.636427268039, 4849.078675051729, 4871.707697538159, 4602.056578401352, 4627.028324051987, 4633.142868569325, 4635.953640463687, 4682.461516925461, 4604.493505714436, 4635.884102897455, 4638.8608341749805, 4667.743274119956, 4684.7891844867745, 4370.803313850948, 4524.0951809637545, 4559.521250268674, 4563.201439748097, 4594.0582180653555, 4643.071385722937, 4654.557817007379, 4658.627309815139, 4686.133065382915, 4706.670533062653, 4517.6837621366185, 4525.389072475174, 4540.50054494012, 4549.3176023596725, 4570.223062079388], "unit": "score", "name": "dojo.html", "value": 4416.1445783231275}, {"lowerIsBetter": false, "replicates": [491.86227856200276, 493.9259111133332, 513.4121430961549, 520.7760662914948, 536.0244355273403, 24869.129580464687, 33603.66396336036, 34023.489647655246, 34038.14904627386, 34064.31871362571, 35985.2802943941, 36891.81554092226, 36934.63065369346, 36937.0, 36978.630213697856, 6674.16572928384, 7504.287092726182, 7693.576853273068, 9555.283353748497, 9740.123388894997, 9660.5169741513, 9763.658271960483, 9771.657991970282, 9774.755631109243, 9796.902030979705, 9764.804703905918, 9840.70477885661, 9863.358881672668, 9868.802623947517, 9869.407835529855, 9750.707478775612, 9866.506674666238, 9869.851952220723, 9872.210223182128, 9879.06148915852, 9882.160016398615, 10046.748831279203, 10049.296549241555, 10055.145312648434, 10058.89941100587, 37060.44409333862, 37533.81233093845, 37541.812290938644, 37612.43581346282, 37661.623383766084, 2818.4926713191617, 2888.942221155565, 3039.559263906743, 3054.1601059708537, 3120.89076882308, 28083.29791755202, 28453.715462845314, 28572.142835714963, 29150.979715709847, 29738.70261297381, 3443.8450269737923, 3459.619441861393, 3499.195185107414, 3500.702440292578, 3515.91210219744, 214070.0, 237178.0, 239056.99999999825, 241753.0, 244185.0, 51050.0, 51547.48452515502, 51726.0, 51817.48182518127, 51846.74076629668, 60079.0, 61232.69383653053, 61373.693131534055, 61457.0, 61488.69255653693, 13244.20534767917, 14387.78418323726, 14440.277986100864, 14541.709165816836, 14726.0, 10256.53845576936, 10287.331323464101, 10288.742781430525, 10289.30226512632, 10311.329763565343, 18850.43448696514, 18992.145353459127, 19057.71413428772, 19071.52321191981, 19076.0, 7475.70097196117, 7917.485363451357, 8065.9596702016115, 8074.717384891501, 8078.23256790604, 753.8040109571551, 788.621461698388, 817.4931542443722, 857.7684025313255, 875.2647775868301, 26300.0, 26761.866190668923, 26921.192364229104, 27214.863925680642, 27221.727782722315, 895.9148880856309, 907.7594437474074, 969.4086607169621, 1038.3510306058713, 1040.54216144896, 13918.164910105426, 13999.650008749659, 14109.576712698636, 14173.625927557707, 14330.928345358207, 257697.0, 260419.0, 262063.0, 262139.0, 262793.0, 45497.0, 45848.0, 45947.540524594995, 46144.3078353825, 46167.30749038767, 930.4417349590192, 1148.133159464599, 1149.4712432281078, 1150.0, 1183.5679976808403, 24520.621157102312, 26873.0, 27141.72858271471, 27150.72849271482, 27273.86363068172, 35989.64010359863, 36700.26599467942, 37751.62248377591, 37792.62207378001, 37868.43197352097, 188876.0, 190206.0, 192216.0, 192971.03514482337, 193129.0, 31793.841030794698, 32579.674203257666, 32582.674173257965, 35536.0, 36488.0, 36329.81835090808, 37966.81016594899, 38007.2398552033, 39141.0, 39180.80409598048, 29967.70032299649, 30820.845895770377, 30892.0, 31876.68123318737, 33602.66397336093, 35590.0, 35667.46498802468, 35716.107097322776, 35763.46354804732, 36207.45688814722, 34715.13212169716, 35499.0, 35827.92516224518, 35893.461598075526, 35917.0, 31448.68551314549, 32105.357892841545, 32236.516452253705, 32359.893480147064, 32509.67490325161, 24874.0, 25252.873735631205, 25300.620490692287, 25421.87289063543, 25588.104416345337], "unit": "score", "name": "ext.html", "value": 17160.76359489977}, {"lowerIsBetter": false, "replicates": [329.7675139026986, 334.5216340632894, 334.9184816366283, 337.22774845603567, 338.3655645664379, 14940.701185976273, 15478.380864765395, 15531.0, 16423.917880410612, 16843.073630950323, 14767.409303627843, 14983.700325993474, 14989.62525936852, 15621.375144994186, 15862.682746345095, 4823.686460380073, 4851.757412129397, 4903.681260718042, 4904.5340692634145, 4971.825986090487, 4780.900362961, 4799.760011999403, 4902.289168070628, 4903.607711383099, 4905.117078925792, 4865.19724245499, 4889.535494128052, 4901.460839307673, 4907.950920490803, 4913.017396520692, 4727.338172655848, 4854.247591623304, 4861.708297502126, 4888.755562221892, 4891.6331275154325, 4299.226139294926, 4302.290122129876, 4305.935410968838, 4319.092990472004, 4330.13397320534, 18555.814441855542, 19071.0, 19081.90459047696, 19293.131809068625, 19306.87624361319, 1765.2409463930505, 1799.091458813291, 1899.9525011874814, 2154.7737487563895, 2261.8190544756544, 11931.40342982856, 12016.399180040962, 12214.877851221463, 12383.62849114528, 12449.813252801216, 1696.6352234269568, 1741.1642411642356, 1756.8331008554167, 1757.6396838648047, 1761.1898526677744, 55539.444605554236, 55572.0, 55944.0, 56504.717476412356, 57271.427285727026, 8959.462432254086, 9028.277737780962, 9269.212116970133, 9300.20948219409, 9442.716718498456, 11919.940400297943, 11927.403629818475, 11964.0, 11995.340256285988, 12000.63998080059, 6695.430888374445, 6780.491463140284, 6807.625580593016, 6841.486888483284, 6983.790486285419, 6656.600603963778, 6715.4291885190305, 6800.183977922582, 6814.1482314710665, 6852.006459063408, 5493.560515158778, 5589.860253493695, 5596.468335508121, 5618.578606604521, 5657.9434205658235, 1529.350026238844, 1586.643005323816, 1642.8439298266646, 1679.554917946745, 1689.0963334615922, 804.4047404920434, 826.0, 869.5912920927154, 878.6617152396374, 898.9370744047985, 14778.778318325234, 15863.444779432895, 16007.0, 16123.919380403024, 16136.919315403347, 860.492309537376, 861.543382007537, 887.0685779931047, 889.564113584339, 910.1762904571374, 9256.305777066747, 9402.858957115648, 9486.573104210327, 9489.715308540755, 9636.518174091267, 268727.0, 273887.0, 274207.0, 369127.0, 373238.0, 58411.707941460874, 59788.40211597915, 63744.362556373846, 64948.0, 65180.34819651743, 881.9294456443469, 893.7854914820526, 899.604174163366, 913.7076135636665, 915.2769312243254, 13733.244671543162, 14202.573922782332, 14215.573532794033, 14597.635059123606, 14627.70744585081, 30305.0, 30792.0, 31794.6820531801, 32039.519407209376, 32422.189445263113, 44280.778596106815, 44598.77700611476, 44951.775241123585, 44981.32528012148, 44990.0, 6885.345892140239, 6905.585664860125, 7129.857402852018, 7197.676104575202, 7304.050473438419, 9427.292953028687, 10758.838617420588, 10942.726431839268, 10968.122550196125, 11211.60759373418, 7001.50989430735, 8863.955680221557, 9215.953920230357, 9226.123518265755, 9364.672236471963, 9378.812423751624, 9422.481763503074, 9595.568199430903, 9724.611015559298, 9887.901120988698, 9465.47939863314, 9465.574049167666, 9490.525473726148, 9839.065288797552, 10002.399856008662, 6962.23415424313, 6984.930150698428, 7235.0, 7254.238304977901, 7358.1538123116525, 8228.382871284557, 9174.119305542214, 9236.815263694823, 9280.814383712423, 9343.953280233556], "unit": "score", "name": "jquery.html", "value": 7649.320636540959}, {"lowerIsBetter": false, "replicates": [1132.4620805117574, 1359.2727890578542, 1380.682443038101, 1496.4537943650564, 1722.6813039587685, 7122.786316410509, 7272.381847542959, 7275.854482910338, 7287.890681639779, 7292.8906066409045, 7142.607156606385, 7281.1262648482125, 7291.817704557388, 7298.343149116578, 7307.963460182705, 1811.2030706489168, 2100.9264675736354, 2126.2345555599973, 2149.1940522304135, 2150.4623844038993, 2168.522924956515, 2175.2495389090736, 2175.2930297653247, 2175.423512769117, 2175.8150557202657, 2019.7879222681627, 2058.5677007828376, 2063.731714877071, 2069.379186244128, 2077.1379877350882, 2101.485136141647, 2102.6425507663735, 2121.0349291072525, 2122.702821604969, 2123.416060583344, 2099.359695292935, 2111.1133324003954, 2115.9788402115937, 2119.872807631547, 2121.2681624839406, 7412.59230742309, 7502.287282708188, 7505.249475052506, 7505.286997735207, 7506.136794268675, 4211.263028969948, 4309.461317335333, 4345.739255644671, 4347.0653809430805, 4356.411884395629, 2788.623535822658, 2816.436712657456, 2862.1985843963726, 2864.2266588021325, 2935.398243360106, 888.6756333938131, 906.6146887572821, 924.8427767279578, 925.8611208318739, 1682.2682133272067, 9461.479618620973, 9565.856512152322, 9580.13778759915, 9582.808343833154, 9589.952050239774, 3670.284294562535, 3774.471573979645, 3784.2242340320167, 3873.96126038736, 3874.5737968823405, 7864.331531819859, 7872.803179920548, 7892.210778922062, 7898.407619428566, 7901.091374491892, 3725.6460636239512, 4216.177845320133, 4218.8312467500955, 4226.302660061056, 4228.873133805991, 3456.4469684850305, 3463.982680086634, 3491.825408729553, 3803.4675145479655, 3929.8035098244973, 3163.8576264068174, 3225.451673215559, 3275.8853440129483, 3280.393127271415, 3298.7855789373616, 922.280621115531, 949.8432758594754, 951.8191543606692, 957.1003256938455, 957.4781743949565, 1119.6025410979148, 1141.6004398460473, 1145.2155273637584, 1148.4659633270403, 1176.4000359816555, 6628.966855165693, 6707.832304192337, 6735.494837887178, 6736.360045795642, 6788.0, 1025.0841784383583, 1026.553449249564, 1027.8920713324994, 1033.121846430543, 1059.0521483272428, 5446.2647542582035, 5481.068218402801, 5510.6969116698165, 5535.142052981794, 5536.252605898233, 8639.092895246034, 8838.337124715672, 9010.414323068979, 9038.774030649287, 9137.725868223964, 8836.469811811312, 8918.73243802687, 8929.687460938836, 9036.277097832157, 9040.547972601344, 6850.794476165723, 6953.826154346182, 6989.405900498413, 7049.083619129583, 7077.256888026786, 6737.0, 6744.662766861736, 6752.493562982698, 6790.7623233186605, 6794.72821087151, 7815.981694095401, 7905.32804711583, 8008.479448835807, 8156.796080098045, 8181.427300088937, 8078.23256790604, 8223.712170074019, 8270.958645206736, 8344.666213351398, 8349.499030058216, 4991.900161996812, 5483.945160548503, 5545.057340252248, 5553.111502159635, 5583.0, 6811.148606424197, 6933.0986971693355, 6947.687354068978, 6950.443964482931, 6974.965125174342, 5898.734556944862, 6242.875142497034, 6262.718177682106, 6316.084167795736, 6352.269489008823, 5863.501602363847, 6004.699765011645, 6038.51691864641, 6120.969395152996, 6230.563860529901, 6404.935950640434, 6576.934230657632, 6581.2102547694585, 6583.670816459062, 6600.9009864851105, 6072.332043475126, 6080.69596520181, 6081.057436097412, 6096.847578810565, 6104.542159337979, 6163.876722465436, 6184.443400094013, 6258.655773932477, 6270.372962703693, 6275.121482992476], "unit": "score", "name": "mootools.html", "value": 4133.619479331305}, {"lowerIsBetter": false, "replicates": [298.7833820480152, 298.85057471264366, 300.2149379372939, 303.989360372387, 307.68923387378754, 5155.432902380744, 5258.079836028694, 5310.76101575429, 5324.866878328039, 5327.094393953028, 5230.816921407752, 5256.894862102756, 5287.365516138059, 5289.973550132244, 5290.153575427932, 3851.1912498375373, 3932.2135572885536, 4022.5172979242534, 4040.0505881117915, 4055.0673345130635, 3983.9601603984024, 4019.799010049486, 4025.335819589764, 4029.798510074499, 4029.818658160375, 3929.842806287745, 3971.761694298337, 3985.4221137934983, 3989.4414781930554, 4001.779902105383, 3786.4131059685656, 3897.298486272484, 3988.1824226033596, 3992.3811809169624, 4003.3794761811964, 3470.0804286864, 3475.6176820549717, 3477.982610086933, 3480.738944579167, 3492.388831954398, 5024.874378140539, 5042.319286896259, 5047.87380315495, 5050.0, 5053.0399224147295, 4572.245579479382, 4573.588377046049, 4574.1080489304595, 4578.610818080467, 4584.977075114636, 5459.017376872162, 5462.453754624546, 5464.808731694372, 5465.781368745245, 5468.152436372368, 3788.1287303920253, 3789.1853251550774, 3789.3936970084656, 3789.5263092113487, 3791.639794219572, 5579.804706835282, 5684.914726279109, 5777.884442311214, 5784.566157538159, 5800.100984347433, 3867.0, 3880.6507414332846, 3901.941470877939, 3903.941440878389, 3906.1015966327905, 3956.0703234739813, 3960.2475529649273, 3960.8415663373717, 3966.1076257841755, 3966.3058964681063, 4564.452265728134, 4568.977155114203, 4573.977130114328, 4586.72479651222, 4587.839425620154, 5520.309961254843, 5526.47498487643, 5530.391656917735, 5532.30846144232, 5537.556995440355, 1365.8907287416982, 1380.0960370957039, 1381.4336122189854, 1384.4531410092957, 1384.5223397927698, 878.1789027259533, 889.1508609278123, 931.59475628102, 940.0176815228103, 941.3081385181886, 4646.7444290564345, 4769.689970151929, 4851.902961940741, 4860.8298709545, 4865.756712164449, 5666.801661941812, 5705.0, 5750.712464376765, 5776.3068431787615, 5778.422157784188, 4896.853094407174, 4899.951000490021, 4905.3132561441425, 4908.9754551227015, 4910.361652985089, 3051.4659934511815, 3080.522519009557, 3080.8767649294227, 3084.552739852709, 3085.151583314562, 5424.321959755031, 5426.240326354314, 5428.538574221236, 5434.456554344613, 5436.483534064337, 5739.65562066269, 5925.081612350093, 5925.733341999534, 5928.170056192136, 5932.7330270137945, 5402.35171779389, 5418.864528386822, 5419.593530485229, 5429.511343978982, 5433.701146436826, 5762.193292939076, 5764.193012978102, 5767.596268261182, 5769.336526299529, 5770.567207459373, 5647.463490968352, 5656.5757568181725, 5658.03813351723, 5659.236003139688, 5660.886782264414, 5423.050966080841, 5425.83722488326, 5426.104692725656, 5430.185472179205, 5433.483819037185, 3744.6629803317833, 3883.6893048555485, 3890.630390112935, 3894.1822217334675, 3898.1813819098306, 5633.521150702072, 5647.350554686263, 5647.7176141193595, 5650.237217975685, 5656.490915817596, 5444.3194600674915, 5447.727613619382, 5447.836564903059, 5452.672839629635, 5453.945460545344, 5384.488473595002, 5406.7296635167295, 5426.511613954763, 5439.700816454974, 5447.700376479332, 5369.838904832861, 5389.326334208224, 5397.460253974728, 5398.406175320633, 5401.567874570103, 5323.334583177103, 5498.532624726943, 5508.614396992332, 5511.614187006871, 5531.2532808072, 5271.7891284349735, 5311.256424100552, 5345.812896548602, 5371.194320851903, 5371.919421208607], "unit": "score", "name": "prototype.html", "value": 4112.223311656391}, {"lowerIsBetter": false, "replicates": [545.9563234941203, 632.5462972171941, 657.3065415986133, 658.6344578758788, 665.7536711416775, 11411.771764564704, 11649.825252621218, 11650.708732281697, 11652.766944661102, 11679.766404671913, 11667.12496562759, 11697.883021169786, 12035.338056406894, 12149.149559530837, 12172.0, 615.2893408113614, 776.041588638033, 795.2047952047952, 797.5732982854174, 819.3486178488087, 809.8420807942424, 812.0945146162046, 812.4191203289647, 812.5287333346674, 812.5774597209447, 843.1905370843997, 843.4264700004026, 851.1360968616859, 851.7572491839827, 852.2372476633409, 641.935806419359, 658.2791842931982, 841.1840514700731, 843.2495079379327, 858.5278097046662, 627.425905296653, 630.6468377708497, 630.9652969086699, 630.9842253943642, 631.09753053134, 12200.328981905992, 12325.876741232563, 12345.13584049117, 12359.505619775198, 12377.814332785016, 11735.530578776925, 11830.704232394173, 11999.340036298001, 12188.146829721923, 12427.44076516559, 9572.282078844115, 9652.324337296392, 9719.951400243024, 9764.121229089345, 9945.80108397828, 3286.3098749262685, 3324.501324801275, 3362.327534493111, 3375.9831200844083, 3376.206591451007, 39418.60581394178, 39522.80238598789, 39774.20451590952, 39851.40222896659, 40697.0, 9962.103410693073, 9971.601135954481, 10028.197744180448, 10178.796424071477, 10202.795944081077, 16990.150492475328, 17036.829631703524, 17051.829481705023, 17177.742333865, 17188.828111718973, 6621.9006714899315, 6653.933460665428, 6675.165604299463, 6744.291849355747, 6801.727930882808, 3616.782993020427, 3643.526341575578, 3649.3613617617343, 3702.66675999156, 3761.0, 2816.6479190101236, 2839.5314773062214, 2854.0866922584573, 2855.157728470106, 2855.6573211214786, 501.005504074412, 505.15386727232476, 506.8732816795801, 515.9767810448539, 522.1619301021881, 485.5675756518285, 576.4264556766045, 599.3048064245454, 599.6881621556767, 606.9423404776539, 7528.373643704802, 7592.8481430372185, 7623.390128789683, 7806.4925779824125, 7850.136484986647, 561.5563704673344, 562.749576438481, 568.6076607141142, 583.4165834165834, 593.8930992421319, 3446.138465383654, 3499.2476617527354, 3506.8772592959635, 3580.785152890835, 3594.0, 45287.547124528995, 46204.306935395995, 47565.28652070222, 47747.28379074317, 47764.5223547767, 43074.35388469176, 43266.567334326886, 43384.56615433868, 43928.56071439308, 44216.0, 38245.42631860524, 39030.80484597559, 39082.60917390903, 39193.80403098023, 39915.2016959665, 7327.596982166032, 7346.52247603904, 7358.484906056525, 7390.03929489163, 7420.257974202536, 28976.565351520167, 30818.537721934637, 31578.842105789325, 31695.52456713105, 31903.521447177845, 37872.81063594665, 38154.236915262096, 38185.80907095447, 39166.21667566576, 39180.0, 10238.385696858213, 10394.428306442916, 10441.843372349573, 10487.0, 10509.684709458728, 10841.295315804447, 10876.564937402416, 11067.280626759235, 11195.60815371458, 11219.0, 8459.323254139532, 10126.89873101289, 10384.896151038392, 10518.158547316043, 10617.893821062, 9254.0, 9619.903800961902, 9678.322517423712, 9728.854067188857, 10280.485975701335, 10336.948315258376, 10420.895791041992, 10485.161187105166, 10625.0, 10781.460926953465, 8101.230383113595, 8119.715809946623, 8248.175182481704, 8290.834183316421, 8335.208155225244, 8270.586470676562, 8410.915890841257, 8543.24870368352, 8563.100874408097, 8610.870836937325], "unit": "score", "name": "yui.html", "value": 5672.56498976199}], "name": "dromaeo_css", "value": 6183.569951069866}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 109.0, 113.0, 114.0, 113.0, 104.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [157.0, 136.0, 154.0, 180.0, 141.0, 159.0, 157.0, 130.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 160.0, 160.0, 160.0, 163.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 98.0, 93.0, 74.0, 73.0, 74.0, 113.0, 103.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 144.0, 94.0, 95.0, 95.0, 139.0, 94.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 149.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 67.0, 66.0, 74.0, 67.0, 75.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 67.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 70.0, 69.0, 70.0, 70.0, 72.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 86.0, 83.0, 84.0, 84.0, 83.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 120.0, 138.0, 126.0, 124.0, 123.0, 119.0, 127.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [148.0, 137.0, 150.0, 150.0, 147.0, 138.0, 148.0, 149.0, 148.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 72.0, 71.0, 71.0, 70.0, 71.0, 73.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1539.8}]} 20:36:42 INFO - Return code: 0 20:36:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:36:42 ERROR - # TBPL SUCCESS # 20:36:42 INFO - Running post-action listener: _resource_record_post_action 20:36:42 INFO - Running post-run listener: _resource_record_post_run 20:36:43 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521900032; Read time: 12; Write time: 517800 20:36:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233672704; Read time: 0; Write time: 352260 20:36:43 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288227328; Read time: 12; Write time: 165540 20:36:43 INFO - Running post-run listener: _upload_blobber_files 20:36:43 INFO - Blob upload gear active. 20:36:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:36:43 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 20:36:43 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:36:43 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:36:43 INFO - (blobuploader) - INFO - Open directory for files ... 20:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:36:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:44 INFO - (blobuploader) - INFO - Done attempting. 20:36:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:36:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:45 INFO - (blobuploader) - INFO - Done attempting. 20:36:45 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:45 INFO - Return code: 0 20:36:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e045d2bb06ddef449561e00ab606d97866bd919618c91ec5a1a8ca2fde94aac12709ad27fa7b98d34e2d5630ba96e4cf7b24240097967da0a3829521a533a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b0fe6596797f711eaba6fbd5308608b85ee26a288aed19c31d263f9311e1acd12d1f49ccbb42bebb1ea823fad19fb8b9608439c7d44dd95f9ab1eaf4e3b3031"} 20:36:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:45 INFO - Contents: 20:36:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e045d2bb06ddef449561e00ab606d97866bd919618c91ec5a1a8ca2fde94aac12709ad27fa7b98d34e2d5630ba96e4cf7b24240097967da0a3829521a533a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b0fe6596797f711eaba6fbd5308608b85ee26a288aed19c31d263f9311e1acd12d1f49ccbb42bebb1ea823fad19fb8b9608439c7d44dd95f9ab1eaf4e3b3031"} 20:36:45 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:45 INFO - Copying logs to upload dir... 20:36:45 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.316632 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-10 20:36:45.615615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 20:36:45.619414) ========= 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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e045d2bb06ddef449561e00ab606d97866bd919618c91ec5a1a8ca2fde94aac12709ad27fa7b98d34e2d5630ba96e4cf7b24240097967da0a3829521a533a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b0fe6596797f711eaba6fbd5308608b85ee26a288aed19c31d263f9311e1acd12d1f49ccbb42bebb1ea823fad19fb8b9608439c7d44dd95f9ab1eaf4e3b3031"} build_url:https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/P26AiCBrSFalX-f1KP-trw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e045d2bb06ddef449561e00ab606d97866bd919618c91ec5a1a8ca2fde94aac12709ad27fa7b98d34e2d5630ba96e4cf7b24240097967da0a3829521a533a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b0fe6596797f711eaba6fbd5308608b85ee26a288aed19c31d263f9311e1acd12d1f49ccbb42bebb1ea823fad19fb8b9608439c7d44dd95f9ab1eaf4e3b3031"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 20:36:45.645723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:36:45.646062) ========= 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=32c5991c409366f7fec8a718000001d2-1457667909.753685-1264067002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 20:36:45.730638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 20:36:45.731093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 20:36:45.731478) ========= ========= Total master_lag: 0.33 =========