builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1458863306.76 results: success (0) buildid: 20160324152237 builduid: 17a49d3f93cd434bb50d46093a539145 revision: b942c98f56c4c2926b8b81b98425072a091bbf7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.761643) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.762089) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.762403) ========= 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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006223 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.785319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.785624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.799352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.799675) ========= 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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.849059) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.849396) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.849768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:26.850044) ========= 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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 16:48: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.3M=0s 2016-03-24 16:48:27 (89.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154209 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:27.016830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:27.017139) ========= 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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:27.067129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 16:48:27.067488) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b942c98f56c4c2926b8b81b98425072a091bbf7b --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 b942c98f56c4c2926b8b81b98425072a091bbf7b --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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 16:48:27,206 truncating revision to first 12 chars 2016-03-24 16:48:27,206 Setting DEBUG logging. 2016-03-24 16:48:27,206 attempt 1/10 2016-03-24 16:48:27,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b942c98f56c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 16:48:28,003 unpacking tar archive at: mozilla-central-b942c98f56c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.059182 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 16:48:28.139323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:28.139726) ========= echo b942c98f56c4c2926b8b81b98425072a091bbf7b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b942c98f56c4c2926b8b81b98425072a091bbf7b'] 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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b942c98f56c4c2926b8b81b98425072a091bbf7b program finished with exit code 0 elapsedTime=0.003515 script_repo_revision: 'b942c98f56c4c2926b8b81b98425072a091bbf7b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:28.188834) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:28.189242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 16:48:28.200466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-24 16:48:28.200745) ========= /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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:48:28 INFO - MultiFileLogger online at 20160324 16:48:28 in /builds/slave/test 16:48:28 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 16:48:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:48:28 INFO - {'append_to_log': False, 16:48:28 INFO - 'base_work_dir': '/builds/slave/test', 16:48:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:48:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:48:28 INFO - 'branch': 'Firefox-Non-PGO', 16:48:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:48:28 INFO - 'config_files': ('talos/linux_config.py',), 16:48:28 INFO - 'default_actions': ('clobber', 16:48:28 INFO - 'read-buildbot-config', 16:48:28 INFO - 'download-and-extract', 16:48:28 INFO - 'populate-webroot', 16:48:28 INFO - 'create-virtualenv', 16:48:28 INFO - 'install', 16:48:28 INFO - 'run-tests'), 16:48:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:48:28 INFO - 'download_minidump_stackwalk': True, 16:48:28 INFO - 'download_symbols': 'ondemand', 16:48:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:48:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:48:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:48:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:48:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:48:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:48:28 INFO - 'installer_path': 'installer.exe', 16:48:28 INFO - 'log_level': 'info', 16:48:28 INFO - 'log_name': 'talos', 16:48:28 INFO - 'log_to_console': True, 16:48:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:48:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:48:28 INFO - 'opt_config_files': (), 16:48:28 INFO - 'pip_index': False, 16:48:28 INFO - 'sps_profile': False, 16:48:28 INFO - 'sps_profile_interval': 0, 16:48:28 INFO - 'suite': 'dromaeojs', 16:48:28 INFO - 'system_bits': '32', 16:48:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:48:28 INFO - 'title': 'talos-linux64-ix-053', 16:48:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:48:28 INFO - 'use_talos_json': True, 16:48:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:48:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:48:28 INFO - 'work_dir': 'build'} 16:48:28 INFO - ##### 16:48:28 INFO - ##### Running clobber step. 16:48:28 INFO - ##### 16:48:28 INFO - Running pre-action listener: _resource_record_pre_action 16:48:28 INFO - Running main action method: clobber 16:48:28 INFO - rmtree: /builds/slave/test/build 16:48:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:48:29 INFO - Running post-action listener: _resource_record_post_action 16:48:29 INFO - ##### 16:48:29 INFO - ##### Running read-buildbot-config step. 16:48:29 INFO - ##### 16:48:29 INFO - Running pre-action listener: _resource_record_pre_action 16:48:29 INFO - Running main action method: read_buildbot_config 16:48:29 INFO - Using buildbot properties: 16:48:29 INFO - { 16:48:29 INFO - "project": "", 16:48:29 INFO - "product": "firefox", 16:48:29 INFO - "script_repo_revision": "production", 16:48:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:48:29 INFO - "repository": "", 16:48:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:48:29 INFO - "buildid": "20160324152237", 16:48:29 INFO - "pgo_build": "False", 16:48:29 INFO - "basedir": "/builds/slave/test", 16:48:29 INFO - "buildnumber": 458, 16:48:29 INFO - "slavename": "talos-linux64-ix-053", 16:48:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:48:29 INFO - "platform": "ubuntu64_hw", 16:48:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:48:29 INFO - "branch": "mozilla-central", 16:48:29 INFO - "repo_path": "mozilla-central", 16:48:29 INFO - "revision": "b942c98f56c4c2926b8b81b98425072a091bbf7b", 16:48:29 INFO - "stage_platform": "linux64", 16:48:29 INFO - "builduid": "17a49d3f93cd434bb50d46093a539145", 16:48:29 INFO - "slavebuilddir": "test" 16:48:29 INFO - } 16:48:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:48:29 INFO - Running post-action listener: _resource_record_post_action 16:48:29 INFO - ##### 16:48:29 INFO - ##### Running download-and-extract step. 16:48:29 INFO - ##### 16:48:29 INFO - Running pre-action listener: _resource_record_pre_action 16:48:29 INFO - Running main action method: download_and_extract 16:48:29 INFO - mkdir: /builds/slave/test/build/tests 16:48:29 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')]} 16:48:29 INFO - https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:30 INFO - Downloaded 1361 bytes. 16:48:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:48:30 INFO - Using the following test package requirements: 16:48:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:48:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:48:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'jsshell-linux-x86_64.zip'], 16:48:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:48:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:48:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:48:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:48:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:48:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:30 INFO - https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:31 INFO - Downloaded 22068399 bytes. 16:48:31 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'] 16:48:31 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 16:48:32 INFO - Return code: 0 16:48:32 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 16:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:32 INFO - https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:48:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:48:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:48:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:33 INFO - Downloaded 22068399 bytes. 16:48:33 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'] 16:48:33 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 16:48:35 INFO - Return code: 0 16:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:35 INFO - https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:36 INFO - Downloaded 10847187 bytes. 16:48:36 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'] 16:48:36 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 16:48:36 INFO - Return code: 0 16:48:36 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')]} 16:48:36 INFO - https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIXGeNraSzKfFx18DTsl1g/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 16:48:38 INFO - Downloaded 54267712 bytes. 16:48:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:48:38 INFO - mkdir: /builds/slave/test/properties 16:48:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:48:38 INFO - Writing to file /builds/slave/test/properties/build_url 16:48:38 INFO - Contents: 16:48:38 INFO - build_url:https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:48:39 INFO - Running post-action listener: _resource_record_post_action 16:48:39 INFO - Running post-action listener: set_extra_try_arguments 16:48:39 INFO - ##### 16:48:39 INFO - ##### Running populate-webroot step. 16:48:39 INFO - ##### 16:48:39 INFO - Running pre-action listener: _resource_record_pre_action 16:48:39 INFO - Running main action method: populate_webroot 16:48:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:48:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:48:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:48:39 INFO - '--tppagecycles', 16:48:39 INFO - '7'], 16:48:39 INFO - 'tests': ['tsvgm']}}, 16:48:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:48:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:48:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:48:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:48:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'tests': ['damp', 'tps']}, 16:48:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['damp', 'tps']}, 16:48:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:48:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:48:39 INFO - 'other': {'tests': ['a11yr', 16:48:39 INFO - 'ts_paint', 16:48:39 INFO - 'tpaint', 16:48:39 INFO - 'sessionrestore', 16:48:39 INFO - 'sessionrestore_no_auto_restore', 16:48:39 INFO - 'tabpaint']}, 16:48:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['a11yr', 16:48:39 INFO - 'ts_paint', 16:48:39 INFO - 'tpaint', 16:48:39 INFO - 'sessionrestore', 16:48:39 INFO - 'sessionrestore_no_auto_restore', 16:48:39 INFO - 'tabpaint']}, 16:48:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['a11yr', 16:48:39 INFO - 'ts_paint', 16:48:39 INFO - 'tpaint', 16:48:39 INFO - 'sessionrestore', 16:48:39 INFO - 'sessionrestore_no_auto_restore', 16:48:39 INFO - 'tabpaint']}, 16:48:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['a11yr', 16:48:39 INFO - 'ts_paint', 16:48:39 INFO - 'tpaint', 16:48:39 INFO - 'sessionrestore', 16:48:39 INFO - 'sessionrestore_no_auto_restore', 16:48:39 INFO - 'tabpaint']}, 16:48:39 INFO - 'other_l64': {'tests': ['a11yr', 16:48:39 INFO - 'ts_paint', 16:48:39 INFO - 'tpaint', 16:48:39 INFO - 'sessionrestore', 16:48:39 INFO - 'sessionrestore_no_auto_restore', 16:48:39 INFO - 'tabpaint']}, 16:48:39 INFO - 'other_nol64': {'tests': ['a11yr', 16:48:39 INFO - 'ts_paint', 16:48:39 INFO - 'tpaint', 16:48:39 INFO - 'sessionrestore', 16:48:39 INFO - 'sessionrestore_no_auto_restore', 16:48:39 INFO - 'tabpaint']}, 16:48:39 INFO - 'svgr': {'tests': ['tsvgx', 16:48:39 INFO - 'tsvgr_opacity', 16:48:39 INFO - 'tart', 16:48:39 INFO - 'tscrollx', 16:48:39 INFO - 'cart']}, 16:48:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['tsvgx', 16:48:39 INFO - 'tsvgr_opacity', 16:48:39 INFO - 'tart', 16:48:39 INFO - 'tscrollx', 16:48:39 INFO - 'cart']}, 16:48:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'tests': ['tp5o']}, 16:48:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'talos_options': ['--e10s'], 16:48:39 INFO - 'tests': ['tp5o']}, 16:48:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'talos_options': ['--xperf_path', 16:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:39 INFO - 'tests': ['tp5n']}, 16:48:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:39 INFO - 'talos_options': ['--e10s', 16:48:39 INFO - '--xperf_path', 16:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:39 INFO - 'tests': ['tp5n']}}, 16:48:39 INFO - 'talos.zip': {'path': '', 16:48:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:48:39 INFO - Running post-action listener: _resource_record_post_action 16:48:39 INFO - ##### 16:48:39 INFO - ##### Running create-virtualenv step. 16:48:39 INFO - ##### 16:48:39 INFO - Running pre-action listener: _resource_record_pre_action 16:48:39 INFO - Running main action method: create_virtualenv 16:48:39 INFO - Creating virtualenv /builds/slave/test/build/venv 16:48:39 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 16:48:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:48:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:48:39 INFO - Using real prefix '/usr' 16:48:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:48:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:48:42 INFO - Installing pip.................done. 16:48:42 INFO - Return code: 0 16:48:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:48:42 INFO - Using env: {'DISPLAY': ':0', 16:48:42 INFO - 'HOME': '/home/cltbld', 16:48:42 INFO - 'LANG': 'en_US.UTF-8', 16:48:42 INFO - 'LANGUAGE': 'en_US:en', 16:48:42 INFO - 'LOGNAME': 'cltbld', 16:48:42 INFO - 'MAIL': '/var/mail/cltbld', 16:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:42 INFO - 'MOZ_NO_REMOTE': '1', 16:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:42 INFO - 'NO_EM_RESTART': '1', 16:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:42 INFO - 'PWD': '/builds/slave/test', 16:48:42 INFO - 'SHELL': '/bin/bash', 16:48:42 INFO - 'SHLVL': '1', 16:48:42 INFO - 'TERM': 'linux', 16:48:42 INFO - 'TMOUT': '86400', 16:48:42 INFO - 'USER': 'cltbld', 16:48:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:42 INFO - '_': '/tools/buildbot/bin/python'} 16:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:42 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 16:48:42 INFO - Cleaning up... 16:48:42 INFO - Return code: 0 16:48:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:48:42 INFO - Using env: {'DISPLAY': ':0', 16:48:42 INFO - 'HOME': '/home/cltbld', 16:48:42 INFO - 'LANG': 'en_US.UTF-8', 16:48:42 INFO - 'LANGUAGE': 'en_US:en', 16:48:42 INFO - 'LOGNAME': 'cltbld', 16:48:42 INFO - 'MAIL': '/var/mail/cltbld', 16:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:42 INFO - 'MOZ_NO_REMOTE': '1', 16:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:42 INFO - 'NO_EM_RESTART': '1', 16:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:42 INFO - 'PWD': '/builds/slave/test', 16:48:42 INFO - 'SHELL': '/bin/bash', 16:48:42 INFO - 'SHLVL': '1', 16:48:42 INFO - 'TERM': 'linux', 16:48:42 INFO - 'TMOUT': '86400', 16:48:42 INFO - 'USER': 'cltbld', 16:48:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:42 INFO - '_': '/tools/buildbot/bin/python'} 16:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:42 INFO - Downloading/unpacking psutil>=0.7.1 16:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:48:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:44 INFO - Installing collected packages: psutil 16:48:44 INFO - Running setup.py install for psutil 16:48:44 INFO - building 'psutil._psutil_linux' extension 16:48:44 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 16:48:44 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 16:48:44 INFO - building 'psutil._psutil_posix' extension 16:48:44 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 16:48:44 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 16:48:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:44 INFO - Successfully installed psutil 16:48:44 INFO - Cleaning up... 16:48:44 INFO - Return code: 0 16:48:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:48:44 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')]} 16:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:44 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')]} 16:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:44 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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48:44 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 16:48:44 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 16:48:44 INFO - Using env: {'DISPLAY': ':0', 16:48:44 INFO - 'HOME': '/home/cltbld', 16:48:44 INFO - 'LANG': 'en_US.UTF-8', 16:48:44 INFO - 'LANGUAGE': 'en_US:en', 16:48:44 INFO - 'LOGNAME': 'cltbld', 16:48:44 INFO - 'MAIL': '/var/mail/cltbld', 16:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:44 INFO - 'MOZ_NO_REMOTE': '1', 16:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:44 INFO - 'NO_EM_RESTART': '1', 16:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:44 INFO - 'PWD': '/builds/slave/test', 16:48:44 INFO - 'SHELL': '/bin/bash', 16:48:44 INFO - 'SHLVL': '1', 16:48:44 INFO - 'TERM': 'linux', 16:48:44 INFO - 'TMOUT': '86400', 16:48:44 INFO - 'USER': 'cltbld', 16:48:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:44 INFO - '_': '/tools/buildbot/bin/python'} 16:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:48:47 INFO - Installing collected packages: mozsystemmonitor 16:48:47 INFO - Running setup.py install for mozsystemmonitor 16:48:47 INFO - Successfully installed mozsystemmonitor 16:48:47 INFO - Cleaning up... 16:48:47 INFO - Return code: 0 16:48:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:48: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')]} 16:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48: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')]} 16:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48: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', '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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:48: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 blobuploader==1.2.4 16:48:47 INFO - Using env: {'DISPLAY': ':0', 16:48:47 INFO - 'HOME': '/home/cltbld', 16:48:47 INFO - 'LANG': 'en_US.UTF-8', 16:48:47 INFO - 'LANGUAGE': 'en_US:en', 16:48:47 INFO - 'LOGNAME': 'cltbld', 16:48:47 INFO - 'MAIL': '/var/mail/cltbld', 16:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:47 INFO - 'MOZ_NO_REMOTE': '1', 16:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:47 INFO - 'NO_EM_RESTART': '1', 16:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:47 INFO - 'PWD': '/builds/slave/test', 16:48:47 INFO - 'SHELL': '/bin/bash', 16:48:47 INFO - 'SHLVL': '1', 16:48:47 INFO - 'TERM': 'linux', 16:48:47 INFO - 'TMOUT': '86400', 16:48:47 INFO - 'USER': 'cltbld', 16:48:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:47 INFO - '_': '/tools/buildbot/bin/python'} 16:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:48:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:48:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:49 INFO - Downloading docopt-0.6.1.tar.gz 16:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:48:50 INFO - Installing collected packages: blobuploader, requests, docopt 16:48:50 INFO - Running setup.py install for blobuploader 16:48:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:48:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:48:50 INFO - Running setup.py install for requests 16:48:50 INFO - Running setup.py install for docopt 16:48:50 INFO - Successfully installed blobuploader requests docopt 16:48:50 INFO - Cleaning up... 16:48:50 INFO - Return code: 0 16:48:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48: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')]} 16:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48: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')]} 16:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:50 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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48:50 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 16:48:50 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 16:48:50 INFO - Using env: {'DISPLAY': ':0', 16:48:50 INFO - 'HOME': '/home/cltbld', 16:48:50 INFO - 'LANG': 'en_US.UTF-8', 16:48:50 INFO - 'LANGUAGE': 'en_US:en', 16:48:50 INFO - 'LOGNAME': 'cltbld', 16:48:50 INFO - 'MAIL': '/var/mail/cltbld', 16:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:50 INFO - 'MOZ_NO_REMOTE': '1', 16:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:50 INFO - 'NO_EM_RESTART': '1', 16:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:50 INFO - 'PWD': '/builds/slave/test', 16:48:50 INFO - 'SHELL': '/bin/bash', 16:48:50 INFO - 'SHLVL': '1', 16:48:50 INFO - 'TERM': 'linux', 16:48:50 INFO - 'TMOUT': '86400', 16:48:50 INFO - 'USER': 'cltbld', 16:48:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:50 INFO - '_': '/tools/buildbot/bin/python'} 16:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:50 INFO - Running setup.py (path:/tmp/pip-gzSbFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:50 INFO - Running setup.py (path:/tmp/pip-4Y9DHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:51 INFO - Running setup.py (path:/tmp/pip-RL6Wo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:51 INFO - Running setup.py (path:/tmp/pip-19YER6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:51 INFO - Running setup.py (path:/tmp/pip-30Z3Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:51 INFO - Running setup.py (path:/tmp/pip-fXYHVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:51 INFO - Running setup.py (path:/tmp/pip-N5S_PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:51 INFO - Running setup.py (path:/tmp/pip-qu_EwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:51 INFO - Running setup.py (path:/tmp/pip-0rLdbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:51 INFO - Running setup.py (path:/tmp/pip-gHocQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:51 INFO - Running setup.py (path:/tmp/pip-g0bpnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:51 INFO - Running setup.py (path:/tmp/pip-rkqW3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:51 INFO - Running setup.py (path:/tmp/pip-yIh_7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:51 INFO - Running setup.py (path:/tmp/pip-3Tx72e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:51 INFO - Running setup.py (path:/tmp/pip-A2q4Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:51 INFO - Running setup.py (path:/tmp/pip-eHjNlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:52 INFO - Running setup.py (path:/tmp/pip-cZ2ji6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:48:52 INFO - Running setup.py install for manifestparser 16:48:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Running setup.py install for mozcrash 16:48:52 INFO - Running setup.py install for mozdebug 16:48:52 INFO - Running setup.py install for mozdevice 16:48:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Running setup.py install for mozfile 16:48:52 INFO - Running setup.py install for mozhttpd 16:48:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Running setup.py install for mozinfo 16:48:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Running setup.py install for mozInstall 16:48:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:48:52 INFO - Running setup.py install for mozleak 16:48:52 INFO - Running setup.py install for mozlog 16:48:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:48:53 INFO - Running setup.py install for moznetwork 16:48:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:48:53 INFO - Running setup.py install for mozprocess 16:48:53 INFO - Running setup.py install for mozprofile 16:48:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:48:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:48:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:48:53 INFO - Running setup.py install for mozrunner 16:48:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:48:53 INFO - Running setup.py install for mozscreenshot 16:48:53 INFO - Running setup.py install for moztest 16:48:53 INFO - Running setup.py install for mozversion 16:48:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:48:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:48:53 INFO - Cleaning up... 16:48:53 INFO - Return code: 0 16:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:53 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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48:53 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 16:48:53 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 16:48:53 INFO - Using env: {'DISPLAY': ':0', 16:48:53 INFO - 'HOME': '/home/cltbld', 16:48:53 INFO - 'LANG': 'en_US.UTF-8', 16:48:53 INFO - 'LANGUAGE': 'en_US:en', 16:48:53 INFO - 'LOGNAME': 'cltbld', 16:48:53 INFO - 'MAIL': '/var/mail/cltbld', 16:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:53 INFO - 'MOZ_NO_REMOTE': '1', 16:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:53 INFO - 'NO_EM_RESTART': '1', 16:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:53 INFO - 'PWD': '/builds/slave/test', 16:48:53 INFO - 'SHELL': '/bin/bash', 16:48:53 INFO - 'SHLVL': '1', 16:48:53 INFO - 'TERM': 'linux', 16:48:53 INFO - 'TMOUT': '86400', 16:48:53 INFO - 'USER': 'cltbld', 16:48:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:53 INFO - '_': '/tools/buildbot/bin/python'} 16:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:54 INFO - Running setup.py (path:/tmp/pip-O582tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:54 INFO - Running setup.py (path:/tmp/pip-O5d0Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:54 INFO - Running setup.py (path:/tmp/pip-7LbkDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:54 INFO - Running setup.py (path:/tmp/pip-oZpEA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:54 INFO - Running setup.py (path:/tmp/pip-0d2Nbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:54 INFO - Running setup.py (path:/tmp/pip-2vVSLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:54 INFO - Running setup.py (path:/tmp/pip-AaIx2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:54 INFO - Running setup.py (path:/tmp/pip-7WW96p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:54 INFO - Running setup.py (path:/tmp/pip-lQvGCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:54 INFO - Running setup.py (path:/tmp/pip-CJSUZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:54 INFO - Running setup.py (path:/tmp/pip-bVy6aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:54 INFO - Running setup.py (path:/tmp/pip-7ZE_jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:54 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)) 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:54 INFO - Running setup.py (path:/tmp/pip-V2cZx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:55 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)) 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:55 INFO - Running setup.py (path:/tmp/pip-JLpiMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:55 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)) 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:55 INFO - Running setup.py (path:/tmp/pip-4nowxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:55 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)) 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:55 INFO - Running setup.py (path:/tmp/pip-n4WHoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:55 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)) 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:55 INFO - Running setup.py (path:/tmp/pip-cJIF1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:55 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)) 16:48:55 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)) 16:48:55 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)) 16:48:55 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)) 16:48:55 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)) 16:48:55 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)) 16:48:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48:57 INFO - Downloading blessings-1.6.tar.gz 16:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:48:57 INFO - Installing collected packages: blessings 16:48:57 INFO - Running setup.py install for blessings 16:48:57 INFO - Successfully installed blessings 16:48:57 INFO - Cleaning up... 16:48:57 INFO - Return code: 0 16:48:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:48:57 INFO - Reading from file tmpfile_stdout 16:48:57 INFO - Current package versions: 16:48:57 INFO - argparse == 1.2.1 16:48:57 INFO - blessings == 1.6 16:48:57 INFO - blobuploader == 1.2.4 16:48:57 INFO - docopt == 0.6.1 16:48:57 INFO - manifestparser == 1.1 16:48:57 INFO - mozInstall == 1.12 16:48:57 INFO - mozcrash == 0.17 16:48:57 INFO - mozdebug == 0.1 16:48:57 INFO - mozdevice == 0.48 16:48:57 INFO - mozfile == 1.2 16:48:57 INFO - mozhttpd == 0.7 16:48:57 INFO - mozinfo == 0.9 16:48:57 INFO - mozleak == 0.1 16:48:57 INFO - mozlog == 3.1 16:48:57 INFO - moznetwork == 0.27 16:48:57 INFO - mozprocess == 0.22 16:48:57 INFO - mozprofile == 0.28 16:48:57 INFO - mozrunner == 6.11 16:48:57 INFO - mozscreenshot == 0.1 16:48:57 INFO - mozsystemmonitor == 0.0 16:48:57 INFO - moztest == 0.7 16:48:57 INFO - mozversion == 1.4 16:48:57 INFO - psutil == 3.1.1 16:48:57 INFO - requests == 1.2.3 16:48:57 INFO - wsgiref == 0.1.2 16:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:57 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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48:57 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 16:48:57 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 16:48:57 INFO - Using env: {'DISPLAY': ':0', 16:48:57 INFO - 'HOME': '/home/cltbld', 16:48:57 INFO - 'LANG': 'en_US.UTF-8', 16:48:57 INFO - 'LANGUAGE': 'en_US:en', 16:48:57 INFO - 'LOGNAME': 'cltbld', 16:48:57 INFO - 'MAIL': '/var/mail/cltbld', 16:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:57 INFO - 'MOZ_NO_REMOTE': '1', 16:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:57 INFO - 'NO_EM_RESTART': '1', 16:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:57 INFO - 'PWD': '/builds/slave/test', 16:48:57 INFO - 'SHELL': '/bin/bash', 16:48:57 INFO - 'SHLVL': '1', 16:48:57 INFO - 'TERM': 'linux', 16:48:57 INFO - 'TMOUT': '86400', 16:48:57 INFO - 'USER': 'cltbld', 16:48:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:57 INFO - '_': '/tools/buildbot/bin/python'} 16:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 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)) 16:48:57 INFO - Cleaning up... 16:48:57 INFO - Return code: 0 16:48:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:57 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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:48:57 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 16:48:57 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 16:48:57 INFO - Using env: {'DISPLAY': ':0', 16:48:57 INFO - 'HOME': '/home/cltbld', 16:48:57 INFO - 'LANG': 'en_US.UTF-8', 16:48:57 INFO - 'LANGUAGE': 'en_US:en', 16:48:57 INFO - 'LOGNAME': 'cltbld', 16:48:57 INFO - 'MAIL': '/var/mail/cltbld', 16:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:57 INFO - 'MOZ_NO_REMOTE': '1', 16:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:57 INFO - 'NO_EM_RESTART': '1', 16:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:57 INFO - 'PWD': '/builds/slave/test', 16:48:57 INFO - 'SHELL': '/bin/bash', 16:48:57 INFO - 'SHLVL': '1', 16:48:57 INFO - 'TERM': 'linux', 16:48:57 INFO - 'TMOUT': '86400', 16:48:57 INFO - 'USER': 'cltbld', 16:48:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:57 INFO - '_': '/tools/buildbot/bin/python'} 16:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:58 INFO - Downloading/unpacking jsonschema 16:48:58 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 16:48:58 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 16:48:58 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 16:48:58 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 16:48:58 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 16:48:58 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 16:48:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:48:59 INFO - Downloading/unpacking functools32 (from jsonschema) 16:48:59 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 16:48:59 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 16:48:59 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 16:48:59 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 16:48:59 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 16:48:59 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 16:49:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:49:00 INFO - warning: no files found matching '*.txt' 16:49:00 INFO - no previously-included directories found matching 'build' 16:49:00 INFO - no previously-included directories found matching 'dist' 16:49:00 INFO - no previously-included directories found matching '.git*' 16:49:00 INFO - Installing collected packages: jsonschema, functools32 16:49:00 INFO - Running setup.py install for functools32 16:49:00 INFO - warning: no files found matching '*.txt' 16:49:00 INFO - no previously-included directories found matching 'build' 16:49:00 INFO - no previously-included directories found matching 'dist' 16:49:00 INFO - no previously-included directories found matching '.git*' 16:49:00 INFO - Successfully installed jsonschema functools32 16:49:00 INFO - Cleaning up... 16:49:00 INFO - Return code: 0 16:49:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:49:00 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')]} 16:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:00 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')]} 16:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:00 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 0x7f38ceff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, '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': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', '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 16:49:00 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 16:49:00 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 16:49:00 INFO - Using env: {'DISPLAY': ':0', 16:49:00 INFO - 'HOME': '/home/cltbld', 16:49:00 INFO - 'LANG': 'en_US.UTF-8', 16:49:00 INFO - 'LANGUAGE': 'en_US:en', 16:49:00 INFO - 'LOGNAME': 'cltbld', 16:49:00 INFO - 'MAIL': '/var/mail/cltbld', 16:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:00 INFO - 'MOZ_NO_REMOTE': '1', 16:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:00 INFO - 'NO_EM_RESTART': '1', 16:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:00 INFO - 'PWD': '/builds/slave/test', 16:49:00 INFO - 'SHELL': '/bin/bash', 16:49:00 INFO - 'SHLVL': '1', 16:49:00 INFO - 'TERM': 'linux', 16:49:00 INFO - 'TMOUT': '86400', 16:49:00 INFO - 'USER': 'cltbld', 16:49:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:00 INFO - '_': '/tools/buildbot/bin/python'} 16:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:00 INFO - Downloading/unpacking flake8 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:49:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:49:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:49:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:03 INFO - no previously-included directories found matching 'docs/_build' 16:49:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:49:03 INFO - Running setup.py install for pep8 16:49:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:03 INFO - no previously-included directories found matching 'docs/_build' 16:49:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:49:03 INFO - Cleaning up... 16:49:03 INFO - Return code: 0 16:49:03 INFO - Running post-action listener: _resource_record_post_action 16:49:03 INFO - Running post-action listener: _start_resource_monitoring 16:49:03 INFO - Starting resource monitoring. 16:49:03 INFO - ##### 16:49:03 INFO - ##### Running install step. 16:49:03 INFO - ##### 16:49:03 INFO - Running pre-action listener: _resource_record_pre_action 16:49:03 INFO - Running main action method: install 16:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:03 INFO - Reading from file tmpfile_stdout 16:49:03 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:49:03 INFO - Reading from file tmpfile_stdout 16:49:03 INFO - Output received: 16:49:03 INFO - Usage: mozinstall [options] installer 16:49:03 INFO - Options: 16:49:03 INFO - -h, --help show this help message and exit 16:49:03 INFO - -d DEST, --destination=DEST 16:49:03 INFO - Directory to install application into. [default: 16:49:03 INFO - "/builds/slave/test"] 16:49:03 INFO - --app=APP Application being installed. [default: firefox] 16:49:03 INFO - mkdir: /builds/slave/test/build/application 16:49:03 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'] 16:49:03 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 16:49:19 INFO - Reading from file tmpfile_stdout 16:49:19 INFO - Output received: 16:49:19 INFO - /builds/slave/test/build/application/firefox/firefox 16:49:19 INFO - Running post-action listener: _resource_record_post_action 16:49:19 INFO - ##### 16:49:19 INFO - ##### Running run-tests step. 16:49:19 INFO - ##### 16:49:19 INFO - Running pre-action listener: _resource_record_pre_action 16:49:19 INFO - Running main action method: run_tests 16:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:49:19 INFO - Python 2.7.3 16:49:19 INFO - Return code: 0 16:49:19 INFO - grabbing minidump binary from tooltool 16:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:19 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 0x1191410>, '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 0x1192310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11927a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:49:19 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 16:49:19 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 16:49:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:49:19 INFO - Return code: 0 16:49:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:49:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:49:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:49:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:49:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:49:20 INFO - Return code: 0 16:49:20 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/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 16:49:20 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/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 16:49:20 INFO - Using env: {'DISPLAY': ':0', 16:49:20 INFO - 'HOME': '/home/cltbld', 16:49:20 INFO - 'LANG': 'en_US.UTF-8', 16:49:20 INFO - 'LANGUAGE': 'en_US:en', 16:49:20 INFO - 'LOGNAME': 'cltbld', 16:49:20 INFO - 'MAIL': '/var/mail/cltbld', 16:49:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:49:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:20 INFO - 'MOZ_NO_REMOTE': '1', 16:49:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:20 INFO - 'NO_EM_RESTART': '1', 16:49:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:20 INFO - 'PWD': '/builds/slave/test', 16:49:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:49:20 INFO - 'SHELL': '/bin/bash', 16:49:20 INFO - 'SHLVL': '1', 16:49:20 INFO - 'TERM': 'linux', 16:49:20 INFO - 'TMOUT': '86400', 16:49:20 INFO - 'USER': 'cltbld', 16:49:20 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357', 16:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:20 INFO - '_': '/tools/buildbot/bin/python'} 16:49:20 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/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 16:49:20 INFO - mozversion application_buildid: 20160324152237 16:49:20 INFO - mozversion application_changeset: b942c98f56c4c2926b8b81b98425072a091bbf7b 16:49:20 INFO - mozversion application_display_name: Nightly 16:49:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:49:20 INFO - mozversion application_name: Firefox 16:49:20 INFO - mozversion application_remotingname: firefox 16:49:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:49:20 INFO - mozversion application_vendor: Mozilla 16:49:20 INFO - mozversion application_version: 48.0a1 16:49:20 INFO - mozversion platform_buildid: 20160324152237 16:49:20 INFO - mozversion platform_changeset: b942c98f56c4c2926b8b81b98425072a091bbf7b 16:49:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:49:20 INFO - mozversion platform_version: 48.0a1 16:49:20 INFO - using testdate: 1458863360 16:49:20 INFO - actual date: 1458863360 16:49:20 INFO - starting webserver on 'localhost:45337' 16:49:20 INFO - SUITE-START | Running 2 tests 16:49:20 INFO - TEST-START | dromaeo_css 16:49:20 INFO - operating with platform_type : linux_ 16:49:20 INFO - Initialising browser for dromaeo_css test... 16:49:20 INFO - TEST-INFO | started process 32744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_6ypf3/profile http://localhost:45337/getInfo.html) 16:49:25 INFO - PROCESS | 32744 | __metrics Screen width/height:1600/1200 16:49:25 INFO - PROCESS | 32744 | colorDepth:24 16:49:25 INFO - PROCESS | 32744 | Browser inner width/height: 1024/697 16:49:25 INFO - PROCESS | 32744 | __metrics 16:49:26 ERROR - PROCESS | 32744 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:49:26 INFO - PROCESS | 32744 | 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. 16:49:27 INFO - TEST-INFO | 32744: exit 0 16:49:27 INFO - Browser initialized. 16:49:27 INFO - Running cycle 1/1 for dromaeo_css test... 16:49:27 INFO - TEST-INFO | started process 370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_6ypf3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:39 INFO - PROCESS | 370 | RSS: Main: 155254784 16:49:39 INFO - PROCESS | 370 | 16:50:30 INFO - PROCESS | 370 | 1458863430707 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] 16:52:42 INFO - PROCESS | 370 | Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45337/tests/dromaeo/cssquery-ext.html) 16:52:43 INFO - PROCESS | 370 | RSS: Main: 237142016 16:52:43 INFO - PROCESS | 370 | 16:55:45 INFO - PROCESS | 370 | Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-ext.html (next: http://localhost:45337/tests/dromaeo/cssquery-jquery.html) 16:55:46 INFO - PROCESS | 370 | RSS: Main: 243118080 16:55:46 INFO - PROCESS | 370 | 16:58:48 INFO - PROCESS | 370 | Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45337/tests/dromaeo/cssquery-mootools.html) 16:58:48 INFO - PROCESS | 370 | RSS: Main: 245751808 16:58:48 INFO - PROCESS | 370 | 17:01:50 INFO - PROCESS | 370 | Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45337/tests/dromaeo/cssquery-prototype.html) 17:01:51 INFO - PROCESS | 370 | RSS: Main: 218988544 17:01:51 INFO - PROCESS | 370 | 17:04:54 INFO - PROCESS | 370 | Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45337/tests/dromaeo/cssquery-yui.html) 17:04:54 INFO - PROCESS | 370 | RSS: Main: 202752000 17:04:54 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-yui.html (next: http://localhost:45337/tests/dromaeo/cssquery-dojo.html) 17:07:57 INFO - PROCESS | 370 | RSS: Main: 260898816 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | __start_tp_report 17:07:57 INFO - PROCESS | 370 | _x_x_mozilla_page_load 17:07:57 INFO - PROCESS | 370 | _x_x_mozilla_page_load_details 17:07:57 INFO - PROCESS | 370 | |i|pagename|runs| 17:07:57 INFO - PROCESS | 370 | |0;dojo.html;2614.437895852392;2697.109953715274;2700.702922678506;2715.8234714743535;2717.701052884184;4634.189016922042;4711.246200607903;4711.599514041306;4720.433547974244;4745.715257084568;4668.323093151491;4726.598239149676;4743.691660042095;4759.405074365704;4798.376211092553;4246.936295955556;4293.978530107345;4314.97842510787;4352.673549483786;4469.687121901468;4399.692021558492;4424.823007079713;4426.2254105531565;4464.17412778637;4472.798724057409;4256.3189889617515;4297.162053399588;4331.06882020364;4340.7178533395545;4366;4340.305551111838;4342.066455712037;4383.605475507188;4384.101259241879;4420.977895110504;4301.2902871026245;4310.374995625617;4345.391645169679;4346.56534346566;4356.760378179199;4591.357209990604;4637.350770892078;4641.9535804641855;4702.78837452312;4713.835015774465;5072.518110779507;5085.440601533828;5086.949130508685;5087.033463641897;5108.386993560796;5087.872803179913;5090.898182036375;5100.515451032146;5111.821086261963;5135.794568217267;4624.583787459112;4741.952580474185;4747.833825816149;4823.059503396804;4837.782299796518;5187.19598462239;5207.5833933286;5208.869778255498;5210.244514545446;5238.633295669267;4988.800447982113;4988.800447982113;4992.151334273182;4998.2002879539095;5037.496250374933;4986.750662466862;4996.6752161110135;5065.721385323769;5077.416097148875;5106.336176297058;5065.6200784941275;5070.2141168119;5070.7464626768515;5071;5079.238114282887;5032.421271553745;5035.043341765053;5035.169197082514;5042.42012168598;5087.592992560586;4197.958020419756;4292.055747735493;4292.077203401283;4297.333913243452;4398.3842262083335;3799.6200379961783;3821.063839359319;3839.6160383961937;3845.3462911305146;3847.1343947611563;4384.4519435070615;4384.671149663788;4387.298032314814;4389.604935555815;4404.823807047682;5139.7687104080405;5142.100132476801;5142.6400151989;5152.974235128875;5192.766325515361;4395.450568678915;4398.560143985575;4399.20814253431;4407.206702793464;4434.623057040188;4559.886002849889;4576.496585375606;4634.397528321364;4635.768211589474;4638.768061596907;4696.225122854759;4701.858944231679;4705.035467729107;4737.431508219036;4739.194336962793;4968.652194346361;4973.577245933991;5018.87452813668;5029.622778291569;5073.822416215415;4707.811687532598;4709.317149013443;4749.667523273476;4852.320675105418;4867.58625516835;5018.372703412074;5026.47222041695;5034.823781167642;5038.798448062036;5093.312402825572;5121.07820592297;5130.461301563282;5134.358205224347;5135.15269980449;5141.177411614124;4792.544708252711;4906.803727850846;4955.628327875496;4966.130927087673;5007.1487847065355;4891.828785992473;4924.532169443897;4931.950680493293;4941.2835138905375;4978.153713868724;4783.689060211075;4861.392325959255;4870.196417591058;4876.171050921281;4900.92648610264;4959.677620954626;4999.200127979506;5009.8589791588665;5020.849374518771;5073.391193056709;4895.388076490439;4913.091078150554;4914.70511769295;4925.975370123127;4930.4822993586595 17:07:57 INFO - PROCESS | 370 | |1;ext.html;515.9948400515995;534.7353060235183;542.9565634749221;560.7056295444894;564.3087218157757;35182.64817351826;35489.467657985086;35880.28239435213;35894.282114357695;35899.2820143597;35640.82179589098;36239.818800906025;36273.27453450936;36298.45552316718;36347;7202.963985180093;7380.852382952337;7416.110066791993;7610.923890761077;9569.66506172284;9714.562844671971;9850.605975760996;9853.06395892389;9859.112679858812;9862.802743945116;9840.753981150492;9947.353422027545;9949.801003979916;9953.402795832237;9955.850662240073;7536.359409450203;9948.900510994907;10235.130013948823;10238.7440313992;10239.283250172492;9690.32167748258;9822.852657210076;9823.607055717763;9830.606775728962;9832.852507212398;35344.29311413783;35821;35826.566937322736;35882.461763073574;35926;3141.2461009357817;3183.3792410479964;3261.5433839262523;3417.743669224818;3472.9131771705656;29529.261768455744;29820.254493637614;30390.69609303901;30397.69602303971;31218.84390578055;3494.2487365216602;3540.539729835131;3561.4123669594487;3574.588037725084;3579.158897659048;184564;187201;188368;188609;245445;56937.71531142318;57729.71135144297;57767.13349299764;57803.4219657798;57813.421865781645;61288.69355653193;64847.35152648507;65621.39082350516;65747.34252657508;65756.34243657599;14944.850551494563;15052.172130532927;15070.397184112513;15102.169380684169;15108.39566417353;11534.192606517463;11595.594154204562;11628.6511404658;11628.6511404658;11631.65105046833;19486.05675269028;19772;19786.50533736668;19789.30737424183;19854.40436786899;6378.553501254961;7507.849843003219;7730.342920851678;7836.083756763721;7879.803004924923;911.2983003087586;936.4989730494153;939.3987847777428;950.4867371619387;954.6420092465326;26728.732712672623;28017.159485215478;28611.14166575006;28633;28653.570196447068;1028.83024300991;1035.5961175141701;1065.4459680965854;1067.3062509368817;1080.9459527023616;14262.643433914234;14720.337584808709;14729.779053314209;14806;15000.324985375684;279978;280798;283027;283433;284168;47307;48537.514624854004;48582;48586.27120593194;48691.5130848687;1040.7710303733168;1129.6667483092508;1141.697450175704;1184.5676328140166;1225.724212052281;18024.729629055837;24964;26126.216213513624;26136.693165342036;26139.607905881046;35933;36165.457518136725;36225.45661815128;36353.27293454169;36406;149572;152788.236058819;153667;153936;154110;31728.36543269168;41167.382489263284;41857.79071104625;41880.58119418767;42175.15649686928;37093.81453092717;37672.62327376801;38177.809110954266;39600.3886494441;40004.399934001594;32527.34945301128;38214.80892595519;38227.617723822405;38552;39267.41098883462;32025.839870800497;32075.518867216542;32159.51760723638;32345.35309293848;32623.34753304968;32636.510452343708;33165.17087072843;33172.33655326832;33282.66717332796;33466.66533334733;28663.856680716464;29272.707272926997;30067;31946;32081;24331.63502547428;24898.50202995966;24936.750632493444;25165.622515662646;25272 17:07:57 INFO - PROCESS | 370 | |2;jquery.html;346.5062286242105;351.257091252002;359.73020234823883;366.40459253712714;368.0798004987531;15515.844841551581;15808.841911580881;15873.761893571591;16230;16246.268917898693;15054.6989060219;15413.383464661429;15560.45538406156;15577;15604.141772202523;4933.80264789408;4964.87587810304;5020.221865610836;5033.068882256776;5100.821471248507;4992.226204938241;5003.649744517885;5024.296598476216;5037.874053148664;5042.394912610492;4980.626453016021;4985.825496107637;4990.47600002;4994.225894986283;5000.049990501811;4833.202521583952;4968.826091086813;4981.9252711209365;4993.176125939216;5030.1448753711775;4432.268675668511;4442.2892337225885;4447.799849006802;4448.110377924428;4456.420665313521;18065.819341806546;19247.903760481247;19412.805871941382;19471.610567788706;19482.610347792965;1987.6223517531766;2006.1674405122003;2137.5938571671486;2594.4292255703713;2603.3231359846386;12229.449674764657;12605.243685378906;12662.303573303465;12959.066899208972;12969.351532423341;1739.9913000435045;1813.0662708705026;1821.4899828048167;1871.1018711018787;1889.9622007559772;41665.37501937473;57021;57495.42504574984;62140;62747;9070.092990700878;9162.86255706165;9206.355555111211;9243;9406.341556091145;12476.251424914533;12586.23792669027;12586.748265034648;12602.243865368107;12617.179883307555;6081.209442772411;6723.63020033893;6899.17209934801;7148.821279468055;7169.351049258596;6627.635480048643;6678.398944094957;6807.285235050347;6819.829504262334;6835.897461538081;5403.783848646089;5450.5367043801725;5542.528885044736;5610.719464026783;5647.435256474402;1632.8122265939332;1690.9661806763795;1717.5534361066213;1732.2464727843428;1733.6619359225083;893.2496702769705;914.4696076275744;923.6813299411692;944.7165850244899;964.0744884910424;14707.255764970121;16221.83778162227;16297.511074667778;16396.26216820246;16546.917265413595;908.6910450446879;928.9256859451227;933.3653115881266;941.7174847545709;954.7183580843667;9314.813703725888;9379.062093790566;9564.808703825884;9724.805503890024;9754.219662426989;422129;422386;424307;432891;435471;47630.5236947633;62242;63651;63908.36091639117;64776.67611661911;840.4831028917172;952.3952290295574;960.1454705312277;991.5389343955095;992.7865508915618;14662.120272783666;14843.777343340074;14892.404303827725;15045.473408430653;15189.696206076038;31291;31337.843310784214;31624;31676.35721892012;31933.20166995844;41213;41435.37846932238;41763.37354939617;41865;41932;7383.889241661487;7420.183779784112;7517.097948246245;7646.158922518407;7651.732189373345;11365.261258018203;11425.829092472404;11491.425428728697;11637.185397022127;11678.532858685558;10192.184625230113;10264.794704105727;10300;10350.5342259597;10459.058684718411;9953.800923981335;10160.695179144637;10164.390136591828;10188.490575471345;10348;9121.726348209564;10292.330998485075;10357.119644830274;10469.842952355568;10514.57941682324;7389.150247721366;7389.261073892568;7414.22150674193;7427.405807535492;7574;10273.332233404804;10452.372857628567;10517.21120915919;10529.368237905444;10541 17:07:57 INFO - PROCESS | 370 | |3;mootools.html;1315.7763180259356;1442.271652815328;1456.1336005076982;1610.1788088075077;1763.805981342053;6915.930840691592;7451.664675089621;7533.849323013536;7586.241375862411;7612.2768337007965;7496.512726672776;7653.693852245918;7670.07959044914;7702.499337543056;7710.421718371116;1981.4749091490767;2225.4770129019666;2277.123307526602;2286.1998300594823;2308.3305841306087;2286.554121946213;2292.64464008079;2294.8393612447135;2297.908083676651;2299.735530414007;2207.558488302338;2310.0413328468667;2312.3756585721844;2312.5721741477882;2315.768423157679;2227.7326720793526;2241.316398498457;2264.784845439681;2277.7152855893014;2280.8631482111127;2225.221172589597;2277.9658305125436;2279.726432828071;2282.9657555136687;2286.7713228677167;7828.295453409163;7897.921020789776;7914.485558438741;7914.564698941556;7924.881126783102;4699.812007519695;4799.016201678683;4806.879828004293;4842.297866809293;4846.830360937351;3149.669284725094;3154.4164329598866;3231.337575796956;3241.1248962780155;3273.5580696605894;985.0641890204334;1038.2628333882951;1041.3959903256168;1073.8281874900056;1094.956201751929;10889.074428673572;10892.455377231106;10896.128309735202;10912;10913.508892099875;4327.826886924488;4345.065810850682;4361.934570981438;4363.912721745611;4395.604395604347;9240.122188392092;9250.95374523123;9296.39573427725;9328.580213890391;9336.253099752004;4110.095778928631;4867.902641947141;4873.074115917964;4874.610031197567;4877.244027175722;4169.812358443877;4238.3430568261965;4280.186764514732;4290.227759003409;4310.80601372939;3594.6585074418413;3673.540807399075;3676.5771936227143;3692.390755525308;3738.756980796294;1210.9091818113677;1221.9450124744408;1240.2744394529302;1244.2721008210299;1246.376811594203;1228.5700004998357;1228.7051107734258;1248.1200753468784;1256.0203041627544;1258.937053147339;7424.406047516186;7453;7484.288992545699;7489.812754681177;7531.774046778605;470.7363876229322;477.6298368764166;478.652976591975;482.5946205187589;483.675937122129;5610.97194514033;5658.971705141448;5662.207290979266;5672.574556908248;5702.657840529581;8925.330600204881;9137.40606860552;9252.306077044248;9260.444373337621;9301.953490232641;8958.596863141174;9015.188633022928;9024.909750902407;9024.909750902407;9074.500902450429;6980.7905762827195;7056.6118863463;7236.421086313082;7256.963715181496;7332.816679583053;7017.7192912282935;7035.577865328097;7041.225465198926;7048.682809273698;7059.25877782846;8361.289290410139;8380.329573634217;8614.526201058752;8788;8811.735647930573;8680.088590697886;8895.510746908982;8906.554672266231;8906.955465222632;9077.682281120393;6079.392060793885;6828.760993365408;6932.688029038604;6960.164780226405;7080.221175670775;7252.129744430702;7256.7822965311125;7272.745453909088;7273.236310187354;7298.343149116605;6470.935290647033;6667.566608170453;6707.66461676924;6811.795646130624;6867.141607299088;6615.735370585316;6628.337166283333;6675.899861501985;6691.2639609643875;6754.696038678173;7011.439084873095;7063.823404414725;7086.610236437045;7111.111111111111;7117.572945623072;6638.5684930479365;6673.132492775908;6677.833054173684;6679.866402672016;6684.732610695518;6553.639549824615;6609.834754131185;6622.503312251504;6623.635700036544;6629.4696424284975 17:07:57 INFO - PROCESS | 370 | |4;prototype.html;317.4523946192819;321.38936021559033;323.2113642711783;327.13472864273996;331.75284413112234;5303.867403314915;5422.945770542294;5453.563714902813;5462.972685136579;5466.671999680022;5329.866753331169;5362.35651721794;5374.973125134378;5381.112116500783;5381.461853814617;3998.400239964014;4034.878953631381;4082.6121518455698;4194.727342722721;4205;4178.916421671564;4187.979060104695;4190.350495673176;4194.916101677964;4196.244675958326;4127.030147915252;4144.834206631731;4145.046639272969;4146.025683964281;4149.149424368013;3932.390479475686;4033.4756481657196;4129.731567448106;4131.421600975866;4136.896577585554;3643.1074386775144;3648.543932008499;3652.397354436515;3654.817259137059;3658.4512323151475;5023.547880690755;5040;5043.067032598981;5043.67216130954;5047.697138171721;4762.28565715142;4780.402449693788;4781.282807578857;4782.521747825224;4783.545563171493;5581.748821303051;5597.3003374578175;5599.440055994409;5604.019296623115;5607.4112218217315;4017.879463616096;4021.396790481422;4027.1140349123148;4035;4035.1727895781296;5655.717214139277;5854.47309742121;5856.502197313191;5879.206307148565;5977.342492325797;4020.73865198767;4055.0065234017266;4061.593840615915;4070.247004304154;4079.877603671835;4094.590540945941;4110.835566577303;4111.9177616447505;4112.979435102805;4113.218488487238;4729.456112547101;4736.289556566474;4738.07607516531;4748.264019077049;4753.904921901542;5670.8015219467125;5680.233168522279;5685.204071430003;5686.829395118153;5690.630109042899;1421.8435972043067;1450.8476609955803;1453.4840131753288;1454.0475988227727;1454.367350202644;900.3337530227584;952.2477242977969;961.1301771896445;981.038582189444;985.4383001689112;4850;4917.631177661689;4922.778474968635;4928.137575924199;4940.802367905244;5787.363390027093;5869.735861886225;5886.941130588725;5889.617174883704;5902;4978.950210497921;4984.526469985346;4986.351774269322;4996.850094497171;5004.199328107486;3115.9532607010915;3142.245860993391;3157.636871759731;3161.731252843534;3162.177833763238;5490.972545137249;5504.4770746778995;5509.779608815683;5512.3385193777;5515.779368825282;5860.267466566679;6015.819525414245;6040.637561746309;6040.939590604125;6050.57645964787;5473.534749546254;5481.725913704219;5482.342118945752;5485.6982865942755;5491.066518691832;5842.970785146217;5888.17565540816;5888.205092312483;5891.852703682443;5896.292444906639;5755.395683453345;5755.884882302415;5766.826995190151;5770.567207459373;5774.538036957118;5488.1493368527945;5495.148252020943;5496.80761173357;5497.945020549903;5498.147787093007;3932.6067393261587;4056.492938382702;4067.4102255173425;4068.9389659154544;4071.91856162881;5873;5887.470127688529;5892.94107058924;5896.8820623586425;5897.351291357862;5668.234788303526;5668.801591944262;5680.062789639664;5682.857928551819;5683.857903552444;5660.349059858169;5661.697809503919;5667.064934285797;5668.801591944262;5675.687837168995;5445.972105028012;5574.721263936868;5577.8047768327915;5579.218909352775;5585.664860108406;5655.802046928337;5720.056190728483;5721.027425337619;5723.570732195185;5735.770569177186;5536.75084621201;5568.610197286151;5570.387257401763;5584.664920104807;5585.2180694701965 17:07:57 INFO - PROCESS | 370 | |5;yui.html;619.4332186049764;706.7773651299837;713.543332267349;716.1728203924469;716.928307169283;12098.516059357626;12145.149839511216;12146.271223726582;12166.148369614131;12187;12287;12302.56941007065;12358.011359091273;12372.876271237285;12398.194117382387;658.0655469233676;816.5998660656295;819.0989911097804;832.1262674192104;836.7155167243136;827.5448503323179;829.8049958259804;830.5722552885269;831.4969443486694;836.8117173635944;857.7469646454311;857.7984173719202;858.7981824271292;859.5272600069936;865.9437136586101;684.6302996381972;694.4305669351135;694.5971336624746;854.7521218846528;868.6264906090379;635.678982114034;636.6816591704148;639.5363361562876;639.6481934935766;641.1408712325459;11334.263272887318;11356.26184298018;11392.71518212043;11409;11441.656750297505;11715.4142292885;11882.58410955621;12114.878851211552;12216.083793715417;12608.936955315256;9710.563024663836;9972.501374931224;10121.240906931936;10143.239257055677;10146.898531014669;3338.282269312085;3353.3628610563915;3384.966150338514;3462.4113900636953;3468.2543253200683;40976.180476390604;42528.78735606333;42600.360994585106;42743.35884961728;42849;9793.510324483746;9972.351797133164;10013;10088;10134.493275336205;15744.60638484047;15859.762103568455;15893.443729469644;15894.52316430509;15930.283137258852;6744.831379215559;6840.623765692835;6846.520743547904;6876.759313424006;7066.328698773608;3795.1081495848453;3821.7898015608853;3823.1971286030243;3840.6927445804267;3905.0432644002403;2963.0518234165293;2969.5545668149516;2982.1948074019892;2985.5521671748975;2994.7903646744953;514.3236643813374;516.3339292312875;517.8498235511735;526.531387065512;534.6230907210485;519.4390058736556;535.713393334572;552.988031901619;584.6492104737124;595.5652373767174;8300.833983320299;8400.747977560683;8446.324294056461;8531.274841638406;8706.825863482822;585.7832601937225;634.8793729191439;644.4715333426545;647.601724939159;655.1057806094647;3787.962120378816;3800.9809950950066;3842.366009608439;3918.275119102975;3930.941035884464;47212.5278747215;48919.75540122276;49235.26147107796;49386;49585.25622115671;48072.27891581629;49083;49209;49621.25568116481;49708;41322.1735565287;41679.58320416818;42070.36894446586;42101.15797684029;42313.57686423096;8489.74530764078;8560.186782255676;8673.132686731276;8738.475691458532;8757.299416046573;31538.684613153575;31729.68270317267;32443.35113297768;32551.18622034468;32772.508412373354;37313.44029839609;37400.812995934844;38653.226935460574;41365.793171033954;41612;10531.73670658209;10542;10724;10772.676819695422;10927.726806829893;11906.642800715992;11955.103367247317;12070.637880863587;12092.939535302266;12275.815862762245;10943.616973405893;10966.342019478856;11226.382548959886;11387.943060284646;11487.712807179887;11256.887431125911;11274.661760147208;11312.26470279462;11845.526178952745;12006.339651319262;11006.339619622848;11039.889601103887;11513.942430287794;11524.13568982313;11683.941580292045;9542.565125264864;9612.615495380107;9647.1317581418;9856.507174641096;9875.604975800887;9248.815023699353;9506.809863802824;9512.191463725385;9514.69283157343;9552.188064014637 17:07:57 INFO - PROCESS | 370 | __end_tp_report 17:07:57 INFO - PROCESS | 370 | __start_cc_report 17:07:57 INFO - PROCESS | 370 | _x_x_mozilla_cycle_collect,899 17:07:57 INFO - PROCESS | 370 | __end_cc_report 17:07:57 INFO - PROCESS | 370 | __startTimestamp1458864477688__endTimestamp 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | ------- Summary: start ------- 17:07:57 INFO - PROCESS | 370 | Number of tests: 6 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | [#0] dojo.html Cycles:165 Average:4694.74 Median:4798.38 stddev:485.44 (10.1%) stddev-sans-first:458.68 17:07:57 INFO - PROCESS | 370 | Values: 2614.4 2697.1 2700.7 2715.8 2717.7 4634.2 4711.2 4711.6 4720.4 4745.7 4668.3 4726.6 4743.7 4759.4 4798.4 4246.9 4294.0 4315.0 4352.7 4469.7 4399.7 4424.8 4426.2 4464.2 4472.8 4256.3 4297.2 4331.1 4340.7 4366.0 4340.3 4342.1 4383.6 4384.1 4421.0 4301.3 4310.4 4345.4 4346.6 4356.8 4591.4 4637.4 4642.0 4702.8 4713.8 5072.5 5085.4 5086.9 5087.0 5108.4 5087.9 5090.9 5100.5 5111.8 5135.8 4624.6 4742.0 4747.8 4823.1 4837.8 5187.2 5207.6 5208.9 5210.2 5238.6 4988.8 4988.8 4992.2 4998.2 5037.5 4986.8 4996.7 5065.7 5077.4 5106.3 5065.6 5070.2 5070.7 5071.0 5079.2 5032.4 5035.0 5035.2 5042.4 5087.6 4198.0 4292.1 4292.1 4297.3 4398.4 3799.6 3821.1 3839.6 3845.3 3847.1 4384.5 4384.7 4387.3 4389.6 4404.8 5139.8 5142.1 5142.6 5153.0 5192.8 4395.5 4398.6 4399.2 4407.2 4434.6 4559.9 4576.5 4634.4 4635.8 4638.8 4696.2 4701.9 4705.0 4737.4 4739.2 4968.7 4973.6 5018.9 5029.6 5073.8 4707.8 4709.3 4749.7 4852.3 4867.6 5018.4 5026.5 5034.8 5038.8 5093.3 5121.1 5130.5 5134.4 5135.2 5141.2 4792.5 4906.8 4955.6 4966.1 5007.1 4891.8 4924.5 4932.0 4941.3 4978.2 4783.7 4861.4 4870.2 4876.2 4900.9 4959.7 4999.2 5009.9 5020.8 5073.4 4895.4 4913.1 4914.7 4926.0 4930.5 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | [#1] ext.html Cycles:180 Average:38708.21 Median:19338.45 stddev:56963.73 (294.6%) stddev-sans-first:57051.35 17:07:57 INFO - PROCESS | 370 | Values: 516.0 534.7 543.0 560.7 564.3 35182.6 35489.5 35880.3 35894.3 35899.3 35640.8 36239.8 36273.3 36298.5 36347.0 7203.0 7380.9 7416.1 7610.9 9569.7 9714.6 9850.6 9853.1 9859.1 9862.8 9840.8 9947.4 9949.8 9953.4 9955.9 7536.4 9948.9 10235.1 10238.7 10239.3 9690.3 9822.9 9823.6 9830.6 9832.9 35344.3 35821.0 35826.6 35882.5 35926.0 3141.2 3183.4 3261.5 3417.7 3472.9 29529.3 29820.3 30390.7 30397.7 31218.8 3494.2 3540.5 3561.4 3574.6 3579.2 184564.0 187201.0 188368.0 188609.0 245445.0 56937.7 57729.7 57767.1 57803.4 57813.4 61288.7 64847.4 65621.4 65747.3 65756.3 14944.9 15052.2 15070.4 15102.2 15108.4 11534.2 11595.6 11628.7 11628.7 11631.7 19486.1 19772.0 19786.5 19789.3 19854.4 6378.6 7507.8 7730.3 7836.1 7879.8 911.3 936.5 939.4 950.5 954.6 26728.7 28017.2 28611.1 28633.0 28653.6 1028.8 1035.6 1065.4 1067.3 1080.9 14262.6 14720.3 14729.8 14806.0 15000.3 279978.0 280798.0 283027.0 283433.0 284168.0 47307.0 48537.5 48582.0 48586.3 48691.5 1040.8 1129.7 1141.7 1184.6 1225.7 18024.7 24964.0 26126.2 26136.7 26139.6 35933.0 36165.5 36225.5 36353.3 36406.0 149572.0 152788.2 153667.0 153936.0 154110.0 31728.4 41167.4 41857.8 41880.6 42175.2 37093.8 37672.6 38177.8 39600.4 40004.4 32527.3 38214.8 38227.6 38552.0 39267.4 32025.8 32075.5 32159.5 32345.4 32623.3 32636.5 33165.2 33172.3 33282.7 33466.7 28663.9 29272.7 30067.0 31946.0 32081.0 24331.6 24898.5 24936.8 25165.6 25272.0 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | [#2] jquery.html Cycles:180 Average:23968.21 Median:423346.50 stddev:69807.22 (16.5%) stddev-sans-first:69980.52 17:07:57 INFO - PROCESS | 370 | Values: 346.5 351.3 359.7 366.4 368.1 15515.8 15808.8 15873.8 16230.0 16246.3 15054.7 15413.4 15560.5 15577.0 15604.1 4933.8 4964.9 5020.2 5033.1 5100.8 4992.2 5003.6 5024.3 5037.9 5042.4 4980.6 4985.8 4990.5 4994.2 5000.0 4833.2 4968.8 4981.9 4993.2 5030.1 4432.3 4442.3 4447.8 4448.1 4456.4 18065.8 19247.9 19412.8 19471.6 19482.6 1987.6 2006.2 2137.6 2594.4 2603.3 12229.4 12605.2 12662.3 12959.1 12969.4 1740.0 1813.1 1821.5 1871.1 1890.0 41665.4 57021.0 57495.4 62140.0 62747.0 9070.1 9162.9 9206.4 9243.0 9406.3 12476.3 12586.2 12586.7 12602.2 12617.2 6081.2 6723.6 6899.2 7148.8 7169.4 6627.6 6678.4 6807.3 6819.8 6835.9 5403.8 5450.5 5542.5 5610.7 5647.4 1632.8 1691.0 1717.6 1732.2 1733.7 893.2 914.5 923.7 944.7 964.1 14707.3 16221.8 16297.5 16396.3 16546.9 908.7 928.9 933.4 941.7 954.7 9314.8 9379.1 9564.8 9724.8 9754.2 422129.0 422386.0 424307.0 432891.0 435471.0 47630.5 62242.0 63651.0 63908.4 64776.7 840.5 952.4 960.1 991.5 992.8 14662.1 14843.8 14892.4 15045.5 15189.7 31291.0 31337.8 31624.0 31676.4 31933.2 41213.0 41435.4 41763.4 41865.0 41932.0 7383.9 7420.2 7517.1 7646.2 7651.7 11365.3 11425.8 11491.4 11637.2 11678.5 10192.2 10264.8 10300.0 10350.5 10459.1 9953.8 10160.7 10164.4 10188.5 10348.0 9121.7 10292.3 10357.1 10469.8 10514.6 7389.2 7389.3 7414.2 7427.4 7574.0 10273.3 10452.4 10517.2 10529.4 10541.0 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | [#3] mootools.html Cycles:180 Average:5439.96 Median:6512.29 stddev:2839.75 (43.6%) stddev-sans-first:2830.79 17:07:57 INFO - PROCESS | 370 | Values: 1315.8 1442.3 1456.1 1610.2 1763.8 6915.9 7451.7 7533.8 7586.2 7612.3 7496.5 7653.7 7670.1 7702.5 7710.4 1981.5 2225.5 2277.1 2286.2 2308.3 2286.6 2292.6 2294.8 2297.9 2299.7 2207.6 2310.0 2312.4 2312.6 2315.8 2227.7 2241.3 2264.8 2277.7 2280.9 2225.2 2278.0 2279.7 2283.0 2286.8 7828.3 7897.9 7914.5 7914.6 7924.9 4699.8 4799.0 4806.9 4842.3 4846.8 3149.7 3154.4 3231.3 3241.1 3273.6 985.1 1038.3 1041.4 1073.8 1095.0 10889.1 10892.5 10896.1 10912.0 10913.5 4327.8 4345.1 4361.9 4363.9 4395.6 9240.1 9251.0 9296.4 9328.6 9336.3 4110.1 4867.9 4873.1 4874.6 4877.2 4169.8 4238.3 4280.2 4290.2 4310.8 3594.7 3673.5 3676.6 3692.4 3738.8 1210.9 1221.9 1240.3 1244.3 1246.4 1228.6 1228.7 1248.1 1256.0 1258.9 7424.4 7453.0 7484.3 7489.8 7531.8 470.7 477.6 478.7 482.6 483.7 5611.0 5659.0 5662.2 5672.6 5702.7 8925.3 9137.4 9252.3 9260.4 9302.0 8958.6 9015.2 9024.9 9024.9 9074.5 6980.8 7056.6 7236.4 7257.0 7332.8 7017.7 7035.6 7041.2 7048.7 7059.3 8361.3 8380.3 8614.5 8788.0 8811.7 8680.1 8895.5 8906.6 8907.0 9077.7 6079.4 6828.8 6932.7 6960.2 7080.2 7252.1 7256.8 7272.7 7273.2 7298.3 6470.9 6667.6 6707.7 6811.8 6867.1 6615.7 6628.3 6675.9 6691.3 6754.7 7011.4 7063.8 7086.6 7111.1 7117.6 6638.6 6673.1 6677.8 6679.9 6684.7 6553.6 6609.8 6622.5 6623.6 6629.5 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | [#4] prototype.html Cycles:180 Average:4686.32 Median:5402.20 stddev:1376.76 (25.5%) stddev-sans-first:1341.00 17:07:57 INFO - PROCESS | 370 | Values: 317.5 321.4 323.2 327.1 331.8 5303.9 5422.9 5453.6 5463.0 5466.7 5329.9 5362.4 5375.0 5381.1 5381.5 3998.4 4034.9 4082.6 4194.7 4205.0 4178.9 4188.0 4190.4 4194.9 4196.2 4127.0 4144.8 4145.0 4146.0 4149.1 3932.4 4033.5 4129.7 4131.4 4136.9 3643.1 3648.5 3652.4 3654.8 3658.5 5023.5 5040.0 5043.1 5043.7 5047.7 4762.3 4780.4 4781.3 4782.5 4783.5 5581.7 5597.3 5599.4 5604.0 5607.4 4017.9 4021.4 4027.1 4035.0 4035.2 5655.7 5854.5 5856.5 5879.2 5977.3 4020.7 4055.0 4061.6 4070.2 4079.9 4094.6 4110.8 4111.9 4113.0 4113.2 4729.5 4736.3 4738.1 4748.3 4753.9 5670.8 5680.2 5685.2 5686.8 5690.6 1421.8 1450.8 1453.5 1454.0 1454.4 900.3 952.2 961.1 981.0 985.4 4850.0 4917.6 4922.8 4928.1 4940.8 5787.4 5869.7 5886.9 5889.6 5902.0 4979.0 4984.5 4986.4 4996.9 5004.2 3116.0 3142.2 3157.6 3161.7 3162.2 5491.0 5504.5 5509.8 5512.3 5515.8 5860.3 6015.8 6040.6 6040.9 6050.6 5473.5 5481.7 5482.3 5485.7 5491.1 5843.0 5888.2 5888.2 5891.9 5896.3 5755.4 5755.9 5766.8 5770.6 5774.5 5488.1 5495.1 5496.8 5497.9 5498.1 3932.6 4056.5 4067.4 4068.9 4071.9 5873.0 5887.5 5892.9 5896.9 5897.4 5668.2 5668.8 5680.1 5682.9 5683.9 5660.3 5661.7 5667.1 5668.8 5675.7 5446.0 5574.7 5577.8 5579.2 5585.7 5655.8 5720.1 5721.0 5723.6 5735.8 5536.8 5568.6 5570.4 5584.7 5585.2 17:07:57 INFO - PROCESS | 370 | 17:07:57 INFO - PROCESS | 370 | [#5] yui.html Cycles:180 Average:12721.61 Median:42207.37 stddev:14199.06 (33.6%) stddev-sans-first:14209.81 17:07:57 INFO - PROCESS | 370 | Values: 619.4 706.8 713.5 716.2 716.9 12098.5 12145.1 12146.3 12166.1 12187.0 12287.0 12302.6 12358.0 12372.9 12398.2 658.1 816.6 819.1 832.1 836.7 827.5 829.8 830.6 831.5 836.8 857.7 857.8 858.8 859.5 865.9 684.6 694.4 694.6 854.8 868.6 635.7 636.7 639.5 639.6 641.1 11334.3 11356.3 11392.7 11409.0 11441.7 11715.4 11882.6 12114.9 12216.1 12608.9 9710.6 9972.5 10121.2 10143.2 10146.9 3338.3 3353.4 3385.0 3462.4 3468.3 40976.2 42528.8 42600.4 42743.4 42849.0 9793.5 9972.4 10013.0 10088.0 10134.5 15744.6 15859.8 15893.4 15894.5 15930.3 6744.8 6840.6 6846.5 6876.8 7066.3 3795.1 3821.8 3823.2 3840.7 3905.0 2963.1 2969.6 2982.2 2985.6 2994.8 514.3 516.3 517.8 526.5 534.6 519.4 535.7 553.0 584.6 595.6 8300.8 8400.7 8446.3 8531.3 8706.8 585.8 634.9 644.5 647.6 655.1 3788.0 3801.0 3842.4 3918.3 3930.9 47212.5 48919.8 49235.3 49386.0 49585.3 48072.3 49083.0 49209.0 49621.3 49708.0 41322.2 41679.6 42070.4 42101.2 42313.6 8489.7 8560.2 8673.1 8738.5 8757.3 31538.7 31729.7 32443.4 32551.2 32772.5 37313.4 37400.8 38653.2 41365.8 41612.0 10531.7 10542.0 10724.0 10772.7 10927.7 11906.6 11955.1 12070.6 12092.9 12275.8 10943.6 10966.3 11226.4 11387.9 11487.7 11256.9 11274.7 11312.3 11845.5 12006.3 11006.3 11039.9 11513.9 11524.1 11683.9 9542.6 9612.6 9647.1 9856.5 9875.6 9248.8 9506.8 9512.2 9514.7 9552.2 17:07:57 INFO - PROCESS | 370 | -------- Summary: end -------- 17:07:57 INFO - PROCESS | 370 | 17:07:58 INFO - TEST-INFO | 370: exit 0 17:07:58 INFO - TEST-OK | dromaeo_css | took 1117774ms 17:07:58 INFO - TEST-START | kraken 17:07:58 INFO - operating with platform_type : linux_ 17:07:58 INFO - Initialising browser for kraken test... 17:07:58 INFO - TEST-INFO | started process 559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodLv5j/profile http://localhost:45337/getInfo.html) 17:08:03 INFO - PROCESS | 559 | __metrics Screen width/height:1600/1200 17:08:03 INFO - PROCESS | 559 | colorDepth:24 17:08:03 INFO - PROCESS | 559 | Browser inner width/height: 1024/697 17:08:03 INFO - PROCESS | 559 | __metrics 17:08:03 ERROR - PROCESS | 559 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:08:04 INFO - TEST-INFO | 559: exit 0 17:08:04 INFO - Browser initialized. 17:08:04 INFO - Running cycle 1/1 for kraken test... 17:08:04 INFO - TEST-INFO | started process 643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodLv5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:16 INFO - PROCESS | 643 | RSS: Main: 155029504 17:08:16 INFO - PROCESS | 643 | 17:08:19 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-beat-detection) 17:08:19 INFO - PROCESS | 643 | RSS: Main: 196206592 17:08:19 INFO - PROCESS | 643 | 17:08:22 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-dft) 17:08:23 INFO - PROCESS | 643 | RSS: Main: 186703872 17:08:23 INFO - PROCESS | 643 | 17:08:26 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-fft) 17:08:26 INFO - PROCESS | 643 | RSS: Main: 172650496 17:08:26 INFO - PROCESS | 643 | 17:08:28 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-oscillator) 17:08:29 INFO - PROCESS | 643 | RSS: Main: 172740608 17:08:29 INFO - PROCESS | 643 | 17:08:31 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:32 INFO - PROCESS | 643 | RSS: Main: 173973504 17:08:32 INFO - PROCESS | 643 | 17:08:35 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45337/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:36 INFO - PROCESS | 643 | RSS: Main: 174391296 17:08:36 INFO - PROCESS | 643 | 17:08:39 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45337/tests/kraken/driver.html?testName=imaging-desaturate) 17:08:40 INFO - PROCESS | 643 | RSS: Main: 175034368 17:08:40 INFO - PROCESS | 643 | 17:08:43 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45337/tests/kraken/driver.html?testName=json-parse-financial) 17:08:43 INFO - PROCESS | 643 | RSS: Main: 175316992 17:08:43 INFO - PROCESS | 643 | 17:08:45 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:08:45 INFO - PROCESS | 643 | RSS: Main: 187744256 17:08:45 INFO - PROCESS | 643 | 17:08:47 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:08:48 INFO - PROCESS | 643 | RSS: Main: 186085376 17:08:48 INFO - PROCESS | 643 | 17:08:50 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:08:51 INFO - PROCESS | 643 | RSS: Main: 194572288 17:08:51 INFO - PROCESS | 643 | 17:08:53 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:08:54 INFO - PROCESS | 643 | RSS: Main: 201949184 17:08:54 INFO - PROCESS | 643 | 17:08:56 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:08:57 INFO - PROCESS | 643 | RSS: Main: 200400896 17:08:57 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45337/tests/kraken/driver.html?testName=ai-astar) 17:08:59 INFO - PROCESS | 643 | RSS: Main: 261906432 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | __start_tp_report 17:08:59 INFO - PROCESS | 643 | _x_x_mozilla_page_load 17:08:59 INFO - PROCESS | 643 | _x_x_mozilla_page_load_details 17:08:59 INFO - PROCESS | 643 | |i|pagename|runs| 17:08:59 INFO - PROCESS | 643 | |0;ai-astar;110;112;108;112;112;111;101;110;110;112 17:08:59 INFO - PROCESS | 643 | |1;audio-beat-detection;153;129;158;180;132;155;158;132;191;135 17:08:59 INFO - PROCESS | 643 | |2;audio-dft;163;163;160;160;159;160;163;163;161;164 17:08:59 INFO - PROCESS | 643 | |3;audio-fft;74;73;105;93;74;74;74;110;94;75 17:08:59 INFO - PROCESS | 643 | |4;audio-oscillator;95;95;143;94;94;94;137;95;92;134 17:08:59 INFO - PROCESS | 643 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;117;117;117 17:08:59 INFO - PROCESS | 643 | |6;imaging-darkroom;146;147;147;145;147;146;147;146;145;145 17:08:59 INFO - PROCESS | 643 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;96;96 17:08:59 INFO - PROCESS | 643 | |8;json-parse-financial;65;64;64;65;65;74;65;73;64;62 17:08:59 INFO - PROCESS | 643 | |9;json-stringify-tinderbox;64;64;65;65;64;64;65;64;64;64 17:08:59 INFO - PROCESS | 643 | |10;stanford-crypto-aes;81;83;82;81;82;82;81;83;82;82 17:08:59 INFO - PROCESS | 643 | |11;stanford-crypto-ccm;125;121;145;115;119;118;127;120;117;123 17:08:59 INFO - PROCESS | 643 | |12;stanford-crypto-pbkdf2;143;143;141;136;141;133;141;141;145;139 17:08:59 INFO - PROCESS | 643 | |13;stanford-crypto-sha256-iterative;68;69;68;69;69;65;65;65;65;65 17:08:59 INFO - PROCESS | 643 | __end_tp_report 17:08:59 INFO - PROCESS | 643 | __start_cc_report 17:08:59 INFO - PROCESS | 643 | _x_x_mozilla_cycle_collect,1168 17:08:59 INFO - PROCESS | 643 | __end_cc_report 17:08:59 INFO - PROCESS | 643 | __startTimestamp1458864539293__endTimestamp 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | ------- Summary: start ------- 17:08:59 INFO - PROCESS | 643 | Number of tests: 14 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:3.36 (3.0%) stddev-sans-first:3.56 17:08:59 INFO - PROCESS | 643 | Values: 110.0 112.0 108.0 112.0 112.0 111.0 101.0 110.0 110.0 112.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:156.50 stddev:21.09 (13.5%) stddev-sans-first:22.37 17:08:59 INFO - PROCESS | 643 | Values: 153.0 129.0 158.0 180.0 132.0 155.0 158.0 132.0 191.0 135.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#2] audio-dft Cycles:10 Average:161.60 Median:163.00 stddev:1.78 (1.1%) stddev-sans-first:1.81 17:08:59 INFO - PROCESS | 643 | Values: 163.0 163.0 160.0 160.0 159.0 160.0 163.0 163.0 161.0 164.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#3] audio-fft Cycles:10 Average:84.60 Median:74.00 stddev:14.52 (19.6%) stddev-sans-first:14.88 17:08:59 INFO - PROCESS | 643 | Values: 74.0 73.0 105.0 93.0 74.0 74.0 74.0 110.0 94.0 75.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.31 (22.7%) stddev-sans-first:22.14 17:08:59 INFO - PROCESS | 643 | Values: 95.0 95.0 143.0 94.0 94.0 94.0 137.0 95.0 92.0 134.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:08:59 INFO - PROCESS | 643 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 17:08:59 INFO - PROCESS | 643 | Values: 146.0 147.0 147.0 145.0 147.0 146.0 147.0 146.0 145.0 145.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:08:59 INFO - PROCESS | 643 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:4.01 (6.2%) stddev-sans-first:4.24 17:08:59 INFO - PROCESS | 643 | Values: 65.0 64.0 64.0 65.0 65.0 74.0 65.0 73.0 64.0 62.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 17:08:59 INFO - PROCESS | 643 | Values: 64.0 64.0 65.0 65.0 64.0 64.0 65.0 64.0 64.0 64.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 17:08:59 INFO - PROCESS | 643 | Values: 81.0 83.0 82.0 81.0 82.0 82.0 81.0 83.0 82.0 82.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:122.00 stddev:8.55 (7.0%) stddev-sans-first:9.04 17:08:59 INFO - PROCESS | 643 | Values: 125.0 121.0 145.0 115.0 119.0 118.0 127.0 120.0 117.0 123.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:141.00 stddev:3.53 (2.5%) stddev-sans-first:3.61 17:08:59 INFO - PROCESS | 643 | Values: 143.0 143.0 141.0 136.0 141.0 133.0 141.0 141.0 145.0 139.0 17:08:59 INFO - PROCESS | 643 | 17:08:59 INFO - PROCESS | 643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:68.00 stddev:1.93 (2.8%) stddev-sans-first:2.00 17:08:59 INFO - PROCESS | 643 | Values: 68.0 69.0 68.0 69.0 69.0 65.0 65.0 65.0 65.0 65.0 17:08:59 INFO - PROCESS | 643 | -------- Summary: end -------- 17:08:59 INFO - PROCESS | 643 | 17:09:00 INFO - TEST-INFO | 643: exit 0 17:09:00 INFO - TEST-OK | kraken | took 61905ms 17:09:00 INFO - SUITE-END | took 1179s 17:09:00 INFO - Completed test suite (00:19:39) 17:09:00 INFO - javascript benchmark 17:09:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.437895852392, 2697.109953715274, 2700.702922678506, 2715.8234714743535, 2717.701052884184, 4634.189016922042, 4711.246200607903, 4711.599514041306, 4720.433547974244, 4745.715257084568, 4668.323093151491, 4726.598239149676, 4743.691660042095, 4759.405074365704, 4798.376211092553, 4246.936295955556, 4293.978530107345, 4314.97842510787, 4352.673549483786, 4469.687121901468, 4399.692021558492, 4424.823007079713, 4426.2254105531565, 4464.17412778637, 4472.798724057409, 4256.3189889617515, 4297.162053399588, 4331.06882020364, 4340.7178533395545, 4366.0, 4340.305551111838, 4342.066455712037, 4383.605475507188, 4384.101259241879, 4420.977895110504, 4301.2902871026245, 4310.374995625617, 4345.391645169679, 4346.56534346566, 4356.760378179199, 4591.357209990604, 4637.350770892078, 4641.9535804641855, 4702.78837452312, 4713.835015774465, 5072.518110779507, 5085.440601533828, 5086.949130508685, 5087.033463641897, 5108.386993560796, 5087.872803179913, 5090.898182036375, 5100.515451032146, 5111.821086261963, 5135.794568217267, 4624.583787459112, 4741.952580474185, 4747.833825816149, 4823.059503396804, 4837.782299796518, 5187.19598462239, 5207.5833933286, 5208.869778255498, 5210.244514545446, 5238.633295669267, 4988.800447982113, 4988.800447982113, 4992.151334273182, 4998.2002879539095, 5037.496250374933, 4986.750662466862, 4996.6752161110135, 5065.721385323769, 5077.416097148875, 5106.336176297058, 5065.6200784941275, 5070.2141168119, 5070.7464626768515, 5071.0, 5079.238114282887, 5032.421271553745, 5035.043341765053, 5035.169197082514, 5042.42012168598, 5087.592992560586, 4197.958020419756, 4292.055747735493, 4292.077203401283, 4297.333913243452, 4398.3842262083335, 3799.6200379961783, 3821.063839359319, 3839.6160383961937, 3845.3462911305146, 3847.1343947611563, 4384.4519435070615, 4384.671149663788, 4387.298032314814, 4389.604935555815, 4404.823807047682, 5139.7687104080405, 5142.100132476801, 5142.6400151989, 5152.974235128875, 5192.766325515361, 4395.450568678915, 4398.560143985575, 4399.20814253431, 4407.206702793464, 4434.623057040188, 4559.886002849889, 4576.496585375606, 4634.397528321364, 4635.768211589474, 4638.768061596907, 4696.225122854759, 4701.858944231679, 4705.035467729107, 4737.431508219036, 4739.194336962793, 4968.652194346361, 4973.577245933991, 5018.87452813668, 5029.622778291569, 5073.822416215415, 4707.811687532598, 4709.317149013443, 4749.667523273476, 4852.320675105418, 4867.58625516835, 5018.372703412074, 5026.47222041695, 5034.823781167642, 5038.798448062036, 5093.312402825572, 5121.07820592297, 5130.461301563282, 5134.358205224347, 5135.15269980449, 5141.177411614124, 4792.544708252711, 4906.803727850846, 4955.628327875496, 4966.130927087673, 5007.1487847065355, 4891.828785992473, 4924.532169443897, 4931.950680493293, 4941.2835138905375, 4978.153713868724, 4783.689060211075, 4861.392325959255, 4870.196417591058, 4876.171050921281, 4900.92648610264, 4959.677620954626, 4999.200127979506, 5009.8589791588665, 5020.849374518771, 5073.391193056709, 4895.388076490439, 4913.091078150554, 4914.70511769295, 4925.975370123127, 4930.4822993586595], "unit": "score", "name": "dojo.html", "value": 4664.375771847321}, {"lowerIsBetter": false, "replicates": [515.9948400515995, 534.7353060235183, 542.9565634749221, 560.7056295444894, 564.3087218157757, 35182.64817351826, 35489.467657985086, 35880.28239435213, 35894.282114357695, 35899.2820143597, 35640.82179589098, 36239.818800906025, 36273.27453450936, 36298.45552316718, 36347.0, 7202.963985180093, 7380.852382952337, 7416.110066791993, 7610.923890761077, 9569.66506172284, 9714.562844671971, 9850.605975760996, 9853.06395892389, 9859.112679858812, 9862.802743945116, 9840.753981150492, 9947.353422027545, 9949.801003979916, 9953.402795832237, 9955.850662240073, 7536.359409450203, 9948.900510994907, 10235.130013948823, 10238.7440313992, 10239.283250172492, 9690.32167748258, 9822.852657210076, 9823.607055717763, 9830.606775728962, 9832.852507212398, 35344.29311413783, 35821.0, 35826.566937322736, 35882.461763073574, 35926.0, 3141.2461009357817, 3183.3792410479964, 3261.5433839262523, 3417.743669224818, 3472.9131771705656, 29529.261768455744, 29820.254493637614, 30390.69609303901, 30397.69602303971, 31218.84390578055, 3494.2487365216602, 3540.539729835131, 3561.4123669594487, 3574.588037725084, 3579.158897659048, 184564.0, 187201.0, 188368.0, 188609.0, 245445.0, 56937.71531142318, 57729.71135144297, 57767.13349299764, 57803.4219657798, 57813.421865781645, 61288.69355653193, 64847.35152648507, 65621.39082350516, 65747.34252657508, 65756.34243657599, 14944.850551494563, 15052.172130532927, 15070.397184112513, 15102.169380684169, 15108.39566417353, 11534.192606517463, 11595.594154204562, 11628.6511404658, 11628.6511404658, 11631.65105046833, 19486.05675269028, 19772.0, 19786.50533736668, 19789.30737424183, 19854.40436786899, 6378.553501254961, 7507.849843003219, 7730.342920851678, 7836.083756763721, 7879.803004924923, 911.2983003087586, 936.4989730494153, 939.3987847777428, 950.4867371619387, 954.6420092465326, 26728.732712672623, 28017.159485215478, 28611.14166575006, 28633.0, 28653.570196447068, 1028.83024300991, 1035.5961175141701, 1065.4459680965854, 1067.3062509368817, 1080.9459527023616, 14262.643433914234, 14720.337584808709, 14729.779053314209, 14806.0, 15000.324985375684, 279978.0, 280798.0, 283027.0, 283433.0, 284168.0, 47307.0, 48537.514624854004, 48582.0, 48586.27120593194, 48691.5130848687, 1040.7710303733168, 1129.6667483092508, 1141.697450175704, 1184.5676328140166, 1225.724212052281, 18024.729629055837, 24964.0, 26126.216213513624, 26136.693165342036, 26139.607905881046, 35933.0, 36165.457518136725, 36225.45661815128, 36353.27293454169, 36406.0, 149572.0, 152788.236058819, 153667.0, 153936.0, 154110.0, 31728.36543269168, 41167.382489263284, 41857.79071104625, 41880.58119418767, 42175.15649686928, 37093.81453092717, 37672.62327376801, 38177.809110954266, 39600.3886494441, 40004.399934001594, 32527.34945301128, 38214.80892595519, 38227.617723822405, 38552.0, 39267.41098883462, 32025.839870800497, 32075.518867216542, 32159.51760723638, 32345.35309293848, 32623.34753304968, 32636.510452343708, 33165.17087072843, 33172.33655326832, 33282.66717332796, 33466.66533334733, 28663.856680716464, 29272.707272926997, 30067.0, 31946.0, 32081.0, 24331.63502547428, 24898.50202995966, 24936.750632493444, 25165.622515662646, 25272.0], "unit": "score", "name": "ext.html", "value": 17433.470021926838}, {"lowerIsBetter": false, "replicates": [346.5062286242105, 351.257091252002, 359.73020234823883, 366.40459253712714, 368.0798004987531, 15515.844841551581, 15808.841911580881, 15873.761893571591, 16230.0, 16246.268917898693, 15054.6989060219, 15413.383464661429, 15560.45538406156, 15577.0, 15604.141772202523, 4933.80264789408, 4964.87587810304, 5020.221865610836, 5033.068882256776, 5100.821471248507, 4992.226204938241, 5003.649744517885, 5024.296598476216, 5037.874053148664, 5042.394912610492, 4980.626453016021, 4985.825496107637, 4990.47600002, 4994.225894986283, 5000.049990501811, 4833.202521583952, 4968.826091086813, 4981.9252711209365, 4993.176125939216, 5030.1448753711775, 4432.268675668511, 4442.2892337225885, 4447.799849006802, 4448.110377924428, 4456.420665313521, 18065.819341806546, 19247.903760481247, 19412.805871941382, 19471.610567788706, 19482.610347792965, 1987.6223517531766, 2006.1674405122003, 2137.5938571671486, 2594.4292255703713, 2603.3231359846386, 12229.449674764657, 12605.243685378906, 12662.303573303465, 12959.066899208972, 12969.351532423341, 1739.9913000435045, 1813.0662708705026, 1821.4899828048167, 1871.1018711018787, 1889.9622007559772, 41665.37501937473, 57021.0, 57495.42504574984, 62140.0, 62747.0, 9070.092990700878, 9162.86255706165, 9206.355555111211, 9243.0, 9406.341556091145, 12476.251424914533, 12586.23792669027, 12586.748265034648, 12602.243865368107, 12617.179883307555, 6081.209442772411, 6723.63020033893, 6899.17209934801, 7148.821279468055, 7169.351049258596, 6627.635480048643, 6678.398944094957, 6807.285235050347, 6819.829504262334, 6835.897461538081, 5403.783848646089, 5450.5367043801725, 5542.528885044736, 5610.719464026783, 5647.435256474402, 1632.8122265939332, 1690.9661806763795, 1717.5534361066213, 1732.2464727843428, 1733.6619359225083, 893.2496702769705, 914.4696076275744, 923.6813299411692, 944.7165850244899, 964.0744884910424, 14707.255764970121, 16221.83778162227, 16297.511074667778, 16396.26216820246, 16546.917265413595, 908.6910450446879, 928.9256859451227, 933.3653115881266, 941.7174847545709, 954.7183580843667, 9314.813703725888, 9379.062093790566, 9564.808703825884, 9724.805503890024, 9754.219662426989, 422129.0, 422386.0, 424307.0, 432891.0, 435471.0, 47630.5236947633, 62242.0, 63651.0, 63908.36091639117, 64776.67611661911, 840.4831028917172, 952.3952290295574, 960.1454705312277, 991.5389343955095, 992.7865508915618, 14662.120272783666, 14843.777343340074, 14892.404303827725, 15045.473408430653, 15189.696206076038, 31291.0, 31337.843310784214, 31624.0, 31676.35721892012, 31933.20166995844, 41213.0, 41435.37846932238, 41763.37354939617, 41865.0, 41932.0, 7383.889241661487, 7420.183779784112, 7517.097948246245, 7646.158922518407, 7651.732189373345, 11365.261258018203, 11425.829092472404, 11491.425428728697, 11637.185397022127, 11678.532858685558, 10192.184625230113, 10264.794704105727, 10300.0, 10350.5342259597, 10459.058684718411, 9953.800923981335, 10160.695179144637, 10164.390136591828, 10188.490575471345, 10348.0, 9121.726348209564, 10292.330998485075, 10357.119644830274, 10469.842952355568, 10514.57941682324, 7389.150247721366, 7389.261073892568, 7414.22150674193, 7427.405807535492, 7574.0, 10273.332233404804, 10452.372857628567, 10517.21120915919, 10529.368237905444, 10541.0], "unit": "score", "name": "jquery.html", "value": 7995.51349210339}, {"lowerIsBetter": false, "replicates": [1315.7763180259356, 1442.271652815328, 1456.1336005076982, 1610.1788088075077, 1763.805981342053, 6915.930840691592, 7451.664675089621, 7533.849323013536, 7586.241375862411, 7612.2768337007965, 7496.512726672776, 7653.693852245918, 7670.07959044914, 7702.499337543056, 7710.421718371116, 1981.4749091490767, 2225.4770129019666, 2277.123307526602, 2286.1998300594823, 2308.3305841306087, 2286.554121946213, 2292.64464008079, 2294.8393612447135, 2297.908083676651, 2299.735530414007, 2207.558488302338, 2310.0413328468667, 2312.3756585721844, 2312.5721741477882, 2315.768423157679, 2227.7326720793526, 2241.316398498457, 2264.784845439681, 2277.7152855893014, 2280.8631482111127, 2225.221172589597, 2277.9658305125436, 2279.726432828071, 2282.9657555136687, 2286.7713228677167, 7828.295453409163, 7897.921020789776, 7914.485558438741, 7914.564698941556, 7924.881126783102, 4699.812007519695, 4799.016201678683, 4806.879828004293, 4842.297866809293, 4846.830360937351, 3149.669284725094, 3154.4164329598866, 3231.337575796956, 3241.1248962780155, 3273.5580696605894, 985.0641890204334, 1038.2628333882951, 1041.3959903256168, 1073.8281874900056, 1094.956201751929, 10889.074428673572, 10892.455377231106, 10896.128309735202, 10912.0, 10913.508892099875, 4327.826886924488, 4345.065810850682, 4361.934570981438, 4363.912721745611, 4395.604395604347, 9240.122188392092, 9250.95374523123, 9296.39573427725, 9328.580213890391, 9336.253099752004, 4110.095778928631, 4867.902641947141, 4873.074115917964, 4874.610031197567, 4877.244027175722, 4169.812358443877, 4238.3430568261965, 4280.186764514732, 4290.227759003409, 4310.80601372939, 3594.6585074418413, 3673.540807399075, 3676.5771936227143, 3692.390755525308, 3738.756980796294, 1210.9091818113677, 1221.9450124744408, 1240.2744394529302, 1244.2721008210299, 1246.376811594203, 1228.5700004998357, 1228.7051107734258, 1248.1200753468784, 1256.0203041627544, 1258.937053147339, 7424.406047516186, 7453.0, 7484.288992545699, 7489.812754681177, 7531.774046778605, 470.7363876229322, 477.6298368764166, 478.652976591975, 482.5946205187589, 483.675937122129, 5610.97194514033, 5658.971705141448, 5662.207290979266, 5672.574556908248, 5702.657840529581, 8925.330600204881, 9137.40606860552, 9252.306077044248, 9260.444373337621, 9301.953490232641, 8958.596863141174, 9015.188633022928, 9024.909750902407, 9024.909750902407, 9074.500902450429, 6980.7905762827195, 7056.6118863463, 7236.421086313082, 7256.963715181496, 7332.816679583053, 7017.7192912282935, 7035.577865328097, 7041.225465198926, 7048.682809273698, 7059.25877782846, 8361.289290410139, 8380.329573634217, 8614.526201058752, 8788.0, 8811.735647930573, 8680.088590697886, 8895.510746908982, 8906.554672266231, 8906.955465222632, 9077.682281120393, 6079.392060793885, 6828.760993365408, 6932.688029038604, 6960.164780226405, 7080.221175670775, 7252.129744430702, 7256.7822965311125, 7272.745453909088, 7273.236310187354, 7298.343149116605, 6470.935290647033, 6667.566608170453, 6707.66461676924, 6811.795646130624, 6867.141607299088, 6615.735370585316, 6628.337166283333, 6675.899861501985, 6691.2639609643875, 6754.696038678173, 7011.439084873095, 7063.823404414725, 7086.610236437045, 7111.111111111111, 7117.572945623072, 6638.5684930479365, 6673.132492775908, 6677.833054173684, 6679.866402672016, 6684.732610695518, 6553.639549824615, 6609.834754131185, 6622.503312251504, 6623.635700036544, 6629.4696424284975], "unit": "score", "name": "mootools.html", "value": 4400.223286261368}, {"lowerIsBetter": false, "replicates": [317.4523946192819, 321.38936021559033, 323.2113642711783, 327.13472864273996, 331.75284413112234, 5303.867403314915, 5422.945770542294, 5453.563714902813, 5462.972685136579, 5466.671999680022, 5329.866753331169, 5362.35651721794, 5374.973125134378, 5381.112116500783, 5381.461853814617, 3998.400239964014, 4034.878953631381, 4082.6121518455698, 4194.727342722721, 4205.0, 4178.916421671564, 4187.979060104695, 4190.350495673176, 4194.916101677964, 4196.244675958326, 4127.030147915252, 4144.834206631731, 4145.046639272969, 4146.025683964281, 4149.149424368013, 3932.390479475686, 4033.4756481657196, 4129.731567448106, 4131.421600975866, 4136.896577585554, 3643.1074386775144, 3648.543932008499, 3652.397354436515, 3654.817259137059, 3658.4512323151475, 5023.547880690755, 5040.0, 5043.067032598981, 5043.67216130954, 5047.697138171721, 4762.28565715142, 4780.402449693788, 4781.282807578857, 4782.521747825224, 4783.545563171493, 5581.748821303051, 5597.3003374578175, 5599.440055994409, 5604.019296623115, 5607.4112218217315, 4017.879463616096, 4021.396790481422, 4027.1140349123148, 4035.0, 4035.1727895781296, 5655.717214139277, 5854.47309742121, 5856.502197313191, 5879.206307148565, 5977.342492325797, 4020.73865198767, 4055.0065234017266, 4061.593840615915, 4070.247004304154, 4079.877603671835, 4094.590540945941, 4110.835566577303, 4111.9177616447505, 4112.979435102805, 4113.218488487238, 4729.456112547101, 4736.289556566474, 4738.07607516531, 4748.264019077049, 4753.904921901542, 5670.8015219467125, 5680.233168522279, 5685.204071430003, 5686.829395118153, 5690.630109042899, 1421.8435972043067, 1450.8476609955803, 1453.4840131753288, 1454.0475988227727, 1454.367350202644, 900.3337530227584, 952.2477242977969, 961.1301771896445, 981.038582189444, 985.4383001689112, 4850.0, 4917.631177661689, 4922.778474968635, 4928.137575924199, 4940.802367905244, 5787.363390027093, 5869.735861886225, 5886.941130588725, 5889.617174883704, 5902.0, 4978.950210497921, 4984.526469985346, 4986.351774269322, 4996.850094497171, 5004.199328107486, 3115.9532607010915, 3142.245860993391, 3157.636871759731, 3161.731252843534, 3162.177833763238, 5490.972545137249, 5504.4770746778995, 5509.779608815683, 5512.3385193777, 5515.779368825282, 5860.267466566679, 6015.819525414245, 6040.637561746309, 6040.939590604125, 6050.57645964787, 5473.534749546254, 5481.725913704219, 5482.342118945752, 5485.6982865942755, 5491.066518691832, 5842.970785146217, 5888.17565540816, 5888.205092312483, 5891.852703682443, 5896.292444906639, 5755.395683453345, 5755.884882302415, 5766.826995190151, 5770.567207459373, 5774.538036957118, 5488.1493368527945, 5495.148252020943, 5496.80761173357, 5497.945020549903, 5498.147787093007, 3932.6067393261587, 4056.492938382702, 4067.4102255173425, 4068.9389659154544, 4071.91856162881, 5873.0, 5887.470127688529, 5892.94107058924, 5896.8820623586425, 5897.351291357862, 5668.234788303526, 5668.801591944262, 5680.062789639664, 5682.857928551819, 5683.857903552444, 5660.349059858169, 5661.697809503919, 5667.064934285797, 5668.801591944262, 5675.687837168995, 5445.972105028012, 5574.721263936868, 5577.8047768327915, 5579.218909352775, 5585.664860108406, 5655.802046928337, 5720.056190728483, 5721.027425337619, 5723.570732195185, 5735.770569177186, 5536.75084621201, 5568.610197286151, 5570.387257401763, 5584.664920104807, 5585.2180694701965], "unit": "score", "name": "prototype.html", "value": 4246.9339522959535}, {"lowerIsBetter": false, "replicates": [619.4332186049764, 706.7773651299837, 713.543332267349, 716.1728203924469, 716.928307169283, 12098.516059357626, 12145.149839511216, 12146.271223726582, 12166.148369614131, 12187.0, 12287.0, 12302.56941007065, 12358.011359091273, 12372.876271237285, 12398.194117382387, 658.0655469233676, 816.5998660656295, 819.0989911097804, 832.1262674192104, 836.7155167243136, 827.5448503323179, 829.8049958259804, 830.5722552885269, 831.4969443486694, 836.8117173635944, 857.7469646454311, 857.7984173719202, 858.7981824271292, 859.5272600069936, 865.9437136586101, 684.6302996381972, 694.4305669351135, 694.5971336624746, 854.7521218846528, 868.6264906090379, 635.678982114034, 636.6816591704148, 639.5363361562876, 639.6481934935766, 641.1408712325459, 11334.263272887318, 11356.26184298018, 11392.71518212043, 11409.0, 11441.656750297505, 11715.4142292885, 11882.58410955621, 12114.878851211552, 12216.083793715417, 12608.936955315256, 9710.563024663836, 9972.501374931224, 10121.240906931936, 10143.239257055677, 10146.898531014669, 3338.282269312085, 3353.3628610563915, 3384.966150338514, 3462.4113900636953, 3468.2543253200683, 40976.180476390604, 42528.78735606333, 42600.360994585106, 42743.35884961728, 42849.0, 9793.510324483746, 9972.351797133164, 10013.0, 10088.0, 10134.493275336205, 15744.60638484047, 15859.762103568455, 15893.443729469644, 15894.52316430509, 15930.283137258852, 6744.831379215559, 6840.623765692835, 6846.520743547904, 6876.759313424006, 7066.328698773608, 3795.1081495848453, 3821.7898015608853, 3823.1971286030243, 3840.6927445804267, 3905.0432644002403, 2963.0518234165293, 2969.5545668149516, 2982.1948074019892, 2985.5521671748975, 2994.7903646744953, 514.3236643813374, 516.3339292312875, 517.8498235511735, 526.531387065512, 534.6230907210485, 519.4390058736556, 535.713393334572, 552.988031901619, 584.6492104737124, 595.5652373767174, 8300.833983320299, 8400.747977560683, 8446.324294056461, 8531.274841638406, 8706.825863482822, 585.7832601937225, 634.8793729191439, 644.4715333426545, 647.601724939159, 655.1057806094647, 3787.962120378816, 3800.9809950950066, 3842.366009608439, 3918.275119102975, 3930.941035884464, 47212.5278747215, 48919.75540122276, 49235.26147107796, 49386.0, 49585.25622115671, 48072.27891581629, 49083.0, 49209.0, 49621.25568116481, 49708.0, 41322.1735565287, 41679.58320416818, 42070.36894446586, 42101.15797684029, 42313.57686423096, 8489.74530764078, 8560.186782255676, 8673.132686731276, 8738.475691458532, 8757.299416046573, 31538.684613153575, 31729.68270317267, 32443.35113297768, 32551.18622034468, 32772.508412373354, 37313.44029839609, 37400.812995934844, 38653.226935460574, 41365.793171033954, 41612.0, 10531.73670658209, 10542.0, 10724.0, 10772.676819695422, 10927.726806829893, 11906.642800715992, 11955.103367247317, 12070.637880863587, 12092.939535302266, 12275.815862762245, 10943.616973405893, 10966.342019478856, 11226.382548959886, 11387.943060284646, 11487.712807179887, 11256.887431125911, 11274.661760147208, 11312.26470279462, 11845.526178952745, 12006.339651319262, 11006.339619622848, 11039.889601103887, 11513.942430287794, 11524.13568982313, 11683.941580292045, 9542.565125264864, 9612.615495380107, 9647.1317581418, 9856.507174641096, 9875.604975800887, 9248.815023699353, 9506.809863802824, 9512.191463725385, 9514.69283157343, 9552.188064014637], "unit": "score", "name": "yui.html", "value": 5963.333232224821}], "name": "dromaeo_css", "value": 6456.80388523701}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 108.0, 112.0, 112.0, 111.0, 101.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 158.0, 180.0, 132.0, 155.0, 158.0, 132.0, 191.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 160.0, 160.0, 159.0, 160.0, 163.0, 163.0, 161.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 105.0, 93.0, 74.0, 74.0, 74.0, 110.0, 94.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 143.0, 94.0, 94.0, 94.0, 137.0, 95.0, 92.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 145.0, 147.0, 146.0, 147.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 74.0, 65.0, 73.0, 64.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 82.0, 81.0, 82.0, 82.0, 81.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [125.0, 121.0, 145.0, 115.0, 119.0, 118.0, 127.0, 120.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 141.0, 136.0, 141.0, 133.0, 141.0, 141.0, 145.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1516.2}]} 17:09:00 INFO - Return code: 0 17:09:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:09:00 ERROR - # TBPL SUCCESS # 17:09:00 INFO - Running post-action listener: _resource_record_post_action 17:09:00 INFO - Running post-run listener: _resource_record_post_run 17:09:01 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 519929856; Read time: 16; Write time: 520044 17:09:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233144320; Read time: 0; Write time: 284844 17:09:01 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 16384; Write bytes: 286785536; Read time: 16; Write time: 235200 17:09:01 INFO - Running post-run listener: _upload_blobber_files 17:09:01 INFO - Blob upload gear active. 17:09:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:01 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 17:09:01 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'] 17:09:01 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 17:09:02 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:02 INFO - (blobuploader) - INFO - Done attempting. 17:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:09:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:03 INFO - (blobuploader) - INFO - Done attempting. 17:09:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:03 INFO - Return code: 0 17:09:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/849ccd8e4af65993aab316ab56032b6614f4fdd237cbe10fc766adf071ef2f72153a39c3f370e0cf3833fff981b9c30c1c11c6976a282ed7ab00b55b1862e545", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a890cf3c194c1af8cf91a74f738a5c5cf696ac75ab897d9644124aa1666b51cbd810dd309d73510f1571431fb5f014e86e68726d4dbae3c7de0683ee6c8cdfc"} 17:09:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:03 INFO - Contents: 17:09:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/849ccd8e4af65993aab316ab56032b6614f4fdd237cbe10fc766adf071ef2f72153a39c3f370e0cf3833fff981b9c30c1c11c6976a282ed7ab00b55b1862e545", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a890cf3c194c1af8cf91a74f738a5c5cf696ac75ab897d9644124aa1666b51cbd810dd309d73510f1571431fb5f014e86e68726d4dbae3c7de0683ee6c8cdfc"} 17:09:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:03 INFO - Copying logs to upload dir... 17:09:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.487508 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-24 17:09:03.704365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 17:09:03.707654) ========= 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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 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/849ccd8e4af65993aab316ab56032b6614f4fdd237cbe10fc766adf071ef2f72153a39c3f370e0cf3833fff981b9c30c1c11c6976a282ed7ab00b55b1862e545", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a890cf3c194c1af8cf91a74f738a5c5cf696ac75ab897d9644124aa1666b51cbd810dd309d73510f1571431fb5f014e86e68726d4dbae3c7de0683ee6c8cdfc"} build_url:https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/EIXGeNraSzKfFx18DTsl1g/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/849ccd8e4af65993aab316ab56032b6614f4fdd237cbe10fc766adf071ef2f72153a39c3f370e0cf3833fff981b9c30c1c11c6976a282ed7ab00b55b1862e545", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a890cf3c194c1af8cf91a74f738a5c5cf696ac75ab897d9644124aa1666b51cbd810dd309d73510f1571431fb5f014e86e68726d4dbae3c7de0683ee6c8cdfc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 17:09:03.732399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:09:03.732723) ========= 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=920470bf432669ad7e3a5387000001ca-1458863306.210202-497836357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:09:03.815993) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 17:09:03.816313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 17:09:03.816605) ========= ========= Total master_lag: 0.27 =========