builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1458126926.07 results: success (0) buildid: 20160316025546 builduid: e0d577403d934075896813836e9b0302 revision: d49937a2e5fe27e469781ea09c42aa2a142cf77d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.070420) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.070853) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.071154) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006461 basedir: '/builds/slave/test' ========= master_lag: 0.11 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.191576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.191894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.205393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.205766) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.255056) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.255362) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.255711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.256000) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 04:15:26-- 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% 70.9M=0s 2016-03-16 04:15:26 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.199899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.468157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.468523) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014735 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.517356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:26.517671) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d49937a2e5fe27e469781ea09c42aa2a142cf77d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d49937a2e5fe27e469781ea09c42aa2a142cf77d --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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 04:15:26,659 truncating revision to first 12 chars 2016-03-16 04:15:26,659 Setting DEBUG logging. 2016-03-16 04:15:26,659 attempt 1/10 2016-03-16 04:15:26,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d49937a2e5fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 04:15:27,293 unpacking tar archive at: mozilla-central-d49937a2e5fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:27.435415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:27.435776) ========= echo d49937a2e5fe27e469781ea09c42aa2a142cf77d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd49937a2e5fe27e469781ea09c42aa2a142cf77d'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d49937a2e5fe27e469781ea09c42aa2a142cf77d program finished with exit code 0 elapsedTime=0.004704 script_repo_revision: 'd49937a2e5fe27e469781ea09c42aa2a142cf77d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:27.485432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:27.485718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 04:15:27.495379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-16 04:15:27.495658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:15:27 INFO - MultiFileLogger online at 20160316 04:15:27 in /builds/slave/test 04:15:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:15:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:15:27 INFO - {'append_to_log': False, 04:15:27 INFO - 'base_work_dir': '/builds/slave/test', 04:15:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:15:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:15:27 INFO - 'branch': 'Firefox-Non-PGO', 04:15:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:27 INFO - 'config_files': ('talos/linux_config.py',), 04:15:27 INFO - 'default_actions': ('clobber', 04:15:27 INFO - 'read-buildbot-config', 04:15:27 INFO - 'download-and-extract', 04:15:27 INFO - 'populate-webroot', 04:15:27 INFO - 'create-virtualenv', 04:15:27 INFO - 'install', 04:15:27 INFO - 'run-tests'), 04:15:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:27 INFO - 'download_minidump_stackwalk': True, 04:15:27 INFO - 'download_symbols': 'ondemand', 04:15:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:27 INFO - 'installer_path': 'installer.exe', 04:15:27 INFO - 'log_level': 'info', 04:15:27 INFO - 'log_name': 'talos', 04:15:27 INFO - 'log_to_console': True, 04:15:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:15:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:15:27 INFO - 'opt_config_files': (), 04:15:27 INFO - 'pip_index': False, 04:15:27 INFO - 'sps_profile': False, 04:15:27 INFO - 'sps_profile_interval': 0, 04:15:27 INFO - 'suite': 'dromaeojs', 04:15:27 INFO - 'system_bits': '32', 04:15:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:27 INFO - 'title': 'talos-linux64-ix-041', 04:15:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:27 INFO - 'use_talos_json': True, 04:15:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:15:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:27 INFO - 'work_dir': 'build'} 04:15:27 INFO - ##### 04:15:27 INFO - ##### Running clobber step. 04:15:27 INFO - ##### 04:15:27 INFO - Running pre-action listener: _resource_record_pre_action 04:15:27 INFO - Running main action method: clobber 04:15:27 INFO - rmtree: /builds/slave/test/build 04:15:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:15:28 INFO - Running post-action listener: _resource_record_post_action 04:15:28 INFO - ##### 04:15:28 INFO - ##### Running read-buildbot-config step. 04:15:28 INFO - ##### 04:15:28 INFO - Running pre-action listener: _resource_record_pre_action 04:15:28 INFO - Running main action method: read_buildbot_config 04:15:28 INFO - Using buildbot properties: 04:15:28 INFO - { 04:15:28 INFO - "project": "", 04:15:28 INFO - "product": "firefox", 04:15:28 INFO - "script_repo_revision": "production", 04:15:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:15:28 INFO - "repository": "", 04:15:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:15:28 INFO - "buildid": "20160316025546", 04:15:28 INFO - "pgo_build": "False", 04:15:28 INFO - "basedir": "/builds/slave/test", 04:15:28 INFO - "buildnumber": 450, 04:15:28 INFO - "slavename": "talos-linux64-ix-041", 04:15:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:15:28 INFO - "platform": "ubuntu64_hw", 04:15:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:15:28 INFO - "branch": "mozilla-central", 04:15:28 INFO - "repo_path": "mozilla-central", 04:15:28 INFO - "revision": "d49937a2e5fe27e469781ea09c42aa2a142cf77d", 04:15:28 INFO - "stage_platform": "linux64", 04:15:28 INFO - "builduid": "e0d577403d934075896813836e9b0302", 04:15:28 INFO - "slavebuilddir": "test" 04:15:28 INFO - } 04:15:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:15:28 INFO - Running post-action listener: _resource_record_post_action 04:15:28 INFO - ##### 04:15:28 INFO - ##### Running download-and-extract step. 04:15:28 INFO - ##### 04:15:28 INFO - Running pre-action listener: _resource_record_pre_action 04:15:28 INFO - Running main action method: download_and_extract 04:15:28 INFO - mkdir: /builds/slave/test/build/tests 04:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:28 INFO - https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:33 INFO - Downloaded 1361 bytes. 04:15:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:15:33 INFO - Using the following test package requirements: 04:15:33 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:15:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:15:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'jsshell-linux-x86_64.zip'], 04:15:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:15:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:15:33 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:15:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:15:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:15:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:15:33 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')]} 04:15:33 INFO - https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:38 INFO - Downloaded 21992660 bytes. 04:15:38 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'] 04:15:38 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 04:15:39 INFO - Return code: 0 04:15:39 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 04:15: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')]} 04:15:39 INFO - https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:40 INFO - Downloaded 21992660 bytes. 04:15:40 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'] 04:15:40 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 04:15:41 INFO - Return code: 0 04:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:41 INFO - https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:42 INFO - Downloaded 10846462 bytes. 04:15:42 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'] 04:15:42 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 04:15:43 INFO - Return code: 0 04:15: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')]} 04:15:43 INFO - https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZp2DGNeScabibSmRxVnRg/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 04:15:44 INFO - Downloaded 54094269 bytes. 04:15:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:15:44 INFO - mkdir: /builds/slave/test/properties 04:15:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:15:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:15:44 INFO - Contents: 04:15:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:15:45 INFO - Running post-action listener: _resource_record_post_action 04:15:45 INFO - Running post-action listener: set_extra_try_arguments 04:15:45 INFO - ##### 04:15:45 INFO - ##### Running populate-webroot step. 04:15:45 INFO - ##### 04:15:45 INFO - Running pre-action listener: _resource_record_pre_action 04:15:45 INFO - Running main action method: populate_webroot 04:15:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:15:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:15:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:15:45 INFO - '--tppagecycles', 04:15:45 INFO - '7'], 04:15:45 INFO - 'tests': ['tsvgm']}}, 04:15:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:15:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:15:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:15:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:15:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'tests': ['damp', 'tps']}, 04:15:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['damp', 'tps']}, 04:15:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:15:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:15:45 INFO - 'other': {'tests': ['a11yr', 04:15:45 INFO - 'ts_paint', 04:15:45 INFO - 'tpaint', 04:15:45 INFO - 'sessionrestore', 04:15:45 INFO - 'sessionrestore_no_auto_restore', 04:15:45 INFO - 'tabpaint']}, 04:15:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['a11yr', 04:15:45 INFO - 'ts_paint', 04:15:45 INFO - 'tpaint', 04:15:45 INFO - 'sessionrestore', 04:15:45 INFO - 'sessionrestore_no_auto_restore', 04:15:45 INFO - 'tabpaint']}, 04:15:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['a11yr', 04:15:45 INFO - 'ts_paint', 04:15:45 INFO - 'tpaint', 04:15:45 INFO - 'sessionrestore', 04:15:45 INFO - 'sessionrestore_no_auto_restore', 04:15:45 INFO - 'tabpaint']}, 04:15:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['a11yr', 04:15:45 INFO - 'ts_paint', 04:15:45 INFO - 'tpaint', 04:15:45 INFO - 'sessionrestore', 04:15:45 INFO - 'sessionrestore_no_auto_restore', 04:15:45 INFO - 'tabpaint']}, 04:15:45 INFO - 'other_l64': {'tests': ['a11yr', 04:15:45 INFO - 'ts_paint', 04:15:45 INFO - 'tpaint', 04:15:45 INFO - 'sessionrestore', 04:15:45 INFO - 'sessionrestore_no_auto_restore', 04:15:45 INFO - 'tabpaint']}, 04:15:45 INFO - 'other_nol64': {'tests': ['a11yr', 04:15:45 INFO - 'ts_paint', 04:15:45 INFO - 'tpaint', 04:15:45 INFO - 'sessionrestore', 04:15:45 INFO - 'sessionrestore_no_auto_restore', 04:15:45 INFO - 'tabpaint']}, 04:15:45 INFO - 'svgr': {'tests': ['tsvgx', 04:15:45 INFO - 'tsvgr_opacity', 04:15:45 INFO - 'tart', 04:15:45 INFO - 'tscrollx', 04:15:45 INFO - 'cart']}, 04:15:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['tsvgx', 04:15:45 INFO - 'tsvgr_opacity', 04:15:45 INFO - 'tart', 04:15:45 INFO - 'tscrollx', 04:15:45 INFO - 'cart']}, 04:15:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'tests': ['tp5o']}, 04:15:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'talos_options': ['--e10s'], 04:15:45 INFO - 'tests': ['tp5o']}, 04:15:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'talos_options': ['--xperf_path', 04:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:45 INFO - 'tests': ['tp5n']}, 04:15:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:45 INFO - 'talos_options': ['--e10s', 04:15:45 INFO - '--xperf_path', 04:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:45 INFO - 'tests': ['tp5n']}}, 04:15:45 INFO - 'talos.zip': {'path': '', 04:15:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:15:45 INFO - Running post-action listener: _resource_record_post_action 04:15:45 INFO - ##### 04:15:45 INFO - ##### Running create-virtualenv step. 04:15:45 INFO - ##### 04:15:45 INFO - Running pre-action listener: _resource_record_pre_action 04:15:45 INFO - Running main action method: create_virtualenv 04:15:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:15:45 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 04:15:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:15:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:15:45 INFO - Using real prefix '/usr' 04:15:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:15:47 INFO - Installing pip.................done. 04:15:47 INFO - Return code: 0 04:15:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:15:47 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')]} 04:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:47 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')]} 04:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:47 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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:15:47 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 04:15:47 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 04:15:47 INFO - Using env: {'DISPLAY': ':0', 04:15:47 INFO - 'HOME': '/home/cltbld', 04:15:47 INFO - 'LANG': 'en_US.UTF-8', 04:15:47 INFO - 'LANGUAGE': 'en_US:en', 04:15:47 INFO - 'LOGNAME': 'cltbld', 04:15:47 INFO - 'MAIL': '/var/mail/cltbld', 04:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:47 INFO - 'MOZ_NO_REMOTE': '1', 04:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:47 INFO - 'NO_EM_RESTART': '1', 04:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:47 INFO - 'PWD': '/builds/slave/test', 04:15:47 INFO - 'SHELL': '/bin/bash', 04:15:47 INFO - 'SHLVL': '1', 04:15:47 INFO - 'TERM': 'linux', 04:15:47 INFO - 'TMOUT': '86400', 04:15:47 INFO - 'USER': 'cltbld', 04:15:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:47 INFO - '_': '/tools/buildbot/bin/python'} 04:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:47 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 04:15:47 INFO - Cleaning up... 04:15:47 INFO - Return code: 0 04:15:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:15:47 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')]} 04:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:47 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')]} 04:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:47 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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:15:47 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 04:15:47 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 04:15:47 INFO - Using env: {'DISPLAY': ':0', 04:15:47 INFO - 'HOME': '/home/cltbld', 04:15:47 INFO - 'LANG': 'en_US.UTF-8', 04:15:47 INFO - 'LANGUAGE': 'en_US:en', 04:15:47 INFO - 'LOGNAME': 'cltbld', 04:15:47 INFO - 'MAIL': '/var/mail/cltbld', 04:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:47 INFO - 'MOZ_NO_REMOTE': '1', 04:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:47 INFO - 'NO_EM_RESTART': '1', 04:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:47 INFO - 'PWD': '/builds/slave/test', 04:15:47 INFO - 'SHELL': '/bin/bash', 04:15:47 INFO - 'SHLVL': '1', 04:15:47 INFO - 'TERM': 'linux', 04:15:47 INFO - 'TMOUT': '86400', 04:15:47 INFO - 'USER': 'cltbld', 04:15:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:47 INFO - '_': '/tools/buildbot/bin/python'} 04:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:48 INFO - Downloading/unpacking psutil>=0.7.1 04:15:48 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 04:15:48 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 04:15:48 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 04:15:48 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 04:15:48 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 04:15:48 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 04:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:50 INFO - Installing collected packages: psutil 04:15:50 INFO - Running setup.py install for psutil 04:15:50 INFO - building 'psutil._psutil_linux' extension 04:15:50 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 04:15:50 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 04:15:50 INFO - building 'psutil._psutil_posix' extension 04:15:50 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 04:15:50 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 04:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:50 INFO - Successfully installed psutil 04:15:50 INFO - Cleaning up... 04:15:50 INFO - Return code: 0 04:15:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:15: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')]} 04:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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')]} 04:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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', '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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:15: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:15: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 mozsystemmonitor==0.0.0 04:15:50 INFO - Using env: {'DISPLAY': ':0', 04:15:50 INFO - 'HOME': '/home/cltbld', 04:15:50 INFO - 'LANG': 'en_US.UTF-8', 04:15:50 INFO - 'LANGUAGE': 'en_US:en', 04:15:50 INFO - 'LOGNAME': 'cltbld', 04:15:50 INFO - 'MAIL': '/var/mail/cltbld', 04:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:50 INFO - 'MOZ_NO_REMOTE': '1', 04:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:50 INFO - 'NO_EM_RESTART': '1', 04:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:50 INFO - 'PWD': '/builds/slave/test', 04:15:50 INFO - 'SHELL': '/bin/bash', 04:15:50 INFO - 'SHLVL': '1', 04:15:50 INFO - 'TERM': 'linux', 04:15:50 INFO - 'TMOUT': '86400', 04:15:50 INFO - 'USER': 'cltbld', 04:15:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:50 INFO - '_': '/tools/buildbot/bin/python'} 04:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:15:52 INFO - Installing collected packages: mozsystemmonitor 04:15:52 INFO - Running setup.py install for mozsystemmonitor 04:15:52 INFO - Successfully installed mozsystemmonitor 04:15:52 INFO - Cleaning up... 04:15:52 INFO - Return code: 0 04:15:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:15:52 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')]} 04:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:52 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')]} 04:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:52 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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:15:52 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 04:15:52 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 04:15:52 INFO - Using env: {'DISPLAY': ':0', 04:15:52 INFO - 'HOME': '/home/cltbld', 04:15:52 INFO - 'LANG': 'en_US.UTF-8', 04:15:52 INFO - 'LANGUAGE': 'en_US:en', 04:15:52 INFO - 'LOGNAME': 'cltbld', 04:15:52 INFO - 'MAIL': '/var/mail/cltbld', 04:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:52 INFO - 'MOZ_NO_REMOTE': '1', 04:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:52 INFO - 'NO_EM_RESTART': '1', 04:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:52 INFO - 'PWD': '/builds/slave/test', 04:15:52 INFO - 'SHELL': '/bin/bash', 04:15:52 INFO - 'SHLVL': '1', 04:15:52 INFO - 'TERM': 'linux', 04:15:52 INFO - 'TMOUT': '86400', 04:15:52 INFO - 'USER': 'cltbld', 04:15:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:52 INFO - '_': '/tools/buildbot/bin/python'} 04:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:15:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:15:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:55 INFO - Downloading docopt-0.6.1.tar.gz 04:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:15:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:15:55 INFO - Running setup.py install for blobuploader 04:15:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:15:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:15:55 INFO - Running setup.py install for requests 04:15:56 INFO - Running setup.py install for docopt 04:15:56 INFO - Successfully installed blobuploader requests docopt 04:15:56 INFO - Cleaning up... 04:15:56 INFO - Return code: 0 04:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:56 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')]} 04:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:56 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')]} 04:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:56 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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:15:56 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 04:15:56 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 04:15:56 INFO - Using env: {'DISPLAY': ':0', 04:15:56 INFO - 'HOME': '/home/cltbld', 04:15:56 INFO - 'LANG': 'en_US.UTF-8', 04:15:56 INFO - 'LANGUAGE': 'en_US:en', 04:15:56 INFO - 'LOGNAME': 'cltbld', 04:15:56 INFO - 'MAIL': '/var/mail/cltbld', 04:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:56 INFO - 'MOZ_NO_REMOTE': '1', 04:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:56 INFO - 'NO_EM_RESTART': '1', 04:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:56 INFO - 'PWD': '/builds/slave/test', 04:15:56 INFO - 'SHELL': '/bin/bash', 04:15:56 INFO - 'SHLVL': '1', 04:15:56 INFO - 'TERM': 'linux', 04:15:56 INFO - 'TMOUT': '86400', 04:15:56 INFO - 'USER': 'cltbld', 04:15:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:56 INFO - '_': '/tools/buildbot/bin/python'} 04:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:56 INFO - Running setup.py (path:/tmp/pip-BWpiij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:56 INFO - Running setup.py (path:/tmp/pip-Mw4nvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:56 INFO - Running setup.py (path:/tmp/pip-jWiDl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:56 INFO - Running setup.py (path:/tmp/pip-Nc_k2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:56 INFO - Running setup.py (path:/tmp/pip-sMsrnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:56 INFO - Running setup.py (path:/tmp/pip-FUHXi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:56 INFO - Running setup.py (path:/tmp/pip-L7kiB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:56 INFO - Running setup.py (path:/tmp/pip-ys156S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:56 INFO - Running setup.py (path:/tmp/pip-ddlqV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:57 INFO - Running setup.py (path:/tmp/pip-LizxXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:57 INFO - Running setup.py (path:/tmp/pip-_n6Fix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:57 INFO - Running setup.py (path:/tmp/pip-Oqw3qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:57 INFO - Running setup.py (path:/tmp/pip-itzlV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:57 INFO - Running setup.py (path:/tmp/pip-cYtLp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:57 INFO - Running setup.py (path:/tmp/pip-Q7GlbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:57 INFO - Running setup.py (path:/tmp/pip-3LYank-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:57 INFO - Running setup.py (path:/tmp/pip-B2tucX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:15:57 INFO - Running setup.py install for manifestparser 04:15:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:15:57 INFO - Running setup.py install for mozcrash 04:15:57 INFO - Running setup.py install for mozdebug 04:15:57 INFO - Running setup.py install for mozdevice 04:15:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Running setup.py install for mozfile 04:15:58 INFO - Running setup.py install for mozhttpd 04:15:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Running setup.py install for mozinfo 04:15:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Running setup.py install for mozInstall 04:15:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Running setup.py install for mozleak 04:15:58 INFO - Running setup.py install for mozlog 04:15:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Running setup.py install for moznetwork 04:15:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Running setup.py install for mozprocess 04:15:58 INFO - Running setup.py install for mozprofile 04:15:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:15:58 INFO - Running setup.py install for mozrunner 04:15:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:15:59 INFO - Running setup.py install for mozscreenshot 04:15:59 INFO - Running setup.py install for moztest 04:15:59 INFO - Running setup.py install for mozversion 04:15:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:15:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:15:59 INFO - Cleaning up... 04:15:59 INFO - Return code: 0 04:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:59 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')]} 04:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:59 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')]} 04:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:59 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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:15:59 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 04:15:59 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 04:15:59 INFO - Using env: {'DISPLAY': ':0', 04:15:59 INFO - 'HOME': '/home/cltbld', 04:15:59 INFO - 'LANG': 'en_US.UTF-8', 04:15:59 INFO - 'LANGUAGE': 'en_US:en', 04:15:59 INFO - 'LOGNAME': 'cltbld', 04:15:59 INFO - 'MAIL': '/var/mail/cltbld', 04:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:59 INFO - 'MOZ_NO_REMOTE': '1', 04:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:59 INFO - 'NO_EM_RESTART': '1', 04:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:59 INFO - 'PWD': '/builds/slave/test', 04:15:59 INFO - 'SHELL': '/bin/bash', 04:15:59 INFO - 'SHLVL': '1', 04:15:59 INFO - 'TERM': 'linux', 04:15:59 INFO - 'TMOUT': '86400', 04:15:59 INFO - 'USER': 'cltbld', 04:15:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:59 INFO - '_': '/tools/buildbot/bin/python'} 04:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:59 INFO - Running setup.py (path:/tmp/pip-n0EYQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:59 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)) 04:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:59 INFO - Running setup.py (path:/tmp/pip-zCPjzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:59 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)) 04:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:59 INFO - Running setup.py (path:/tmp/pip-fGuffS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:59 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)) 04:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:59 INFO - Running setup.py (path:/tmp/pip-oRbrCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:59 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)) 04:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:59 INFO - Running setup.py (path:/tmp/pip-pKtY1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:59 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)) 04:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:59 INFO - Running setup.py (path:/tmp/pip-Wi5Im0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:00 INFO - Running setup.py (path:/tmp/pip-1iXu_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:00 INFO - Running setup.py (path:/tmp/pip-6nUJZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:00 INFO - Running setup.py (path:/tmp/pip-a7n6nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:00 INFO - Running setup.py (path:/tmp/pip-YgEl66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:00 INFO - Running setup.py (path:/tmp/pip-4ZDCzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:00 INFO - Running setup.py (path:/tmp/pip-7fKiXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:00 INFO - Running setup.py (path:/tmp/pip-pdmh6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:00 INFO - Running setup.py (path:/tmp/pip-O1CBqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:00 INFO - Running setup.py (path:/tmp/pip-yAlfdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:00 INFO - Running setup.py (path:/tmp/pip-mrMg2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:00 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)) 04:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:00 INFO - Running setup.py (path:/tmp/pip-TXaNE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:00 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)) 04:16:00 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)) 04:16:00 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)) 04:16:00 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)) 04:16:00 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)) 04:16:00 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)) 04:16:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:00 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 04:16:00 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 04:16:00 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 04:16:00 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 04:16:00 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 04:16:00 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 04:16:02 INFO - Downloading blessings-1.6.tar.gz 04:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:02 INFO - Installing collected packages: blessings 04:16:02 INFO - Running setup.py install for blessings 04:16:02 INFO - Successfully installed blessings 04:16:02 INFO - Cleaning up... 04:16:02 INFO - Return code: 0 04:16:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:03 INFO - Reading from file tmpfile_stdout 04:16:03 INFO - Current package versions: 04:16:03 INFO - argparse == 1.2.1 04:16:03 INFO - blessings == 1.6 04:16:03 INFO - blobuploader == 1.2.4 04:16:03 INFO - docopt == 0.6.1 04:16:03 INFO - manifestparser == 1.1 04:16:03 INFO - mozInstall == 1.12 04:16:03 INFO - mozcrash == 0.17 04:16:03 INFO - mozdebug == 0.1 04:16:03 INFO - mozdevice == 0.48 04:16:03 INFO - mozfile == 1.2 04:16:03 INFO - mozhttpd == 0.7 04:16:03 INFO - mozinfo == 0.9 04:16:03 INFO - mozleak == 0.1 04:16:03 INFO - mozlog == 3.1 04:16:03 INFO - moznetwork == 0.27 04:16:03 INFO - mozprocess == 0.22 04:16:03 INFO - mozprofile == 0.28 04:16:03 INFO - mozrunner == 6.11 04:16:03 INFO - mozscreenshot == 0.1 04:16:03 INFO - mozsystemmonitor == 0.0 04:16:03 INFO - moztest == 0.7 04:16:03 INFO - mozversion == 1.4 04:16:03 INFO - psutil == 3.1.1 04:16:03 INFO - requests == 1.2.3 04:16:03 INFO - wsgiref == 0.1.2 04:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:03 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')]} 04:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:03 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')]} 04:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:03 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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:16:03 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 04:16:03 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 04:16:03 INFO - Using env: {'DISPLAY': ':0', 04:16:03 INFO - 'HOME': '/home/cltbld', 04:16:03 INFO - 'LANG': 'en_US.UTF-8', 04:16:03 INFO - 'LANGUAGE': 'en_US:en', 04:16:03 INFO - 'LOGNAME': 'cltbld', 04:16:03 INFO - 'MAIL': '/var/mail/cltbld', 04:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:03 INFO - 'MOZ_NO_REMOTE': '1', 04:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:03 INFO - 'NO_EM_RESTART': '1', 04:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:03 INFO - 'PWD': '/builds/slave/test', 04:16:03 INFO - 'SHELL': '/bin/bash', 04:16:03 INFO - 'SHLVL': '1', 04:16:03 INFO - 'TERM': 'linux', 04:16:03 INFO - 'TMOUT': '86400', 04:16:03 INFO - 'USER': 'cltbld', 04:16:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:03 INFO - '_': '/tools/buildbot/bin/python'} 04:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 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)) 04:16:03 INFO - Cleaning up... 04:16:03 INFO - Return code: 0 04:16:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:03 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')]} 04:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:03 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')]} 04:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:03 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 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:16:03 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 04:16:03 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 04:16:03 INFO - Using env: {'DISPLAY': ':0', 04:16:03 INFO - 'HOME': '/home/cltbld', 04:16:03 INFO - 'LANG': 'en_US.UTF-8', 04:16:03 INFO - 'LANGUAGE': 'en_US:en', 04:16:03 INFO - 'LOGNAME': 'cltbld', 04:16:03 INFO - 'MAIL': '/var/mail/cltbld', 04:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:03 INFO - 'MOZ_NO_REMOTE': '1', 04:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:03 INFO - 'NO_EM_RESTART': '1', 04:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:03 INFO - 'PWD': '/builds/slave/test', 04:16:03 INFO - 'SHELL': '/bin/bash', 04:16:03 INFO - 'SHLVL': '1', 04:16:03 INFO - 'TERM': 'linux', 04:16:03 INFO - 'TMOUT': '86400', 04:16:03 INFO - 'USER': 'cltbld', 04:16:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:03 INFO - '_': '/tools/buildbot/bin/python'} 04:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:03 INFO - Downloading/unpacking jsonschema 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:05 INFO - Downloading/unpacking functools32 (from jsonschema) 04:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:05 INFO - warning: no files found matching '*.txt' 04:16:05 INFO - no previously-included directories found matching 'build' 04:16:05 INFO - no previously-included directories found matching 'dist' 04:16:05 INFO - no previously-included directories found matching '.git*' 04:16:05 INFO - Installing collected packages: jsonschema, functools32 04:16:05 INFO - Running setup.py install for functools32 04:16:05 INFO - warning: no files found matching '*.txt' 04:16:05 INFO - no previously-included directories found matching 'build' 04:16:05 INFO - no previously-included directories found matching 'dist' 04:16:05 INFO - no previously-included directories found matching '.git*' 04:16:05 INFO - Successfully installed jsonschema functools32 04:16:05 INFO - Cleaning up... 04:16:05 INFO - Return code: 0 04:16:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc224e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', '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 04:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:16:05 INFO - Using env: {'DISPLAY': ':0', 04:16:05 INFO - 'HOME': '/home/cltbld', 04:16:05 INFO - 'LANG': 'en_US.UTF-8', 04:16:05 INFO - 'LANGUAGE': 'en_US:en', 04:16:05 INFO - 'LOGNAME': 'cltbld', 04:16:05 INFO - 'MAIL': '/var/mail/cltbld', 04:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:05 INFO - 'MOZ_NO_REMOTE': '1', 04:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:05 INFO - 'NO_EM_RESTART': '1', 04:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:05 INFO - 'PWD': '/builds/slave/test', 04:16:05 INFO - 'SHELL': '/bin/bash', 04:16:05 INFO - 'SHLVL': '1', 04:16:05 INFO - 'TERM': 'linux', 04:16:05 INFO - 'TMOUT': '86400', 04:16:05 INFO - 'USER': 'cltbld', 04:16:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:05 INFO - '_': '/tools/buildbot/bin/python'} 04:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:06 INFO - Downloading/unpacking flake8 04:16:06 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 04:16:06 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 04:16:06 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 04:16:06 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 04:16:06 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 04:16:06 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 04:16:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:16:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:16:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 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 04:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:08 INFO - no previously-included directories found matching 'docs/_build' 04:16:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:16:08 INFO - Running setup.py install for pep8 04:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:08 INFO - no previously-included directories found matching 'docs/_build' 04:16:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:16:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:16:08 INFO - Cleaning up... 04:16:08 INFO - Return code: 0 04:16:08 INFO - Running post-action listener: _resource_record_post_action 04:16:08 INFO - Running post-action listener: _start_resource_monitoring 04:16:08 INFO - Starting resource monitoring. 04:16:08 INFO - ##### 04:16:08 INFO - ##### Running install step. 04:16:08 INFO - ##### 04:16:08 INFO - Running pre-action listener: _resource_record_pre_action 04:16:08 INFO - Running main action method: install 04:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:09 INFO - Reading from file tmpfile_stdout 04:16:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:09 INFO - Reading from file tmpfile_stdout 04:16:09 INFO - Output received: 04:16:09 INFO - Usage: mozinstall [options] installer 04:16:09 INFO - Options: 04:16:09 INFO - -h, --help show this help message and exit 04:16:09 INFO - -d DEST, --destination=DEST 04:16:09 INFO - Directory to install application into. [default: 04:16:09 INFO - "/builds/slave/test"] 04:16:09 INFO - --app=APP Application being installed. [default: firefox] 04:16:09 INFO - mkdir: /builds/slave/test/build/application 04:16:09 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'] 04:16:09 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 04:16:24 INFO - Reading from file tmpfile_stdout 04:16:24 INFO - Output received: 04:16:24 INFO - /builds/slave/test/build/application/firefox/firefox 04:16:24 INFO - Running post-action listener: _resource_record_post_action 04:16:24 INFO - ##### 04:16:24 INFO - ##### Running run-tests step. 04:16:24 INFO - ##### 04:16:24 INFO - Running pre-action listener: _resource_record_pre_action 04:16:24 INFO - Running main action method: run_tests 04:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:16:24 INFO - Python 2.7.3 04:16:24 INFO - Return code: 0 04:16:24 INFO - grabbing minidump binary from tooltool 04:16:24 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')]} 04:16:24 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 0x27ff160>, '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 0x2800060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28004f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:16:24 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 04:16:24 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 04:16:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:16:24 INFO - Return code: 0 04:16:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:16:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:16:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:16:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:16:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:16:25 INFO - Return code: 0 04:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 04:16:25 INFO - Using env: {'DISPLAY': ':0', 04:16:25 INFO - 'HOME': '/home/cltbld', 04:16:25 INFO - 'LANG': 'en_US.UTF-8', 04:16:25 INFO - 'LANGUAGE': 'en_US:en', 04:16:25 INFO - 'LOGNAME': 'cltbld', 04:16:25 INFO - 'MAIL': '/var/mail/cltbld', 04:16:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:16:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:25 INFO - 'MOZ_NO_REMOTE': '1', 04:16:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:25 INFO - 'NO_EM_RESTART': '1', 04:16:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:25 INFO - 'PWD': '/builds/slave/test', 04:16:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:16:25 INFO - 'SHELL': '/bin/bash', 04:16:25 INFO - 'SHLVL': '1', 04:16:25 INFO - 'TERM': 'linux', 04:16:25 INFO - 'TMOUT': '86400', 04:16:25 INFO - 'USER': 'cltbld', 04:16:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704', 04:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:25 INFO - '_': '/tools/buildbot/bin/python'} 04:16:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:16:26 INFO - mozversion application_buildid: 20160316025546 04:16:26 INFO - mozversion application_changeset: d49937a2e5fe27e469781ea09c42aa2a142cf77d 04:16:26 INFO - mozversion application_display_name: Nightly 04:16:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:16:26 INFO - mozversion application_name: Firefox 04:16:26 INFO - mozversion application_remotingname: firefox 04:16:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:16:26 INFO - mozversion application_vendor: Mozilla 04:16:26 INFO - mozversion application_version: 48.0a1 04:16:26 INFO - mozversion platform_buildid: 20160316025546 04:16:26 INFO - mozversion platform_changeset: d49937a2e5fe27e469781ea09c42aa2a142cf77d 04:16:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:16:26 INFO - mozversion platform_version: 48.0a1 04:16:26 INFO - using testdate: 1458126986 04:16:26 INFO - actual date: 1458126986 04:16:26 INFO - starting webserver on 'localhost:54784' 04:16:26 INFO - SUITE-START | Running 2 tests 04:16:26 INFO - TEST-START | dromaeo_css 04:16:26 INFO - operating with platform_type : linux_ 04:16:26 INFO - Initialising browser for dromaeo_css test... 04:16:26 INFO - TEST-INFO | started process 13659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFudqZ5/profile http://localhost:54784/getInfo.html) 04:16:30 INFO - PROCESS | 13659 | __metrics Screen width/height:1600/1200 04:16:30 INFO - PROCESS | 13659 | colorDepth:24 04:16:30 INFO - PROCESS | 13659 | Browser inner width/height: 1024/697 04:16:30 INFO - PROCESS | 13659 | __metrics 04:16:31 ERROR - PROCESS | 13659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:16:32 INFO - TEST-INFO | 13659: exit 0 04:16:32 INFO - Browser initialized. 04:16:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:16:32 INFO - TEST-INFO | started process 13751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFudqZ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:44 INFO - PROCESS | 13751 | RSS: Main: 154435584 04:16:44 INFO - PROCESS | 13751 | 04:17:35 INFO - PROCESS | 13751 | 1458127055285 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] 04:19:46 INFO - PROCESS | 13751 | Cycle 1(1): loaded http://localhost:54784/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54784/tests/dromaeo/cssquery-ext.html) 04:19:48 INFO - PROCESS | 13751 | RSS: Main: 277966848 04:19:48 INFO - PROCESS | 13751 | 04:22:50 INFO - PROCESS | 13751 | Cycle 1(1): loaded http://localhost:54784/tests/dromaeo/cssquery-ext.html (next: http://localhost:54784/tests/dromaeo/cssquery-jquery.html) 04:22:51 INFO - PROCESS | 13751 | RSS: Main: 239677440 04:22:51 INFO - PROCESS | 13751 | 04:25:53 INFO - PROCESS | 13751 | Cycle 1(1): loaded http://localhost:54784/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54784/tests/dromaeo/cssquery-mootools.html) 04:25:53 INFO - PROCESS | 13751 | RSS: Main: 242778112 04:25:53 INFO - PROCESS | 13751 | 04:28:55 INFO - PROCESS | 13751 | Cycle 1(1): loaded http://localhost:54784/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54784/tests/dromaeo/cssquery-prototype.html) 04:28:56 INFO - PROCESS | 13751 | RSS: Main: 212246528 04:28:56 INFO - PROCESS | 13751 | 04:31:58 INFO - PROCESS | 13751 | Cycle 1(1): loaded http://localhost:54784/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54784/tests/dromaeo/cssquery-yui.html) 04:31:59 INFO - PROCESS | 13751 | RSS: Main: 207118336 04:31:59 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | Cycle 1(1): loaded http://localhost:54784/tests/dromaeo/cssquery-yui.html (next: http://localhost:54784/tests/dromaeo/cssquery-dojo.html) 04:35:02 INFO - PROCESS | 13751 | RSS: Main: 272912384 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | __start_tp_report 04:35:02 INFO - PROCESS | 13751 | _x_x_mozilla_page_load 04:35:02 INFO - PROCESS | 13751 | _x_x_mozilla_page_load_details 04:35:02 INFO - PROCESS | 13751 | |i|pagename|runs| 04:35:02 INFO - PROCESS | 13751 | |0;dojo.html;2591.196729014005;2638.6174004769296;2657.973420265798;2677.477891811098;2694.797890158238;4630.861074167776;4642.767861606923;4643.117807616554;4646.233371493699;4684.6252299816015;4750.049990001996;4810.663253572251;4815.542523460274;4834.830780922668;4844.128056949757;4278.550752171024;4279.978600106995;4292.720973136752;4319.028218650794;4400.537943515933;4339.761313127777;4368.606825385715;4397.252467080588;4421.270490369101;4422.09347083847;4227.682923780729;4297.699161058727;4313.482382114166;4313.784310784479;4405.185040767452;4225.78871056449;4244.681648876347;4251.553586873365;4255.148970205972;4257.063446041866;4229.302165142748;4229.97885010573;4230.428892099558;4233.174530966463;4233.745975241495;4526.728396296233;4536.115457485792;4546.181687296285;4619.699719518254;4665.2768820832825;5031.597472202215;5038.924416133761;5042.3949126104735;5047.570956468705;5090.236464530313;5061.924071138936;5063.063333283354;5069;5071.56891664209;5104.948950510485;4614.400127983375;4681.625469962395;4718.882027949328;4751.59611433032;4763.618910487153;5084.3644544431945;5132.3327967364;5138.87152821175;5139.871503212449;5147.613928955343;4850.587700045536;4899.632527560376;4900.362952816111;4901.068796928572;4971.925421118686;4953.23224900141;4989;5037.395512538519;5056.342675452242;5060.797568097309;4946.579540739078;4947.134251505972;4958.429780575208;4959.429665588431;5007.24891266313;4919.2867034279825;4927.162382395001;4929.260610908321;4935.580475659609;4977.825776097891;4210.7684077375425;4213.873583792491;4231.196072746168;4291.03451723366;4298.26929421999;3670.44943258508;3689.24370504046;3698.1863989922713;3715.479832823407;3735.6077611850365;4262.041040765865;4312.180685669713;4314.892127696833;4331.350297455344;4368.104538569649;5071.8985620287385;5077.822276220315;5085.1355269604255;5130.717810520383;5146.356705411824;4340.717853339523;4379.233634114017;4386.736795792199;4389.18800021997;4391.934120988188;4458.063806600585;4534.433195850519;4560.817567297271;4567.10941366437;4591.127685739765;4773.71357718538;4798.7840547174765;4805.4233491979785;4807.831725889577;4851.345068415719;5063.696178229318;5067.974660126676;5078;5080.00939816747;5122.615803814654;4719.929201061918;4741.739204343794;4788.521147885183;4806.447258565309;4852.611791056777;4964.975175124101;4979.626528010342;4990.50094990498;4993.850184494471;5014.197728363591;5031.22016087507;5043.949560504348;5044.470330615232;5066.69599823997;5096.923546146737;4775.2359622460235;4874.878128046827;4903.387076615423;4926.852194434173;4966.379202599675;4891.779869905791;4913.189323761682;4922.163232250455;4923.483034281492;4969.652124351261;4788.090262850047;4820.035992801384;4826.8793280168275;4858.246971719389;4879.634027447884;4661.463931647904;4797.160496913096;4886.486918873609;4902.558769710743;4988.650794444354;4761.595264402565;4768.880777980578;4818.325434439252;4823.758812059453;4835.178019736582 04:35:02 INFO - PROCESS | 13751 | |1;ext.html;521.606187328567;533.885214678844;542.7530473634496;551.6304076268897;572.9598928075036;27196.728032719693;27598.724012759867;27615.723842761567;27619.447611047766;27633.309167270803;34272.485912711265;34666.82666586663;34673.47989780155;34696.47955280667;34793.30413391737;7886.250806173404;8073.11195768465;8080.31317338024;8083.949086618732;8084.02991641001;7849.725259615914;7962.880556791652;8006.439549231556;8024.317932975675;8028.558429286387;7984.520928744265;8049.436539442241;8055.597220138999;8056.476329038623;8059.63731632075;7966.522008679498;8031.277185053374;8037.919620803776;8040.316573091294;8043.678252869849;7814.921850781533;7941.483803552751;7948;7949.841003179962;7950.681972721084;38492.80753596242;39007.60992390096;39050.21899562021;39084.60915390838;39094.41358379627;3073.4621441247914;3190.872365105393;3232.2565809863627;3475.600305964796;3538.752287339887;28836.423271534662;29101.85449072741;29269;29505.70494295051;30138.24654383636;3427.7943323400677;3459.9481007784902;3477.374072666919;3482.9825850870584;3527.7177825774133;237325;237634;237981;238209;238522;53614.7319263409;53837;54024.94812889049;54090.72954635201;54113.458865410845;62088.68955655283;63127.36872631215;63127.6843615779;63196;63199;14099.577012689635;14312.713745725026;14344.713105737826;14367.2098034607;14372;10655.200859935536;10717.0890474309;10786.73033174177;10815.513301901434;10823.080038196684;18940.337088201846;19234.942078185555;19890.403287901387;20074.19703211855;20167.294144704865;7730.149683534807;7878.290953814184;7997.720079797179;8022;8080.39397045224;840.0423517190408;868.322708287524;871.1419252036738;1024.626011505795;1061.867266591676;26707.732922670526;27450;27478.313042174104;27734.56646483039;27969.580456293173;978.6819283732815;1002.734275417015;1030.2479190191052;1048.4233671480656;1072.1958531101673;13710.520131795538;14317.188319636341;14379.712405751827;14582;14635;296897;301520;301659;301762;302643;46947.76526117416;47516.76241618839;47522.28716569254;47529.52470475251;47539;1083.101026148295;1224.8040313549789;1240.4480006397248;1258.6224132760135;1263.9052071094889;27270.863645681646;29531.852340739017;29606.851965740032;29775.553366699085;29996.70003299939;39267;40410;40412.79793601131;40443.59556404516;40524.326594277416;240854;253453;253613;253678;253868;26872.462550748485;27382.45235095247;33027;34334.48498272578;34656.82671586626;40134.59865401308;40494;41014.589854101076;41312.58687413087;41868.44118249983;34511.13722156966;35102;35808;35808.46287305745;35856.4621530672;35146.64853351434;35528.822355888056;35661.82169089138;35763.284734304645;35838.64161358353;33284.33431331311;33872.49191262182;33969;34042.14894627654;34222.82888585541;32322.35355292834;33262.833685831414;33458.33083338271;33598.66401335955;33856.49215261724;25520.49817343018;25928.733889309995;25976.8701156493;26261;26276.21171364862 04:35:02 INFO - PROCESS | 13751 | |2;jquery.html;352.6297387742869;356.5543071161048;358.7273672009273;363.6127524186741;365.7933267703749;15199.544013679593;15764.211789410541;15981.84018159818;16720.163991800393;16731.16344182789;10716.73208169796;10888.074513666328;11099.334039957588;11209;11223.719407014829;4626.629869610423;4738.241881298993;4752.287156926454;4764.118638051971;4766.951270720453;3483.6342184070686;5222.399424066224;5442.319710036246;5456.91814622779;5461.208124821898;5429.9185512217155;5431.022415965124;5431.293931788862;5451.855110426815;5463.180522921554;5321.388040375348;5970.820875373745;5976.133460648203;5982.611130276518;5986.2517185351835;5289.3917199521775;5304;5305.7877684892555;5307.044731948247;5307.6019298552765;14035.50875719345;18939.526511837175;20040.09819558109;20107.296244631514;20122.094505747278;1909.675355189621;1914.473519782071;1934.332655233942;1984.642764302425;2029.9797002029939;9236.445813251226;9676.080772326617;10518.579256829718;10572.207084468695;13336;1804.9368272110414;1833.2850188426523;1870.5136664467336;1883.905804709759;1896.2320260294603;60609.39390606037;60890.08664870031;60999.69500152515;61637.38362616361;62054.68972655108;10424.583016679248;10459.058684718411;10569.788604227871;10576.259661823753;10675.252732308663;13494.865051349558;13574.864251357558;13615.31923403826;13664.52174173919;13723.862761372258;6909.7581584644295;7127.75052873147;7154.821129471701;7199.748008819666;7210.495265331377;6596.10952521413;6605.933940660628;6730.0577919091365;6750.898736518956;6757.966210168917;4358.0412309291905;4394.604485596312;4498.3252512123445;4501.257292546758;4527.569880861313;1693.5512089296346;1737.3832289537286;1746.502246859639;1748.8338607832236;1758.3757765993143;862.7023676831483;874.8337815814975;892.6563273139758;916.9821498137062;993.7118235711563;16168.191590420667;16693.248803803857;16821.243044063045;17174.055426951636;17238.482845514656;843.6836186430089;860.6471346747803;870.856308709056;883.1962913748458;926.0878035135386;9235.722928312161;9616.855747163798;9623.855642165374;9697.321187516805;9814.852777208347;414319;428648;439778;444245;451138;64840;67142;67559.66220168966;67882;68137.65931170313;909;912.5938957164132;928.8931772846074;931.7810314576069;956.7512446763752;14450.927745361207;14559.636009099857;14756.409743610135;14778.448262932667;14891.776623350443;31004.68995310018;31044.22389440282;31308.373832523677;32026.19934501656;32074.35851283008;43073.569264306956;43107.568924310355;44351.33472997843;44799;49401.75299123625;7451.627418628938;7695.23047695226;7698.8845167321415;7785.961070194613;7857.842843143219;11604.245724027911;11814.527418903148;11949.820752688544;11966.58116965902;11982.400879956142;10151.137153342048;10271.640492582725;10444.63443779464;10461.9476902615;10687.30532515384;10147.289689721649;10234.795304094025;10273.845892311472;10413.114885234538;10640.946795265974;10394.688159355232;10472.371657700562;10477;10691.5188816505;11019.779604408028;7534.849303014019;7663.195364486649;7695;7698.0762308523335;7804.765857024298;9832.754181145528;10146.644867429604;10405.9479702601;10407;10562 04:35:02 INFO - PROCESS | 13751 | |3;mootools.html;1288.2013151845856;1432;1439.8920080993921;1603.1423188594104;1798.6132981408994;7212.242714514972;7416.629168541578;7429.851402971937;7444.553326800396;7446.553206807595;7200.459965502595;7377.26227377262;7387.37207337377;7391.186969433358;7400.296971787671;1931.082735700538;2224.0547767198955;2247.3033359658557;2278.874661893595;2281.566502364554;2293.69035180251;2296.024189719371;2296.1619009061737;2298.448372390631;2299.4711216420233;2167.729033870766;2219.866807991518;2225.032111031698;2225.63277059285;2226.198568515333;2197.560487902426;2239.1155493579945;2239.1826983151195;2257.4243567890167;2264.547090581882;2189.255653077961;2207.9006444709867;2223.29966060692;2233.095596283508;2234.575430668168;7405;7451.3293803557945;7463.813404664873;7467.066616672916;7469.47713660044;4498.572635599646;4634.768261586941;4635.165670179366;4636.466806317283;4640.025594625133;3067.217859445849;3079.8768049278;3129.248980244725;3133.341998180385;3216.1477208539754;981.087588542655;993.1310103659298;1002.5087707023579;1006.2050979726008;1027.4451796030135;9296.39573427725;9377.39046961952;9393.76515587109;9395.530223488799;9403.858942115805;3904.7852368119457;4001.9399709003806;4033.233685599727;4113.629773320416;4122.91754164915;7581.583012934341;7770.378369730408;7807.102183248999;7818.296353328228;7821.061472623322;4033.798310084484;4220.746755194698;4240.618344349024;4240.936385954152;4245.596668316505;4092.979535102365;4229.238737027303;4237.555056719062;4248.214080395075;4254.829806807693;3423.0928803866495;3494.982525087409;3512.454520011187;3535.964640353615;3544.9822750886083;1019.5463018956641;1050.8056009638242;1058.6030238660503;1061.1192710050639;1073.4579037586125;1204.2052245517916;1211.9939400302942;1218.7806194885006;1231.7967535356565;1237.4926280225245;6753.662316884136;6905.309469053054;7236.204017558064;7310;7323.121225452873;978.3787295067541;1011.5043628621922;1074.6238816414193;1076.1767248055244;1083.1659622090947;5534.252875861707;5593.272874526286;5618.719064046782;5631.915521267184;5638.633488823213;8718.215360617574;8788.780280493038;8996.100389961082;9048.638054477879;9128;8964;9212.170904618617;9251;9278.072192780668;9297.302702297355;7086.291370862976;7179.353858152791;7250.09373828261;7308.963455182797;7322.890156647654;6927.68825402848;6975.651217439209;6997.405220556309;7018.894716579358;7070.469714771516;7756.612169391621;7975.5613441261285;8022.679092836222;8083.555404452576;8301.252887240178;8023.959880200561;8252.876206857021;8376.413651044368;8379.120192379956;8383.538905360263;5843.29880414353;6173.074038894202;6361.077643741724;6528.151340325728;6698.430633396216;7090.397316228178;7096.361327480551;7141.714331426685;7143.1428228612895;7143.607101609254;6240.656763878031;6420.518461115342;6433.935660643334;6540.247871494839;6630.436412904957;6404.423601875854;6464.903026454513;6474.546781725234;6510.121133646897;6682.899756503559;6866.588004719732;6869.587824730532;6919.827004324932;6923.446124310144;6926.515143939876;5986.521078313637;6024.698765061642;6387.5209359297305;6395.616263024233;6396.392342727433;6403.295637479967;6420.903686444613;6448.226212854487;6455.4512866406885;6464.773732919325 04:35:02 INFO - PROCESS | 13751 | |4;prototype.html;308.20790568239624;311.4456267843239;312.7123046796947;320.5832417856786;321.6638612649781;5304.708241046741;5376.112941364675;5435;5474.014677358074;5478;5338.786448542063;5362.088444964355;5396.514313711765;5399.946000539993;5407.242985981966;3820.0449887528116;3986.5614782373914;4067.2678917794783;4083.4691490106393;4118.073433477473;4068.6338229559333;4077.2049450357194;4084.264832330179;4094.2220978014084;4103.4870641169855;4052.0477687743355;4065.715399921992;4073.674106071522;4074.9812546863286;4075.8777236682945;3864.86472973446;3953.683705303569;4039.555648878621;4051.2505186540584;4053.6351728344293;3515.6132825389186;3519.4896739972814;3524.0485069031474;3526;3535.9646403535894;5200.167973124319;5200.92198617021;5209.244659524347;5215.322008138955;5215.6609820361555;4707.7881495332795;4707.811687532495;4709;4711.623070154379;4717.834875779366;5639;5641.661500309953;5643.238162848004;5653.9151912721345;5654.9151762723595;3881.146147847497;3903.2974064668347;3904.1996390739832;3908.062065104383;3909.139989202371;5720.170575266563;5875.206847075633;5945.137954996545;5946.464818166386;5952.255968003999;3909.3354129798004;3952.960470395317;3954.3277642800795;3956.22853543562;3957.643812056871;4010.7393019453643;4010.859619913289;4014.2372949140154;4014.277430062617;4015.799210039545;4619.445666520039;4619.445666520039;4623.583877451046;4633.443986721615;4636.35091087248;5577.1355439906065;5584.21820945068;5589.35722391922;5592.189132575753;5598.188262701967;1390.3534856291874;1413.0814970269407;1414.0313884988816;1414.6321956291233;1416.0583212164001;880.5377176982136;913.5569248914271;922.082527884759;928.7817362919709;939.0281059103795;4909.091818013679;4927.137750893579;4928.408590969107;4929.2359684248995;4936.605071594264;5844.12338149281;5850.385709500526;5850.5612079094235;5851.853703657443;5871.4128587141795;4955.331030310934;4955.4548999610015;4963.975180124076;4965.553100220997;4967.130752118364;3097.798643088192;3136.764742644311;3137.200013996462;3142.6543080261154;3143.512755522898;5486;5493.258410114663;5503.807366742145;5505.889882202414;5510.779568817203;5892.469677729025;6088.238970128734;6093.055576385667;6098.603590766586;6102.328743838174;5555.1667249912025;5570.526505247019;5580.023495888203;5587.636803607753;5590.496855283044;5942.940570594239;5943.375945525658;5944.316403613467;5950;5958.731857066356;5782.5663075268685;5783.537317014713;5784.190213370048;5786.276715410574;5788.565857560784;5378.892422151614;5499.780008799603;5569.33168019824;5577.553795696415;5583.246261754611;3947.743396679207;3962.8216730247786;3971.451134057662;3978.403239514096;3985.740926839746;5858.326292476249;5879;5888.3228428729535;5901;5904.1143828424365;5670.5180059695385;5678.77284908599;5679.17651940458;5679.6876171810945;5680.062789639828;5667.574931880043;5670.064439367623;5682.176084467812;5683.886322273449;5684.9431505684415;5415;5569.248151499496;5571.637843540157;5580.776768929198;5581.441855814386;5638.5489160867855;5666.178404131296;5667.1782591524825;5670.631408958405;5681.801136960186;5547.89180111555;5576.749046292845;5586.653605485787;5589.077802162597;5589.664620122806 04:35:02 INFO - PROCESS | 13751 | |5;yui.html;670.6311528659238;677.9224892126203;768.7808974442281;781.4245359360958;795.5266616363266;11948.581799637004;12272.938635306811;12275.386230688453;12279.017678585715;12294.877051229485;12036.157468977175;12044.939775301133;12068.336241506713;12111.75776484472;12158.452869620865;639.9232092148949;797.5453991224989;801.8155824160447;814.4380377539509;814.7311387242196;817.0522194254665;822.0382152881143;822.0505316359614;822.284612387224;822.440740296598;848.3467729848013;859.6905114158898;859.7893516088567;860.5052095045343;860.5826174305457;677.133269415147;836.3560058754725;846.9195426434479;851.0935853316198;852.3820230333021;623.2365352443221;628.9779857705004;629.3046183966696;629.5309994054459;629.8614304852925;12001.51993920242;12073.698157546132;12104.21322614036;12111;12149.93925030378;12108.334041627708;13031.218126912321;13093.214407135602;13306.800397994039;13431.12697674648;9399.34204605678;9541.427514349092;10326.32878862879;10607.15142788575;10613.9469302653;3330.9833450832834;3338.6494418086236;3363.5795525559306;3377.3245350929665;3459.187091033605;41731.7913410431;41909.790451047855;42347.153056938994;42656.786716066534;42731.78634106841;8978.191962723386;9513.096255855682;9531.809363812685;9539.761505962268;9617.663381781604;17010.234539445755;17062.061586612606;17078.316867325415;17084.914575427043;17094.40169594058;6997.545159564612;7049.08361912948;7077.115360579927;7137.321954414322;7236.312550307713;3829.1193025604266;3880.4567360569545;3934.9001819405444;3938.6258305460933;4006.59934006597;2882.1929859639336;2898.971010289912;2906.346072133753;2912.8980485683323;2928.546075358323;509.15988618778573;516.3855012535071;520.0223579670196;522.6602708239675;522.9372475302988;531.5694287627034;537.3498067338486;613.7391608566342;658.4501940879323;660.7687309441657;8002.439829212016;8211.34309255258;8247.134050924686;8334.291585215204;8375.916240837636;492.5025724018767;621.2234706616729;623.975040998355;634.5462993959342;640.8173670503884;3752.6247375262255;3815.6184381562175;3842.865499707497;3909.139989202371;3916.3342231820657;53065.469345306825;54486.727566361915;54729.45270547323;54759.178612320844;54863.45136548663;44290.33564496535;44511.77744111259;45105.774471127435;47552.762236188595;47619;41816.581834181874;42077;42234.78882605567;42284.36573451401;43305;7305.853882922205;7482.326590606872;7485.1017877855;7537.095548534211;7679.347255483346;32725.672743272262;32847;33119.337613248084;33887;34266.31467370688;39031.609683902796;42992.785036074616;43121.78439107785;43143;43683;8985;9092.136247056518;9201.30990175753;9241.306901982243;9389.906100938902;10209.795804083727;10237.846432303373;10372.429516376671;10478.476076196008;10729.302595331279;8662.436941598777;11642.359670218219;11654.067674585844;11764.235324703866;11790.764184716429;10172.542235599563;11056.723581910517;11134.33194008362;11530.019948304489;11569.19015668895;11368.829467557827;11408.600698975495;11911.642650720492;11957.521699131938;11965.341906195243;8804.779880503038;8999;9061.90938090637;9124.224440922597;9408.482533460725;8849.38054336216;8967.461952282883;8995.190432861074;9227.76930576741;9228.538573071453 04:35:02 INFO - PROCESS | 13751 | __end_tp_report 04:35:02 INFO - PROCESS | 13751 | __start_cc_report 04:35:02 INFO - PROCESS | 13751 | _x_x_mozilla_cycle_collect,1113 04:35:02 INFO - PROCESS | 13751 | __end_cc_report 04:35:02 INFO - PROCESS | 13751 | __startTimestamp1458128102349__endTimestamp 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | ------- Summary: start ------- 04:35:02 INFO - PROCESS | 13751 | Number of tests: 6 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | [#0] dojo.html Cycles:165 Average:4644.67 Median:4805.42 stddev:489.46 (10.2%) stddev-sans-first:463.70 04:35:02 INFO - PROCESS | 13751 | Values: 2591.2 2638.6 2658.0 2677.5 2694.8 4630.9 4642.8 4643.1 4646.2 4684.6 4750.0 4810.7 4815.5 4834.8 4844.1 4278.6 4280.0 4292.7 4319.0 4400.5 4339.8 4368.6 4397.3 4421.3 4422.1 4227.7 4297.7 4313.5 4313.8 4405.2 4225.8 4244.7 4251.6 4255.1 4257.1 4229.3 4230.0 4230.4 4233.2 4233.7 4526.7 4536.1 4546.2 4619.7 4665.3 5031.6 5038.9 5042.4 5047.6 5090.2 5061.9 5063.1 5069.0 5071.6 5104.9 4614.4 4681.6 4718.9 4751.6 4763.6 5084.4 5132.3 5138.9 5139.9 5147.6 4850.6 4899.6 4900.4 4901.1 4971.9 4953.2 4989.0 5037.4 5056.3 5060.8 4946.6 4947.1 4958.4 4959.4 5007.2 4919.3 4927.2 4929.3 4935.6 4977.8 4210.8 4213.9 4231.2 4291.0 4298.3 3670.4 3689.2 3698.2 3715.5 3735.6 4262.0 4312.2 4314.9 4331.4 4368.1 5071.9 5077.8 5085.1 5130.7 5146.4 4340.7 4379.2 4386.7 4389.2 4391.9 4458.1 4534.4 4560.8 4567.1 4591.1 4773.7 4798.8 4805.4 4807.8 4851.3 5063.7 5068.0 5078.0 5080.0 5122.6 4719.9 4741.7 4788.5 4806.4 4852.6 4965.0 4979.6 4990.5 4993.9 5014.2 5031.2 5043.9 5044.5 5066.7 5096.9 4775.2 4874.9 4903.4 4926.9 4966.4 4891.8 4913.2 4922.2 4923.5 4969.7 4788.1 4820.0 4826.9 4858.2 4879.6 4661.5 4797.2 4886.5 4902.6 4988.7 4761.6 4768.9 4818.3 4823.8 4835.2 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | [#1] ext.html Cycles:180 Average:42652.32 Median:18985.54 stddev:69085.07 (363.9%) stddev-sans-first:69206.45 04:35:02 INFO - PROCESS | 13751 | Values: 521.6 533.9 542.8 551.6 573.0 27196.7 27598.7 27615.7 27619.4 27633.3 34272.5 34666.8 34673.5 34696.5 34793.3 7886.3 8073.1 8080.3 8083.9 8084.0 7849.7 7962.9 8006.4 8024.3 8028.6 7984.5 8049.4 8055.6 8056.5 8059.6 7966.5 8031.3 8037.9 8040.3 8043.7 7814.9 7941.5 7948.0 7949.8 7950.7 38492.8 39007.6 39050.2 39084.6 39094.4 3073.5 3190.9 3232.3 3475.6 3538.8 28836.4 29101.9 29269.0 29505.7 30138.2 3427.8 3459.9 3477.4 3483.0 3527.7 237325.0 237634.0 237981.0 238209.0 238522.0 53614.7 53837.0 54024.9 54090.7 54113.5 62088.7 63127.4 63127.7 63196.0 63199.0 14099.6 14312.7 14344.7 14367.2 14372.0 10655.2 10717.1 10786.7 10815.5 10823.1 18940.3 19234.9 19890.4 20074.2 20167.3 7730.1 7878.3 7997.7 8022.0 8080.4 840.0 868.3 871.1 1024.6 1061.9 26707.7 27450.0 27478.3 27734.6 27969.6 978.7 1002.7 1030.2 1048.4 1072.2 13710.5 14317.2 14379.7 14582.0 14635.0 296897.0 301520.0 301659.0 301762.0 302643.0 46947.8 47516.8 47522.3 47529.5 47539.0 1083.1 1224.8 1240.4 1258.6 1263.9 27270.9 29531.9 29606.9 29775.6 29996.7 39267.0 40410.0 40412.8 40443.6 40524.3 240854.0 253453.0 253613.0 253678.0 253868.0 26872.5 27382.5 33027.0 34334.5 34656.8 40134.6 40494.0 41014.6 41312.6 41868.4 34511.1 35102.0 35808.0 35808.5 35856.5 35146.6 35528.8 35661.8 35763.3 35838.6 33284.3 33872.5 33969.0 34042.1 34222.8 32322.4 33262.8 33458.3 33598.7 33856.5 25520.5 25928.7 25976.9 26261.0 26276.2 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | [#2] jquery.html Cycles:180 Average:24560.74 Median:43090.57 stddev:71338.29 (165.6%) stddev-sans-first:71515.25 04:35:02 INFO - PROCESS | 13751 | Values: 352.6 356.6 358.7 363.6 365.8 15199.5 15764.2 15981.8 16720.2 16731.2 10716.7 10888.1 11099.3 11209.0 11223.7 4626.6 4738.2 4752.3 4764.1 4767.0 3483.6 5222.4 5442.3 5456.9 5461.2 5429.9 5431.0 5431.3 5451.9 5463.2 5321.4 5970.8 5976.1 5982.6 5986.3 5289.4 5304.0 5305.8 5307.0 5307.6 14035.5 18939.5 20040.1 20107.3 20122.1 1909.7 1914.5 1934.3 1984.6 2030.0 9236.4 9676.1 10518.6 10572.2 13336.0 1804.9 1833.3 1870.5 1883.9 1896.2 60609.4 60890.1 60999.7 61637.4 62054.7 10424.6 10459.1 10569.8 10576.3 10675.3 13494.9 13574.9 13615.3 13664.5 13723.9 6909.8 7127.8 7154.8 7199.7 7210.5 6596.1 6605.9 6730.1 6750.9 6758.0 4358.0 4394.6 4498.3 4501.3 4527.6 1693.6 1737.4 1746.5 1748.8 1758.4 862.7 874.8 892.7 917.0 993.7 16168.2 16693.2 16821.2 17174.1 17238.5 843.7 860.6 870.9 883.2 926.1 9235.7 9616.9 9623.9 9697.3 9814.9 414319.0 428648.0 439778.0 444245.0 451138.0 64840.0 67142.0 67559.7 67882.0 68137.7 909.0 912.6 928.9 931.8 956.8 14450.9 14559.6 14756.4 14778.4 14891.8 31004.7 31044.2 31308.4 32026.2 32074.4 43073.6 43107.6 44351.3 44799.0 49401.8 7451.6 7695.2 7698.9 7786.0 7857.8 11604.2 11814.5 11949.8 11966.6 11982.4 10151.1 10271.6 10444.6 10461.9 10687.3 10147.3 10234.8 10273.8 10413.1 10640.9 10394.7 10472.4 10477.0 10691.5 11019.8 7534.8 7663.2 7695.0 7698.1 7804.8 9832.8 10146.6 10405.9 10407.0 10562.0 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | [#3] mootools.html Cycles:180 Average:5204.58 Median:6399.84 stddev:2630.23 (41.1%) stddev-sans-first:2621.13 04:35:02 INFO - PROCESS | 13751 | Values: 1288.2 1432.0 1439.9 1603.1 1798.6 7212.2 7416.6 7429.9 7444.6 7446.6 7200.5 7377.3 7387.4 7391.2 7400.3 1931.1 2224.1 2247.3 2278.9 2281.6 2293.7 2296.0 2296.2 2298.4 2299.5 2167.7 2219.9 2225.0 2225.6 2226.2 2197.6 2239.1 2239.2 2257.4 2264.5 2189.3 2207.9 2223.3 2233.1 2234.6 7405.0 7451.3 7463.8 7467.1 7469.5 4498.6 4634.8 4635.2 4636.5 4640.0 3067.2 3079.9 3129.2 3133.3 3216.1 981.1 993.1 1002.5 1006.2 1027.4 9296.4 9377.4 9393.8 9395.5 9403.9 3904.8 4001.9 4033.2 4113.6 4122.9 7581.6 7770.4 7807.1 7818.3 7821.1 4033.8 4220.7 4240.6 4240.9 4245.6 4093.0 4229.2 4237.6 4248.2 4254.8 3423.1 3495.0 3512.5 3536.0 3545.0 1019.5 1050.8 1058.6 1061.1 1073.5 1204.2 1212.0 1218.8 1231.8 1237.5 6753.7 6905.3 7236.2 7310.0 7323.1 978.4 1011.5 1074.6 1076.2 1083.2 5534.3 5593.3 5618.7 5631.9 5638.6 8718.2 8788.8 8996.1 9048.6 9128.0 8964.0 9212.2 9251.0 9278.1 9297.3 7086.3 7179.4 7250.1 7309.0 7322.9 6927.7 6975.7 6997.4 7018.9 7070.5 7756.6 7975.6 8022.7 8083.6 8301.3 8024.0 8252.9 8376.4 8379.1 8383.5 5843.3 6173.1 6361.1 6528.2 6698.4 7090.4 7096.4 7141.7 7143.1 7143.6 6240.7 6420.5 6433.9 6540.2 6630.4 6404.4 6464.9 6474.5 6510.1 6682.9 6866.6 6869.6 6919.8 6923.4 6926.5 5986.5 6024.7 6387.5 6395.6 6396.4 6403.3 6420.9 6448.2 6455.5 6464.8 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | [#4] prototype.html Cycles:180 Average:4664.08 Median:5398.23 stddev:1401.73 (26.0%) stddev-sans-first:1367.00 04:35:02 INFO - PROCESS | 13751 | Values: 308.2 311.4 312.7 320.6 321.7 5304.7 5376.1 5435.0 5474.0 5478.0 5338.8 5362.1 5396.5 5399.9 5407.2 3820.0 3986.6 4067.3 4083.5 4118.1 4068.6 4077.2 4084.3 4094.2 4103.5 4052.0 4065.7 4073.7 4075.0 4075.9 3864.9 3953.7 4039.6 4051.3 4053.6 3515.6 3519.5 3524.0 3526.0 3536.0 5200.2 5200.9 5209.2 5215.3 5215.7 4707.8 4707.8 4709.0 4711.6 4717.8 5639.0 5641.7 5643.2 5653.9 5654.9 3881.1 3903.3 3904.2 3908.1 3909.1 5720.2 5875.2 5945.1 5946.5 5952.3 3909.3 3953.0 3954.3 3956.2 3957.6 4010.7 4010.9 4014.2 4014.3 4015.8 4619.4 4619.4 4623.6 4633.4 4636.4 5577.1 5584.2 5589.4 5592.2 5598.2 1390.4 1413.1 1414.0 1414.6 1416.1 880.5 913.6 922.1 928.8 939.0 4909.1 4927.1 4928.4 4929.2 4936.6 5844.1 5850.4 5850.6 5851.9 5871.4 4955.3 4955.5 4964.0 4965.6 4967.1 3097.8 3136.8 3137.2 3142.7 3143.5 5486.0 5493.3 5503.8 5505.9 5510.8 5892.5 6088.2 6093.1 6098.6 6102.3 5555.2 5570.5 5580.0 5587.6 5590.5 5942.9 5943.4 5944.3 5950.0 5958.7 5782.6 5783.5 5784.2 5786.3 5788.6 5378.9 5499.8 5569.3 5577.6 5583.2 3947.7 3962.8 3971.5 3978.4 3985.7 5858.3 5879.0 5888.3 5901.0 5904.1 5670.5 5678.8 5679.2 5679.7 5680.1 5667.6 5670.1 5682.2 5683.9 5684.9 5415.0 5569.2 5571.6 5580.8 5581.4 5638.5 5666.2 5667.2 5670.6 5681.8 5547.9 5576.7 5586.7 5589.1 5589.7 04:35:02 INFO - PROCESS | 13751 | 04:35:02 INFO - PROCESS | 13751 | [#5] yui.html Cycles:180 Average:12817.45 Median:47585.88 stddev:14669.56 (30.8%) stddev-sans-first:14682.35 04:35:02 INFO - PROCESS | 13751 | Values: 670.6 677.9 768.8 781.4 795.5 11948.6 12272.9 12275.4 12279.0 12294.9 12036.2 12044.9 12068.3 12111.8 12158.5 639.9 797.5 801.8 814.4 814.7 817.1 822.0 822.1 822.3 822.4 848.3 859.7 859.8 860.5 860.6 677.1 836.4 846.9 851.1 852.4 623.2 629.0 629.3 629.5 629.9 12001.5 12073.7 12104.2 12111.0 12149.9 12108.3 13031.2 13093.2 13306.8 13431.1 9399.3 9541.4 10326.3 10607.2 10613.9 3331.0 3338.6 3363.6 3377.3 3459.2 41731.8 41909.8 42347.2 42656.8 42731.8 8978.2 9513.1 9531.8 9539.8 9617.7 17010.2 17062.1 17078.3 17084.9 17094.4 6997.5 7049.1 7077.1 7137.3 7236.3 3829.1 3880.5 3934.9 3938.6 4006.6 2882.2 2899.0 2906.3 2912.9 2928.5 509.2 516.4 520.0 522.7 522.9 531.6 537.3 613.7 658.5 660.8 8002.4 8211.3 8247.1 8334.3 8375.9 492.5 621.2 624.0 634.5 640.8 3752.6 3815.6 3842.9 3909.1 3916.3 53065.5 54486.7 54729.5 54759.2 54863.5 44290.3 44511.8 45105.8 47552.8 47619.0 41816.6 42077.0 42234.8 42284.4 43305.0 7305.9 7482.3 7485.1 7537.1 7679.3 32725.7 32847.0 33119.3 33887.0 34266.3 39031.6 42992.8 43121.8 43143.0 43683.0 8985.0 9092.1 9201.3 9241.3 9389.9 10209.8 10237.8 10372.4 10478.5 10729.3 8662.4 11642.4 11654.1 11764.2 11790.8 10172.5 11056.7 11134.3 11530.0 11569.2 11368.8 11408.6 11911.6 11957.5 11965.3 8804.8 8999.0 9061.9 9124.2 9408.5 8849.4 8967.5 8995.2 9227.8 9228.5 04:35:02 INFO - PROCESS | 13751 | -------- Summary: end -------- 04:35:02 INFO - PROCESS | 13751 | 04:35:03 INFO - TEST-INFO | 13751: exit 0 04:35:03 INFO - TEST-OK | dromaeo_css | took 1117068ms 04:35:03 INFO - TEST-START | kraken 04:35:03 INFO - operating with platform_type : linux_ 04:35:03 INFO - Initialising browser for kraken test... 04:35:03 INFO - TEST-INFO | started process 13930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiC2AT3/profile http://localhost:54784/getInfo.html) 04:35:07 INFO - PROCESS | 13930 | __metrics Screen width/height:1600/1200 04:35:07 INFO - PROCESS | 13930 | colorDepth:24 04:35:07 INFO - PROCESS | 13930 | Browser inner width/height: 1024/697 04:35:07 INFO - PROCESS | 13930 | __metrics 04:35:08 ERROR - PROCESS | 13930 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:35:08 INFO - PROCESS | 13930 | 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. 04:35:09 INFO - TEST-INFO | 13930: exit 0 04:35:09 INFO - Browser initialized. 04:35:09 INFO - Running cycle 1/1 for kraken test... 04:35:09 INFO - TEST-INFO | started process 14010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiC2AT3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:21 INFO - PROCESS | 14010 | RSS: Main: 154816512 04:35:21 INFO - PROCESS | 14010 | 04:35:23 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54784/tests/kraken/driver.html?testName=audio-beat-detection) 04:35:24 INFO - PROCESS | 14010 | RSS: Main: 196767744 04:35:24 INFO - PROCESS | 14010 | 04:35:27 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54784/tests/kraken/driver.html?testName=audio-dft) 04:35:27 INFO - PROCESS | 14010 | RSS: Main: 185159680 04:35:27 INFO - PROCESS | 14010 | 04:35:30 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54784/tests/kraken/driver.html?testName=audio-fft) 04:35:31 INFO - PROCESS | 14010 | RSS: Main: 173060096 04:35:31 INFO - PROCESS | 14010 | 04:35:33 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54784/tests/kraken/driver.html?testName=audio-oscillator) 04:35:33 INFO - PROCESS | 14010 | RSS: Main: 171945984 04:35:33 INFO - PROCESS | 14010 | 04:35:36 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54784/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:36 INFO - PROCESS | 14010 | RSS: Main: 175108096 04:35:36 INFO - PROCESS | 14010 | 04:35:39 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54784/tests/kraken/driver.html?testName=imaging-darkroom) 04:35:40 INFO - PROCESS | 14010 | RSS: Main: 174211072 04:35:40 INFO - PROCESS | 14010 | 04:35:43 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54784/tests/kraken/driver.html?testName=imaging-desaturate) 04:35:44 INFO - PROCESS | 14010 | RSS: Main: 175759360 04:35:44 INFO - PROCESS | 14010 | 04:35:47 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54784/tests/kraken/driver.html?testName=json-parse-financial) 04:35:47 INFO - PROCESS | 14010 | RSS: Main: 175210496 04:35:47 INFO - PROCESS | 14010 | 04:35:49 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54784/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:35:50 INFO - PROCESS | 14010 | RSS: Main: 185917440 04:35:50 INFO - PROCESS | 14010 | 04:35:51 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:35:52 INFO - PROCESS | 14010 | RSS: Main: 182403072 04:35:52 INFO - PROCESS | 14010 | 04:35:54 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:35:55 INFO - PROCESS | 14010 | RSS: Main: 193126400 04:35:55 INFO - PROCESS | 14010 | 04:35:57 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:35:58 INFO - PROCESS | 14010 | RSS: Main: 198959104 04:35:58 INFO - PROCESS | 14010 | 04:36:00 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:01 INFO - PROCESS | 14010 | RSS: Main: 197914624 04:36:01 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | Cycle 1(1): loaded http://localhost:54784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54784/tests/kraken/driver.html?testName=ai-astar) 04:36:03 INFO - PROCESS | 14010 | RSS: Main: 257482752 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | __start_tp_report 04:36:03 INFO - PROCESS | 14010 | _x_x_mozilla_page_load 04:36:03 INFO - PROCESS | 14010 | _x_x_mozilla_page_load_details 04:36:03 INFO - PROCESS | 14010 | |i|pagename|runs| 04:36:03 INFO - PROCESS | 14010 | |0;ai-astar;111;113;108;112;115;113;101;113;113;111 04:36:03 INFO - PROCESS | 14010 | |1;audio-beat-detection;156;128;148;177;129;165;152;132;184;130 04:36:03 INFO - PROCESS | 14010 | |2;audio-dft;164;162;163;160;161;160;162;161;162;161 04:36:03 INFO - PROCESS | 14010 | |3;audio-fft;73;73;100;95;75;76;72;115;96;75 04:36:03 INFO - PROCESS | 14010 | |4;audio-oscillator;94;94;134;93;93;94;139;92;95;129 04:36:03 INFO - PROCESS | 14010 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;117;117 04:36:03 INFO - PROCESS | 14010 | |6;imaging-darkroom;145;147;146;148;146;146;146;146;146;146 04:36:03 INFO - PROCESS | 14010 | |7;imaging-desaturate;96;96;96;96;95;98;95;95;96;95 04:36:03 INFO - PROCESS | 14010 | |8;json-parse-financial;67;66;66;65;66;66;66;75;64;64 04:36:03 INFO - PROCESS | 14010 | |9;json-stringify-tinderbox;65;66;65;66;64;65;66;64;65;65 04:36:03 INFO - PROCESS | 14010 | |10;stanford-crypto-aes;80;81;80;80;83;81;83;82;82;81 04:36:03 INFO - PROCESS | 14010 | |11;stanford-crypto-ccm;127;126;115;120;124;132;116;115;122;114 04:36:03 INFO - PROCESS | 14010 | |12;stanford-crypto-pbkdf2;131;129;141;141;145;133;144;142;147;145 04:36:03 INFO - PROCESS | 14010 | |13;stanford-crypto-sha256-iterative;67;66;65;65;69;66;67;67;65;66 04:36:03 INFO - PROCESS | 14010 | __end_tp_report 04:36:03 INFO - PROCESS | 14010 | __start_cc_report 04:36:03 INFO - PROCESS | 14010 | _x_x_mozilla_cycle_collect,1137 04:36:03 INFO - PROCESS | 14010 | __end_cc_report 04:36:03 INFO - PROCESS | 14010 | __startTimestamp1458128163520__endTimestamp 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | ------- Summary: start ------- 04:36:03 INFO - PROCESS | 14010 | Number of tests: 14 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.97 (3.5%) stddev-sans-first:4.21 04:36:03 INFO - PROCESS | 14010 | Values: 111.0 113.0 108.0 112.0 115.0 113.0 101.0 113.0 113.0 111.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:154.00 stddev:20.56 (13.3%) stddev-sans-first:21.69 04:36:03 INFO - PROCESS | 14010 | Values: 156.0 128.0 148.0 177.0 129.0 165.0 152.0 132.0 184.0 130.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.00 04:36:03 INFO - PROCESS | 14010 | Values: 164.0 162.0 163.0 160.0 161.0 160.0 162.0 161.0 162.0 161.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#3] audio-fft Cycles:10 Average:85.00 Median:75.00 stddev:15.22 (20.3%) stddev-sans-first:15.51 04:36:03 INFO - PROCESS | 14010 | Values: 73.0 73.0 100.0 95.0 75.0 76.0 72.0 115.0 96.0 75.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:93.50 stddev:19.69 (21.1%) stddev-sans-first:20.42 04:36:03 INFO - PROCESS | 14010 | Values: 94.0 94.0 134.0 93.0 93.0 94.0 139.0 92.0 95.0 129.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:36:03 INFO - PROCESS | 14010 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 04:36:03 INFO - PROCESS | 14010 | Values: 145.0 147.0 146.0 148.0 146.0 146.0 146.0 146.0 146.0 146.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 04:36:03 INFO - PROCESS | 14010 | Values: 96.0 96.0 96.0 96.0 95.0 98.0 95.0 95.0 96.0 95.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:3.14 (4.8%) stddev-sans-first:3.32 04:36:03 INFO - PROCESS | 14010 | Values: 67.0 66.0 66.0 65.0 66.0 66.0 66.0 75.0 64.0 64.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 04:36:03 INFO - PROCESS | 14010 | Values: 65.0 66.0 65.0 66.0 64.0 65.0 66.0 64.0 65.0 65.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:1.16 (1.4%) stddev-sans-first:1.13 04:36:03 INFO - PROCESS | 14010 | Values: 80.0 81.0 80.0 80.0 83.0 81.0 83.0 82.0 82.0 81.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:123.00 stddev:6.14 (5.0%) stddev-sans-first:6.13 04:36:03 INFO - PROCESS | 14010 | Values: 127.0 126.0 115.0 120.0 124.0 132.0 116.0 115.0 122.0 114.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:143.00 stddev:6.43 (4.5%) stddev-sans-first:5.97 04:36:03 INFO - PROCESS | 14010 | Values: 131.0 129.0 141.0 141.0 145.0 133.0 144.0 142.0 147.0 145.0 04:36:03 INFO - PROCESS | 14010 | 04:36:03 INFO - PROCESS | 14010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 04:36:03 INFO - PROCESS | 14010 | Values: 67.0 66.0 65.0 65.0 69.0 66.0 67.0 67.0 65.0 66.0 04:36:03 INFO - PROCESS | 14010 | -------- Summary: end -------- 04:36:03 INFO - PROCESS | 14010 | 04:36:04 INFO - TEST-INFO | 14010: exit 0 04:36:04 INFO - TEST-OK | kraken | took 61351ms 04:36:04 INFO - SUITE-END | took 1178s 04:36:04 INFO - Completed test suite (00:19:38) 04:36:04 INFO - javascript benchmark 04:36:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.196729014005, 2638.6174004769296, 2657.973420265798, 2677.477891811098, 2694.797890158238, 4630.861074167776, 4642.767861606923, 4643.117807616554, 4646.233371493699, 4684.6252299816015, 4750.049990001996, 4810.663253572251, 4815.542523460274, 4834.830780922668, 4844.128056949757, 4278.550752171024, 4279.978600106995, 4292.720973136752, 4319.028218650794, 4400.537943515933, 4339.761313127777, 4368.606825385715, 4397.252467080588, 4421.270490369101, 4422.09347083847, 4227.682923780729, 4297.699161058727, 4313.482382114166, 4313.784310784479, 4405.185040767452, 4225.78871056449, 4244.681648876347, 4251.553586873365, 4255.148970205972, 4257.063446041866, 4229.302165142748, 4229.97885010573, 4230.428892099558, 4233.174530966463, 4233.745975241495, 4526.728396296233, 4536.115457485792, 4546.181687296285, 4619.699719518254, 4665.2768820832825, 5031.597472202215, 5038.924416133761, 5042.3949126104735, 5047.570956468705, 5090.236464530313, 5061.924071138936, 5063.063333283354, 5069.0, 5071.56891664209, 5104.948950510485, 4614.400127983375, 4681.625469962395, 4718.882027949328, 4751.59611433032, 4763.618910487153, 5084.3644544431945, 5132.3327967364, 5138.87152821175, 5139.871503212449, 5147.613928955343, 4850.587700045536, 4899.632527560376, 4900.362952816111, 4901.068796928572, 4971.925421118686, 4953.23224900141, 4989.0, 5037.395512538519, 5056.342675452242, 5060.797568097309, 4946.579540739078, 4947.134251505972, 4958.429780575208, 4959.429665588431, 5007.24891266313, 4919.2867034279825, 4927.162382395001, 4929.260610908321, 4935.580475659609, 4977.825776097891, 4210.7684077375425, 4213.873583792491, 4231.196072746168, 4291.03451723366, 4298.26929421999, 3670.44943258508, 3689.24370504046, 3698.1863989922713, 3715.479832823407, 3735.6077611850365, 4262.041040765865, 4312.180685669713, 4314.892127696833, 4331.350297455344, 4368.104538569649, 5071.8985620287385, 5077.822276220315, 5085.1355269604255, 5130.717810520383, 5146.356705411824, 4340.717853339523, 4379.233634114017, 4386.736795792199, 4389.18800021997, 4391.934120988188, 4458.063806600585, 4534.433195850519, 4560.817567297271, 4567.10941366437, 4591.127685739765, 4773.71357718538, 4798.7840547174765, 4805.4233491979785, 4807.831725889577, 4851.345068415719, 5063.696178229318, 5067.974660126676, 5078.0, 5080.00939816747, 5122.615803814654, 4719.929201061918, 4741.739204343794, 4788.521147885183, 4806.447258565309, 4852.611791056777, 4964.975175124101, 4979.626528010342, 4990.50094990498, 4993.850184494471, 5014.197728363591, 5031.22016087507, 5043.949560504348, 5044.470330615232, 5066.69599823997, 5096.923546146737, 4775.2359622460235, 4874.878128046827, 4903.387076615423, 4926.852194434173, 4966.379202599675, 4891.779869905791, 4913.189323761682, 4922.163232250455, 4923.483034281492, 4969.652124351261, 4788.090262850047, 4820.035992801384, 4826.8793280168275, 4858.246971719389, 4879.634027447884, 4661.463931647904, 4797.160496913096, 4886.486918873609, 4902.558769710743, 4988.650794444354, 4761.595264402565, 4768.880777980578, 4818.325434439252, 4823.758812059453, 4835.178019736582], "unit": "score", "name": "dojo.html", "value": 4613.471930569151}, {"lowerIsBetter": false, "replicates": [521.606187328567, 533.885214678844, 542.7530473634496, 551.6304076268897, 572.9598928075036, 27196.728032719693, 27598.724012759867, 27615.723842761567, 27619.447611047766, 27633.309167270803, 34272.485912711265, 34666.82666586663, 34673.47989780155, 34696.47955280667, 34793.30413391737, 7886.250806173404, 8073.11195768465, 8080.31317338024, 8083.949086618732, 8084.02991641001, 7849.725259615914, 7962.880556791652, 8006.439549231556, 8024.317932975675, 8028.558429286387, 7984.520928744265, 8049.436539442241, 8055.597220138999, 8056.476329038623, 8059.63731632075, 7966.522008679498, 8031.277185053374, 8037.919620803776, 8040.316573091294, 8043.678252869849, 7814.921850781533, 7941.483803552751, 7948.0, 7949.841003179962, 7950.681972721084, 38492.80753596242, 39007.60992390096, 39050.21899562021, 39084.60915390838, 39094.41358379627, 3073.4621441247914, 3190.872365105393, 3232.2565809863627, 3475.600305964796, 3538.752287339887, 28836.423271534662, 29101.85449072741, 29269.0, 29505.70494295051, 30138.24654383636, 3427.7943323400677, 3459.9481007784902, 3477.374072666919, 3482.9825850870584, 3527.7177825774133, 237325.0, 237634.0, 237981.0, 238209.0, 238522.0, 53614.7319263409, 53837.0, 54024.94812889049, 54090.72954635201, 54113.458865410845, 62088.68955655283, 63127.36872631215, 63127.6843615779, 63196.0, 63199.0, 14099.577012689635, 14312.713745725026, 14344.713105737826, 14367.2098034607, 14372.0, 10655.200859935536, 10717.0890474309, 10786.73033174177, 10815.513301901434, 10823.080038196684, 18940.337088201846, 19234.942078185555, 19890.403287901387, 20074.19703211855, 20167.294144704865, 7730.149683534807, 7878.290953814184, 7997.720079797179, 8022.0, 8080.39397045224, 840.0423517190408, 868.322708287524, 871.1419252036738, 1024.626011505795, 1061.867266591676, 26707.732922670526, 27450.0, 27478.313042174104, 27734.56646483039, 27969.580456293173, 978.6819283732815, 1002.734275417015, 1030.2479190191052, 1048.4233671480656, 1072.1958531101673, 13710.520131795538, 14317.188319636341, 14379.712405751827, 14582.0, 14635.0, 296897.0, 301520.0, 301659.0, 301762.0, 302643.0, 46947.76526117416, 47516.76241618839, 47522.28716569254, 47529.52470475251, 47539.0, 1083.101026148295, 1224.8040313549789, 1240.4480006397248, 1258.6224132760135, 1263.9052071094889, 27270.863645681646, 29531.852340739017, 29606.851965740032, 29775.553366699085, 29996.70003299939, 39267.0, 40410.0, 40412.79793601131, 40443.59556404516, 40524.326594277416, 240854.0, 253453.0, 253613.0, 253678.0, 253868.0, 26872.462550748485, 27382.45235095247, 33027.0, 34334.48498272578, 34656.82671586626, 40134.59865401308, 40494.0, 41014.589854101076, 41312.58687413087, 41868.44118249983, 34511.13722156966, 35102.0, 35808.0, 35808.46287305745, 35856.4621530672, 35146.64853351434, 35528.822355888056, 35661.82169089138, 35763.284734304645, 35838.64161358353, 33284.33431331311, 33872.49191262182, 33969.0, 34042.14894627654, 34222.82888585541, 32322.35355292834, 33262.833685831414, 33458.33083338271, 33598.66401335955, 33856.49215261724, 25520.49817343018, 25928.733889309995, 25976.8701156493, 26261.0, 26276.21171364862], "unit": "score", "name": "ext.html", "value": 17332.375865510734}, {"lowerIsBetter": false, "replicates": [352.6297387742869, 356.5543071161048, 358.7273672009273, 363.6127524186741, 365.7933267703749, 15199.544013679593, 15764.211789410541, 15981.84018159818, 16720.163991800393, 16731.16344182789, 10716.73208169796, 10888.074513666328, 11099.334039957588, 11209.0, 11223.719407014829, 4626.629869610423, 4738.241881298993, 4752.287156926454, 4764.118638051971, 4766.951270720453, 3483.6342184070686, 5222.399424066224, 5442.319710036246, 5456.91814622779, 5461.208124821898, 5429.9185512217155, 5431.022415965124, 5431.293931788862, 5451.855110426815, 5463.180522921554, 5321.388040375348, 5970.820875373745, 5976.133460648203, 5982.611130276518, 5986.2517185351835, 5289.3917199521775, 5304.0, 5305.7877684892555, 5307.044731948247, 5307.6019298552765, 14035.50875719345, 18939.526511837175, 20040.09819558109, 20107.296244631514, 20122.094505747278, 1909.675355189621, 1914.473519782071, 1934.332655233942, 1984.642764302425, 2029.9797002029939, 9236.445813251226, 9676.080772326617, 10518.579256829718, 10572.207084468695, 13336.0, 1804.9368272110414, 1833.2850188426523, 1870.5136664467336, 1883.905804709759, 1896.2320260294603, 60609.39390606037, 60890.08664870031, 60999.69500152515, 61637.38362616361, 62054.68972655108, 10424.583016679248, 10459.058684718411, 10569.788604227871, 10576.259661823753, 10675.252732308663, 13494.865051349558, 13574.864251357558, 13615.31923403826, 13664.52174173919, 13723.862761372258, 6909.7581584644295, 7127.75052873147, 7154.821129471701, 7199.748008819666, 7210.495265331377, 6596.10952521413, 6605.933940660628, 6730.0577919091365, 6750.898736518956, 6757.966210168917, 4358.0412309291905, 4394.604485596312, 4498.3252512123445, 4501.257292546758, 4527.569880861313, 1693.5512089296346, 1737.3832289537286, 1746.502246859639, 1748.8338607832236, 1758.3757765993143, 862.7023676831483, 874.8337815814975, 892.6563273139758, 916.9821498137062, 993.7118235711563, 16168.191590420667, 16693.248803803857, 16821.243044063045, 17174.055426951636, 17238.482845514656, 843.6836186430089, 860.6471346747803, 870.856308709056, 883.1962913748458, 926.0878035135386, 9235.722928312161, 9616.855747163798, 9623.855642165374, 9697.321187516805, 9814.852777208347, 414319.0, 428648.0, 439778.0, 444245.0, 451138.0, 64840.0, 67142.0, 67559.66220168966, 67882.0, 68137.65931170313, 909.0, 912.5938957164132, 928.8931772846074, 931.7810314576069, 956.7512446763752, 14450.927745361207, 14559.636009099857, 14756.409743610135, 14778.448262932667, 14891.776623350443, 31004.68995310018, 31044.22389440282, 31308.373832523677, 32026.19934501656, 32074.35851283008, 43073.569264306956, 43107.568924310355, 44351.33472997843, 44799.0, 49401.75299123625, 7451.627418628938, 7695.23047695226, 7698.8845167321415, 7785.961070194613, 7857.842843143219, 11604.245724027911, 11814.527418903148, 11949.820752688544, 11966.58116965902, 11982.400879956142, 10151.137153342048, 10271.640492582725, 10444.63443779464, 10461.9476902615, 10687.30532515384, 10147.289689721649, 10234.795304094025, 10273.845892311472, 10413.114885234538, 10640.946795265974, 10394.688159355232, 10472.371657700562, 10477.0, 10691.5188816505, 11019.779604408028, 7534.849303014019, 7663.195364486649, 7695.0, 7698.0762308523335, 7804.765857024298, 9832.754181145528, 10146.644867429604, 10405.9479702601, 10407.0, 10562.0], "unit": "score", "name": "jquery.html", "value": 8021.814636897869}, {"lowerIsBetter": false, "replicates": [1288.2013151845856, 1432.0, 1439.8920080993921, 1603.1423188594104, 1798.6132981408994, 7212.242714514972, 7416.629168541578, 7429.851402971937, 7444.553326800396, 7446.553206807595, 7200.459965502595, 7377.26227377262, 7387.37207337377, 7391.186969433358, 7400.296971787671, 1931.082735700538, 2224.0547767198955, 2247.3033359658557, 2278.874661893595, 2281.566502364554, 2293.69035180251, 2296.024189719371, 2296.1619009061737, 2298.448372390631, 2299.4711216420233, 2167.729033870766, 2219.866807991518, 2225.032111031698, 2225.63277059285, 2226.198568515333, 2197.560487902426, 2239.1155493579945, 2239.1826983151195, 2257.4243567890167, 2264.547090581882, 2189.255653077961, 2207.9006444709867, 2223.29966060692, 2233.095596283508, 2234.575430668168, 7405.0, 7451.3293803557945, 7463.813404664873, 7467.066616672916, 7469.47713660044, 4498.572635599646, 4634.768261586941, 4635.165670179366, 4636.466806317283, 4640.025594625133, 3067.217859445849, 3079.8768049278, 3129.248980244725, 3133.341998180385, 3216.1477208539754, 981.087588542655, 993.1310103659298, 1002.5087707023579, 1006.2050979726008, 1027.4451796030135, 9296.39573427725, 9377.39046961952, 9393.76515587109, 9395.530223488799, 9403.858942115805, 3904.7852368119457, 4001.9399709003806, 4033.233685599727, 4113.629773320416, 4122.91754164915, 7581.583012934341, 7770.378369730408, 7807.102183248999, 7818.296353328228, 7821.061472623322, 4033.798310084484, 4220.746755194698, 4240.618344349024, 4240.936385954152, 4245.596668316505, 4092.979535102365, 4229.238737027303, 4237.555056719062, 4248.214080395075, 4254.829806807693, 3423.0928803866495, 3494.982525087409, 3512.454520011187, 3535.964640353615, 3544.9822750886083, 1019.5463018956641, 1050.8056009638242, 1058.6030238660503, 1061.1192710050639, 1073.4579037586125, 1204.2052245517916, 1211.9939400302942, 1218.7806194885006, 1231.7967535356565, 1237.4926280225245, 6753.662316884136, 6905.309469053054, 7236.204017558064, 7310.0, 7323.121225452873, 978.3787295067541, 1011.5043628621922, 1074.6238816414193, 1076.1767248055244, 1083.1659622090947, 5534.252875861707, 5593.272874526286, 5618.719064046782, 5631.915521267184, 5638.633488823213, 8718.215360617574, 8788.780280493038, 8996.100389961082, 9048.638054477879, 9128.0, 8964.0, 9212.170904618617, 9251.0, 9278.072192780668, 9297.302702297355, 7086.291370862976, 7179.353858152791, 7250.09373828261, 7308.963455182797, 7322.890156647654, 6927.68825402848, 6975.651217439209, 6997.405220556309, 7018.894716579358, 7070.469714771516, 7756.612169391621, 7975.5613441261285, 8022.679092836222, 8083.555404452576, 8301.252887240178, 8023.959880200561, 8252.876206857021, 8376.413651044368, 8379.120192379956, 8383.538905360263, 5843.29880414353, 6173.074038894202, 6361.077643741724, 6528.151340325728, 6698.430633396216, 7090.397316228178, 7096.361327480551, 7141.714331426685, 7143.1428228612895, 7143.607101609254, 6240.656763878031, 6420.518461115342, 6433.935660643334, 6540.247871494839, 6630.436412904957, 6404.423601875854, 6464.903026454513, 6474.546781725234, 6510.121133646897, 6682.899756503559, 6866.588004719732, 6869.587824730532, 6919.827004324932, 6923.446124310144, 6926.515143939876, 5986.521078313637, 6024.698765061642, 6387.5209359297305, 6395.616263024233, 6396.392342727433, 6403.295637479967, 6420.903686444613, 6448.226212854487, 6455.4512866406885, 6464.773732919325], "unit": "score", "name": "mootools.html", "value": 4309.437248825428}, {"lowerIsBetter": false, "replicates": [308.20790568239624, 311.4456267843239, 312.7123046796947, 320.5832417856786, 321.6638612649781, 5304.708241046741, 5376.112941364675, 5435.0, 5474.014677358074, 5478.0, 5338.786448542063, 5362.088444964355, 5396.514313711765, 5399.946000539993, 5407.242985981966, 3820.0449887528116, 3986.5614782373914, 4067.2678917794783, 4083.4691490106393, 4118.073433477473, 4068.6338229559333, 4077.2049450357194, 4084.264832330179, 4094.2220978014084, 4103.4870641169855, 4052.0477687743355, 4065.715399921992, 4073.674106071522, 4074.9812546863286, 4075.8777236682945, 3864.86472973446, 3953.683705303569, 4039.555648878621, 4051.2505186540584, 4053.6351728344293, 3515.6132825389186, 3519.4896739972814, 3524.0485069031474, 3526.0, 3535.9646403535894, 5200.167973124319, 5200.92198617021, 5209.244659524347, 5215.322008138955, 5215.6609820361555, 4707.7881495332795, 4707.811687532495, 4709.0, 4711.623070154379, 4717.834875779366, 5639.0, 5641.661500309953, 5643.238162848004, 5653.9151912721345, 5654.9151762723595, 3881.146147847497, 3903.2974064668347, 3904.1996390739832, 3908.062065104383, 3909.139989202371, 5720.170575266563, 5875.206847075633, 5945.137954996545, 5946.464818166386, 5952.255968003999, 3909.3354129798004, 3952.960470395317, 3954.3277642800795, 3956.22853543562, 3957.643812056871, 4010.7393019453643, 4010.859619913289, 4014.2372949140154, 4014.277430062617, 4015.799210039545, 4619.445666520039, 4619.445666520039, 4623.583877451046, 4633.443986721615, 4636.35091087248, 5577.1355439906065, 5584.21820945068, 5589.35722391922, 5592.189132575753, 5598.188262701967, 1390.3534856291874, 1413.0814970269407, 1414.0313884988816, 1414.6321956291233, 1416.0583212164001, 880.5377176982136, 913.5569248914271, 922.082527884759, 928.7817362919709, 939.0281059103795, 4909.091818013679, 4927.137750893579, 4928.408590969107, 4929.2359684248995, 4936.605071594264, 5844.12338149281, 5850.385709500526, 5850.5612079094235, 5851.853703657443, 5871.4128587141795, 4955.331030310934, 4955.4548999610015, 4963.975180124076, 4965.553100220997, 4967.130752118364, 3097.798643088192, 3136.764742644311, 3137.200013996462, 3142.6543080261154, 3143.512755522898, 5486.0, 5493.258410114663, 5503.807366742145, 5505.889882202414, 5510.779568817203, 5892.469677729025, 6088.238970128734, 6093.055576385667, 6098.603590766586, 6102.328743838174, 5555.1667249912025, 5570.526505247019, 5580.023495888203, 5587.636803607753, 5590.496855283044, 5942.940570594239, 5943.375945525658, 5944.316403613467, 5950.0, 5958.731857066356, 5782.5663075268685, 5783.537317014713, 5784.190213370048, 5786.276715410574, 5788.565857560784, 5378.892422151614, 5499.780008799603, 5569.33168019824, 5577.553795696415, 5583.246261754611, 3947.743396679207, 3962.8216730247786, 3971.451134057662, 3978.403239514096, 3985.740926839746, 5858.326292476249, 5879.0, 5888.3228428729535, 5901.0, 5904.1143828424365, 5670.5180059695385, 5678.77284908599, 5679.17651940458, 5679.6876171810945, 5680.062789639828, 5667.574931880043, 5670.064439367623, 5682.176084467812, 5683.886322273449, 5684.9431505684415, 5415.0, 5569.248151499496, 5571.637843540157, 5580.776768929198, 5581.441855814386, 5638.5489160867855, 5666.178404131296, 5667.1782591524825, 5670.631408958405, 5681.801136960186, 5547.89180111555, 5576.749046292845, 5586.653605485787, 5589.077802162597, 5589.664620122806], "unit": "score", "name": "prototype.html", "value": 4212.15773190819}, {"lowerIsBetter": false, "replicates": [670.6311528659238, 677.9224892126203, 768.7808974442281, 781.4245359360958, 795.5266616363266, 11948.581799637004, 12272.938635306811, 12275.386230688453, 12279.017678585715, 12294.877051229485, 12036.157468977175, 12044.939775301133, 12068.336241506713, 12111.75776484472, 12158.452869620865, 639.9232092148949, 797.5453991224989, 801.8155824160447, 814.4380377539509, 814.7311387242196, 817.0522194254665, 822.0382152881143, 822.0505316359614, 822.284612387224, 822.440740296598, 848.3467729848013, 859.6905114158898, 859.7893516088567, 860.5052095045343, 860.5826174305457, 677.133269415147, 836.3560058754725, 846.9195426434479, 851.0935853316198, 852.3820230333021, 623.2365352443221, 628.9779857705004, 629.3046183966696, 629.5309994054459, 629.8614304852925, 12001.51993920242, 12073.698157546132, 12104.21322614036, 12111.0, 12149.93925030378, 12108.334041627708, 13031.218126912321, 13093.214407135602, 13306.800397994039, 13431.12697674648, 9399.34204605678, 9541.427514349092, 10326.32878862879, 10607.15142788575, 10613.9469302653, 3330.9833450832834, 3338.6494418086236, 3363.5795525559306, 3377.3245350929665, 3459.187091033605, 41731.7913410431, 41909.790451047855, 42347.153056938994, 42656.786716066534, 42731.78634106841, 8978.191962723386, 9513.096255855682, 9531.809363812685, 9539.761505962268, 9617.663381781604, 17010.234539445755, 17062.061586612606, 17078.316867325415, 17084.914575427043, 17094.40169594058, 6997.545159564612, 7049.08361912948, 7077.115360579927, 7137.321954414322, 7236.312550307713, 3829.1193025604266, 3880.4567360569545, 3934.9001819405444, 3938.6258305460933, 4006.59934006597, 2882.1929859639336, 2898.971010289912, 2906.346072133753, 2912.8980485683323, 2928.546075358323, 509.15988618778573, 516.3855012535071, 520.0223579670196, 522.6602708239675, 522.9372475302988, 531.5694287627034, 537.3498067338486, 613.7391608566342, 658.4501940879323, 660.7687309441657, 8002.439829212016, 8211.34309255258, 8247.134050924686, 8334.291585215204, 8375.916240837636, 492.5025724018767, 621.2234706616729, 623.975040998355, 634.5462993959342, 640.8173670503884, 3752.6247375262255, 3815.6184381562175, 3842.865499707497, 3909.139989202371, 3916.3342231820657, 53065.469345306825, 54486.727566361915, 54729.45270547323, 54759.178612320844, 54863.45136548663, 44290.33564496535, 44511.77744111259, 45105.774471127435, 47552.762236188595, 47619.0, 41816.581834181874, 42077.0, 42234.78882605567, 42284.36573451401, 43305.0, 7305.853882922205, 7482.326590606872, 7485.1017877855, 7537.095548534211, 7679.347255483346, 32725.672743272262, 32847.0, 33119.337613248084, 33887.0, 34266.31467370688, 39031.609683902796, 42992.785036074616, 43121.78439107785, 43143.0, 43683.0, 8985.0, 9092.136247056518, 9201.30990175753, 9241.306901982243, 9389.906100938902, 10209.795804083727, 10237.846432303373, 10372.429516376671, 10478.476076196008, 10729.302595331279, 8662.436941598777, 11642.359670218219, 11654.067674585844, 11764.235324703866, 11790.764184716429, 10172.542235599563, 11056.723581910517, 11134.33194008362, 11530.019948304489, 11569.19015668895, 11368.829467557827, 11408.600698975495, 11911.642650720492, 11957.521699131938, 11965.341906195243, 8804.779880503038, 8999.0, 9061.90938090637, 9124.224440922597, 9408.482533460725, 8849.38054336216, 8967.461952282883, 8995.190432861074, 9227.76930576741, 9228.538573071453], "unit": "score", "name": "yui.html", "value": 5931.005966953096}], "name": "dromaeo_css", "value": 6405.34649554758}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 108.0, 112.0, 115.0, 113.0, 101.0, 113.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 148.0, 177.0, 129.0, 165.0, 152.0, 132.0, 184.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 163.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 100.0, 95.0, 75.0, 76.0, 72.0, 115.0, 96.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 134.0, 93.0, 93.0, 94.0, 139.0, 92.0, 95.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 98.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 75.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 66.0, 64.0, 65.0, 66.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 80.0, 80.0, 83.0, 81.0, 83.0, 82.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 115.0, 120.0, 124.0, 132.0, 116.0, 115.0, 122.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [131.0, 129.0, 141.0, 141.0, 145.0, 133.0, 144.0, 142.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 65.0, 69.0, 66.0, 67.0, 67.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1512.7999999999997}]} 04:36:04 INFO - Return code: 0 04:36:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:36:04 ERROR - # TBPL SUCCESS # 04:36:04 INFO - Running post-action listener: _resource_record_post_action 04:36:04 INFO - Running post-run listener: _resource_record_post_run 04:36:05 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 518639616; Read time: 0; Write time: 413128 04:36:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232452096; Read time: 0; Write time: 239472 04:36:05 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 286187520; Read time: 0; Write time: 173656 04:36:05 INFO - Running post-run listener: _upload_blobber_files 04:36:05 INFO - Blob upload gear active. 04:36:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:36:05 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 04:36:05 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:36:05 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:36:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:07 INFO - (blobuploader) - INFO - Done attempting. 04:36:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:36:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:07 INFO - (blobuploader) - INFO - Done attempting. 04:36:07 INFO - (blobuploader) - INFO - Iteration through files over. 04:36:07 INFO - Return code: 0 04:36:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:36:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:36:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1639214243723be3ee3a08da5455e631a123be6d23b885cad273ffdabfbb85d04139fbe2d31bc2a1620e27222504f21c8bcb053846b195dd2899ef8d3414bf31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/102ed77dabf6ab95c0626694ff9ab415aba2624b3a846d4fbdf7cc7f8adc2f94a91f1e8c621db351b72bf04e369424060b325a10f12d2d09409f34c6c141b73b"} 04:36:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:36:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:36:07 INFO - Contents: 04:36:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1639214243723be3ee3a08da5455e631a123be6d23b885cad273ffdabfbb85d04139fbe2d31bc2a1620e27222504f21c8bcb053846b195dd2899ef8d3414bf31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/102ed77dabf6ab95c0626694ff9ab415aba2624b3a846d4fbdf7cc7f8adc2f94a91f1e8c621db351b72bf04e369424060b325a10f12d2d09409f34c6c141b73b"} 04:36:07 INFO - Running post-run listener: copy_logs_to_upload_dir 04:36:07 INFO - Copying logs to upload dir... 04:36:07 INFO - mkdir: /builds/slave/test/build/upload/logs 04:36:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.240007 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-16 04:36:07.750870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 04:36:07.754419) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1639214243723be3ee3a08da5455e631a123be6d23b885cad273ffdabfbb85d04139fbe2d31bc2a1620e27222504f21c8bcb053846b195dd2899ef8d3414bf31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/102ed77dabf6ab95c0626694ff9ab415aba2624b3a846d4fbdf7cc7f8adc2f94a91f1e8c621db351b72bf04e369424060b325a10f12d2d09409f34c6c141b73b"} build_url:https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/LZp2DGNeScabibSmRxVnRg/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/Firefox-Non-PGO/sha512/1639214243723be3ee3a08da5455e631a123be6d23b885cad273ffdabfbb85d04139fbe2d31bc2a1620e27222504f21c8bcb053846b195dd2899ef8d3414bf31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/102ed77dabf6ab95c0626694ff9ab415aba2624b3a846d4fbdf7cc7f8adc2f94a91f1e8c621db351b72bf04e369424060b325a10f12d2d09409f34c6c141b73b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 04:36:07.779310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:36:07.779636) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1458126744.414248-1904053704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 04:36:07.863875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 04:36:07.864214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 04:36:07.864525) ========= ========= Total master_lag: 0.37 =========