builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1458317296.74 results: success (0) buildid: 20160318081009 builduid: b4cc926c21b643c4a574292dd09a675e revision: 82a7735069d1d3c9c51554933d1137d446b07c7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.740599) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.741277) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.741764) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006502 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.768827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.769252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.801459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.801795) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.858671) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.859042) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.859459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:16.859785) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 09:08:17-- 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% 50.5M=0s 2016-03-18 09:08:17 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.024498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.024821) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013523 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.080796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.081480) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 82a7735069d1d3c9c51554933d1137d446b07c7e --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 82a7735069d1d3c9c51554933d1137d446b07c7e --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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 09:08:18,054 truncating revision to first 12 chars 2016-03-18 09:08:18,054 Setting DEBUG logging. 2016-03-18 09:08:18,054 attempt 1/10 2016-03-18 09:08:18,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/82a7735069d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 09:08:18,563 unpacking tar archive at: fx-team-82a7735069d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.868658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.869031) ========= echo 82a7735069d1d3c9c51554933d1137d446b07c7e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'82a7735069d1d3c9c51554933d1137d446b07c7e'] 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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 82a7735069d1d3c9c51554933d1137d446b07c7e program finished with exit code 0 elapsedTime=0.004059 script_repo_revision: '82a7735069d1d3c9c51554933d1137d446b07c7e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.918317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.918676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:17.928737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-18 09:08:17.929123) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:08:18 INFO - MultiFileLogger online at 20160318 09:08:18 in /builds/slave/test 09:08:18 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 09:08:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:08:19 INFO - {'append_to_log': False, 09:08:19 INFO - 'base_work_dir': '/builds/slave/test', 09:08:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:08:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:08:19 INFO - 'branch': 'Fx-Team-Non-PGO', 09:08:19 INFO - 'buildbot_json_path': 'buildprops.json', 09:08:19 INFO - 'config_files': ('talos/linux_config.py',), 09:08:19 INFO - 'default_actions': ('clobber', 09:08:19 INFO - 'read-buildbot-config', 09:08:19 INFO - 'download-and-extract', 09:08:19 INFO - 'populate-webroot', 09:08:19 INFO - 'create-virtualenv', 09:08:19 INFO - 'install', 09:08:19 INFO - 'run-tests'), 09:08:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:08:19 INFO - 'download_minidump_stackwalk': True, 09:08:19 INFO - 'download_symbols': 'ondemand', 09:08:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:08:19 INFO - 'tooltool.py': '/tools/tooltool.py', 09:08:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:08:19 INFO - '/tools/misc-python/virtualenv.py')}, 09:08:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:08:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:08:19 INFO - 'installer_path': 'installer.exe', 09:08:19 INFO - 'log_level': 'info', 09:08:19 INFO - 'log_name': 'talos', 09:08:19 INFO - 'log_to_console': True, 09:08:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:08:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:08:19 INFO - 'opt_config_files': (), 09:08:19 INFO - 'pip_index': False, 09:08:19 INFO - 'sps_profile': False, 09:08:19 INFO - 'sps_profile_interval': 0, 09:08:19 INFO - 'suite': 'dromaeojs', 09:08:19 INFO - 'system_bits': '32', 09:08:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:08:19 INFO - 'title': 'talos-linux64-ix-057', 09:08:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:08:19 INFO - 'use_talos_json': True, 09:08:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:08:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:08:19 INFO - 'work_dir': 'build'} 09:08:19 INFO - ##### 09:08:19 INFO - ##### Running clobber step. 09:08:19 INFO - ##### 09:08:19 INFO - Running pre-action listener: _resource_record_pre_action 09:08:19 INFO - Running main action method: clobber 09:08:19 INFO - rmtree: /builds/slave/test/build 09:08:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:08:19 INFO - Running post-action listener: _resource_record_post_action 09:08:19 INFO - ##### 09:08:19 INFO - ##### Running read-buildbot-config step. 09:08:19 INFO - ##### 09:08:19 INFO - Running pre-action listener: _resource_record_pre_action 09:08:19 INFO - Running main action method: read_buildbot_config 09:08:19 INFO - Using buildbot properties: 09:08:19 INFO - { 09:08:19 INFO - "project": "", 09:08:19 INFO - "product": "firefox", 09:08:19 INFO - "script_repo_revision": "production", 09:08:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:08:19 INFO - "repository": "", 09:08:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:08:19 INFO - "buildid": "20160318081009", 09:08:19 INFO - "pgo_build": "False", 09:08:19 INFO - "basedir": "/builds/slave/test", 09:08:19 INFO - "buildnumber": 1474, 09:08:19 INFO - "slavename": "talos-linux64-ix-057", 09:08:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:08:19 INFO - "platform": "ubuntu64_hw", 09:08:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:08:19 INFO - "branch": "fx-team", 09:08:19 INFO - "repo_path": "integration/fx-team", 09:08:19 INFO - "revision": "82a7735069d1d3c9c51554933d1137d446b07c7e", 09:08:19 INFO - "stage_platform": "linux64", 09:08:19 INFO - "builduid": "b4cc926c21b643c4a574292dd09a675e", 09:08:19 INFO - "slavebuilddir": "test" 09:08:19 INFO - } 09:08:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:08:19 INFO - Running post-action listener: _resource_record_post_action 09:08:19 INFO - ##### 09:08:19 INFO - ##### Running download-and-extract step. 09:08:19 INFO - ##### 09:08:19 INFO - Running pre-action listener: _resource_record_pre_action 09:08:19 INFO - Running main action method: download_and_extract 09:08:19 INFO - mkdir: /builds/slave/test/build/tests 09:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:19 INFO - https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:20 INFO - Downloaded 1361 bytes. 09:08:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:08:20 INFO - Using the following test package requirements: 09:08:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:08:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:08:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:08:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'jsshell-linux-x86_64.zip'], 09:08:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:08:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:08:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:08:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:08:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:08:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:08:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:20 INFO - https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:22 INFO - Downloaded 22009031 bytes. 09:08:22 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'] 09:08:22 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 09:08:23 INFO - Return code: 0 09:08:23 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 09:08: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')]} 09:08:23 INFO - https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:24 INFO - Downloaded 22009031 bytes. 09:08:24 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'] 09:08:24 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 09:08:26 INFO - Return code: 0 09:08: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')]} 09:08:26 INFO - https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:27 INFO - Downloaded 10846565 bytes. 09:08:27 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'] 09:08:27 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 09:08:27 INFO - Return code: 0 09:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:27 INFO - https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEusLzdIRgG6mab_M6gxbg/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 09:08:31 INFO - Downloaded 54145259 bytes. 09:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:08:31 INFO - mkdir: /builds/slave/test/properties 09:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:08:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:08:31 INFO - Contents: 09:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:08:31 INFO - Running post-action listener: _resource_record_post_action 09:08:31 INFO - Running post-action listener: set_extra_try_arguments 09:08:31 INFO - ##### 09:08:31 INFO - ##### Running populate-webroot step. 09:08:31 INFO - ##### 09:08:31 INFO - Running pre-action listener: _resource_record_pre_action 09:08:31 INFO - Running main action method: populate_webroot 09:08:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:08:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:08:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:08:31 INFO - '--tppagecycles', 09:08:31 INFO - '7'], 09:08:31 INFO - 'tests': ['tsvgm']}}, 09:08:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:08:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:08:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:08:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:08:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'tests': ['damp', 'tps']}, 09:08:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['damp', 'tps']}, 09:08:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:08:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:08:31 INFO - 'other': {'tests': ['a11yr', 09:08:31 INFO - 'ts_paint', 09:08:31 INFO - 'tpaint', 09:08:31 INFO - 'sessionrestore', 09:08:31 INFO - 'sessionrestore_no_auto_restore', 09:08:31 INFO - 'tabpaint']}, 09:08:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['a11yr', 09:08:31 INFO - 'ts_paint', 09:08:31 INFO - 'tpaint', 09:08:31 INFO - 'sessionrestore', 09:08:31 INFO - 'sessionrestore_no_auto_restore', 09:08:31 INFO - 'tabpaint']}, 09:08:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['a11yr', 09:08:31 INFO - 'ts_paint', 09:08:31 INFO - 'tpaint', 09:08:31 INFO - 'sessionrestore', 09:08:31 INFO - 'sessionrestore_no_auto_restore', 09:08:31 INFO - 'tabpaint']}, 09:08:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['a11yr', 09:08:31 INFO - 'ts_paint', 09:08:31 INFO - 'tpaint', 09:08:31 INFO - 'sessionrestore', 09:08:31 INFO - 'sessionrestore_no_auto_restore', 09:08:31 INFO - 'tabpaint']}, 09:08:31 INFO - 'other_l64': {'tests': ['a11yr', 09:08:31 INFO - 'ts_paint', 09:08:31 INFO - 'tpaint', 09:08:31 INFO - 'sessionrestore', 09:08:31 INFO - 'sessionrestore_no_auto_restore', 09:08:31 INFO - 'tabpaint']}, 09:08:31 INFO - 'other_nol64': {'tests': ['a11yr', 09:08:31 INFO - 'ts_paint', 09:08:31 INFO - 'tpaint', 09:08:31 INFO - 'sessionrestore', 09:08:31 INFO - 'sessionrestore_no_auto_restore', 09:08:31 INFO - 'tabpaint']}, 09:08:31 INFO - 'svgr': {'tests': ['tsvgx', 09:08:31 INFO - 'tsvgr_opacity', 09:08:31 INFO - 'tart', 09:08:31 INFO - 'tscrollx', 09:08:31 INFO - 'cart']}, 09:08:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['tsvgx', 09:08:31 INFO - 'tsvgr_opacity', 09:08:31 INFO - 'tart', 09:08:31 INFO - 'tscrollx', 09:08:31 INFO - 'cart']}, 09:08:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'tests': ['tp5o']}, 09:08:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'talos_options': ['--e10s'], 09:08:31 INFO - 'tests': ['tp5o']}, 09:08:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'talos_options': ['--xperf_path', 09:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:31 INFO - 'tests': ['tp5n']}, 09:08:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:31 INFO - 'talos_options': ['--e10s', 09:08:31 INFO - '--xperf_path', 09:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:31 INFO - 'tests': ['tp5n']}}, 09:08:31 INFO - 'talos.zip': {'path': '', 09:08:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:08:31 INFO - Running post-action listener: _resource_record_post_action 09:08:31 INFO - ##### 09:08:31 INFO - ##### Running create-virtualenv step. 09:08:31 INFO - ##### 09:08:31 INFO - Running pre-action listener: _resource_record_pre_action 09:08:31 INFO - Running main action method: create_virtualenv 09:08:31 INFO - Creating virtualenv /builds/slave/test/build/venv 09:08:31 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 09:08:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:08:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:08:32 INFO - Using real prefix '/usr' 09:08:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:08:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:08:34 INFO - Installing pip.................done. 09:08:34 INFO - Return code: 0 09:08:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:34 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:34 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 09:08:34 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 09:08:34 INFO - Using env: {'DISPLAY': ':0', 09:08:34 INFO - 'HOME': '/home/cltbld', 09:08:34 INFO - 'LANG': 'en_US.UTF-8', 09:08:34 INFO - 'LANGUAGE': 'en_US:en', 09:08:34 INFO - 'LOGNAME': 'cltbld', 09:08:34 INFO - 'MAIL': '/var/mail/cltbld', 09:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:34 INFO - 'MOZ_NO_REMOTE': '1', 09:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:34 INFO - 'NO_EM_RESTART': '1', 09:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:34 INFO - 'PWD': '/builds/slave/test', 09:08:34 INFO - 'SHELL': '/bin/bash', 09:08:34 INFO - 'SHLVL': '1', 09:08:34 INFO - 'TERM': 'linux', 09:08:34 INFO - 'TMOUT': '86400', 09:08:34 INFO - 'USER': 'cltbld', 09:08:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:34 INFO - '_': '/tools/buildbot/bin/python'} 09:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:34 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 09:08:34 INFO - Cleaning up... 09:08:34 INFO - Return code: 0 09:08:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:34 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:34 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 09:08:34 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 09:08:34 INFO - Using env: {'DISPLAY': ':0', 09:08:34 INFO - 'HOME': '/home/cltbld', 09:08:34 INFO - 'LANG': 'en_US.UTF-8', 09:08:34 INFO - 'LANGUAGE': 'en_US:en', 09:08:34 INFO - 'LOGNAME': 'cltbld', 09:08:34 INFO - 'MAIL': '/var/mail/cltbld', 09:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:34 INFO - 'MOZ_NO_REMOTE': '1', 09:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:34 INFO - 'NO_EM_RESTART': '1', 09:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:34 INFO - 'PWD': '/builds/slave/test', 09:08:34 INFO - 'SHELL': '/bin/bash', 09:08:34 INFO - 'SHLVL': '1', 09:08:34 INFO - 'TERM': 'linux', 09:08:34 INFO - 'TMOUT': '86400', 09:08:34 INFO - 'USER': 'cltbld', 09:08:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:34 INFO - '_': '/tools/buildbot/bin/python'} 09:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:34 INFO - Downloading/unpacking psutil>=0.7.1 09:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:36 INFO - Installing collected packages: psutil 09:08:36 INFO - Running setup.py install for psutil 09:08:36 INFO - building 'psutil._psutil_linux' extension 09:08:36 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 09:08:37 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 09:08:37 INFO - building 'psutil._psutil_posix' extension 09:08:37 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 09:08:37 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 09:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:37 INFO - Successfully installed psutil 09:08:37 INFO - Cleaning up... 09:08:37 INFO - Return code: 0 09:08:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:37 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:37 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 09:08:37 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 09:08:37 INFO - Using env: {'DISPLAY': ':0', 09:08:37 INFO - 'HOME': '/home/cltbld', 09:08:37 INFO - 'LANG': 'en_US.UTF-8', 09:08:37 INFO - 'LANGUAGE': 'en_US:en', 09:08:37 INFO - 'LOGNAME': 'cltbld', 09:08:37 INFO - 'MAIL': '/var/mail/cltbld', 09:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:37 INFO - 'MOZ_NO_REMOTE': '1', 09:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:37 INFO - 'NO_EM_RESTART': '1', 09:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:37 INFO - 'PWD': '/builds/slave/test', 09:08:37 INFO - 'SHELL': '/bin/bash', 09:08:37 INFO - 'SHLVL': '1', 09:08:37 INFO - 'TERM': 'linux', 09:08:37 INFO - 'TMOUT': '86400', 09:08:37 INFO - 'USER': 'cltbld', 09:08:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:37 INFO - '_': '/tools/buildbot/bin/python'} 09:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:08:37 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 09:08:37 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 09:08:37 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 09:08:37 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 09:08:37 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 09:08:37 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 09:08:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:08:39 INFO - Installing collected packages: mozsystemmonitor 09:08:39 INFO - Running setup.py install for mozsystemmonitor 09:08:39 INFO - Successfully installed mozsystemmonitor 09:08:39 INFO - Cleaning up... 09:08:39 INFO - Return code: 0 09:08:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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', '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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:08: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 blobuploader==1.2.4 09:08:39 INFO - Using env: {'DISPLAY': ':0', 09:08:39 INFO - 'HOME': '/home/cltbld', 09:08:39 INFO - 'LANG': 'en_US.UTF-8', 09:08:39 INFO - 'LANGUAGE': 'en_US:en', 09:08:39 INFO - 'LOGNAME': 'cltbld', 09:08:39 INFO - 'MAIL': '/var/mail/cltbld', 09:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:39 INFO - 'MOZ_NO_REMOTE': '1', 09:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:39 INFO - 'NO_EM_RESTART': '1', 09:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:39 INFO - 'PWD': '/builds/slave/test', 09:08:39 INFO - 'SHELL': '/bin/bash', 09:08:39 INFO - 'SHLVL': '1', 09:08:39 INFO - 'TERM': 'linux', 09:08:39 INFO - 'TMOUT': '86400', 09:08:39 INFO - 'USER': 'cltbld', 09:08:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:39 INFO - '_': '/tools/buildbot/bin/python'} 09:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:08:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:42 INFO - Downloading docopt-0.6.1.tar.gz 09:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:42 INFO - Running setup.py install for blobuploader 09:08:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:08:42 INFO - Running setup.py install for requests 09:08:43 INFO - Running setup.py install for docopt 09:08:43 INFO - Successfully installed blobuploader requests docopt 09:08:43 INFO - Cleaning up... 09:08:43 INFO - Return code: 0 09:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:43 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')]} 09:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:43 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')]} 09:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:43 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:43 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 09:08:43 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 09:08:43 INFO - Using env: {'DISPLAY': ':0', 09:08:43 INFO - 'HOME': '/home/cltbld', 09:08:43 INFO - 'LANG': 'en_US.UTF-8', 09:08:43 INFO - 'LANGUAGE': 'en_US:en', 09:08:43 INFO - 'LOGNAME': 'cltbld', 09:08:43 INFO - 'MAIL': '/var/mail/cltbld', 09:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:43 INFO - 'MOZ_NO_REMOTE': '1', 09:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:43 INFO - 'NO_EM_RESTART': '1', 09:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:43 INFO - 'PWD': '/builds/slave/test', 09:08:43 INFO - 'SHELL': '/bin/bash', 09:08:43 INFO - 'SHLVL': '1', 09:08:43 INFO - 'TERM': 'linux', 09:08:43 INFO - 'TMOUT': '86400', 09:08:43 INFO - 'USER': 'cltbld', 09:08:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:43 INFO - '_': '/tools/buildbot/bin/python'} 09:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:43 INFO - Running setup.py (path:/tmp/pip-VJQDQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:43 INFO - Running setup.py (path:/tmp/pip-ncabJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:43 INFO - Running setup.py (path:/tmp/pip-U94urD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:43 INFO - Running setup.py (path:/tmp/pip-ZaRdjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:43 INFO - Running setup.py (path:/tmp/pip-cr0ZF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:43 INFO - Running setup.py (path:/tmp/pip-WGm3NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:43 INFO - Running setup.py (path:/tmp/pip-rSzWKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:43 INFO - Running setup.py (path:/tmp/pip-EG5Mf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:43 INFO - Running setup.py (path:/tmp/pip-KOX8nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:44 INFO - Running setup.py (path:/tmp/pip-oupYd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:44 INFO - Running setup.py (path:/tmp/pip-bN8I8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:44 INFO - Running setup.py (path:/tmp/pip-dtPbrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:44 INFO - Running setup.py (path:/tmp/pip-5Qkd_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:44 INFO - Running setup.py (path:/tmp/pip-WosYZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:44 INFO - Running setup.py (path:/tmp/pip-CwV5Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:44 INFO - Running setup.py (path:/tmp/pip-aFKsKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:44 INFO - Running setup.py (path:/tmp/pip-aHsNnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:08:44 INFO - Running setup.py install for manifestparser 09:08:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:08:44 INFO - Running setup.py install for mozcrash 09:08:44 INFO - Running setup.py install for mozdebug 09:08:44 INFO - Running setup.py install for mozdevice 09:08:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Running setup.py install for mozfile 09:08:45 INFO - Running setup.py install for mozhttpd 09:08:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Running setup.py install for mozinfo 09:08:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Running setup.py install for mozInstall 09:08:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Running setup.py install for mozleak 09:08:45 INFO - Running setup.py install for mozlog 09:08:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Running setup.py install for moznetwork 09:08:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Running setup.py install for mozprocess 09:08:45 INFO - Running setup.py install for mozprofile 09:08:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:08:45 INFO - Running setup.py install for mozrunner 09:08:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:08:46 INFO - Running setup.py install for mozscreenshot 09:08:46 INFO - Running setup.py install for moztest 09:08:46 INFO - Running setup.py install for mozversion 09:08:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:08:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:08:46 INFO - Cleaning up... 09:08:46 INFO - Return code: 0 09:08:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:46 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:46 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 09:08:46 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 09:08:46 INFO - Using env: {'DISPLAY': ':0', 09:08:46 INFO - 'HOME': '/home/cltbld', 09:08:46 INFO - 'LANG': 'en_US.UTF-8', 09:08:46 INFO - 'LANGUAGE': 'en_US:en', 09:08:46 INFO - 'LOGNAME': 'cltbld', 09:08:46 INFO - 'MAIL': '/var/mail/cltbld', 09:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:46 INFO - 'MOZ_NO_REMOTE': '1', 09:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:46 INFO - 'NO_EM_RESTART': '1', 09:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:46 INFO - 'PWD': '/builds/slave/test', 09:08:46 INFO - 'SHELL': '/bin/bash', 09:08:46 INFO - 'SHLVL': '1', 09:08:46 INFO - 'TERM': 'linux', 09:08:46 INFO - 'TMOUT': '86400', 09:08:46 INFO - 'USER': 'cltbld', 09:08:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:46 INFO - '_': '/tools/buildbot/bin/python'} 09:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:46 INFO - Running setup.py (path:/tmp/pip-uOjkqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:46 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)) 09:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:46 INFO - Running setup.py (path:/tmp/pip-jNu4K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:46 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)) 09:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:46 INFO - Running setup.py (path:/tmp/pip-QFcKlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:46 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)) 09:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:46 INFO - Running setup.py (path:/tmp/pip-AW57WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:46 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)) 09:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:46 INFO - Running setup.py (path:/tmp/pip-j3bBrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:46 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)) 09:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:46 INFO - Running setup.py (path:/tmp/pip-1AFpur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:47 INFO - Running setup.py (path:/tmp/pip-PvLl8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:47 INFO - Running setup.py (path:/tmp/pip-Pu1Dy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:47 INFO - Running setup.py (path:/tmp/pip-jqN6Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:47 INFO - Running setup.py (path:/tmp/pip-_DgYcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:47 INFO - Running setup.py (path:/tmp/pip-Q9VcLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:47 INFO - Running setup.py (path:/tmp/pip-JdhbNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:47 INFO - Running setup.py (path:/tmp/pip-a_d_hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:47 INFO - Running setup.py (path:/tmp/pip-Gysz6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:47 INFO - Running setup.py (path:/tmp/pip-6BEHg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:47 INFO - Running setup.py (path:/tmp/pip-KuT8Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:47 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)) 09:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:47 INFO - Running setup.py (path:/tmp/pip-R9AB6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:47 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)) 09:08:47 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)) 09:08:47 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)) 09:08:47 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)) 09:08:47 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)) 09:08:47 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)) 09:08:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:08:47 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 09:08:47 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 09:08:47 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 09:08:47 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 09:08:47 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 09:08:47 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 09:08:49 INFO - Downloading blessings-1.6.tar.gz 09:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:08:49 INFO - Installing collected packages: blessings 09:08:49 INFO - Running setup.py install for blessings 09:08:49 INFO - Successfully installed blessings 09:08:49 INFO - Cleaning up... 09:08:49 INFO - Return code: 0 09:08:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:08:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:50 INFO - Reading from file tmpfile_stdout 09:08:50 INFO - Current package versions: 09:08:50 INFO - argparse == 1.2.1 09:08:50 INFO - blessings == 1.6 09:08:50 INFO - blobuploader == 1.2.4 09:08:50 INFO - docopt == 0.6.1 09:08:50 INFO - manifestparser == 1.1 09:08:50 INFO - mozInstall == 1.12 09:08:50 INFO - mozcrash == 0.17 09:08:50 INFO - mozdebug == 0.1 09:08:50 INFO - mozdevice == 0.48 09:08:50 INFO - mozfile == 1.2 09:08:50 INFO - mozhttpd == 0.7 09:08:50 INFO - mozinfo == 0.9 09:08:50 INFO - mozleak == 0.1 09:08:50 INFO - mozlog == 3.1 09:08:50 INFO - moznetwork == 0.27 09:08:50 INFO - mozprocess == 0.22 09:08:50 INFO - mozprofile == 0.28 09:08:50 INFO - mozrunner == 6.11 09:08:50 INFO - mozscreenshot == 0.1 09:08:50 INFO - mozsystemmonitor == 0.0 09:08:50 INFO - moztest == 0.7 09:08:50 INFO - mozversion == 1.4 09:08:50 INFO - psutil == 3.1.1 09:08:50 INFO - requests == 1.2.3 09:08:50 INFO - wsgiref == 0.1.2 09:08:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:50 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')]} 09:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:50 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')]} 09:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:50 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:50 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 09:08:50 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 09:08:50 INFO - Using env: {'DISPLAY': ':0', 09:08:50 INFO - 'HOME': '/home/cltbld', 09:08:50 INFO - 'LANG': 'en_US.UTF-8', 09:08:50 INFO - 'LANGUAGE': 'en_US:en', 09:08:50 INFO - 'LOGNAME': 'cltbld', 09:08:50 INFO - 'MAIL': '/var/mail/cltbld', 09:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:50 INFO - 'MOZ_NO_REMOTE': '1', 09:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:50 INFO - 'NO_EM_RESTART': '1', 09:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:50 INFO - 'PWD': '/builds/slave/test', 09:08:50 INFO - 'SHELL': '/bin/bash', 09:08:50 INFO - 'SHLVL': '1', 09:08:50 INFO - 'TERM': 'linux', 09:08:50 INFO - 'TMOUT': '86400', 09:08:50 INFO - 'USER': 'cltbld', 09:08:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:50 INFO - '_': '/tools/buildbot/bin/python'} 09:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 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)) 09:08:50 INFO - Cleaning up... 09:08:50 INFO - Return code: 0 09:08:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:08:50 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')]} 09:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:50 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')]} 09:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:50 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:50 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 09:08:50 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 09:08:50 INFO - Using env: {'DISPLAY': ':0', 09:08:50 INFO - 'HOME': '/home/cltbld', 09:08:50 INFO - 'LANG': 'en_US.UTF-8', 09:08:50 INFO - 'LANGUAGE': 'en_US:en', 09:08:50 INFO - 'LOGNAME': 'cltbld', 09:08:50 INFO - 'MAIL': '/var/mail/cltbld', 09:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:50 INFO - 'MOZ_NO_REMOTE': '1', 09:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:50 INFO - 'NO_EM_RESTART': '1', 09:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:50 INFO - 'PWD': '/builds/slave/test', 09:08:50 INFO - 'SHELL': '/bin/bash', 09:08:50 INFO - 'SHLVL': '1', 09:08:50 INFO - 'TERM': 'linux', 09:08:50 INFO - 'TMOUT': '86400', 09:08:50 INFO - 'USER': 'cltbld', 09:08:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:50 INFO - '_': '/tools/buildbot/bin/python'} 09:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:50 INFO - Downloading/unpacking jsonschema 09:08:50 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 09:08:50 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 09:08:50 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 09:08:50 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 09:08:50 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 09:08:50 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 09:08:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:08:52 INFO - Downloading/unpacking functools32 (from jsonschema) 09:08:52 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 09:08:52 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 09:08:52 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 09:08:52 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 09:08:52 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 09:08:52 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 09:08:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:08:52 INFO - warning: no files found matching '*.txt' 09:08:52 INFO - no previously-included directories found matching 'build' 09:08:52 INFO - no previously-included directories found matching 'dist' 09:08:52 INFO - no previously-included directories found matching '.git*' 09:08:52 INFO - Installing collected packages: jsonschema, functools32 09:08:52 INFO - Running setup.py install for functools32 09:08:52 INFO - warning: no files found matching '*.txt' 09:08:52 INFO - no previously-included directories found matching 'build' 09:08:52 INFO - no previously-included directories found matching 'dist' 09:08:52 INFO - no previously-included directories found matching '.git*' 09:08:53 INFO - Successfully installed jsonschema functools32 09:08:53 INFO - Cleaning up... 09:08:53 INFO - Return code: 0 09:08:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:08:53 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')]} 09:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:53 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')]} 09:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:53 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 0x7f18d2348f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', '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 09:08:53 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 09:08:53 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 09:08:53 INFO - Using env: {'DISPLAY': ':0', 09:08:53 INFO - 'HOME': '/home/cltbld', 09:08:53 INFO - 'LANG': 'en_US.UTF-8', 09:08:53 INFO - 'LANGUAGE': 'en_US:en', 09:08:53 INFO - 'LOGNAME': 'cltbld', 09:08:53 INFO - 'MAIL': '/var/mail/cltbld', 09:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:53 INFO - 'MOZ_NO_REMOTE': '1', 09:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:53 INFO - 'NO_EM_RESTART': '1', 09:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:53 INFO - 'PWD': '/builds/slave/test', 09:08:53 INFO - 'SHELL': '/bin/bash', 09:08:53 INFO - 'SHLVL': '1', 09:08:53 INFO - 'TERM': 'linux', 09:08:53 INFO - 'TMOUT': '86400', 09:08:53 INFO - 'USER': 'cltbld', 09:08:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:53 INFO - '_': '/tools/buildbot/bin/python'} 09:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:53 INFO - Downloading/unpacking flake8 09:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:08:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:08:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:08:55 INFO - no previously-included directories found matching 'docs/_build' 09:08:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:08:55 INFO - Running setup.py install for pep8 09:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:08:55 INFO - no previously-included directories found matching 'docs/_build' 09:08:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:08:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:08:56 INFO - Cleaning up... 09:08:56 INFO - Return code: 0 09:08:56 INFO - Running post-action listener: _resource_record_post_action 09:08:56 INFO - Running post-action listener: _start_resource_monitoring 09:08:56 INFO - Starting resource monitoring. 09:08:56 INFO - ##### 09:08:56 INFO - ##### Running install step. 09:08:56 INFO - ##### 09:08:56 INFO - Running pre-action listener: _resource_record_pre_action 09:08:56 INFO - Running main action method: install 09:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:56 INFO - Reading from file tmpfile_stdout 09:08:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:08:56 INFO - Reading from file tmpfile_stdout 09:08:56 INFO - Output received: 09:08:56 INFO - Usage: mozinstall [options] installer 09:08:56 INFO - Options: 09:08:56 INFO - -h, --help show this help message and exit 09:08:56 INFO - -d DEST, --destination=DEST 09:08:56 INFO - Directory to install application into. [default: 09:08:56 INFO - "/builds/slave/test"] 09:08:56 INFO - --app=APP Application being installed. [default: firefox] 09:08:56 INFO - mkdir: /builds/slave/test/build/application 09:08:56 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'] 09:08:56 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 09:09:11 INFO - Reading from file tmpfile_stdout 09:09:11 INFO - Output received: 09:09:11 INFO - /builds/slave/test/build/application/firefox/firefox 09:09:11 INFO - Running post-action listener: _resource_record_post_action 09:09:11 INFO - ##### 09:09:11 INFO - ##### Running run-tests step. 09:09:11 INFO - ##### 09:09:11 INFO - Running pre-action listener: _resource_record_pre_action 09:09:11 INFO - Running main action method: run_tests 09:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:09:11 INFO - Python 2.7.3 09:09:11 INFO - Return code: 0 09:09:11 INFO - grabbing minidump binary from tooltool 09:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:11 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 0x12ab410>, '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 0x12ac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ac7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:09:11 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 09:09:11 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 09:09:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:09:12 INFO - Return code: 0 09:09:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:09:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:09:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:09:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:09:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:09:13 INFO - Return code: 0 09:09:13 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/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 09:09:13 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/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 09:09:13 INFO - Using env: {'DISPLAY': ':0', 09:09:13 INFO - 'HOME': '/home/cltbld', 09:09:13 INFO - 'LANG': 'en_US.UTF-8', 09:09:13 INFO - 'LANGUAGE': 'en_US:en', 09:09:13 INFO - 'LOGNAME': 'cltbld', 09:09:13 INFO - 'MAIL': '/var/mail/cltbld', 09:09:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:09:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:13 INFO - 'MOZ_NO_REMOTE': '1', 09:09:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:13 INFO - 'NO_EM_RESTART': '1', 09:09:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:13 INFO - 'PWD': '/builds/slave/test', 09:09:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:09:13 INFO - 'SHELL': '/bin/bash', 09:09:13 INFO - 'SHLVL': '1', 09:09:13 INFO - 'TERM': 'linux', 09:09:13 INFO - 'TMOUT': '86400', 09:09:13 INFO - 'USER': 'cltbld', 09:09:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513', 09:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:13 INFO - '_': '/tools/buildbot/bin/python'} 09:09:13 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/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 09:09:13 INFO - mozversion application_buildid: 20160318081009 09:09:13 INFO - mozversion application_changeset: 82a7735069d1d3c9c51554933d1137d446b07c7e 09:09:13 INFO - mozversion application_display_name: Nightly 09:09:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:09:13 INFO - mozversion application_name: Firefox 09:09:13 INFO - mozversion application_remotingname: firefox 09:09:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:09:13 INFO - mozversion application_vendor: Mozilla 09:09:13 INFO - mozversion application_version: 48.0a1 09:09:13 INFO - mozversion platform_buildid: 20160318081009 09:09:13 INFO - mozversion platform_changeset: 82a7735069d1d3c9c51554933d1137d446b07c7e 09:09:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:09:13 INFO - mozversion platform_version: 48.0a1 09:09:13 INFO - using testdate: 1458317353 09:09:13 INFO - actual date: 1458317353 09:09:13 INFO - starting webserver on 'localhost:48586' 09:09:13 INFO - SUITE-START | Running 2 tests 09:09:13 INFO - TEST-START | dromaeo_css 09:09:13 INFO - operating with platform_type : linux_ 09:09:13 INFO - Initialising browser for dromaeo_css test... 09:09:13 INFO - TEST-INFO | started process 16473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjmEbDD/profile http://localhost:48586/getInfo.html) 09:09:17 INFO - PROCESS | 16473 | __metrics Screen width/height:1600/1200 09:09:17 INFO - PROCESS | 16473 | colorDepth:24 09:09:17 INFO - PROCESS | 16473 | Browser inner width/height: 1024/697 09:09:17 INFO - PROCESS | 16473 | __metrics 09:09:18 ERROR - PROCESS | 16473 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:09:18 INFO - PROCESS | 16473 | 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. 09:09:19 INFO - TEST-INFO | 16473: exit 0 09:09:19 INFO - Browser initialized. 09:09:19 INFO - Running cycle 1/1 for dromaeo_css test... 09:09:19 INFO - TEST-INFO | started process 16565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjmEbDD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:31 INFO - PROCESS | 16565 | RSS: Main: 155168768 09:09:31 INFO - PROCESS | 16565 | 09:10:22 INFO - PROCESS | 16565 | 1458317422595 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] 09:12:33 INFO - PROCESS | 16565 | Cycle 1(1): loaded http://localhost:48586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48586/tests/dromaeo/cssquery-ext.html) 09:12:34 INFO - PROCESS | 16565 | RSS: Main: 243683328 09:12:34 INFO - PROCESS | 16565 | 09:15:37 INFO - PROCESS | 16565 | Cycle 1(1): loaded http://localhost:48586/tests/dromaeo/cssquery-ext.html (next: http://localhost:48586/tests/dromaeo/cssquery-jquery.html) 09:15:37 INFO - PROCESS | 16565 | RSS: Main: 235614208 09:15:37 INFO - PROCESS | 16565 | 09:18:39 INFO - PROCESS | 16565 | Cycle 1(1): loaded http://localhost:48586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48586/tests/dromaeo/cssquery-mootools.html) 09:18:40 INFO - PROCESS | 16565 | RSS: Main: 236470272 09:18:40 INFO - PROCESS | 16565 | 09:21:42 INFO - PROCESS | 16565 | Cycle 1(1): loaded http://localhost:48586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48586/tests/dromaeo/cssquery-prototype.html) 09:21:42 INFO - PROCESS | 16565 | RSS: Main: 212393984 09:21:42 INFO - PROCESS | 16565 | 09:24:45 INFO - PROCESS | 16565 | Cycle 1(1): loaded http://localhost:48586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48586/tests/dromaeo/cssquery-yui.html) 09:24:46 INFO - PROCESS | 16565 | RSS: Main: 203010048 09:24:46 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | Cycle 1(1): loaded http://localhost:48586/tests/dromaeo/cssquery-yui.html (next: http://localhost:48586/tests/dromaeo/cssquery-dojo.html) 09:27:49 INFO - PROCESS | 16565 | RSS: Main: 277151744 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | __start_tp_report 09:27:49 INFO - PROCESS | 16565 | _x_x_mozilla_page_load 09:27:49 INFO - PROCESS | 16565 | _x_x_mozilla_page_load_details 09:27:49 INFO - PROCESS | 16565 | |i|pagename|runs| 09:27:49 INFO - PROCESS | 16565 | |0;dojo.html;2594.2736033910505;2675.7748411538346;2680.2897232233463;2687.556553168727;2712.64735584374;4616.861494155172;4686.226772582524;4693.319468677039;4706.8352607658735;4751.90496190076;4684;4699.506551812062;4746.264329028997;4749.952500474994;4781.282807578865;4316.20150272199;4338.934915976263;4346.15250026245;4382.561743825624;4459.308807134899;4272.337787642905;4380.167768124063;4409.977950110245;4436.97781511092;4446.71096378736;4258.978705106486;4314.978425107885;4329.740215587075;4367.650587952956;4374.693771436001;4325.870223893288;4328.069465065026;4331.025519258142;4364.585364390377;4369.235383807821;4221.6833737469815;4285.485741710983;4320.13597280542;4323.762193079379;4351.0862718829085;4564.132814765184;4605.884852878671;4617.468991066037;4622.12179685862;4668.5564871337165;5066.923996140061;5086.771095300684;5090.974545127251;5096.108181068335;5116.386033675945;4888.41339039314;4996.100701873661;5077.111505486562;5096.592272618182;5098.770555325019;4709.128811169944;4726.243800991825;4726.409198850144;4769.976150119262;4773.689710168828;5158.509941555546;5160.690358578422;5163.690178589221;5164.56101231392;5164.8192313268855;4875.366202393737;4905.583025442806;5009.799608015712;5018.146915024455;5022.096022715946;5011.373578302712;5028.497150284942;5035.345405097387;5042.697438153723;5089.898202035939;4997.750112494361;4999;5001.924971125436;5001.974990125026;5045.873853153627;4884.145274576935;4977.352944117241;5009.223570346602;5050.191969284897;5061.063703214917;4182.435371224907;4215.57844215576;4216.683748718859;4223.472065991751;4257.723247988871;3663.377225871608;3751.0622344413896;3763.360228761117;3767.05823544114;3782.1868298315994;4309.052008558112;4329.848455304049;4356.3683265926265;4384.649228061748;4394.252976993918;5030.698158110525;5050.343455350854;5053.343065401547;5058.671186372874;5078.13671675816;4292.377605247221;4342.522322544518;4356.3683265926265;4358.956410435919;4401.823927042947;4485.304777759387;4517.254652982221;4543.34121552373;4563.018950925567;4570.611498022638;4773.09311230865;4804.0872234275375;4804.42346918372;4805.423349198119;4850.7817148227705;4947.1342515059005;5036.294918711456;5043.067032598981;5055.241713742821;5093.1341671915125;4709.317149013443;4758.857234282977;4782.641301902441;4799.28010798383;4822.95177048225;4993.950060499348;5015.22264049073;5023.547880690755;5032.3961124665275;5069.8732531687;4994.9750251248515;5065.873353166053;5081.618878584047;5088.211327244283;5146;4898.142825005539;4917;4920.507949205051;4923.163062279493;4970.030843985388;4907.779149938333;4911.99304142657;4916.115099282163;4916.434610019894;4961.231009193581;4767.809287628456;4841.644339584922;4866.829660961849;4898.926516102332;4908.6073114151495;4903.656744028027;4914.336564563881;4935.728534930613;4961.107000739901;4987.950120498748;4808.63935204868;4811.230203167476;4824.469308376146;4827.806887724451;4870.31815545831 09:27:49 INFO - PROCESS | 16565 | |1;ext.html;505.98735031624227;523.7826302084635;538.4346436241946;558.3244274427942;570.0821677099868;26183.345416364602;27040.594391084123;27093.322666933313;35019.82490087546;35061.2987740245;37969;38556;38566.22867542647;38601.61398386015;38621.80689096558;7550.88673669894;7692.923070769305;7695.961520192392;7708.768736937873;7742.419318551103;7480.17718051014;7617.885731714029;7713.920051192809;9784.902150978505;10108.646197383094;9844.360116592434;9905.603775848957;9912.950435247814;9916.256280778935;9957.900420995806;9691.90308096917;9749.268804839594;9758.463284519348;9762.511874406251;9769;7430.925690743077;9675;9947.552360143738;10167.389956602627;10182.13451856593;34553;34855.1286217844;34913.650863491544;34942.82528587366;34989.12527186815;2893.208332918227;2907.1133304342166;2936.3574074258;3418.6923176914197;3493.388726880519;29480.41039179226;29725.256868578243;29802.254943626365;30043.69956300431;30344.393112137634;3333.749968752353;3360.462326027848;3372.898813035613;3378.1554611347165;3450.1547120955524;245477.99999999822;246447;247345;247630;247800;56449;56610;56753.43246567564;56772;56812.43187568154;59130;59304.70347648234;59307.70346148328;59315.70342148262;59317.703411483526;14354.784678229835;14720.558383248519;14786.704265914621;14823;14826.184559849311;10888.455577221108;10895.237333386587;10935.56257749681;10937.343759374464;10962.616308429167;15991.440299589458;18902.81097189038;19430.417087487396;19478;19481;6655.367740064686;6900.482463815234;6964.408025317804;6987;7065.293470652894;883.7127933421535;916.3860213656866;919.8482250428605;986.7483791633088;1046.2205656785743;23452.530949381257;24630.876845615658;24994.500109997698;26348.20955371342;26368.73631263701;905.2305540290832;938.2212763406357;983.3804703037041;1014.7666036811574;1015.8679371681782;13549.187048777105;14023.088499247517;14145.787813182811;14196.574102776933;14242.287885605678;320549;323826;324377;324779;325733;47812.04375912532;48162.759186203846;48245.75877120592;48282.758586206844;48301.033979320215;1042.3276986343765;1135.517405102828;1136.1478890831877;1203.5667159822458;1251.7997120460682;26144.346391339608;27306.726932731213;27800.44399111966;27843.409543885944;29503.26241843971;43230.783846080565;43735.78132109319;43872.34191487194;43988.12023759571;44004.11991760211;337282;346962;347322;347787;347954;36069.45895811512;40774.59225407708;41269.793651031556;41333.173336533706;41359.586404135574;39072.00143197338;39549.209015820095;39550;39551.40672889967;40054;32915.67084329222;33812.661873381934;34090;34201.82899085488;34736.82631586826;33883.66116338805;34030.8298458516;34241.486377703855;34250.314993700486;36948.26103477862;35966.460503092996;36222.45666314955;36592;36938.8153059233;37384.626153738114;29798.404031918806;31154.688453115177;31293.687063129077;31431.842840785648;31842.68157318397;24343.14798982027;27263.182104536896;27706.307342316602;27716.30709232285;27763.44473110486 09:27:49 INFO - PROCESS | 16565 | |2;jquery.html;357.12326239083035;360.96029436761955;361.5769549626936;370.4147447033687;375.8158502333854;14252.358643861013;14525.055871368353;14637.634059148526;15227.619309517268;15526.92236538817;14984.775228371584;15440.536783896501;16549.91725041376;16550.172491375444;16555.25501352439;4880.341153944225;4965.751712414383;5020.673656212352;5023.32185155003;5028.622853286;4897.338859254009;4972.3038774571405;4996.700197988114;4997.125503036954;5033.84898453047;4934.5312195341385;4985.900281994358;4989.301497790312;4990.126727822617;4992.32603598515;4756.143894099061;4934.753262336869;4945.282933974553;4945.3818272715735;4950.603951683875;4427.867163985085;4442.444694413199;4448.599626033641;4450.955490445086;4451.109778044404;18332.175052122686;19493.51266218356;19678.901605492025;19683.212671493122;19714.50713732154;1932.1884808380514;1944.5819148882917;1948.9317873874347;1965.508622844289;1981.6730239510464;12777.552785652457;12849.67875803103;12877.162984406077;12986.22082675033;13026.881183171818;1746;1774.0597483333725;1780.6349698311815;1822.6263615958828;1822.8450581700438;48051.75974120142;53459.19811202835;56682.149767753515;57805.710971445296;59925.400745992854;9021.32340074497;9327.953360233156;9347.672831451002;9796.804063918682;9911.80176396468;11609.709757255967;11645.53417863293;12056.216345937486;12361.93819030917;12438.937805311096;7170.282971702788;7235.8552828944175;7270.127584689871;7396.704131834666;7404.851902961911;7020.368166865007;7038.577685338896;7147.106611673541;7148.46386521013;7153.427725781925;6005.969970150209;6104.694765261719;6124.816255512342;6128.17269668598;6138.416850399205;1779.3772179736989;1798.685230084756;1805.3049575913367;1815.2738904438331;1851.5093500222451;844.2359664503634;883.3895837799288;935.4901578639658;939.3612343606277;951.8429459139164;16189.514314570582;16507.669846603;16740.916295418447;16766.32934682599;17135.914320428317;900.320258205051;906.8413027720122;918.2241006349624;919.0671468459519;941.4727752458645;7734.7679569613;9528.380655257524;9822.165115965223;9881.80236395268;10033.297669163234;445946;449257;453388;458811;462229;69529;69645;70184;71367.64316178385;72406.63796680982;987.7678745494803;988.081084591337;997.7904640025675;1030.294248439821;1033.204432586904;14721.779173312194;14816.777748334;15084.849151508344;15194.392224310905;15452.304646291168;31925.521117183725;33497.66502334945;33933.830330848185;34213.31573368568;34258.65741342555;43742;46241.30638040365;46313.3053004212;46620.7668961653;47480.287795683784;7202.53183543068;7244.203137654748;7443.516171448839;7523.548587084792;7597.126330471845;8219.917800821915;10809.18931080188;10944.45277736094;11340.376279304717;11541.884581154081;9591.520423978913;9841.507924603884;9949.651762188289;10040.64857729976;10062.345947513388;9146.679866204651;9170.037146099563;9680.41917484925;9921.15670168015;10099.7475063124;9582.856257156009;9768.560414781494;10083.546240419051;10132.83472400654;10306.793864122825;7462.776116716507;7545.660445279866;7604.429667774828;7692.653830577749;7773.533587984739;8638.956805215934;9131.77170570741;9417.764555886157;9690.95154524223;9830.705078847646 09:27:49 INFO - PROCESS | 16565 | |3;mootools.html;1317.3874148520936;1413.5652312902403;1426.108682073704;1573.8504842040008;1778.9110544472774;7534.736284230053;7700.5379677219335;7707.845843083135;7721.652525636346;7722.768316950501;7577.280158384945;7782.805429864256;7789.065312162535;7797.2202779722;7798.688052477894;1981.7522809648794;2277.2257432472957;2286.1084177170874;2317.0268487235317;2344.050659482912;2353.14110349722;2361.7284012338628;2364.2788949370433;2364.4207169243473;2365.4322962488964;2253.4929640830765;2319.1071437496603;2325.2326732178426;2325.5232677301115;2336.859788412692;2278.4759505313787;2320.234322673514;2324.6048171810835;2326.464913069995;2331.4521087544413;2302.940647302243;2308.815294776414;2311.052468487912;2318.374039009475;2334.299710086967;7775.300222979902;7812.179721129256;7813.17961614028;7827.452078354518;7829.217078292125;4695.530446955311;4760.690555113906;4782.187028205179;4793.065352256312;4803.927941080887;2945.2489615148;3039.9848000760076;3086.1975886269734;3230.3216324571868;3242.4649932761067;908.9409188402733;912.9908700912972;1003.9949800250952;1010.7725761703631;1036.4662198967537;10372.948135259276;10392.012758787903;10394.532246048946;10400.947995259976;10412.167026637851;4304.91390172201;4367.759773212504;4480.708753930984;4483.417155769795;4485.125400546862;8861.689840855668;8868.11318868108;8912.019677835433;8941.239994600532;8949.149830766068;4204.26425375558;4774.618030557547;4787.2101103318255;4792.616590672737;4795.400574928134;4256.489221293465;4286.592773686495;4296.462942132233;4344.739315641072;4358.694891357574;3730.4963829883163;3818.770873747584;3846.769193848378;3877.263319969253;3893.6495715385186;1283.646997075793;1290.9096363254482;1293.2693028438903;1297.331874084847;1312.7243278911535;1182.2315494928193;1184.8459700239086;1200.543793358518;1206.2400687566776;1221.1635030004475;7391.741289054858;7474.7757567273065;7501.474896757175;7529.548227106282;7541.73603923871;475.18505762617275;483.20030349771184;486.3871521882383;487.765872381259;494.8762809297676;5282.630215884851;5283.260343551906;5285.577153827685;5285.656432331886;5315.548178404802;9471.242300615933;9619;9848.704538863845;9877.75305617351;9988.151007164328;9658.372205806741;9667.226621870233;9768.609255629695;9775.071368220008;9814.214862810957;7428.517146385468;7498.250174982567;7567.091948966159;7628.466007379541;7656.081270247606;7047.929520704727;7060.293970602898;7079.964600176966;7101.964490177723;7134.821629459305;8384.622691978997;8558.52928088961;8730.17063378978;8886.955565222133;8887.37788354809;8736.301095912184;8805.42764720291;8893.955530222307;8907.777305567153;9023.052579479323;5845.503132233808;6527.67361631926;6761.222459417033;6922.273161317989;6977.651117444006;7362.631868406451;7375.557466552024;7400.777976660709;7422.851542969002;7423.962880185781;6482;6669.966650166718;6719.059331693469;6796.218434880052;6839.213490448662;6421;6448.742050317935;6622.933770662425;6652;6714.328567143247;6915.170179578483;6925.930740692528;6960.686769095301;6974.058502102152;6978.511504194657;6221.844453888689;6329.493640508656;6344.587601805868;6346.587471814318;6348.968255158695;6382.20222472191;6390;6404.455621272244;6410.5192110592825;6413.134226879498 09:27:49 INFO - PROCESS | 16565 | |4;prototype.html;324.38205219057676;328.26304945397584;328.90297362278125;332.5875913866806;334.85433836281226;5399.595030372718;5401.135818269073;5407.567394608432;5409.837704868851;5435.347758269008;5401.891962160755;5404.945950540494;5405.081136206844;5413.242146099549;5416.864578385543;4016.3774614934587;4131.58684131586;4194.3498757692605;4209.557996410379;4258.5741425857395;4261.616454519092;4266.338717498793;4266.87199384019;4267.765272909989;4273.038566322583;4212.1996820604145;4216.177845320164;4218.240716670998;4221.831126754926;4231.301835197189;4032.334664780308;4105.322621767405;4154.896127596804;4161.771102589357;4176.60322269384;3680.024793429743;3680.5399325084363;3680.7423480356388;3681.9263614727556;3688.985528979525;5215.973920130413;5225.581953443715;5229.633925625208;5230.032443997872;5232.73836308183;4867.853964381075;4871.098846713369;4872;4874.073925954058;4874.2201247800185;5688.260526131618;5705.2012718219485;5714.257146570961;5720.8283751487525;5727.684977326246;4004;4107.137501124767;4108.301588729923;4110.938335924963;4111.09555897702;5923.17075609415;5981.611195272293;5984.910226346608;5988.550858685616;6000.729967151488;4213.157368526307;4214.030772922245;4215.367694845798;4234.174336004449;4235.957640423557;4272.124214536013;4283.528811830696;4291.6137547620865;4291.678124140702;4292.077203401283;4852.393450818648;4857.465678775332;4857.927131093036;4860;4865.172920603506;5686.715664216773;5722.399148089474;5727.140928860621;5728.627639203439;5732.140178973187;1410.3935307817533;1489.7616381378928;1522.5356266338872;1523.1698724195119;1524.8182658439575;916.5921165081475;965.16513216069;967.1730670276953;975.5268694683073;999.2006394884208;4914.066327397783;4922.803087876517;4938.2839488274;4940.530649588283;4946.1344264753525;5813.04084825999;5915.497182739516;5928.673922934194;5939.762409503658;5945.137954996501;4985.077760614298;4987.675801072919;4990.251462280615;4994.525520075587;4995.200767877122;3122.734567561737;3156.1162874395204;3162.7469802415753;3162.8418579070953;3164.3354895472207;5492.642978206404;5494.313210848644;5497.725113744297;5499.285092937893;5552.500274975271;5806.535477161817;6096.756129754849;6102.389761023862;6106.938930610637;6115.602485838406;5599.32808063035;5615.522680572197;5625.54995600351;5640.125780503947;5641.858953526031;5933.881322373615;5942.435468630473;5960.254968128984;5965.254343207099;6002.33974262822;5788.13178023283;5805.3614102447855;5808.593398462067;5836.328822185503;5842.357340692435;5462.289902312674;5632.239647647515;5633.0987042073075;5636.549076073986;5641.041023026013;4014.9561114109956;4065.5121385433936;4077.734947228421;4078.898027549335;4084.4894388201474;5951.137085122719;5955.196048533393;5960.195373624505;5961.701914904324;5964.254468191476;5724.4561766632105;5746.885062298647;5754.050581654147;5755.5683323750045;5758.646718021346;5698.54411647059;5742.28221472316;5742.913856292075;5745.454181852718;5746.569007324384;5418.485243901823;5583.525400340854;5626.85932851682;5641;5652.095664693629;5677.914831277451;5682.857928551819;5699.287589051369;5701.087825947829;5769.249997500466;5627.549796016391;5635.887282254414;5639;5639.915401268902;5640 09:27:49 INFO - PROCESS | 16565 | |5;yui.html;647.8218489915273;663.847315117523;669.7454967112496;729.2707292707289;760.5132715062358;12471.563495277667;12568.434420451078;12586.370681465936;12604.747905041893;12630.242185468878;12161.087918406132;12195.390230488485;12213.145079844415;12215.816762748565;12241.755164896696;646.6734299178908;789.9802504937365;790.1466416270429;805.0862271322062;817.4318848400364;804.995975020127;806.592670701295;811.9809638903168;812.1107387410776;813.5972693516718;842.4271495383138;850.6469815026757;851.6040041380757;851.6848765956605;852.0967774159411;671.2917871645412;827.1439060572309;838.6938767349874;841.284907828341;847.2247893177765;624.2789578037374;625.1185827982569;625.1747693045182;625.6558892609047;625.6590158363703;12850.357482125857;12876.871231287661;12899.226046437243;12915.354232288348;12923.935380323039;12230.327331996737;12760.80858787119;13031.934840325737;13083.149595276373;13136.474541018348;10116.14012808912;10167.949160254151;10173.949130254301;10265.846012309821;10442.277024290983;3299.0762586475826;3301.0756988043145;3334.4664853623544;3362.226687861781;3397.0318459238997;44554;44692;44894;44968;45533;9642.951785241028;9766;9914.900850991542;9921.702348929544;9969.700908972742;18105.818941810412;18128.728069078974;18151.546211344823;18225.45323640293;18240.81759182391;6384.616922984543;6472.093906853044;6476.190476190476;6484.02739589056;6519.837004074936;3724.385476396364;3777.3578491656485;3782.791946442917;3802.6007269236334;3828.1386687994977;2889.898853540116;2895.884164633433;2914.7085291470685;2928.985355073211;2933.5159698649486;484.3533882267213;508.4804792254444;532.8703149323459;539.9983031476633;551.6717553055926;455.34430420195474;510.18879980830656;539.0593414491738;544.3957207499673;545.2802300962691;7080.362767350963;7379.6679149438405;7406.851862962818;7516.473846830779;7901.565413902291;519.353405010764;528.7752705100316;533.02190480468;538.6741021681904;543.6629289840324;3413.5391722117693;3437.398455270368;3485;3589.2462582857893;3607.5129857469433;50398.49601504012;51220.487795121575;52748.73625631847;52977.47022529726;53428.19857702137;45070;46192.53807461949;46483.53516464792;46555.06889862184;47158.05683886303;41720.58279417167;41900.161996759896;42214.366784498256;42744.57255427406;43253;7976.322012628992;8060.516369017643;8082.595870206584;8096.676132954616;8246.463979841292;31578.842105789325;31825.8408707955;31970;32731.181720457178;32830.34339313248;40050.39924401078;40808.591914080476;40811.79594102129;40847;40894;9820.508974551101;10036.899631003596;10269.589216431557;10361.63734269297;10391;10972.01251887334;11100;11240.887591123985;11399.943000284946;11410.828837567276;10487.580496780043;10747.355158690503;10949.50727217293;11023.173262005543;11073.723156921142;10452.32059916103;10597.25819192649;10692.89307106919;10896.78206435851;10926.453677316262;10437.634682786065;10540.631077912236;10891.891081089405;10905;11143.665690029313;9054.864177037218;9215.170634642915;9244.999950322494;9292.442453452815;9400.388974716621;8766.736997890073;8990.595423206103;9104.226140778108;9255.722328330161;9506.09692079279 09:27:49 INFO - PROCESS | 16565 | __end_tp_report 09:27:49 INFO - PROCESS | 16565 | __start_cc_report 09:27:49 INFO - PROCESS | 16565 | _x_x_mozilla_cycle_collect,893 09:27:49 INFO - PROCESS | 16565 | __end_cc_report 09:27:49 INFO - PROCESS | 16565 | __startTimestamp1458318469277__endTimestamp 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | ------- Summary: start ------- 09:27:49 INFO - PROCESS | 16565 | Number of tests: 6 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | [#0] dojo.html Cycles:165 Average:4664.66 Median:4804.42 stddev:485.51 (10.1%) stddev-sans-first:459.02 09:27:49 INFO - PROCESS | 16565 | Values: 2594.3 2675.8 2680.3 2687.6 2712.6 4616.9 4686.2 4693.3 4706.8 4751.9 4684.0 4699.5 4746.3 4750.0 4781.3 4316.2 4338.9 4346.2 4382.6 4459.3 4272.3 4380.2 4410.0 4437.0 4446.7 4259.0 4315.0 4329.7 4367.7 4374.7 4325.9 4328.1 4331.0 4364.6 4369.2 4221.7 4285.5 4320.1 4323.8 4351.1 4564.1 4605.9 4617.5 4622.1 4668.6 5066.9 5086.8 5091.0 5096.1 5116.4 4888.4 4996.1 5077.1 5096.6 5098.8 4709.1 4726.2 4726.4 4770.0 4773.7 5158.5 5160.7 5163.7 5164.6 5164.8 4875.4 4905.6 5009.8 5018.1 5022.1 5011.4 5028.5 5035.3 5042.7 5089.9 4997.8 4999.0 5001.9 5002.0 5045.9 4884.1 4977.4 5009.2 5050.2 5061.1 4182.4 4215.6 4216.7 4223.5 4257.7 3663.4 3751.1 3763.4 3767.1 3782.2 4309.1 4329.8 4356.4 4384.6 4394.3 5030.7 5050.3 5053.3 5058.7 5078.1 4292.4 4342.5 4356.4 4359.0 4401.8 4485.3 4517.3 4543.3 4563.0 4570.6 4773.1 4804.1 4804.4 4805.4 4850.8 4947.1 5036.3 5043.1 5055.2 5093.1 4709.3 4758.9 4782.6 4799.3 4823.0 4994.0 5015.2 5023.5 5032.4 5069.9 4995.0 5065.9 5081.6 5088.2 5146.0 4898.1 4917.0 4920.5 4923.2 4970.0 4907.8 4912.0 4916.1 4916.4 4961.2 4767.8 4841.6 4866.8 4898.9 4908.6 4903.7 4914.3 4935.7 4961.1 4988.0 4808.6 4811.2 4824.5 4827.8 4870.3 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | [#1] ext.html Cycles:180 Average:46500.44 Median:191261.91 stddev:80882.59 (42.3%) stddev-sans-first:81035.77 09:27:49 INFO - PROCESS | 16565 | Values: 506.0 523.8 538.4 558.3 570.1 26183.3 27040.6 27093.3 35019.8 35061.3 37969.0 38556.0 38566.2 38601.6 38621.8 7550.9 7692.9 7696.0 7708.8 7742.4 7480.2 7617.9 7713.9 9784.9 10108.6 9844.4 9905.6 9913.0 9916.3 9957.9 9691.9 9749.3 9758.5 9762.5 9769.0 7430.9 9675.0 9947.6 10167.4 10182.1 34553.0 34855.1 34913.7 34942.8 34989.1 2893.2 2907.1 2936.4 3418.7 3493.4 29480.4 29725.3 29802.3 30043.7 30344.4 3333.7 3360.5 3372.9 3378.2 3450.2 245478.0 246447.0 247345.0 247630.0 247800.0 56449.0 56610.0 56753.4 56772.0 56812.4 59130.0 59304.7 59307.7 59315.7 59317.7 14354.8 14720.6 14786.7 14823.0 14826.2 10888.5 10895.2 10935.6 10937.3 10962.6 15991.4 18902.8 19430.4 19478.0 19481.0 6655.4 6900.5 6964.4 6987.0 7065.3 883.7 916.4 919.8 986.7 1046.2 23452.5 24630.9 24994.5 26348.2 26368.7 905.2 938.2 983.4 1014.8 1015.9 13549.2 14023.1 14145.8 14196.6 14242.3 320549.0 323826.0 324377.0 324779.0 325733.0 47812.0 48162.8 48245.8 48282.8 48301.0 1042.3 1135.5 1136.1 1203.6 1251.8 26144.3 27306.7 27800.4 27843.4 29503.3 43230.8 43735.8 43872.3 43988.1 44004.1 337282.0 346962.0 347322.0 347787.0 347954.0 36069.5 40774.6 41269.8 41333.2 41359.6 39072.0 39549.2 39550.0 39551.4 40054.0 32915.7 33812.7 34090.0 34201.8 34736.8 33883.7 34030.8 34241.5 34250.3 36948.3 35966.5 36222.5 36592.0 36938.8 37384.6 29798.4 31154.7 31293.7 31431.8 31842.7 24343.1 27263.2 27706.3 27716.3 27763.4 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | [#2] jquery.html Cycles:180 Average:25085.94 Median:4888.84 stddev:74266.90 (1519.1%) stddev-sans-first:74452.02 09:27:49 INFO - PROCESS | 16565 | Values: 357.1 361.0 361.6 370.4 375.8 14252.4 14525.1 14637.6 15227.6 15526.9 14984.8 15440.5 16549.9 16550.2 16555.3 4880.3 4965.8 5020.7 5023.3 5028.6 4897.3 4972.3 4996.7 4997.1 5033.8 4934.5 4985.9 4989.3 4990.1 4992.3 4756.1 4934.8 4945.3 4945.4 4950.6 4427.9 4442.4 4448.6 4451.0 4451.1 18332.2 19493.5 19678.9 19683.2 19714.5 1932.2 1944.6 1948.9 1965.5 1981.7 12777.6 12849.7 12877.2 12986.2 13026.9 1746.0 1774.1 1780.6 1822.6 1822.8 48051.8 53459.2 56682.1 57805.7 59925.4 9021.3 9328.0 9347.7 9796.8 9911.8 11609.7 11645.5 12056.2 12361.9 12438.9 7170.3 7235.9 7270.1 7396.7 7404.9 7020.4 7038.6 7147.1 7148.5 7153.4 6006.0 6104.7 6124.8 6128.2 6138.4 1779.4 1798.7 1805.3 1815.3 1851.5 844.2 883.4 935.5 939.4 951.8 16189.5 16507.7 16740.9 16766.3 17135.9 900.3 906.8 918.2 919.1 941.5 7734.8 9528.4 9822.2 9881.8 10033.3 445946.0 449257.0 453388.0 458811.0 462229.0 69529.0 69645.0 70184.0 71367.6 72406.6 987.8 988.1 997.8 1030.3 1033.2 14721.8 14816.8 15084.8 15194.4 15452.3 31925.5 33497.7 33933.8 34213.3 34258.7 43742.0 46241.3 46313.3 46620.8 47480.3 7202.5 7244.2 7443.5 7523.5 7597.1 8219.9 10809.2 10944.5 11340.4 11541.9 9591.5 9841.5 9949.7 10040.6 10062.3 9146.7 9170.0 9680.4 9921.2 10099.7 9582.9 9768.6 10083.5 10132.8 10306.8 7462.8 7545.7 7604.4 7692.7 7773.5 8639.0 9131.8 9417.8 9691.0 9830.7 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | [#3] mootools.html Cycles:180 Average:5446.70 Median:6337.04 stddev:2853.13 (45.0%) stddev-sans-first:2844.25 09:27:49 INFO - PROCESS | 16565 | Values: 1317.4 1413.6 1426.1 1573.9 1778.9 7534.7 7700.5 7707.8 7721.7 7722.8 7577.3 7782.8 7789.1 7797.2 7798.7 1981.8 2277.2 2286.1 2317.0 2344.1 2353.1 2361.7 2364.3 2364.4 2365.4 2253.5 2319.1 2325.2 2325.5 2336.9 2278.5 2320.2 2324.6 2326.5 2331.5 2302.9 2308.8 2311.1 2318.4 2334.3 7775.3 7812.2 7813.2 7827.5 7829.2 4695.5 4760.7 4782.2 4793.1 4803.9 2945.2 3040.0 3086.2 3230.3 3242.5 908.9 913.0 1004.0 1010.8 1036.5 10372.9 10392.0 10394.5 10400.9 10412.2 4304.9 4367.8 4480.7 4483.4 4485.1 8861.7 8868.1 8912.0 8941.2 8949.1 4204.3 4774.6 4787.2 4792.6 4795.4 4256.5 4286.6 4296.5 4344.7 4358.7 3730.5 3818.8 3846.8 3877.3 3893.6 1283.6 1290.9 1293.3 1297.3 1312.7 1182.2 1184.8 1200.5 1206.2 1221.2 7391.7 7474.8 7501.5 7529.5 7541.7 475.2 483.2 486.4 487.8 494.9 5282.6 5283.3 5285.6 5285.7 5315.5 9471.2 9619.0 9848.7 9877.8 9988.2 9658.4 9667.2 9768.6 9775.1 9814.2 7428.5 7498.3 7567.1 7628.5 7656.1 7047.9 7060.3 7080.0 7102.0 7134.8 8384.6 8558.5 8730.2 8887.0 8887.4 8736.3 8805.4 8894.0 8907.8 9023.1 5845.5 6527.7 6761.2 6922.3 6977.7 7362.6 7375.6 7400.8 7422.9 7424.0 6482.0 6670.0 6719.1 6796.2 6839.2 6421.0 6448.7 6622.9 6652.0 6714.3 6915.2 6925.9 6960.7 6974.1 6978.5 6221.8 6329.5 6344.6 6346.6 6349.0 6382.2 6390.0 6404.5 6410.5 6413.1 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | [#4] prototype.html Cycles:180 Average:4749.99 Median:5408.70 stddev:1387.74 (25.7%) stddev-sans-first:1351.29 09:27:49 INFO - PROCESS | 16565 | Values: 324.4 328.3 328.9 332.6 334.9 5399.6 5401.1 5407.6 5409.8 5435.3 5401.9 5404.9 5405.1 5413.2 5416.9 4016.4 4131.6 4194.3 4209.6 4258.6 4261.6 4266.3 4266.9 4267.8 4273.0 4212.2 4216.2 4218.2 4221.8 4231.3 4032.3 4105.3 4154.9 4161.8 4176.6 3680.0 3680.5 3680.7 3681.9 3689.0 5216.0 5225.6 5229.6 5230.0 5232.7 4867.9 4871.1 4872.0 4874.1 4874.2 5688.3 5705.2 5714.3 5720.8 5727.7 4004.0 4107.1 4108.3 4110.9 4111.1 5923.2 5981.6 5984.9 5988.6 6000.7 4213.2 4214.0 4215.4 4234.2 4236.0 4272.1 4283.5 4291.6 4291.7 4292.1 4852.4 4857.5 4857.9 4860.0 4865.2 5686.7 5722.4 5727.1 5728.6 5732.1 1410.4 1489.8 1522.5 1523.2 1524.8 916.6 965.2 967.2 975.5 999.2 4914.1 4922.8 4938.3 4940.5 4946.1 5813.0 5915.5 5928.7 5939.8 5945.1 4985.1 4987.7 4990.3 4994.5 4995.2 3122.7 3156.1 3162.7 3162.8 3164.3 5492.6 5494.3 5497.7 5499.3 5552.5 5806.5 6096.8 6102.4 6106.9 6115.6 5599.3 5615.5 5625.5 5640.1 5641.9 5933.9 5942.4 5960.3 5965.3 6002.3 5788.1 5805.4 5808.6 5836.3 5842.4 5462.3 5632.2 5633.1 5636.5 5641.0 4015.0 4065.5 4077.7 4078.9 4084.5 5951.1 5955.2 5960.2 5961.7 5964.3 5724.5 5746.9 5754.1 5755.6 5758.6 5698.5 5742.3 5742.9 5745.5 5746.6 5418.5 5583.5 5626.9 5641.0 5652.1 5677.9 5682.9 5699.3 5701.1 5769.2 5627.5 5635.9 5639.0 5639.9 5640.0 09:27:49 INFO - PROCESS | 16565 | 09:27:49 INFO - PROCESS | 16565 | [#5] yui.html Cycles:180 Average:12810.66 Median:44793.00 stddev:14563.83 (32.5%) stddev-sans-first:14576.04 09:27:49 INFO - PROCESS | 16565 | Values: 647.8 663.8 669.7 729.3 760.5 12471.6 12568.4 12586.4 12604.7 12630.2 12161.1 12195.4 12213.1 12215.8 12241.8 646.7 790.0 790.1 805.1 817.4 805.0 806.6 812.0 812.1 813.6 842.4 850.6 851.6 851.7 852.1 671.3 827.1 838.7 841.3 847.2 624.3 625.1 625.2 625.7 625.7 12850.4 12876.9 12899.2 12915.4 12923.9 12230.3 12760.8 13031.9 13083.1 13136.5 10116.1 10167.9 10173.9 10265.8 10442.3 3299.1 3301.1 3334.5 3362.2 3397.0 44554.0 44692.0 44894.0 44968.0 45533.0 9643.0 9766.0 9914.9 9921.7 9969.7 18105.8 18128.7 18151.5 18225.5 18240.8 6384.6 6472.1 6476.2 6484.0 6519.8 3724.4 3777.4 3782.8 3802.6 3828.1 2889.9 2895.9 2914.7 2929.0 2933.5 484.4 508.5 532.9 540.0 551.7 455.3 510.2 539.1 544.4 545.3 7080.4 7379.7 7406.9 7516.5 7901.6 519.4 528.8 533.0 538.7 543.7 3413.5 3437.4 3485.0 3589.2 3607.5 50398.5 51220.5 52748.7 52977.5 53428.2 45070.0 46192.5 46483.5 46555.1 47158.1 41720.6 41900.2 42214.4 42744.6 43253.0 7976.3 8060.5 8082.6 8096.7 8246.5 31578.8 31825.8 31970.0 32731.2 32830.3 40050.4 40808.6 40811.8 40847.0 40894.0 9820.5 10036.9 10269.6 10361.6 10391.0 10972.0 11100.0 11240.9 11399.9 11410.8 10487.6 10747.4 10949.5 11023.2 11073.7 10452.3 10597.3 10692.9 10896.8 10926.5 10437.6 10540.6 10891.9 10905.0 11143.7 9054.9 9215.2 9245.0 9292.4 9400.4 8766.7 8990.6 9104.2 9255.7 9506.1 09:27:49 INFO - PROCESS | 16565 | -------- Summary: end -------- 09:27:49 INFO - PROCESS | 16565 | 09:27:50 INFO - TEST-INFO | 16565: exit 0 09:27:50 INFO - TEST-OK | dromaeo_css | took 1116785ms 09:27:50 INFO - TEST-START | kraken 09:27:50 INFO - operating with platform_type : linux_ 09:27:50 INFO - Initialising browser for kraken test... 09:27:50 INFO - TEST-INFO | started process 16747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Jon30/profile http://localhost:48586/getInfo.html) 09:27:54 INFO - PROCESS | 16747 | __metrics Screen width/height:1600/1200 09:27:54 INFO - PROCESS | 16747 | colorDepth:24 09:27:54 INFO - PROCESS | 16747 | Browser inner width/height: 1024/697 09:27:54 INFO - PROCESS | 16747 | __metrics 09:27:55 ERROR - PROCESS | 16747 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:27:56 INFO - TEST-INFO | 16747: exit 0 09:27:56 INFO - Browser initialized. 09:27:56 INFO - Running cycle 1/1 for kraken test... 09:27:56 INFO - TEST-INFO | started process 16828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Jon30/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:08 INFO - PROCESS | 16828 | RSS: Main: 154226688 09:28:08 INFO - PROCESS | 16828 | 09:28:10 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48586/tests/kraken/driver.html?testName=audio-beat-detection) 09:28:11 INFO - PROCESS | 16828 | RSS: Main: 196825088 09:28:11 INFO - PROCESS | 16828 | 09:28:14 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48586/tests/kraken/driver.html?testName=audio-dft) 09:28:14 INFO - PROCESS | 16828 | RSS: Main: 185880576 09:28:14 INFO - PROCESS | 16828 | 09:28:17 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48586/tests/kraken/driver.html?testName=audio-fft) 09:28:18 INFO - PROCESS | 16828 | RSS: Main: 171925504 09:28:18 INFO - PROCESS | 16828 | 09:28:20 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48586/tests/kraken/driver.html?testName=audio-oscillator) 09:28:20 INFO - PROCESS | 16828 | RSS: Main: 172781568 09:28:20 INFO - PROCESS | 16828 | 09:28:23 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:28:23 INFO - PROCESS | 16828 | RSS: Main: 174960640 09:28:23 INFO - PROCESS | 16828 | 09:28:26 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48586/tests/kraken/driver.html?testName=imaging-darkroom) 09:28:27 INFO - PROCESS | 16828 | RSS: Main: 175845376 09:28:27 INFO - PROCESS | 16828 | 09:28:30 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48586/tests/kraken/driver.html?testName=imaging-desaturate) 09:28:31 INFO - PROCESS | 16828 | RSS: Main: 177463296 09:28:31 INFO - PROCESS | 16828 | 09:28:34 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48586/tests/kraken/driver.html?testName=json-parse-financial) 09:28:35 INFO - PROCESS | 16828 | RSS: Main: 176148480 09:28:35 INFO - PROCESS | 16828 | 09:28:36 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:28:37 INFO - PROCESS | 16828 | RSS: Main: 187801600 09:28:37 INFO - PROCESS | 16828 | 09:28:39 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:28:39 INFO - PROCESS | 16828 | RSS: Main: 184659968 09:28:39 INFO - PROCESS | 16828 | 09:28:41 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:42 INFO - PROCESS | 16828 | RSS: Main: 194682880 09:28:42 INFO - PROCESS | 16828 | 09:28:44 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:45 INFO - PROCESS | 16828 | RSS: Main: 199778304 09:28:45 INFO - PROCESS | 16828 | 09:28:47 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:48 INFO - PROCESS | 16828 | RSS: Main: 198975488 09:28:48 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:48586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48586/tests/kraken/driver.html?testName=ai-astar) 09:28:50 INFO - PROCESS | 16828 | RSS: Main: 258494464 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | __start_tp_report 09:28:50 INFO - PROCESS | 16828 | _x_x_mozilla_page_load 09:28:50 INFO - PROCESS | 16828 | _x_x_mozilla_page_load_details 09:28:50 INFO - PROCESS | 16828 | |i|pagename|runs| 09:28:50 INFO - PROCESS | 16828 | |0;ai-astar;112;116;108;111;113;111;101;112;113;114 09:28:50 INFO - PROCESS | 16828 | |1;audio-beat-detection;161;137;163;173;142;156;150;135;179;133 09:28:50 INFO - PROCESS | 16828 | |2;audio-dft;163;163;160;162;161;161;161;162;162;161 09:28:50 INFO - PROCESS | 16828 | |3;audio-fft;74;74;96;97;74;76;74;127;93;73 09:28:50 INFO - PROCESS | 16828 | |4;audio-oscillator;94;96;133;93;94;93;132;93;93;128 09:28:50 INFO - PROCESS | 16828 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;117;117;117 09:28:50 INFO - PROCESS | 16828 | |6;imaging-darkroom;147;147;146;148;146;146;147;147;147;147 09:28:50 INFO - PROCESS | 16828 | |7;imaging-desaturate;96;96;95;96;95;95;95;96;95;95 09:28:50 INFO - PROCESS | 16828 | |8;json-parse-financial;64;64;65;65;65;64;65;74;63;62 09:28:50 INFO - PROCESS | 16828 | |9;json-stringify-tinderbox;64;65;64;63;65;64;65;65;64;65 09:28:50 INFO - PROCESS | 16828 | |10;stanford-crypto-aes;80;82;83;82;89;89;80;82;82;91 09:28:50 INFO - PROCESS | 16828 | |11;stanford-crypto-ccm;123;116;121;115;118;125;114;123;118;122 09:28:50 INFO - PROCESS | 16828 | |12;stanford-crypto-pbkdf2;129;133;142;139;139;133;138;141;142;141 09:28:50 INFO - PROCESS | 16828 | |13;stanford-crypto-sha256-iterative;66;66;66;70;67;67;67;67;68;67 09:28:50 INFO - PROCESS | 16828 | __end_tp_report 09:28:50 INFO - PROCESS | 16828 | __start_cc_report 09:28:50 INFO - PROCESS | 16828 | _x_x_mozilla_cycle_collect,1125 09:28:50 INFO - PROCESS | 16828 | __end_cc_report 09:28:50 INFO - PROCESS | 16828 | __startTimestamp1458318530591__endTimestamp 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | ------- Summary: start ------- 09:28:50 INFO - PROCESS | 16828 | Number of tests: 14 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:4.12 (3.7%) stddev-sans-first:4.36 09:28:50 INFO - PROCESS | 16828 | Values: 112.0 116.0 108.0 111.0 113.0 111.0 101.0 112.0 113.0 114.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:158.50 stddev:16.19 (10.2%) stddev-sans-first:16.90 09:28:50 INFO - PROCESS | 16828 | Values: 161.0 137.0 163.0 173.0 142.0 156.0 150.0 135.0 179.0 133.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 09:28:50 INFO - PROCESS | 16828 | Values: 163.0 163.0 160.0 162.0 161.0 161.0 161.0 162.0 162.0 161.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#3] audio-fft Cycles:10 Average:85.80 Median:75.00 stddev:17.62 (23.5%) stddev-sans-first:18.17 09:28:50 INFO - PROCESS | 16828 | Values: 74.0 74.0 96.0 97.0 74.0 76.0 74.0 127.0 93.0 73.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:93.00 stddev:18.08 (19.4%) stddev-sans-first:18.74 09:28:50 INFO - PROCESS | 16828 | Values: 94.0 96.0 133.0 93.0 94.0 93.0 132.0 93.0 93.0 128.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 09:28:50 INFO - PROCESS | 16828 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:28:50 INFO - PROCESS | 16828 | Values: 147.0 147.0 146.0 148.0 146.0 146.0 147.0 147.0 147.0 147.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:28:50 INFO - PROCESS | 16828 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:3.28 (5.0%) stddev-sans-first:3.46 09:28:50 INFO - PROCESS | 16828 | Values: 64.0 64.0 65.0 65.0 65.0 64.0 65.0 74.0 63.0 62.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 09:28:50 INFO - PROCESS | 16828 | Values: 64.0 65.0 64.0 63.0 65.0 64.0 65.0 65.0 64.0 65.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.50 stddev:4.06 (4.9%) stddev-sans-first:4.03 09:28:50 INFO - PROCESS | 16828 | Values: 80.0 82.0 83.0 82.0 89.0 89.0 80.0 82.0 82.0 91.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:121.50 stddev:3.81 (3.1%) stddev-sans-first:3.82 09:28:50 INFO - PROCESS | 16828 | Values: 123.0 116.0 121.0 115.0 118.0 125.0 114.0 123.0 118.0 122.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.70 Median:140.00 stddev:4.50 (3.2%) stddev-sans-first:3.50 09:28:50 INFO - PROCESS | 16828 | Values: 129.0 133.0 142.0 139.0 139.0 133.0 138.0 141.0 142.0 141.0 09:28:50 INFO - PROCESS | 16828 | 09:28:50 INFO - PROCESS | 16828 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 09:28:50 INFO - PROCESS | 16828 | Values: 66.0 66.0 66.0 70.0 67.0 67.0 67.0 67.0 68.0 67.0 09:28:50 INFO - PROCESS | 16828 | -------- Summary: end -------- 09:28:50 INFO - PROCESS | 16828 | 09:28:51 INFO - TEST-INFO | 16828: exit 0 09:28:51 INFO - TEST-OK | kraken | took 61486ms 09:28:51 INFO - SUITE-END | took 1178s 09:28:51 INFO - Completed test suite (00:19:38) 09:28:51 INFO - javascript benchmark 09:28:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2594.2736033910505, 2675.7748411538346, 2680.2897232233463, 2687.556553168727, 2712.64735584374, 4616.861494155172, 4686.226772582524, 4693.319468677039, 4706.8352607658735, 4751.90496190076, 4684.0, 4699.506551812062, 4746.264329028997, 4749.952500474994, 4781.282807578865, 4316.20150272199, 4338.934915976263, 4346.15250026245, 4382.561743825624, 4459.308807134899, 4272.337787642905, 4380.167768124063, 4409.977950110245, 4436.97781511092, 4446.71096378736, 4258.978705106486, 4314.978425107885, 4329.740215587075, 4367.650587952956, 4374.693771436001, 4325.870223893288, 4328.069465065026, 4331.025519258142, 4364.585364390377, 4369.235383807821, 4221.6833737469815, 4285.485741710983, 4320.13597280542, 4323.762193079379, 4351.0862718829085, 4564.132814765184, 4605.884852878671, 4617.468991066037, 4622.12179685862, 4668.5564871337165, 5066.923996140061, 5086.771095300684, 5090.974545127251, 5096.108181068335, 5116.386033675945, 4888.41339039314, 4996.100701873661, 5077.111505486562, 5096.592272618182, 5098.770555325019, 4709.128811169944, 4726.243800991825, 4726.409198850144, 4769.976150119262, 4773.689710168828, 5158.509941555546, 5160.690358578422, 5163.690178589221, 5164.56101231392, 5164.8192313268855, 4875.366202393737, 4905.583025442806, 5009.799608015712, 5018.146915024455, 5022.096022715946, 5011.373578302712, 5028.497150284942, 5035.345405097387, 5042.697438153723, 5089.898202035939, 4997.750112494361, 4999.0, 5001.924971125436, 5001.974990125026, 5045.873853153627, 4884.145274576935, 4977.352944117241, 5009.223570346602, 5050.191969284897, 5061.063703214917, 4182.435371224907, 4215.57844215576, 4216.683748718859, 4223.472065991751, 4257.723247988871, 3663.377225871608, 3751.0622344413896, 3763.360228761117, 3767.05823544114, 3782.1868298315994, 4309.052008558112, 4329.848455304049, 4356.3683265926265, 4384.649228061748, 4394.252976993918, 5030.698158110525, 5050.343455350854, 5053.343065401547, 5058.671186372874, 5078.13671675816, 4292.377605247221, 4342.522322544518, 4356.3683265926265, 4358.956410435919, 4401.823927042947, 4485.304777759387, 4517.254652982221, 4543.34121552373, 4563.018950925567, 4570.611498022638, 4773.09311230865, 4804.0872234275375, 4804.42346918372, 4805.423349198119, 4850.7817148227705, 4947.1342515059005, 5036.294918711456, 5043.067032598981, 5055.241713742821, 5093.1341671915125, 4709.317149013443, 4758.857234282977, 4782.641301902441, 4799.28010798383, 4822.95177048225, 4993.950060499348, 5015.22264049073, 5023.547880690755, 5032.3961124665275, 5069.8732531687, 4994.9750251248515, 5065.873353166053, 5081.618878584047, 5088.211327244283, 5146.0, 4898.142825005539, 4917.0, 4920.507949205051, 4923.163062279493, 4970.030843985388, 4907.779149938333, 4911.99304142657, 4916.115099282163, 4916.434610019894, 4961.231009193581, 4767.809287628456, 4841.644339584922, 4866.829660961849, 4898.926516102332, 4908.6073114151495, 4903.656744028027, 4914.336564563881, 4935.728534930613, 4961.107000739901, 4987.950120498748, 4808.63935204868, 4811.230203167476, 4824.469308376146, 4827.806887724451, 4870.31815545831], "unit": "score", "name": "dojo.html", "value": 4634.054986565328}, {"lowerIsBetter": false, "replicates": [505.98735031624227, 523.7826302084635, 538.4346436241946, 558.3244274427942, 570.0821677099868, 26183.345416364602, 27040.594391084123, 27093.322666933313, 35019.82490087546, 35061.2987740245, 37969.0, 38556.0, 38566.22867542647, 38601.61398386015, 38621.80689096558, 7550.88673669894, 7692.923070769305, 7695.961520192392, 7708.768736937873, 7742.419318551103, 7480.17718051014, 7617.885731714029, 7713.920051192809, 9784.902150978505, 10108.646197383094, 9844.360116592434, 9905.603775848957, 9912.950435247814, 9916.256280778935, 9957.900420995806, 9691.90308096917, 9749.268804839594, 9758.463284519348, 9762.511874406251, 9769.0, 7430.925690743077, 9675.0, 9947.552360143738, 10167.389956602627, 10182.13451856593, 34553.0, 34855.1286217844, 34913.650863491544, 34942.82528587366, 34989.12527186815, 2893.208332918227, 2907.1133304342166, 2936.3574074258, 3418.6923176914197, 3493.388726880519, 29480.41039179226, 29725.256868578243, 29802.254943626365, 30043.69956300431, 30344.393112137634, 3333.749968752353, 3360.462326027848, 3372.898813035613, 3378.1554611347165, 3450.1547120955524, 245477.99999999822, 246447.0, 247345.0, 247630.0, 247800.0, 56449.0, 56610.0, 56753.43246567564, 56772.0, 56812.43187568154, 59130.0, 59304.70347648234, 59307.70346148328, 59315.70342148262, 59317.703411483526, 14354.784678229835, 14720.558383248519, 14786.704265914621, 14823.0, 14826.184559849311, 10888.455577221108, 10895.237333386587, 10935.56257749681, 10937.343759374464, 10962.616308429167, 15991.440299589458, 18902.81097189038, 19430.417087487396, 19478.0, 19481.0, 6655.367740064686, 6900.482463815234, 6964.408025317804, 6987.0, 7065.293470652894, 883.7127933421535, 916.3860213656866, 919.8482250428605, 986.7483791633088, 1046.2205656785743, 23452.530949381257, 24630.876845615658, 24994.500109997698, 26348.20955371342, 26368.73631263701, 905.2305540290832, 938.2212763406357, 983.3804703037041, 1014.7666036811574, 1015.8679371681782, 13549.187048777105, 14023.088499247517, 14145.787813182811, 14196.574102776933, 14242.287885605678, 320549.0, 323826.0, 324377.0, 324779.0, 325733.0, 47812.04375912532, 48162.759186203846, 48245.75877120592, 48282.758586206844, 48301.033979320215, 1042.3276986343765, 1135.517405102828, 1136.1478890831877, 1203.5667159822458, 1251.7997120460682, 26144.346391339608, 27306.726932731213, 27800.44399111966, 27843.409543885944, 29503.26241843971, 43230.783846080565, 43735.78132109319, 43872.34191487194, 43988.12023759571, 44004.11991760211, 337282.0, 346962.0, 347322.0, 347787.0, 347954.0, 36069.45895811512, 40774.59225407708, 41269.793651031556, 41333.173336533706, 41359.586404135574, 39072.00143197338, 39549.209015820095, 39550.0, 39551.40672889967, 40054.0, 32915.67084329222, 33812.661873381934, 34090.0, 34201.82899085488, 34736.82631586826, 33883.66116338805, 34030.8298458516, 34241.486377703855, 34250.314993700486, 36948.26103477862, 35966.460503092996, 36222.45666314955, 36592.0, 36938.8153059233, 37384.626153738114, 29798.404031918806, 31154.688453115177, 31293.687063129077, 31431.842840785648, 31842.68157318397, 24343.14798982027, 27263.182104536896, 27706.307342316602, 27716.30709232285, 27763.44473110486], "unit": "score", "name": "ext.html", "value": 17785.805575450246}, {"lowerIsBetter": false, "replicates": [357.12326239083035, 360.96029436761955, 361.5769549626936, 370.4147447033687, 375.8158502333854, 14252.358643861013, 14525.055871368353, 14637.634059148526, 15227.619309517268, 15526.92236538817, 14984.775228371584, 15440.536783896501, 16549.91725041376, 16550.172491375444, 16555.25501352439, 4880.341153944225, 4965.751712414383, 5020.673656212352, 5023.32185155003, 5028.622853286, 4897.338859254009, 4972.3038774571405, 4996.700197988114, 4997.125503036954, 5033.84898453047, 4934.5312195341385, 4985.900281994358, 4989.301497790312, 4990.126727822617, 4992.32603598515, 4756.143894099061, 4934.753262336869, 4945.282933974553, 4945.3818272715735, 4950.603951683875, 4427.867163985085, 4442.444694413199, 4448.599626033641, 4450.955490445086, 4451.109778044404, 18332.175052122686, 19493.51266218356, 19678.901605492025, 19683.212671493122, 19714.50713732154, 1932.1884808380514, 1944.5819148882917, 1948.9317873874347, 1965.508622844289, 1981.6730239510464, 12777.552785652457, 12849.67875803103, 12877.162984406077, 12986.22082675033, 13026.881183171818, 1746.0, 1774.0597483333725, 1780.6349698311815, 1822.6263615958828, 1822.8450581700438, 48051.75974120142, 53459.19811202835, 56682.149767753515, 57805.710971445296, 59925.400745992854, 9021.32340074497, 9327.953360233156, 9347.672831451002, 9796.804063918682, 9911.80176396468, 11609.709757255967, 11645.53417863293, 12056.216345937486, 12361.93819030917, 12438.937805311096, 7170.282971702788, 7235.8552828944175, 7270.127584689871, 7396.704131834666, 7404.851902961911, 7020.368166865007, 7038.577685338896, 7147.106611673541, 7148.46386521013, 7153.427725781925, 6005.969970150209, 6104.694765261719, 6124.816255512342, 6128.17269668598, 6138.416850399205, 1779.3772179736989, 1798.685230084756, 1805.3049575913367, 1815.2738904438331, 1851.5093500222451, 844.2359664503634, 883.3895837799288, 935.4901578639658, 939.3612343606277, 951.8429459139164, 16189.514314570582, 16507.669846603, 16740.916295418447, 16766.32934682599, 17135.914320428317, 900.320258205051, 906.8413027720122, 918.2241006349624, 919.0671468459519, 941.4727752458645, 7734.7679569613, 9528.380655257524, 9822.165115965223, 9881.80236395268, 10033.297669163234, 445946.0, 449257.0, 453388.0, 458811.0, 462229.0, 69529.0, 69645.0, 70184.0, 71367.64316178385, 72406.63796680982, 987.7678745494803, 988.081084591337, 997.7904640025675, 1030.294248439821, 1033.204432586904, 14721.779173312194, 14816.777748334, 15084.849151508344, 15194.392224310905, 15452.304646291168, 31925.521117183725, 33497.66502334945, 33933.830330848185, 34213.31573368568, 34258.65741342555, 43742.0, 46241.30638040365, 46313.3053004212, 46620.7668961653, 47480.287795683784, 7202.53183543068, 7244.203137654748, 7443.516171448839, 7523.548587084792, 7597.126330471845, 8219.917800821915, 10809.18931080188, 10944.45277736094, 11340.376279304717, 11541.884581154081, 9591.520423978913, 9841.507924603884, 9949.651762188289, 10040.64857729976, 10062.345947513388, 9146.679866204651, 9170.037146099563, 9680.41917484925, 9921.15670168015, 10099.7475063124, 9582.856257156009, 9768.560414781494, 10083.546240419051, 10132.83472400654, 10306.793864122825, 7462.776116716507, 7545.660445279866, 7604.429667774828, 7692.653830577749, 7773.533587984739, 8638.956805215934, 9131.77170570741, 9417.764555886157, 9690.95154524223, 9830.705078847646], "unit": "score", "name": "jquery.html", "value": 8037.786791602037}, {"lowerIsBetter": false, "replicates": [1317.3874148520936, 1413.5652312902403, 1426.108682073704, 1573.8504842040008, 1778.9110544472774, 7534.736284230053, 7700.5379677219335, 7707.845843083135, 7721.652525636346, 7722.768316950501, 7577.280158384945, 7782.805429864256, 7789.065312162535, 7797.2202779722, 7798.688052477894, 1981.7522809648794, 2277.2257432472957, 2286.1084177170874, 2317.0268487235317, 2344.050659482912, 2353.14110349722, 2361.7284012338628, 2364.2788949370433, 2364.4207169243473, 2365.4322962488964, 2253.4929640830765, 2319.1071437496603, 2325.2326732178426, 2325.5232677301115, 2336.859788412692, 2278.4759505313787, 2320.234322673514, 2324.6048171810835, 2326.464913069995, 2331.4521087544413, 2302.940647302243, 2308.815294776414, 2311.052468487912, 2318.374039009475, 2334.299710086967, 7775.300222979902, 7812.179721129256, 7813.17961614028, 7827.452078354518, 7829.217078292125, 4695.530446955311, 4760.690555113906, 4782.187028205179, 4793.065352256312, 4803.927941080887, 2945.2489615148, 3039.9848000760076, 3086.1975886269734, 3230.3216324571868, 3242.4649932761067, 908.9409188402733, 912.9908700912972, 1003.9949800250952, 1010.7725761703631, 1036.4662198967537, 10372.948135259276, 10392.012758787903, 10394.532246048946, 10400.947995259976, 10412.167026637851, 4304.91390172201, 4367.759773212504, 4480.708753930984, 4483.417155769795, 4485.125400546862, 8861.689840855668, 8868.11318868108, 8912.019677835433, 8941.239994600532, 8949.149830766068, 4204.26425375558, 4774.618030557547, 4787.2101103318255, 4792.616590672737, 4795.400574928134, 4256.489221293465, 4286.592773686495, 4296.462942132233, 4344.739315641072, 4358.694891357574, 3730.4963829883163, 3818.770873747584, 3846.769193848378, 3877.263319969253, 3893.6495715385186, 1283.646997075793, 1290.9096363254482, 1293.2693028438903, 1297.331874084847, 1312.7243278911535, 1182.2315494928193, 1184.8459700239086, 1200.543793358518, 1206.2400687566776, 1221.1635030004475, 7391.741289054858, 7474.7757567273065, 7501.474896757175, 7529.548227106282, 7541.73603923871, 475.18505762617275, 483.20030349771184, 486.3871521882383, 487.765872381259, 494.8762809297676, 5282.630215884851, 5283.260343551906, 5285.577153827685, 5285.656432331886, 5315.548178404802, 9471.242300615933, 9619.0, 9848.704538863845, 9877.75305617351, 9988.151007164328, 9658.372205806741, 9667.226621870233, 9768.609255629695, 9775.071368220008, 9814.214862810957, 7428.517146385468, 7498.250174982567, 7567.091948966159, 7628.466007379541, 7656.081270247606, 7047.929520704727, 7060.293970602898, 7079.964600176966, 7101.964490177723, 7134.821629459305, 8384.622691978997, 8558.52928088961, 8730.17063378978, 8886.955565222133, 8887.37788354809, 8736.301095912184, 8805.42764720291, 8893.955530222307, 8907.777305567153, 9023.052579479323, 5845.503132233808, 6527.67361631926, 6761.222459417033, 6922.273161317989, 6977.651117444006, 7362.631868406451, 7375.557466552024, 7400.777976660709, 7422.851542969002, 7423.962880185781, 6482.0, 6669.966650166718, 6719.059331693469, 6796.218434880052, 6839.213490448662, 6421.0, 6448.742050317935, 6622.933770662425, 6652.0, 6714.328567143247, 6915.170179578483, 6925.930740692528, 6960.686769095301, 6974.058502102152, 6978.511504194657, 6221.844453888689, 6329.493640508656, 6344.587601805868, 6346.587471814318, 6348.968255158695, 6382.20222472191, 6390.0, 6404.455621272244, 6410.5192110592825, 6413.134226879498], "unit": "score", "name": "mootools.html", "value": 4402.297099856957}, {"lowerIsBetter": false, "replicates": [324.38205219057676, 328.26304945397584, 328.90297362278125, 332.5875913866806, 334.85433836281226, 5399.595030372718, 5401.135818269073, 5407.567394608432, 5409.837704868851, 5435.347758269008, 5401.891962160755, 5404.945950540494, 5405.081136206844, 5413.242146099549, 5416.864578385543, 4016.3774614934587, 4131.58684131586, 4194.3498757692605, 4209.557996410379, 4258.5741425857395, 4261.616454519092, 4266.338717498793, 4266.87199384019, 4267.765272909989, 4273.038566322583, 4212.1996820604145, 4216.177845320164, 4218.240716670998, 4221.831126754926, 4231.301835197189, 4032.334664780308, 4105.322621767405, 4154.896127596804, 4161.771102589357, 4176.60322269384, 3680.024793429743, 3680.5399325084363, 3680.7423480356388, 3681.9263614727556, 3688.985528979525, 5215.973920130413, 5225.581953443715, 5229.633925625208, 5230.032443997872, 5232.73836308183, 4867.853964381075, 4871.098846713369, 4872.0, 4874.073925954058, 4874.2201247800185, 5688.260526131618, 5705.2012718219485, 5714.257146570961, 5720.8283751487525, 5727.684977326246, 4004.0, 4107.137501124767, 4108.301588729923, 4110.938335924963, 4111.09555897702, 5923.17075609415, 5981.611195272293, 5984.910226346608, 5988.550858685616, 6000.729967151488, 4213.157368526307, 4214.030772922245, 4215.367694845798, 4234.174336004449, 4235.957640423557, 4272.124214536013, 4283.528811830696, 4291.6137547620865, 4291.678124140702, 4292.077203401283, 4852.393450818648, 4857.465678775332, 4857.927131093036, 4860.0, 4865.172920603506, 5686.715664216773, 5722.399148089474, 5727.140928860621, 5728.627639203439, 5732.140178973187, 1410.3935307817533, 1489.7616381378928, 1522.5356266338872, 1523.1698724195119, 1524.8182658439575, 916.5921165081475, 965.16513216069, 967.1730670276953, 975.5268694683073, 999.2006394884208, 4914.066327397783, 4922.803087876517, 4938.2839488274, 4940.530649588283, 4946.1344264753525, 5813.04084825999, 5915.497182739516, 5928.673922934194, 5939.762409503658, 5945.137954996501, 4985.077760614298, 4987.675801072919, 4990.251462280615, 4994.525520075587, 4995.200767877122, 3122.734567561737, 3156.1162874395204, 3162.7469802415753, 3162.8418579070953, 3164.3354895472207, 5492.642978206404, 5494.313210848644, 5497.725113744297, 5499.285092937893, 5552.500274975271, 5806.535477161817, 6096.756129754849, 6102.389761023862, 6106.938930610637, 6115.602485838406, 5599.32808063035, 5615.522680572197, 5625.54995600351, 5640.125780503947, 5641.858953526031, 5933.881322373615, 5942.435468630473, 5960.254968128984, 5965.254343207099, 6002.33974262822, 5788.13178023283, 5805.3614102447855, 5808.593398462067, 5836.328822185503, 5842.357340692435, 5462.289902312674, 5632.239647647515, 5633.0987042073075, 5636.549076073986, 5641.041023026013, 4014.9561114109956, 4065.5121385433936, 4077.734947228421, 4078.898027549335, 4084.4894388201474, 5951.137085122719, 5955.196048533393, 5960.195373624505, 5961.701914904324, 5964.254468191476, 5724.4561766632105, 5746.885062298647, 5754.050581654147, 5755.5683323750045, 5758.646718021346, 5698.54411647059, 5742.28221472316, 5742.913856292075, 5745.454181852718, 5746.569007324384, 5418.485243901823, 5583.525400340854, 5626.85932851682, 5641.0, 5652.095664693629, 5677.914831277451, 5682.857928551819, 5699.287589051369, 5701.087825947829, 5769.249997500466, 5627.549796016391, 5635.887282254414, 5639.0, 5639.915401268902, 5640.0], "unit": "score", "name": "prototype.html", "value": 4307.443941290256}, {"lowerIsBetter": false, "replicates": [647.8218489915273, 663.847315117523, 669.7454967112496, 729.2707292707289, 760.5132715062358, 12471.563495277667, 12568.434420451078, 12586.370681465936, 12604.747905041893, 12630.242185468878, 12161.087918406132, 12195.390230488485, 12213.145079844415, 12215.816762748565, 12241.755164896696, 646.6734299178908, 789.9802504937365, 790.1466416270429, 805.0862271322062, 817.4318848400364, 804.995975020127, 806.592670701295, 811.9809638903168, 812.1107387410776, 813.5972693516718, 842.4271495383138, 850.6469815026757, 851.6040041380757, 851.6848765956605, 852.0967774159411, 671.2917871645412, 827.1439060572309, 838.6938767349874, 841.284907828341, 847.2247893177765, 624.2789578037374, 625.1185827982569, 625.1747693045182, 625.6558892609047, 625.6590158363703, 12850.357482125857, 12876.871231287661, 12899.226046437243, 12915.354232288348, 12923.935380323039, 12230.327331996737, 12760.80858787119, 13031.934840325737, 13083.149595276373, 13136.474541018348, 10116.14012808912, 10167.949160254151, 10173.949130254301, 10265.846012309821, 10442.277024290983, 3299.0762586475826, 3301.0756988043145, 3334.4664853623544, 3362.226687861781, 3397.0318459238997, 44554.0, 44692.0, 44894.0, 44968.0, 45533.0, 9642.951785241028, 9766.0, 9914.900850991542, 9921.702348929544, 9969.700908972742, 18105.818941810412, 18128.728069078974, 18151.546211344823, 18225.45323640293, 18240.81759182391, 6384.616922984543, 6472.093906853044, 6476.190476190476, 6484.02739589056, 6519.837004074936, 3724.385476396364, 3777.3578491656485, 3782.791946442917, 3802.6007269236334, 3828.1386687994977, 2889.898853540116, 2895.884164633433, 2914.7085291470685, 2928.985355073211, 2933.5159698649486, 484.3533882267213, 508.4804792254444, 532.8703149323459, 539.9983031476633, 551.6717553055926, 455.34430420195474, 510.18879980830656, 539.0593414491738, 544.3957207499673, 545.2802300962691, 7080.362767350963, 7379.6679149438405, 7406.851862962818, 7516.473846830779, 7901.565413902291, 519.353405010764, 528.7752705100316, 533.02190480468, 538.6741021681904, 543.6629289840324, 3413.5391722117693, 3437.398455270368, 3485.0, 3589.2462582857893, 3607.5129857469433, 50398.49601504012, 51220.487795121575, 52748.73625631847, 52977.47022529726, 53428.19857702137, 45070.0, 46192.53807461949, 46483.53516464792, 46555.06889862184, 47158.05683886303, 41720.58279417167, 41900.161996759896, 42214.366784498256, 42744.57255427406, 43253.0, 7976.322012628992, 8060.516369017643, 8082.595870206584, 8096.676132954616, 8246.463979841292, 31578.842105789325, 31825.8408707955, 31970.0, 32731.181720457178, 32830.34339313248, 40050.39924401078, 40808.591914080476, 40811.79594102129, 40847.0, 40894.0, 9820.508974551101, 10036.899631003596, 10269.589216431557, 10361.63734269297, 10391.0, 10972.01251887334, 11100.0, 11240.887591123985, 11399.943000284946, 11410.828837567276, 10487.580496780043, 10747.355158690503, 10949.50727217293, 11023.173262005543, 11073.723156921142, 10452.32059916103, 10597.25819192649, 10692.89307106919, 10896.78206435851, 10926.453677316262, 10437.634682786065, 10540.631077912236, 10891.891081089405, 10905.0, 11143.665690029313, 9054.864177037218, 9215.170634642915, 9244.999950322494, 9292.442453452815, 9400.388974716621, 8766.736997890073, 8990.595423206103, 9104.226140778108, 9255.722328330161, 9506.09692079279], "unit": "score", "name": "yui.html", "value": 5867.244682779087}], "name": "dromaeo_css", "value": 6475.270819125369}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 116.0, 108.0, 111.0, 113.0, 111.0, 101.0, 112.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [161.0, 137.0, 163.0, 173.0, 142.0, 156.0, 150.0, 135.0, 179.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 160.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 96.0, 97.0, 74.0, 76.0, 74.0, 127.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 133.0, 93.0, 94.0, 93.0, 132.0, 93.0, 93.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 74.0, 63.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 83.0, 82.0, 89.0, 89.0, 80.0, 82.0, 82.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [123.0, 116.0, 121.0, 115.0, 118.0, 125.0, 114.0, 123.0, 118.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [129.0, 133.0, 142.0, 139.0, 139.0, 133.0, 138.0, 141.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 70.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1513.2}]} 09:28:51 INFO - Return code: 0 09:28:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:28:51 ERROR - # TBPL SUCCESS # 09:28:51 INFO - Running post-action listener: _resource_record_post_action 09:28:51 INFO - Running post-run listener: _resource_record_post_run 09:28:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 532443136; Read time: 188; Write time: 572988 09:28:52 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 246034432; Read time: 0; Write time: 401432 09:28:52 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286408704; Read time: 188; Write time: 171556 09:28:52 INFO - Running post-run listener: _upload_blobber_files 09:28:52 INFO - Blob upload gear active. 09:28:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:28:52 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 09:28:52 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'] 09:28:52 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 09:28:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:28:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:28:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:28:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:54 INFO - (blobuploader) - INFO - Done attempting. 09:28:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:28:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:28:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:55 INFO - (blobuploader) - INFO - Done attempting. 09:28:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:28:55 INFO - Return code: 0 09:28:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:28:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:28:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d63f4a5e455aa81b8308b9c3970ca3bb11746f5b43801e447553d5fa4b43663074e440de360e4b354ce59a8a3a1850bdab968455c33f155b9dc28436d15b790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daee4d41d2b4cf4a18a446c3850edbe47152d31f476448eda8f854f5392c12bb46ae5bf2f37fe813943d44ac4a6bd452269b5730f236e38aa763f6b5d80abdea"} 09:28:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:28:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:28:55 INFO - Contents: 09:28:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d63f4a5e455aa81b8308b9c3970ca3bb11746f5b43801e447553d5fa4b43663074e440de360e4b354ce59a8a3a1850bdab968455c33f155b9dc28436d15b790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daee4d41d2b4cf4a18a446c3850edbe47152d31f476448eda8f854f5392c12bb46ae5bf2f37fe813943d44ac4a6bd452269b5730f236e38aa763f6b5d80abdea"} 09:28:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:28:55 INFO - Copying logs to upload dir... 09:28:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:28:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.448387 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-18 09:28:54.390249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:28:54.393333) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 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/d63f4a5e455aa81b8308b9c3970ca3bb11746f5b43801e447553d5fa4b43663074e440de360e4b354ce59a8a3a1850bdab968455c33f155b9dc28436d15b790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daee4d41d2b4cf4a18a446c3850edbe47152d31f476448eda8f854f5392c12bb46ae5bf2f37fe813943d44ac4a6bd452269b5730f236e38aa763f6b5d80abdea"} build_url:https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/dEusLzdIRgG6mab_M6gxbg/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/d63f4a5e455aa81b8308b9c3970ca3bb11746f5b43801e447553d5fa4b43663074e440de360e4b354ce59a8a3a1850bdab968455c33f155b9dc28436d15b790a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daee4d41d2b4cf4a18a446c3850edbe47152d31f476448eda8f854f5392c12bb46ae5bf2f37fe813943d44ac4a6bd452269b5730f236e38aa763f6b5d80abdea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:28:54.425486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:28:54.425818) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458312767.750150-1299460513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:28:54.473883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:28:54.474208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:28:54.474483) ========= ========= Total master_lag: 0.27 =========