builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1459870093.54 results: success (0) buildid: 20160405075115 builduid: abcdb52c19504692a1f3e7b6d43ef26f revision: f0110e77e9f7b40ba80b3640ea7cd038398b8eee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.538867) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.539321) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.539603) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006416 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.563766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.564072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.577805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.578134) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.627431) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.627758) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.628114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.628391) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 08:28:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-05 08:28:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176422 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.817212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.817583) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.867203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:13.867614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0110e77e9f7b40ba80b3640ea7cd038398b8eee --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 f0110e77e9f7b40ba80b3640ea7cd038398b8eee --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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 08:28:13,999 truncating revision to first 12 chars 2016-04-05 08:28:13,999 Setting DEBUG logging. 2016-04-05 08:28:13,999 attempt 1/10 2016-04-05 08:28:13,999 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0110e77e9f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 08:28:14,427 unpacking tar archive at: mozilla-central-f0110e77e9f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:14.621035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:14.621339) ========= echo f0110e77e9f7b40ba80b3640ea7cd038398b8eee in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f0110e77e9f7b40ba80b3640ea7cd038398b8eee'] 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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f0110e77e9f7b40ba80b3640ea7cd038398b8eee program finished with exit code 0 elapsedTime=0.004757 script_repo_revision: 'f0110e77e9f7b40ba80b3640ea7cd038398b8eee' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:14.671999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:14.672277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 08:28:14.681916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-05 08:28:14.682197) ========= /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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:28:14 INFO - MultiFileLogger online at 20160405 08:28:14 in /builds/slave/test 08:28:14 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 08:28:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:14 INFO - {'append_to_log': False, 08:28:14 INFO - 'base_work_dir': '/builds/slave/test', 08:28:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:28:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:14 INFO - 'branch': 'Firefox-Non-PGO', 08:28:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:14 INFO - 'config_files': ('talos/linux_config.py',), 08:28:14 INFO - 'default_actions': ('clobber', 08:28:14 INFO - 'read-buildbot-config', 08:28:14 INFO - 'download-and-extract', 08:28:14 INFO - 'populate-webroot', 08:28:14 INFO - 'create-virtualenv', 08:28:14 INFO - 'install', 08:28:14 INFO - 'run-tests'), 08:28:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:14 INFO - 'download_minidump_stackwalk': True, 08:28:14 INFO - 'download_symbols': 'ondemand', 08:28:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:14 INFO - 'installer_path': 'installer.exe', 08:28:14 INFO - 'log_level': 'info', 08:28:14 INFO - 'log_name': 'talos', 08:28:14 INFO - 'log_to_console': True, 08:28:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:28:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:28:14 INFO - 'opt_config_files': (), 08:28:14 INFO - 'pip_index': False, 08:28:14 INFO - 'sps_profile': False, 08:28:14 INFO - 'sps_profile_interval': 0, 08:28:14 INFO - 'suite': 'dromaeojs', 08:28:14 INFO - 'system_bits': '32', 08:28:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:14 INFO - 'title': 'talos-linux64-ix-046', 08:28:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:14 INFO - 'use_talos_json': True, 08:28:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:14 INFO - 'work_dir': 'build'} 08:28:14 INFO - ##### 08:28:14 INFO - ##### Running clobber step. 08:28:14 INFO - ##### 08:28:14 INFO - Running pre-action listener: _resource_record_pre_action 08:28:14 INFO - Running main action method: clobber 08:28:14 INFO - rmtree: /builds/slave/test/build 08:28:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:15 INFO - Running post-action listener: _resource_record_post_action 08:28:15 INFO - ##### 08:28:15 INFO - ##### Running read-buildbot-config step. 08:28:15 INFO - ##### 08:28:15 INFO - Running pre-action listener: _resource_record_pre_action 08:28:15 INFO - Running main action method: read_buildbot_config 08:28:15 INFO - Using buildbot properties: 08:28:15 INFO - { 08:28:15 INFO - "project": "", 08:28:15 INFO - "product": "firefox", 08:28:15 INFO - "script_repo_revision": "production", 08:28:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:28:15 INFO - "repository": "", 08:28:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:28:15 INFO - "buildid": "20160405075115", 08:28:15 INFO - "pgo_build": "False", 08:28:15 INFO - "basedir": "/builds/slave/test", 08:28:15 INFO - "buildnumber": 541, 08:28:15 INFO - "slavename": "talos-linux64-ix-046", 08:28:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:28:15 INFO - "platform": "ubuntu64_hw", 08:28:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:28:15 INFO - "branch": "mozilla-central", 08:28:15 INFO - "repo_path": "mozilla-central", 08:28:15 INFO - "revision": "f0110e77e9f7b40ba80b3640ea7cd038398b8eee", 08:28:15 INFO - "stage_platform": "linux64", 08:28:15 INFO - "builduid": "abcdb52c19504692a1f3e7b6d43ef26f", 08:28:15 INFO - "slavebuilddir": "test" 08:28:15 INFO - } 08:28:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:28:15 INFO - Running post-action listener: _resource_record_post_action 08:28:15 INFO - ##### 08:28:15 INFO - ##### Running download-and-extract step. 08:28:15 INFO - ##### 08:28:15 INFO - Running pre-action listener: _resource_record_pre_action 08:28:15 INFO - Running main action method: download_and_extract 08:28:15 INFO - mkdir: /builds/slave/test/build/tests 08:28:15 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')]} 08:28:15 INFO - https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:19 INFO - Downloaded 1361 bytes. 08:28:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:28:19 INFO - Using the following test package requirements: 08:28:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:28:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:28:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'jsshell-linux-x86_64.zip'], 08:28:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:28:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:28:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:28:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:28:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:28:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:28: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')]} 08:28:19 INFO - https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:20 INFO - Downloaded 22125720 bytes. 08:28:20 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'] 08:28:20 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 08:28:21 INFO - Return code: 0 08:28:21 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 08:28:21 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')]} 08:28:21 INFO - https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:28 INFO - Downloaded 22125720 bytes. 08:28:28 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'] 08:28:28 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 08:28:29 INFO - Return code: 0 08:28: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')]} 08:28:29 INFO - https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:28:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:31 INFO - Downloaded 10847584 bytes. 08:28:31 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'] 08:28:31 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 08:28:31 INFO - Return code: 0 08:28:31 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')]} 08:28:31 INFO - https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:28:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:28:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:28:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SMcXi3MrRgOrwMaVzHT48w/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 08:28:33 INFO - Downloaded 54084450 bytes. 08:28:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:28:33 INFO - mkdir: /builds/slave/test/properties 08:28:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:33 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:33 INFO - Contents: 08:28:33 INFO - build_url:https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:28:34 INFO - Running post-action listener: _resource_record_post_action 08:28:34 INFO - Running post-action listener: set_extra_try_arguments 08:28:34 INFO - ##### 08:28:34 INFO - ##### Running populate-webroot step. 08:28:34 INFO - ##### 08:28:34 INFO - Running pre-action listener: _resource_record_pre_action 08:28:34 INFO - Running main action method: populate_webroot 08:28:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:34 INFO - '--tppagecycles', 08:28:34 INFO - '7'], 08:28:34 INFO - 'tests': ['tsvgm']}}, 08:28:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:28:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:28:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'tests': ['damp', 'tps']}, 08:28:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['damp', 'tps']}, 08:28:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:28:34 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['dromaeo_dom']}, 08:28:34 INFO - 'other': {'tests': ['a11yr', 08:28:34 INFO - 'ts_paint', 08:28:34 INFO - 'tpaint', 08:28:34 INFO - 'sessionrestore', 08:28:34 INFO - 'sessionrestore_no_auto_restore', 08:28:34 INFO - 'tabpaint']}, 08:28:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['a11yr', 08:28:34 INFO - 'ts_paint', 08:28:34 INFO - 'tpaint', 08:28:34 INFO - 'sessionrestore', 08:28:34 INFO - 'sessionrestore_no_auto_restore', 08:28:34 INFO - 'tabpaint']}, 08:28:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['a11yr', 08:28:34 INFO - 'ts_paint', 08:28:34 INFO - 'tpaint', 08:28:34 INFO - 'sessionrestore', 08:28:34 INFO - 'sessionrestore_no_auto_restore', 08:28:34 INFO - 'tabpaint']}, 08:28:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['a11yr', 08:28:34 INFO - 'ts_paint', 08:28:34 INFO - 'tpaint', 08:28:34 INFO - 'sessionrestore', 08:28:34 INFO - 'sessionrestore_no_auto_restore', 08:28:34 INFO - 'tabpaint']}, 08:28:34 INFO - 'other_l64': {'tests': ['a11yr', 08:28:34 INFO - 'ts_paint', 08:28:34 INFO - 'tpaint', 08:28:34 INFO - 'sessionrestore', 08:28:34 INFO - 'sessionrestore_no_auto_restore', 08:28:34 INFO - 'tabpaint']}, 08:28:34 INFO - 'other_nol64': {'tests': ['a11yr', 08:28:34 INFO - 'ts_paint', 08:28:34 INFO - 'tpaint', 08:28:34 INFO - 'sessionrestore', 08:28:34 INFO - 'sessionrestore_no_auto_restore', 08:28:34 INFO - 'tabpaint']}, 08:28:34 INFO - 'svgr': {'tests': ['tsvgx', 08:28:34 INFO - 'tsvgr_opacity', 08:28:34 INFO - 'tart', 08:28:34 INFO - 'tscrollx', 08:28:34 INFO - 'cart']}, 08:28:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['tsvgx', 08:28:34 INFO - 'tsvgr_opacity', 08:28:34 INFO - 'tart', 08:28:34 INFO - 'tscrollx', 08:28:34 INFO - 'cart']}, 08:28:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'tests': ['tp5o']}, 08:28:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'talos_options': ['--e10s'], 08:28:34 INFO - 'tests': ['tp5o']}, 08:28:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'talos_options': ['--xperf_path', 08:28:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:34 INFO - 'tests': ['tp5n']}, 08:28:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:34 INFO - 'talos_options': ['--e10s', 08:28:34 INFO - '--xperf_path', 08:28:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:34 INFO - 'tests': ['tp5n']}}, 08:28:34 INFO - 'talos.zip': {'path': '', 08:28:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:34 INFO - Running post-action listener: _resource_record_post_action 08:28:34 INFO - ##### 08:28:34 INFO - ##### Running create-virtualenv step. 08:28:34 INFO - ##### 08:28:34 INFO - Running pre-action listener: _resource_record_pre_action 08:28:34 INFO - Running main action method: create_virtualenv 08:28:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:34 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 08:28:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:34 INFO - Using real prefix '/usr' 08:28:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:36 INFO - Installing pip.................done. 08:28:36 INFO - Return code: 0 08:28:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:36 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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:36 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 08:28:36 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 08:28:36 INFO - Using env: {'DISPLAY': ':0', 08:28:36 INFO - 'HOME': '/home/cltbld', 08:28:36 INFO - 'LANG': 'en_US.UTF-8', 08:28:36 INFO - 'LANGUAGE': 'en_US:en', 08:28:36 INFO - 'LOGNAME': 'cltbld', 08:28:36 INFO - 'MAIL': '/var/mail/cltbld', 08:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:36 INFO - 'MOZ_NO_REMOTE': '1', 08:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:36 INFO - 'NO_EM_RESTART': '1', 08:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:36 INFO - 'PWD': '/builds/slave/test', 08:28:36 INFO - 'SHELL': '/bin/bash', 08:28:36 INFO - 'SHLVL': '1', 08:28:36 INFO - 'TERM': 'linux', 08:28:36 INFO - 'TMOUT': '86400', 08:28:36 INFO - 'USER': 'cltbld', 08:28:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:36 INFO - '_': '/tools/buildbot/bin/python'} 08:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:37 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 08:28:37 INFO - Cleaning up... 08:28:37 INFO - Return code: 0 08:28:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:28:37 INFO - Using env: {'DISPLAY': ':0', 08:28:37 INFO - 'HOME': '/home/cltbld', 08:28:37 INFO - 'LANG': 'en_US.UTF-8', 08:28:37 INFO - 'LANGUAGE': 'en_US:en', 08:28:37 INFO - 'LOGNAME': 'cltbld', 08:28:37 INFO - 'MAIL': '/var/mail/cltbld', 08:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:37 INFO - 'MOZ_NO_REMOTE': '1', 08:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:37 INFO - 'NO_EM_RESTART': '1', 08:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:37 INFO - 'PWD': '/builds/slave/test', 08:28:37 INFO - 'SHELL': '/bin/bash', 08:28:37 INFO - 'SHLVL': '1', 08:28:37 INFO - 'TERM': 'linux', 08:28:37 INFO - 'TMOUT': '86400', 08:28:37 INFO - 'USER': 'cltbld', 08:28:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:37 INFO - '_': '/tools/buildbot/bin/python'} 08:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:37 INFO - Downloading/unpacking psutil>=0.7.1 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:39 INFO - Installing collected packages: psutil 08:28:39 INFO - Running setup.py install for psutil 08:28:39 INFO - building 'psutil._psutil_linux' extension 08:28:39 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 08:28:39 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 08:28:39 INFO - building 'psutil._psutil_posix' extension 08:28:39 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 08:28:39 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 08:28:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:39 INFO - Successfully installed psutil 08:28:39 INFO - Cleaning up... 08:28:39 INFO - Return code: 0 08:28:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:28:39 INFO - Using env: {'DISPLAY': ':0', 08:28:39 INFO - 'HOME': '/home/cltbld', 08:28:39 INFO - 'LANG': 'en_US.UTF-8', 08:28:39 INFO - 'LANGUAGE': 'en_US:en', 08:28:39 INFO - 'LOGNAME': 'cltbld', 08:28:39 INFO - 'MAIL': '/var/mail/cltbld', 08:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:39 INFO - 'MOZ_NO_REMOTE': '1', 08:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:39 INFO - 'NO_EM_RESTART': '1', 08:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:39 INFO - 'PWD': '/builds/slave/test', 08:28:39 INFO - 'SHELL': '/bin/bash', 08:28:39 INFO - 'SHLVL': '1', 08:28:39 INFO - 'TERM': 'linux', 08:28:39 INFO - 'TMOUT': '86400', 08:28:39 INFO - 'USER': 'cltbld', 08:28:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:39 INFO - '_': '/tools/buildbot/bin/python'} 08:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:28:42 INFO - Installing collected packages: mozsystemmonitor 08:28:42 INFO - Running setup.py install for mozsystemmonitor 08:28:42 INFO - Successfully installed mozsystemmonitor 08:28:42 INFO - Cleaning up... 08:28:42 INFO - Return code: 0 08:28:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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', '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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:28: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 blobuploader==1.2.4 08:28:42 INFO - Using env: {'DISPLAY': ':0', 08:28:42 INFO - 'HOME': '/home/cltbld', 08:28:42 INFO - 'LANG': 'en_US.UTF-8', 08:28:42 INFO - 'LANGUAGE': 'en_US:en', 08:28:42 INFO - 'LOGNAME': 'cltbld', 08:28:42 INFO - 'MAIL': '/var/mail/cltbld', 08:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:42 INFO - 'MOZ_NO_REMOTE': '1', 08:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:42 INFO - 'NO_EM_RESTART': '1', 08:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:42 INFO - 'PWD': '/builds/slave/test', 08:28:42 INFO - 'SHELL': '/bin/bash', 08:28:42 INFO - 'SHLVL': '1', 08:28:42 INFO - 'TERM': 'linux', 08:28:42 INFO - 'TMOUT': '86400', 08:28:42 INFO - 'USER': 'cltbld', 08:28:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:42 INFO - '_': '/tools/buildbot/bin/python'} 08:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 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 08:28:44 INFO - Downloading docopt-0.6.1.tar.gz 08:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:45 INFO - Running setup.py install for blobuploader 08:28:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:45 INFO - Running setup.py install for requests 08:28:45 INFO - Running setup.py install for docopt 08:28:45 INFO - Successfully installed blobuploader requests docopt 08:28:45 INFO - Cleaning up... 08:28:45 INFO - Return code: 0 08:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:45 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')]} 08:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 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')]} 08:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:45 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 08:28:45 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 08:28:45 INFO - Using env: {'DISPLAY': ':0', 08:28:45 INFO - 'HOME': '/home/cltbld', 08:28:45 INFO - 'LANG': 'en_US.UTF-8', 08:28:45 INFO - 'LANGUAGE': 'en_US:en', 08:28:45 INFO - 'LOGNAME': 'cltbld', 08:28:45 INFO - 'MAIL': '/var/mail/cltbld', 08:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:45 INFO - 'MOZ_NO_REMOTE': '1', 08:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:45 INFO - 'NO_EM_RESTART': '1', 08:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:45 INFO - 'PWD': '/builds/slave/test', 08:28:45 INFO - 'SHELL': '/bin/bash', 08:28:45 INFO - 'SHLVL': '1', 08:28:45 INFO - 'TERM': 'linux', 08:28:45 INFO - 'TMOUT': '86400', 08:28:45 INFO - 'USER': 'cltbld', 08:28:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:45 INFO - '_': '/tools/buildbot/bin/python'} 08:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 INFO - Running setup.py (path:/tmp/pip-fKWUBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 INFO - Running setup.py (path:/tmp/pip-WvNDCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:45 INFO - Running setup.py (path:/tmp/pip-ijkjg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:46 INFO - Running setup.py (path:/tmp/pip-dpo8Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:46 INFO - Running setup.py (path:/tmp/pip-Q5Dhqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:46 INFO - Running setup.py (path:/tmp/pip-AE7JmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:46 INFO - Running setup.py (path:/tmp/pip-9PiwUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:46 INFO - Running setup.py (path:/tmp/pip-8zjEIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:46 INFO - Running setup.py (path:/tmp/pip-XGkZgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:46 INFO - Running setup.py (path:/tmp/pip-WHrXSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 INFO - Running setup.py (path:/tmp/pip-ddYKY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 INFO - Running setup.py (path:/tmp/pip-L1uT1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 INFO - Running setup.py (path:/tmp/pip-6vwXOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 INFO - Running setup.py (path:/tmp/pip-CQ3x7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 INFO - Running setup.py (path:/tmp/pip-U_6eP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:46 INFO - Running setup.py (path:/tmp/pip-2u3O2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:47 INFO - Running setup.py (path:/tmp/pip-GxKG2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:47 INFO - Running setup.py install for manifestparser 08:28:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozcrash 08:28:47 INFO - Running setup.py install for mozdebug 08:28:47 INFO - Running setup.py install for mozdevice 08:28:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozfile 08:28:47 INFO - Running setup.py install for mozhttpd 08:28:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozinfo 08:28:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozInstall 08:28:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozleak 08:28:47 INFO - Running setup.py install for mozlog 08:28:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for moznetwork 08:28:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for mozprocess 08:28:48 INFO - Running setup.py install for mozprofile 08:28:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for mozrunner 08:28:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for mozscreenshot 08:28:48 INFO - Running setup.py install for moztest 08:28:48 INFO - Running setup.py install for mozversion 08:28:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:28:48 INFO - Cleaning up... 08:28:48 INFO - Return code: 0 08:28:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:48 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')]} 08:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:48 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')]} 08:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:48 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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:48 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 08:28:48 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 08:28:48 INFO - Using env: {'DISPLAY': ':0', 08:28:48 INFO - 'HOME': '/home/cltbld', 08:28:48 INFO - 'LANG': 'en_US.UTF-8', 08:28:48 INFO - 'LANGUAGE': 'en_US:en', 08:28:48 INFO - 'LOGNAME': 'cltbld', 08:28:48 INFO - 'MAIL': '/var/mail/cltbld', 08:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:48 INFO - 'MOZ_NO_REMOTE': '1', 08:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:48 INFO - 'NO_EM_RESTART': '1', 08:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:48 INFO - 'PWD': '/builds/slave/test', 08:28:48 INFO - 'SHELL': '/bin/bash', 08:28:48 INFO - 'SHLVL': '1', 08:28:48 INFO - 'TERM': 'linux', 08:28:48 INFO - 'TMOUT': '86400', 08:28:48 INFO - 'USER': 'cltbld', 08:28:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:48 INFO - '_': '/tools/buildbot/bin/python'} 08:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:49 INFO - Running setup.py (path:/tmp/pip-yLdA4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:49 INFO - Running setup.py (path:/tmp/pip-NUcj1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:49 INFO - Running setup.py (path:/tmp/pip-aGhWvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:49 INFO - Running setup.py (path:/tmp/pip-9ZTAwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:49 INFO - Running setup.py (path:/tmp/pip-TzO_WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:49 INFO - Running setup.py (path:/tmp/pip-2dza_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:49 INFO - Running setup.py (path:/tmp/pip-nlyuWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:49 INFO - Running setup.py (path:/tmp/pip-G4dtFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:49 INFO - Running setup.py (path:/tmp/pip-mLTLQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:49 INFO - Running setup.py (path:/tmp/pip-02xkwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:49 INFO - Running setup.py (path:/tmp/pip-Sh14lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:49 INFO - Running setup.py (path:/tmp/pip-YRye9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:49 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)) 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:50 INFO - Running setup.py (path:/tmp/pip-HIBFwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:50 INFO - Running setup.py (path:/tmp/pip-Z1niHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:50 INFO - Running setup.py (path:/tmp/pip-x_M0eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:50 INFO - Running setup.py (path:/tmp/pip-BfqFnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:50 INFO - Running setup.py (path:/tmp/pip-2aoQZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:50 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)) 08:28:50 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)) 08:28:50 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)) 08:28:50 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)) 08:28:50 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)) 08:28:50 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)) 08:28:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:52 INFO - Downloading blessings-1.6.tar.gz 08:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:52 INFO - Installing collected packages: blessings 08:28:52 INFO - Running setup.py install for blessings 08:28:52 INFO - Successfully installed blessings 08:28:52 INFO - Cleaning up... 08:28:52 INFO - Return code: 0 08:28:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:28:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:52 INFO - Reading from file tmpfile_stdout 08:28:52 INFO - Current package versions: 08:28:52 INFO - argparse == 1.2.1 08:28:52 INFO - blessings == 1.6 08:28:52 INFO - blobuploader == 1.2.4 08:28:52 INFO - docopt == 0.6.1 08:28:52 INFO - manifestparser == 1.1 08:28:52 INFO - mozInstall == 1.12 08:28:52 INFO - mozcrash == 0.17 08:28:52 INFO - mozdebug == 0.1 08:28:52 INFO - mozdevice == 0.48 08:28:52 INFO - mozfile == 1.2 08:28:52 INFO - mozhttpd == 0.7 08:28:52 INFO - mozinfo == 0.9 08:28:52 INFO - mozleak == 0.1 08:28:52 INFO - mozlog == 3.1 08:28:52 INFO - moznetwork == 0.27 08:28:52 INFO - mozprocess == 0.22 08:28:52 INFO - mozprofile == 0.28 08:28:52 INFO - mozrunner == 6.11 08:28:52 INFO - mozscreenshot == 0.1 08:28:52 INFO - mozsystemmonitor == 0.0 08:28:52 INFO - moztest == 0.7 08:28:52 INFO - mozversion == 1.4 08:28:52 INFO - psutil == 3.1.1 08:28:52 INFO - requests == 1.2.3 08:28:52 INFO - wsgiref == 0.1.2 08:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:52 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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:52 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 08:28:52 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 08:28:52 INFO - Using env: {'DISPLAY': ':0', 08:28:52 INFO - 'HOME': '/home/cltbld', 08:28:52 INFO - 'LANG': 'en_US.UTF-8', 08:28:52 INFO - 'LANGUAGE': 'en_US:en', 08:28:52 INFO - 'LOGNAME': 'cltbld', 08:28:52 INFO - 'MAIL': '/var/mail/cltbld', 08:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:52 INFO - 'MOZ_NO_REMOTE': '1', 08:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:52 INFO - 'NO_EM_RESTART': '1', 08:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:52 INFO - 'PWD': '/builds/slave/test', 08:28:52 INFO - 'SHELL': '/bin/bash', 08:28:52 INFO - 'SHLVL': '1', 08:28:52 INFO - 'TERM': 'linux', 08:28:52 INFO - 'TMOUT': '86400', 08:28:52 INFO - 'USER': 'cltbld', 08:28:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:52 INFO - '_': '/tools/buildbot/bin/python'} 08:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 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)) 08:28:52 INFO - Cleaning up... 08:28:52 INFO - Return code: 0 08:28:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:28:52 INFO - Using env: {'DISPLAY': ':0', 08:28:52 INFO - 'HOME': '/home/cltbld', 08:28:52 INFO - 'LANG': 'en_US.UTF-8', 08:28:52 INFO - 'LANGUAGE': 'en_US:en', 08:28:52 INFO - 'LOGNAME': 'cltbld', 08:28:52 INFO - 'MAIL': '/var/mail/cltbld', 08:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:52 INFO - 'MOZ_NO_REMOTE': '1', 08:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:52 INFO - 'NO_EM_RESTART': '1', 08:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:52 INFO - 'PWD': '/builds/slave/test', 08:28:52 INFO - 'SHELL': '/bin/bash', 08:28:52 INFO - 'SHLVL': '1', 08:28:52 INFO - 'TERM': 'linux', 08:28:52 INFO - 'TMOUT': '86400', 08:28:52 INFO - 'USER': 'cltbld', 08:28:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:52 INFO - '_': '/tools/buildbot/bin/python'} 08:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:53 INFO - Downloading/unpacking jsonschema 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:54 INFO - Downloading/unpacking functools32 (from jsonschema) 08:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:55 INFO - warning: no files found matching '*.txt' 08:28:55 INFO - no previously-included directories found matching 'build' 08:28:55 INFO - no previously-included directories found matching 'dist' 08:28:55 INFO - no previously-included directories found matching '.git*' 08:28:55 INFO - Installing collected packages: jsonschema, functools32 08:28:55 INFO - Running setup.py install for functools32 08:28:55 INFO - warning: no files found matching '*.txt' 08:28:55 INFO - no previously-included directories found matching 'build' 08:28:55 INFO - no previously-included directories found matching 'dist' 08:28:55 INFO - no previously-included directories found matching '.git*' 08:28:55 INFO - Successfully installed jsonschema functools32 08:28:55 INFO - Cleaning up... 08:28:55 INFO - Return code: 0 08:28:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:28:55 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')]} 08:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:55 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')]} 08:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:55 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 0x7f05cd572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', '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 08:28:55 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 08:28:55 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 08:28:55 INFO - Using env: {'DISPLAY': ':0', 08:28:55 INFO - 'HOME': '/home/cltbld', 08:28:55 INFO - 'LANG': 'en_US.UTF-8', 08:28:55 INFO - 'LANGUAGE': 'en_US:en', 08:28:55 INFO - 'LOGNAME': 'cltbld', 08:28:55 INFO - 'MAIL': '/var/mail/cltbld', 08:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:55 INFO - 'MOZ_NO_REMOTE': '1', 08:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:55 INFO - 'NO_EM_RESTART': '1', 08:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:55 INFO - 'PWD': '/builds/slave/test', 08:28:55 INFO - 'SHELL': '/bin/bash', 08:28:55 INFO - 'SHLVL': '1', 08:28:55 INFO - 'TERM': 'linux', 08:28:55 INFO - 'TMOUT': '86400', 08:28:55 INFO - 'USER': 'cltbld', 08:28:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:55 INFO - '_': '/tools/buildbot/bin/python'} 08:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:55 INFO - Downloading/unpacking flake8 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:28:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:28:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:57 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 08:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:28:58 INFO - no previously-included directories found matching 'docs/_build' 08:28:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:28:58 INFO - Running setup.py install for pep8 08:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:28:58 INFO - no previously-included directories found matching 'docs/_build' 08:28:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:28:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:28:58 INFO - Cleaning up... 08:28:58 INFO - Return code: 0 08:28:58 INFO - Running post-action listener: _resource_record_post_action 08:28:58 INFO - Running post-action listener: _start_resource_monitoring 08:28:58 INFO - Starting resource monitoring. 08:28:58 INFO - ##### 08:28:58 INFO - ##### Running install step. 08:28:58 INFO - ##### 08:28:58 INFO - Running pre-action listener: _resource_record_pre_action 08:28:58 INFO - Running main action method: install 08:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:58 INFO - Reading from file tmpfile_stdout 08:28:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:58 INFO - Reading from file tmpfile_stdout 08:28:58 INFO - Output received: 08:28:58 INFO - Usage: mozinstall [options] installer 08:28:58 INFO - Options: 08:28:58 INFO - -h, --help show this help message and exit 08:28:58 INFO - -d DEST, --destination=DEST 08:28:58 INFO - Directory to install application into. [default: 08:28:58 INFO - "/builds/slave/test"] 08:28:58 INFO - --app=APP Application being installed. [default: firefox] 08:28:58 INFO - mkdir: /builds/slave/test/build/application 08:28:58 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'] 08:28:58 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 08:29:14 INFO - Reading from file tmpfile_stdout 08:29:14 INFO - Output received: 08:29:14 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:14 INFO - Running post-action listener: _resource_record_post_action 08:29:14 INFO - ##### 08:29:14 INFO - ##### Running run-tests step. 08:29:14 INFO - ##### 08:29:14 INFO - Running pre-action listener: _resource_record_pre_action 08:29:14 INFO - Running main action method: run_tests 08:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:14 INFO - Python 2.7.3 08:29:14 INFO - Return code: 0 08:29:14 INFO - grabbing minidump binary from tooltool 08:29:14 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')]} 08:29:14 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 0x2cc4410>, '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 0x2cc5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:14 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 08:29:14 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 08:29:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:14 INFO - Return code: 0 08:29:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:29:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:29:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:29:15 INFO - Return code: 0 08:29:15 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/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:29:15 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/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 08:29:15 INFO - Using env: {'DISPLAY': ':0', 08:29:15 INFO - 'HOME': '/home/cltbld', 08:29:15 INFO - 'LANG': 'en_US.UTF-8', 08:29:15 INFO - 'LANGUAGE': 'en_US:en', 08:29:15 INFO - 'LOGNAME': 'cltbld', 08:29:15 INFO - 'MAIL': '/var/mail/cltbld', 08:29:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:15 INFO - 'MOZ_NO_REMOTE': '1', 08:29:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:15 INFO - 'NO_EM_RESTART': '1', 08:29:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:15 INFO - 'PWD': '/builds/slave/test', 08:29:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:15 INFO - 'SHELL': '/bin/bash', 08:29:15 INFO - 'SHLVL': '1', 08:29:15 INFO - 'TERM': 'linux', 08:29:15 INFO - 'TMOUT': '86400', 08:29:15 INFO - 'USER': 'cltbld', 08:29:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773', 08:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:15 INFO - '_': '/tools/buildbot/bin/python'} 08:29:15 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/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:29:15 INFO - mozversion application_buildid: 20160405075115 08:29:15 INFO - mozversion application_changeset: f0110e77e9f7b40ba80b3640ea7cd038398b8eee 08:29:15 INFO - mozversion application_display_name: Nightly 08:29:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:15 INFO - mozversion application_name: Firefox 08:29:15 INFO - mozversion application_remotingname: firefox 08:29:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:29:15 INFO - mozversion application_vendor: Mozilla 08:29:15 INFO - mozversion application_version: 48.0a1 08:29:15 INFO - mozversion platform_buildid: 20160405075115 08:29:15 INFO - mozversion platform_changeset: f0110e77e9f7b40ba80b3640ea7cd038398b8eee 08:29:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:29:15 INFO - mozversion platform_version: 48.0a1 08:29:15 INFO - using testdate: 1459870155 08:29:15 INFO - actual date: 1459870155 08:29:15 INFO - starting webserver on 'localhost:47812' 08:29:15 INFO - SUITE-START | Running 2 tests 08:29:15 INFO - TEST-START | dromaeo_css 08:29:15 INFO - operating with platform_type : linux_ 08:29:15 INFO - Initialising browser for dromaeo_css test... 08:29:15 INFO - TEST-INFO | started process 20349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjXmpl/profile http://localhost:47812/getInfo.html) 08:29:20 INFO - PROCESS | 20349 | __metrics Screen width/height:1600/1200 08:29:20 INFO - PROCESS | 20349 | colorDepth:24 08:29:20 INFO - PROCESS | 20349 | Browser inner width/height: 1024/697 08:29:20 INFO - PROCESS | 20349 | __metrics 08:29:21 ERROR - PROCESS | 20349 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:29:21 INFO - TEST-INFO | 20349: exit 0 08:29:21 INFO - Browser initialized. 08:29:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:21 INFO - TEST-INFO | started process 20430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjXmpl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:33 INFO - PROCESS | 20430 | RSS: Main: 154112000 08:29:33 INFO - PROCESS | 20430 | 08:30:24 INFO - PROCESS | 20430 | 1459870224819 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] 08:32:36 INFO - PROCESS | 20430 | Cycle 1(1): loaded http://localhost:47812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47812/tests/dromaeo/cssquery-ext.html) 08:32:37 INFO - PROCESS | 20430 | RSS: Main: 270544896 08:32:37 INFO - PROCESS | 20430 | 08:35:39 INFO - PROCESS | 20430 | Cycle 1(1): loaded http://localhost:47812/tests/dromaeo/cssquery-ext.html (next: http://localhost:47812/tests/dromaeo/cssquery-jquery.html) 08:35:40 INFO - PROCESS | 20430 | RSS: Main: 238678016 08:35:40 INFO - PROCESS | 20430 | 08:38:42 INFO - PROCESS | 20430 | Cycle 1(1): loaded http://localhost:47812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47812/tests/dromaeo/cssquery-mootools.html) 08:38:42 INFO - PROCESS | 20430 | RSS: Main: 232591360 08:38:42 INFO - PROCESS | 20430 | 08:41:44 INFO - PROCESS | 20430 | Cycle 1(1): loaded http://localhost:47812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47812/tests/dromaeo/cssquery-prototype.html) 08:41:45 INFO - PROCESS | 20430 | RSS: Main: 221671424 08:41:45 INFO - PROCESS | 20430 | 08:44:48 INFO - PROCESS | 20430 | Cycle 1(1): loaded http://localhost:47812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47812/tests/dromaeo/cssquery-yui.html) 08:44:48 INFO - PROCESS | 20430 | RSS: Main: 197918720 08:44:48 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | Cycle 1(1): loaded http://localhost:47812/tests/dromaeo/cssquery-yui.html (next: http://localhost:47812/tests/dromaeo/cssquery-dojo.html) 08:47:51 INFO - PROCESS | 20430 | RSS: Main: 263802880 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | __start_tp_report 08:47:51 INFO - PROCESS | 20430 | _x_x_mozilla_page_load 08:47:51 INFO - PROCESS | 20430 | _x_x_mozilla_page_load_details 08:47:51 INFO - PROCESS | 20430 | |i|pagename|runs| 08:47:51 INFO - PROCESS | 20430 | |0;dojo.html;2604.3749500119975;2659.5877638965953;2671.5992601109833;2676.826006309591;2693.9326516837077;4529.977350113253;4586.633069354452;4617.607503362218;4619.653525985552;4628.328892310613;4602.746848923308;4624.237000894848;4656.045510670313;4690.460597031342;4695.67130300879;4237.87286381409;4240.406343111967;4271.081717430752;4307.246231909403;4377.4528183977;4324.675649326313;4346.130773845243;4348.173846969065;4381;4395.758233297167;4169.499660040784;4208.642265407444;4252.787360631987;4270.252705776476;4282.807273672693;4251.043515209053;4254;4259.70182087254;4289.6139347458875;4310.978445107786;4221.915561688749;4236.449261596003;4237.618614324695;4251.3622956556455;4280.1653677532895;4412.161689279027;4493.078918821634;4505.868421447096;4549.886252843672;4594.494605593382;4913.975430122862;4919.483454237289;4919.680220785637;4926.827561035382;4929.975350123226;4933.876653083666;4940.851774446773;4941.629377796679;4944.728039957801;4989.401271847401;4569.337446070301;4578.9771051144535;4657.906841863144;4671.813127474931;4675.719456832601;5046.142155833517;5052.444231134572;5054.191329387354;5068.290439338495;5104.438511763703;4852.902941941142;4862.902741945141;4863.489333619989;4868.269759536098;4884.975575122173;4871.585915197177;4875.926861097087;4939;4944;4970.751462426864;4912.852614421573;4915.631327650441;4925.285833554115;4932.0135972804865;4994.9500504994485;4776.665633405698;4928.507149285043;4930.063287975345;4937.136001199848;4979.477154898684;4133.256013917464;4134.586541345841;4137.97931010343;4215.894602634959;4224.91550169001;3620.330238905758;3633.6729694327637;3639;3672;3676.3198808220563;4242.151569686075;4243.554426785205;4243.809028593659;4249.97875010623;4288.09949910516;4849.199882019428;4938.753062346868;4996.125678006334;5040.1179793535985;5040.546350828443;4254.489461264606;4263.275243208662;4270.466191726035;4273.273543497613;4301.741895486281;4366.71616344943;4401.185780630593;4442.2458075992445;4446.3330500424545;4469.843555475608;4649.139909116824;4713;4720.669553131385;4750.429948406213;4752.049590082067;4911.557959783637;4933.235348520985;4933.309336692938;4952.356193694796;4961.776720047535;4578.793954272132;4620.6303495719585;4681.321208424827;4685.4845966944295;4733.840209148781;4868.732219727949;4899.16714158601;4905.632077594123;4907.754612269444;4943.283223932582;4946.897847506344;4962.776675049559;4965.30485732005;4966.230234313687;5017.874553136055;4688.367070445583;4784.497627749036;4815.6388270880525;4854.78153483087;4872.4640289567415;4788.353572267699;4796.25658023007;4800.231962885921;4828.855134345975;4858.076965376567;4751.311059896365;4751.83368582098;4756.643251756202;4758.595519380891;4763.190257656138;4716.457607375059;4767.213409787346;4817.156997525489;4820.421549414093;4901.852944411673;4670.206064969031;4777.522247775195;4822.493638167942;4825.95174048255;4831.710097394168 08:47:51 INFO - PROCESS | 20430 | |1;ext.html;517.5730022731248;527.2223470381188;535.7642637239617;540.0980362794133;546.4835730234928;27751.861240693794;35219.4717079244;35693.821530892375;35743.64256357436;35954.8202258989;38781.612183878155;39057.41413878794;39180.804095979554;39186.60813391865;39252.21495570087;7609.201033891431;7778.4166187535875;7783.688652453895;7784.961075194616;7791.4935529190425;7673.309402153805;7784.961075194645;7797.610119494031;7803.10264319602;7985.441019128663;7959.880601790977;8025.478343907627;8033.839323213532;8042.3566114710975;8046.114927357986;7942.483738556975;7993;8014.078380986145;8022.3983201260135;8024.9197508025045;7882.881756773653;7924.167962363984;7987.241212084843;8016.478928869605;8018.839623207503;39246.60753392458;39690.80154599238;39725.80137099296;39800;39824.00439988994;3076.5385192221124;3188.5536024956523;3204.375146846366;3224.9355012899846;3280.6063272407464;29692.8515357424;29719.70280297191;29804.254893627614;30295.091147265397;30640.38719225603;3355.5973283205926;3500.1074725944723;3536.7877927324444;3554.751167418282;3664.3404187246283;180805;181280.09359953247;182588;182613;182759;47594.5240547597;54715.45284547104;54796;55227.72386138044;55671.443285566624;52188.95622087537;52555.21167182495;52568.474315257125;52571.474285256656;52650;14811.407543698131;15094.320755566026;15109.697806043818;15109.924450377677;15132.697346053237;9426;11268.09855211581;11342.546298148147;11726.648200553826;11954.282743035446;18369.7244541332;18381.81618183801;18382.908085459756;18389.264429422674;18451.723224151647;6342.682865856688;6708.362705542965;6800.863982720318;6909.447244220451;6934.271901450376;905.1220316293185;910.9134632210062;913.6573784830689;934.7149119518476;980.8087422952456;26888.32779180497;27176.728232717815;27704.584431233143;27773.86113069422;27782;998.5321577281385;1007.2848277722899;1022.2333250062453;1094.0481780850712;1119.0767616716241;14152.29238538069;14432.639184020274;14466.566003019927;14483.855161448251;14789.704205915821;295096;299207;299320;299636;299862;47651.285230721565;49168.26247606289;49190;49206.261906071435;49217;1059.7880423915094;1237.6843904804218;1256.9748605027848;1270.2568997136593;1322.8677132286693;24697.62953555662;25142.24573262805;25166.74833251644;25190.370240744127;25281.241562753148;35444.29111417705;35701.82149089238;35726.821365894044;35731.821340893126;35764.821175895;167830;168229;168513;168775;168926;29412.852935736042;30974.84512577513;31351.686483134876;31394.68605314009;31421.685783141875;39166.80416597899;39700;39951.40072898967;40172.799136004134;40574.79712601418;33898.136990920415;33921.66078339185;34076;34101.147471313416;34584.48123278203;33764.3247135051;33960;33988;34001.82999085088;34025.319493610485;33004.1748956278;33802.830985845896;33849.15377115592;33984.830075849466;34182.65817341795;28131.718682813727;29950.855160207866;30023.3995320088;30052;30053;23789.405264868517;24296.271111866674;24313.418721747854;24318;24620.1382951603 08:47:51 INFO - PROCESS | 20430 | |2;jquery.html;339.54161881460027;347.671450479297;356.93039857227853;360.9981950090249;361.59862552566665;15274.84725152748;16013.359465621375;16549;17105.40131095412;17110.657786844255;10207.234457415687;10569.577216911315;13382.531611393579;16738.41415550456;16741;4623.167829790645;4799.064182484417;4799.712017278975;4806.495317991613;4814.566688997989;3331.133905184657;3402.319536092779;5214.556762675158;5423.945760542383;5434.184872269152;5398.13629819229;5412.91880621791;5419.430959749228;5435.483629055253;5435.646682965615;5276.445973172838;5331.760070796823;5386.811461598845;5410.594205434589;5457.263269458612;5231.189165679326;5240.9213861792105;5242.895142097175;5246.134387826004;5257.053730328539;11972.341521216329;15202.543923682197;19947.90026049875;19970.60058798816;19972.90013549923;1909.9713504297447;2014.7280117184139;2220.877851718155;2303.9424014399606;2392.9401764956015;9576.277489896569;9578.904210957871;9650.855237171449;11257.380844053656;13041.478340866353;1729.144073683522;1775.7070083436217;1782.8484578810817;1814.8820326678856;1842.6959551674092;44658.553414465765;46855.604576385325;54404.72797635986;64623;64737;9289.489078100634;9804.803903922024;9889.851652225223;9954.253430992705;10004.249681273934;13416.597502074954;13522.256275904723;13615.863841361657;13616.65958351049;13624.318784060757;7260.854782904313;7464.888026679604;7504.399648028145;7557.093148822067;7591.4685971982535;7143.9285607143265;7253.782386528413;7313.049303590499;7316.268373162641;7354.043974283309;4250.681198910094;4298.957010429918;4334.21984042869;4411.492678341968;4413.1394378095965;1606.598350412397;1632.5755303620906;1682.142107525171;1694.1529235382309;1700.761893334934;850.8340873529602;876.6361959786617;898.8921329440378;909.0273407454093;929.6513807322254;15901.443449479213;16380.508584742476;16502.504924852274;16518.75221871673;16580.253888575044;852.3011130872625;859.866720658299;876.2114097312469;877.3376101043672;882.1046637662778;9255.76860578491;9292.628294868266;9299.95350023259;9403.811923761486;9425.212768612684;254599;260799;371477;377542;381091;77675;78126.6093669528;78305.60847195728;78633.60683196547;79199.60400197962;893.3121496447699;960.7309953213112;978.5987745024506;1003.6186249225248;1013.2521400583934;14990.625234368792;15018.023828451553;15238;15345.386184552493;15421.84578154204;32627.18432039218;33423;34388.65611343855;35726;37915.81042094772;44518.554814452735;45126;45207.32189017233;45347.773261134804;45598.54401455943;7561.621918903923;7593.5823529706395;7767.456278060482;7854.1360450349275;7857.960710196412;8807.64769409242;11549;11765.47055382527;11846.348450835287;11977.041836652872;9829.705108846745;9929.106380425796;9994.350367226107;10102.69691909244;10201.744956375853;10035.849462258218;10323.793524129625;10495.842562361418;10656.360618362924;10676.786464270515;9184.816303674022;10194.847077293698;10220.744481388025;10236.385816851012;10518.842217366593;7416.9258307418395;7633.12219094789;7677.654505547375;7678.5392876427595;7733.961330193313;9613.327067105236;10043.698689039049;10191.490425478845;10191.898081019095;10413.531391087268 08:47:51 INFO - PROCESS | 20430 | |3;mootools.html;1372.6705590658241;1422.5234546426943;1547.7833103365524;1700.761893334934;1766.2140347545349;7101.0413594164775;7236.529625574334;7295.671694773735;7298.525595836267;7335.413166946645;6180.4746596539235;6299.496040316775;6313.021481670348;6317.463015643664;7228;1918.9808101918977;2136.2309568555306;2181.182056728727;2190.123950419837;2199.175309259028;2144.02446886667;2182.639864422368;2185.6940028395957;2190.145843121184;2193.901274442646;1880.9623807523842;2142.1859693316596;2150.580636775829;2151.3330867431146;2157.6439887418555;2134.423705599487;2192.1998470558133;2192.48476607997;2193.352960876537;2194.3416974907623;2099.5276062885882;2123.437289118385;2132.477543001959;2155.4503601581496;2183.6069507488805;7181.605011724353;7186.1735900371605;7217.92782072183;7224.1692205396;7240.13118425787;4342.5874541918465;4484.1928452878465;4484.618807401374;4486.439195100613;4537.387452693877;2839.5030869597945;2863.9284017899718;2970.287131088545;2977.5831383606314;2985.447692176954;935.349931797401;945.3146468810127;961.7403301108661;964.2719746591279;975.0298453039201;9627.037296270388;9643.180329671986;9648.179904708108;9650.469224192666;9663.323567350288;3929.390944403622;4082.4896887889013;4130.793460326971;4149.091417947718;4152.91694166115;8281.917180828235;8343.374246931504;8376.036755773164;8377.204165604258;8377.413581049268;4502.977485112553;4525.932111018337;4549.27211646135;4549.385832912581;4554.385158003627;4145.233131870614;4147.585241475828;4147.709660323749;4152.875413737593;4153.065560248981;3135.90243414803;3456.343294773985;3519.486620753101;3519.6449366993893;3527.2592755521628;1138.3738943580997;1174.442139983501;1176.505867535637;1182.5100373529415;1188.9821652675216;1197.233770386953;1201.2252097397304;1203.9699007524707;1213.3387303919385;1227.5580790915262;6689.531732778659;6853.623050732258;6884.311568843175;6885.518013739091;7015.508914375945;1040.557762950743;1046.2780681329857;1068.8022715797601;1072.8873468285717;1083.3932997521413;5405.945940540544;5465.180222966507;5473.28847249855;5506.834794956158;5507.0637991541535;8447.873281900776;8550.657973681107;8650.78373040679;8740.956295218482;8748.037715851251;8512.787180320542;8532.402731808714;8538;8619;8641.654333826702;6690.933090669128;6777.661116944231;6825.590464572042;6837.076994605664;6896.586204827727;6500.447461965597;6501.089847421459;6536.542442029012;6565.113709649137;6577.80266592003;7563.73526926577;7669.9616501917135;7829.099653539915;7922.366210703015;7937.960310198412;7851.254130857559;7956.801079973047;8076.515409075474;8091.757247282591;8095.635696393559;6342.080398342122;6374.617522948638;6392.232932048184;6401.135846660642;6412.775552855627;6817.488688348493;7000.159980802337;7000.824979375557;7003.124609423822;7014.263502332182;6197;6280.528960328085;6286.5599408041;6343.777967771106;6393.424591786761;6134.079888016655;6182.505399568114;6231.594946328474;6329.082283068838;6384.138141350858;6464.191976003;6503.837404064747;6510.251321098134;6516.120323756232;6652.90020649681;6180.6291622502795;6256.906146407717;6257.78097766576;6265.8120256392385;6267.373262673696;5981.431763982415;6152.507799376129;6158.3841615838055;6225.3774622537385;6237.376262373727 08:47:51 INFO - PROCESS | 20430 | |4;prototype.html;310.2430070627667;312.7466751930938;315.263858889493;315.70797012763194;318.2219473387567;5276.419593844679;5291.338582677161;5379.300690910176;5387.811426600069;5389.272448219499;5293.9735301323435;5296.364436267643;5315.335583052119;5317.5480084192795;5317.893642127165;3933.6263055009726;4025.9597404025876;4125.855595054174;4133.421321015053;4133.42132101506;4113.362428823522;4116.135611521584;4124.958750412503;4131.52487463941;4135.6898232632675;4084.1831633673237;4088.4889388826396;4089.0595163112503;4094.2425651254466;4102.856400025999;3924.6075392460666;4004.3993400989793;4029.395590661395;4041.232165888501;4098.610631989956;3540.7698499597445;3633.8909832705062;3637.0907273181706;3640.7269454791;3642.9453558196647;5121.180611102243;5122.487751224885;5130.025295193938;5135.820246291362;5138.691678499302;4753.786079626425;4759.333693282943;4761.333413322138;4768.856934291942;4778.068276686047;5589.469000444951;5593.8321850344555;5595.524380427669;5596.916046259309;5601.29983752031;4004.3593025115842;4005.0387906902133;4006.3389540725743;4009.4787677602017;4009.578994205596;5591.6365436246515;5758.79844205455;5786.42135786418;5792.275965504312;5860.06239001762;3955.3869150281753;3971.3050216212046;3987.800609969548;3994.3409337458993;4001.0197501612292;4042.7776472293717;4046.77742724153;4047.0894048839364;4048.6963477739287;4056.634902858757;4647.6281897448125;4651.139539185194;4658.114958157939;4674.088552732184;4677.883052923704;5623.746931388097;5626.549876009909;5635.830925072254;5637.577181711388;5637.7181140942785;1399.6920677450944;1422.9612382960497;1427.835798883121;1428.0218050635349;1428.4357678717056;923.9260859131253;933.7478880702308;950.1163917556601;960.8318544254728;961.2790407194605;4743.312219728189;4829.5653391194965;4833.540813622701;4868.367112275381;4933.901321973541;5854;5877.5591830612875;5882.941170588325;5889.352171261158;5894.056950887837;4940.308356830046;4945.480724523945;4950.356453661001;4950.529699678525;4953.529414705597;3113.081640915935;3155.2111972006996;3155.826429546397;3155.921101972469;3159.273367125574;5525.613207075547;5526.088195447786;5527.281453411031;5528.944710552843;5529.751161197756;5884.6469211847425;5954.196183515257;5954.37479064692;5997.310309314397;6113.908291375633;5527.39198688152;5547.639403438763;5551.583631227755;5553.639013464192;5556.444355564492;5868.3251426086545;5877.911831322448;5878.882422351615;5882.852928676817;5897.882042359043;5742.569307301886;5787.36339002701;5792.594518383673;5796.59423840344;5799.623024503394;5530.557555395479;5538.861528461821;5545.279113715353;5550.4449555044175;5550.722463876871;3860.3823388257742;3963.56400795918;3983.7609743415487;4022.456968309241;4031.415444760552;5733.8566535836935;5745.482906538432;5748.655080695172;5754.05058165398;5763.625364351304;5567.972160139173;5588.6646801192055;5594.720263986866;5605.859853503532;5606.551475881838;5558.277423934863;5563.944360556343;5568.16477528374;5569.777208911598;5571.3592936811165;5516.806911758069;5523.116301391919;5530.695811730394;5536.695481748381;5542.725173210104;5466.83226897989;5564.276644036249;5632.802851900164;5643.661380317194;5647.802326918538;5467.17992301158;5491.478309560585;5494.560435165257;5496.148097044965;5496.285482887199 08:47:51 INFO - PROCESS | 20430 | |5;yui.html;684.6097724297151;705.6013352455863;706.4489698035534;723.8479919216965;773.8684423647986;12216.083793715474;12415.56545520907;12452.937735311321;12472.750544989107;12500.062495312864;11808.940955295211;11842.407879606028;11855.22941008836;11879.28724276544;11886.167968242227;629.2574761781119;782.5617654113714;792.132614786809;810.5339429827843;813.0081300812999;816.1226681317578;819.0253598218131;820.3150369441523;820.3683163963744;821.3757544266371;847.8558645030329;853.2235665544356;853.3855623950745;853.90180129285;854.2525290370926;661.4476911778646;837.6440012994453;847.9745607631781;848.8726690996339;856.208007592974;624.8063100438833;625.4902254662436;625.543353352051;625.871696302257;625.9687015649199;11936.940315298454;11953.521859125625;11981.820272695917;12030.759384812254;12042.458089385998;11782.057435405148;12559.372031398394;12578.308193049379;12680.429380677891;12935.611931642066;9783.217342612574;9834.213262938947;9994.650187243411;10116.291859569834;10240.129588984944;3240.303334783009;3256.7068963793135;3273.738100951918;3361.8151001694896;3372.426687463137;43569.56430435718;43653.345199822026;43730.78134609338;43819.342709859375;44351.77824110859;9975.850362244571;10036.849447258297;10201.489925503844;10224.13094886928;10432.634857780093;17985.550361241072;18017.459476215736;18018.639627207383;18020.459386218434;18056.18747156381;6445.1943507061615;6580.670966451658;6590.3080176581725;6670;6715.56348837324;3753.399456087013;3839;3841.654251117413;3889.5138107736534;3906.7655940643654;2787.567926971323;2796.1751283371455;2822.618946442204;2826.081523504869;2826.4488424756973;462.6391414696542;490.1300192158875;490.7276461563795;497.6591035140868;498.40191769876293;541.5586297167796;614.913912052313;619.4332186049714;628.2272804450552;645.4965127200791;7315.30504602062;7662.808809321915;7936.4841285317425;8018.198180181935;8098.878516822252;624.950003999679;631.8072987738784;632.3234139470723;646.1309538670481;656.9770058047945;3498.265364273531;3700.740948133605;3719.256148770257;3749.5875453700073;3775.3581891078584;48650.756746216044;48657.27014094791;48747.512524875005;48946;49316.50683493191;44827.551724482335;45089.32366014512;45407.31889021667;45619;45674.54325456703;41169;43212;43985.56014439814;45463.318050229274;46452.767736161106;8008.1191068983535;8270.090290068209;8387.580620969049;8500.787480313042;8589.226969572768;30744.84627576848;30927.69072309248;31495;32123.51814722828;32196.35607287888;40360.1927961445;40562;40968.38547421851;41865;42203.57796422119;10155.136813370946;10175.86253188357;10208.540615672164;10409.219308551737;10501;11287.492062857027;11465.713357166138;11486.310821350746;11552.480138393961;11646.184767066225;10500.527476263434;10574.154067674413;10795.596572445531;10854.023137917626;10888;10067.798644026932;10330;10399.27205095636;10692.518836652525;10778.245522813328;10357.948210259203;10366.222533310183;10418.635347762793;10536.209784266057;10908.072813810915;9301;9421.528923553931;9479.19426848698;9530.95234523823;9726.319157658896;9263.073692630684;9331.86002209981;9332.953335233551;9414.764630884009;9420.152186303265 08:47:51 INFO - PROCESS | 20430 | __end_tp_report 08:47:51 INFO - PROCESS | 20430 | __start_cc_report 08:47:51 INFO - PROCESS | 20430 | _x_x_mozilla_cycle_collect,1072 08:47:51 INFO - PROCESS | 20430 | __end_cc_report 08:47:51 INFO - PROCESS | 20430 | __startTimestamp1459871271389__endTimestamp 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | ------- Summary: start ------- 08:47:51 INFO - PROCESS | 20430 | Number of tests: 6 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | [#0] dojo.html Cycles:165 Average:4573.44 Median:4713.00 stddev:467.99 (9.9%) stddev-sans-first:443.20 08:47:51 INFO - PROCESS | 20430 | Values: 2604.4 2659.6 2671.6 2676.8 2693.9 4530.0 4586.6 4617.6 4619.7 4628.3 4602.7 4624.2 4656.0 4690.5 4695.7 4237.9 4240.4 4271.1 4307.2 4377.5 4324.7 4346.1 4348.2 4381.0 4395.8 4169.5 4208.6 4252.8 4270.3 4282.8 4251.0 4254.0 4259.7 4289.6 4311.0 4221.9 4236.4 4237.6 4251.4 4280.2 4412.2 4493.1 4505.9 4549.9 4594.5 4914.0 4919.5 4919.7 4926.8 4930.0 4933.9 4940.9 4941.6 4944.7 4989.4 4569.3 4579.0 4657.9 4671.8 4675.7 5046.1 5052.4 5054.2 5068.3 5104.4 4852.9 4862.9 4863.5 4868.3 4885.0 4871.6 4875.9 4939.0 4944.0 4970.8 4912.9 4915.6 4925.3 4932.0 4995.0 4776.7 4928.5 4930.1 4937.1 4979.5 4133.3 4134.6 4138.0 4215.9 4224.9 3620.3 3633.7 3639.0 3672.0 3676.3 4242.2 4243.6 4243.8 4250.0 4288.1 4849.2 4938.8 4996.1 5040.1 5040.5 4254.5 4263.3 4270.5 4273.3 4301.7 4366.7 4401.2 4442.2 4446.3 4469.8 4649.1 4713.0 4720.7 4750.4 4752.0 4911.6 4933.2 4933.3 4952.4 4961.8 4578.8 4620.6 4681.3 4685.5 4733.8 4868.7 4899.2 4905.6 4907.8 4943.3 4946.9 4962.8 4965.3 4966.2 5017.9 4688.4 4784.5 4815.6 4854.8 4872.5 4788.4 4796.3 4800.2 4828.9 4858.1 4751.3 4751.8 4756.6 4758.6 4763.2 4716.5 4767.2 4817.2 4820.4 4901.9 4670.2 4777.5 4822.5 4826.0 4831.7 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | [#1] ext.html Cycles:180 Average:38264.70 Median:34050.66 stddev:58518.10 (171.9%) stddev-sans-first:58613.62 08:47:51 INFO - PROCESS | 20430 | Values: 517.6 527.2 535.8 540.1 546.5 27751.9 35219.5 35693.8 35743.6 35954.8 38781.6 39057.4 39180.8 39186.6 39252.2 7609.2 7778.4 7783.7 7785.0 7791.5 7673.3 7785.0 7797.6 7803.1 7985.4 7959.9 8025.5 8033.8 8042.4 8046.1 7942.5 7993.0 8014.1 8022.4 8024.9 7882.9 7924.2 7987.2 8016.5 8018.8 39246.6 39690.8 39725.8 39800.0 39824.0 3076.5 3188.6 3204.4 3224.9 3280.6 29692.9 29719.7 29804.3 30295.1 30640.4 3355.6 3500.1 3536.8 3554.8 3664.3 180805.0 181280.1 182588.0 182613.0 182759.0 47594.5 54715.5 54796.0 55227.7 55671.4 52189.0 52555.2 52568.5 52571.5 52650.0 14811.4 15094.3 15109.7 15109.9 15132.7 9426.0 11268.1 11342.5 11726.6 11954.3 18369.7 18381.8 18382.9 18389.3 18451.7 6342.7 6708.4 6800.9 6909.4 6934.3 905.1 910.9 913.7 934.7 980.8 26888.3 27176.7 27704.6 27773.9 27782.0 998.5 1007.3 1022.2 1094.0 1119.1 14152.3 14432.6 14466.6 14483.9 14789.7 295096.0 299207.0 299320.0 299636.0 299862.0 47651.3 49168.3 49190.0 49206.3 49217.0 1059.8 1237.7 1257.0 1270.3 1322.9 24697.6 25142.2 25166.7 25190.4 25281.2 35444.3 35701.8 35726.8 35731.8 35764.8 167830.0 168229.0 168513.0 168775.0 168926.0 29412.9 30974.8 31351.7 31394.7 31421.7 39166.8 39700.0 39951.4 40172.8 40574.8 33898.1 33921.7 34076.0 34101.1 34584.5 33764.3 33960.0 33988.0 34001.8 34025.3 33004.2 33802.8 33849.2 33984.8 34182.7 28131.7 29950.9 30023.4 30052.0 30053.0 23789.4 24296.3 24313.4 24318.0 24620.1 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | [#2] jquery.html Cycles:180 Average:21807.73 Median:24465.85 stddev:55377.64 (226.3%) stddev-sans-first:55509.52 08:47:51 INFO - PROCESS | 20430 | Values: 339.5 347.7 356.9 361.0 361.6 15274.8 16013.4 16549.0 17105.4 17110.7 10207.2 10569.6 13382.5 16738.4 16741.0 4623.2 4799.1 4799.7 4806.5 4814.6 3331.1 3402.3 5214.6 5423.9 5434.2 5398.1 5412.9 5419.4 5435.5 5435.6 5276.4 5331.8 5386.8 5410.6 5457.3 5231.2 5240.9 5242.9 5246.1 5257.1 11972.3 15202.5 19947.9 19970.6 19972.9 1910.0 2014.7 2220.9 2303.9 2392.9 9576.3 9578.9 9650.9 11257.4 13041.5 1729.1 1775.7 1782.8 1814.9 1842.7 44658.6 46855.6 54404.7 64623.0 64737.0 9289.5 9804.8 9889.9 9954.3 10004.2 13416.6 13522.3 13615.9 13616.7 13624.3 7260.9 7464.9 7504.4 7557.1 7591.5 7143.9 7253.8 7313.0 7316.3 7354.0 4250.7 4299.0 4334.2 4411.5 4413.1 1606.6 1632.6 1682.1 1694.2 1700.8 850.8 876.6 898.9 909.0 929.7 15901.4 16380.5 16502.5 16518.8 16580.3 852.3 859.9 876.2 877.3 882.1 9255.8 9292.6 9300.0 9403.8 9425.2 254599.0 260799.0 371477.0 377542.0 381091.0 77675.0 78126.6 78305.6 78633.6 79199.6 893.3 960.7 978.6 1003.6 1013.3 14990.6 15018.0 15238.0 15345.4 15421.8 32627.2 33423.0 34388.7 35726.0 37915.8 44518.6 45126.0 45207.3 45347.8 45598.5 7561.6 7593.6 7767.5 7854.1 7858.0 8807.6 11549.0 11765.5 11846.3 11977.0 9829.7 9929.1 9994.4 10102.7 10201.7 10035.8 10323.8 10495.8 10656.4 10676.8 9184.8 10194.8 10220.7 10236.4 10518.8 7416.9 7633.1 7677.7 7678.5 7734.0 9613.3 10043.7 10191.5 10191.9 10413.5 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | [#3] mootools.html Cycles:180 Average:5075.48 Median:6247.14 stddev:2554.90 (40.9%) stddev-sans-first:2546.90 08:47:51 INFO - PROCESS | 20430 | Values: 1372.7 1422.5 1547.8 1700.8 1766.2 7101.0 7236.5 7295.7 7298.5 7335.4 6180.5 6299.5 6313.0 6317.5 7228.0 1919.0 2136.2 2181.2 2190.1 2199.2 2144.0 2182.6 2185.7 2190.1 2193.9 1881.0 2142.2 2150.6 2151.3 2157.6 2134.4 2192.2 2192.5 2193.4 2194.3 2099.5 2123.4 2132.5 2155.5 2183.6 7181.6 7186.2 7217.9 7224.2 7240.1 4342.6 4484.2 4484.6 4486.4 4537.4 2839.5 2863.9 2970.3 2977.6 2985.4 935.3 945.3 961.7 964.3 975.0 9627.0 9643.2 9648.2 9650.5 9663.3 3929.4 4082.5 4130.8 4149.1 4152.9 8281.9 8343.4 8376.0 8377.2 8377.4 4503.0 4525.9 4549.3 4549.4 4554.4 4145.2 4147.6 4147.7 4152.9 4153.1 3135.9 3456.3 3519.5 3519.6 3527.3 1138.4 1174.4 1176.5 1182.5 1189.0 1197.2 1201.2 1204.0 1213.3 1227.6 6689.5 6853.6 6884.3 6885.5 7015.5 1040.6 1046.3 1068.8 1072.9 1083.4 5405.9 5465.2 5473.3 5506.8 5507.1 8447.9 8550.7 8650.8 8741.0 8748.0 8512.8 8532.4 8538.0 8619.0 8641.7 6690.9 6777.7 6825.6 6837.1 6896.6 6500.4 6501.1 6536.5 6565.1 6577.8 7563.7 7670.0 7829.1 7922.4 7938.0 7851.3 7956.8 8076.5 8091.8 8095.6 6342.1 6374.6 6392.2 6401.1 6412.8 6817.5 7000.2 7000.8 7003.1 7014.3 6197.0 6280.5 6286.6 6343.8 6393.4 6134.1 6182.5 6231.6 6329.1 6384.1 6464.2 6503.8 6510.3 6516.1 6652.9 6180.6 6256.9 6257.8 6265.8 6267.4 5981.4 6152.5 6158.4 6225.4 6237.4 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | [#4] prototype.html Cycles:180 Average:4650.29 Median:5317.72 stddev:1372.45 (25.8%) stddev-sans-first:1337.08 08:47:51 INFO - PROCESS | 20430 | Values: 310.2 312.7 315.3 315.7 318.2 5276.4 5291.3 5379.3 5387.8 5389.3 5294.0 5296.4 5315.3 5317.5 5317.9 3933.6 4026.0 4125.9 4133.4 4133.4 4113.4 4116.1 4125.0 4131.5 4135.7 4084.2 4088.5 4089.1 4094.2 4102.9 3924.6 4004.4 4029.4 4041.2 4098.6 3540.8 3633.9 3637.1 3640.7 3642.9 5121.2 5122.5 5130.0 5135.8 5138.7 4753.8 4759.3 4761.3 4768.9 4778.1 5589.5 5593.8 5595.5 5596.9 5601.3 4004.4 4005.0 4006.3 4009.5 4009.6 5591.6 5758.8 5786.4 5792.3 5860.1 3955.4 3971.3 3987.8 3994.3 4001.0 4042.8 4046.8 4047.1 4048.7 4056.6 4647.6 4651.1 4658.1 4674.1 4677.9 5623.7 5626.5 5635.8 5637.6 5637.7 1399.7 1423.0 1427.8 1428.0 1428.4 923.9 933.7 950.1 960.8 961.3 4743.3 4829.6 4833.5 4868.4 4933.9 5854.0 5877.6 5882.9 5889.4 5894.1 4940.3 4945.5 4950.4 4950.5 4953.5 3113.1 3155.2 3155.8 3155.9 3159.3 5525.6 5526.1 5527.3 5528.9 5529.8 5884.6 5954.2 5954.4 5997.3 6113.9 5527.4 5547.6 5551.6 5553.6 5556.4 5868.3 5877.9 5878.9 5882.9 5897.9 5742.6 5787.4 5792.6 5796.6 5799.6 5530.6 5538.9 5545.3 5550.4 5550.7 3860.4 3963.6 3983.8 4022.5 4031.4 5733.9 5745.5 5748.7 5754.1 5763.6 5568.0 5588.7 5594.7 5605.9 5606.6 5558.3 5563.9 5568.2 5569.8 5571.4 5516.8 5523.1 5530.7 5536.7 5542.7 5466.8 5564.3 5632.8 5643.7 5647.8 5467.2 5491.5 5494.6 5496.1 5496.3 08:47:51 INFO - PROCESS | 20430 | 08:47:51 INFO - PROCESS | 20430 | [#5] yui.html Cycles:180 Average:12687.69 Median:43775.06 stddev:14281.01 (32.6%) stddev-sans-first:14292.63 08:47:51 INFO - PROCESS | 20430 | Values: 684.6 705.6 706.4 723.8 773.9 12216.1 12415.6 12452.9 12472.8 12500.1 11808.9 11842.4 11855.2 11879.3 11886.2 629.3 782.6 792.1 810.5 813.0 816.1 819.0 820.3 820.4 821.4 847.9 853.2 853.4 853.9 854.3 661.4 837.6 848.0 848.9 856.2 624.8 625.5 625.5 625.9 626.0 11936.9 11953.5 11981.8 12030.8 12042.5 11782.1 12559.4 12578.3 12680.4 12935.6 9783.2 9834.2 9994.7 10116.3 10240.1 3240.3 3256.7 3273.7 3361.8 3372.4 43569.6 43653.3 43730.8 43819.3 44351.8 9975.9 10036.8 10201.5 10224.1 10432.6 17985.6 18017.5 18018.6 18020.5 18056.2 6445.2 6580.7 6590.3 6670.0 6715.6 3753.4 3839.0 3841.7 3889.5 3906.8 2787.6 2796.2 2822.6 2826.1 2826.4 462.6 490.1 490.7 497.7 498.4 541.6 614.9 619.4 628.2 645.5 7315.3 7662.8 7936.5 8018.2 8098.9 625.0 631.8 632.3 646.1 657.0 3498.3 3700.7 3719.3 3749.6 3775.4 48650.8 48657.3 48747.5 48946.0 49316.5 44827.6 45089.3 45407.3 45619.0 45674.5 41169.0 43212.0 43985.6 45463.3 46452.8 8008.1 8270.1 8387.6 8500.8 8589.2 30744.8 30927.7 31495.0 32123.5 32196.4 40360.2 40562.0 40968.4 41865.0 42203.6 10155.1 10175.9 10208.5 10409.2 10501.0 11287.5 11465.7 11486.3 11552.5 11646.2 10500.5 10574.2 10795.6 10854.0 10888.0 10067.8 10330.0 10399.3 10692.5 10778.2 10357.9 10366.2 10418.6 10536.2 10908.1 9301.0 9421.5 9479.2 9531.0 9726.3 9263.1 9331.9 9333.0 9414.8 9420.2 08:47:51 INFO - PROCESS | 20430 | -------- Summary: end -------- 08:47:51 INFO - PROCESS | 20430 | 08:47:52 INFO - TEST-INFO | 20430: exit 0 08:47:52 INFO - TEST-OK | dromaeo_css | took 1116270ms 08:47:52 INFO - TEST-START | kraken 08:47:52 INFO - operating with platform_type : linux_ 08:47:52 INFO - Initialising browser for kraken test... 08:47:52 INFO - TEST-INFO | started process 20609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGwc3Iz/profile http://localhost:47812/getInfo.html) 08:47:56 INFO - PROCESS | 20609 | __metrics Screen width/height:1600/1200 08:47:56 INFO - PROCESS | 20609 | colorDepth:24 08:47:56 INFO - PROCESS | 20609 | Browser inner width/height: 1024/697 08:47:56 INFO - PROCESS | 20609 | __metrics 08:47:57 ERROR - PROCESS | 20609 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:47:58 INFO - TEST-INFO | 20609: exit 0 08:47:58 INFO - Browser initialized. 08:47:58 INFO - Running cycle 1/1 for kraken test... 08:47:58 INFO - TEST-INFO | started process 20692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGwc3Iz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:10 INFO - PROCESS | 20692 | RSS: Main: 154099712 08:48:10 INFO - PROCESS | 20692 | 08:48:12 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47812/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:13 INFO - PROCESS | 20692 | RSS: Main: 194015232 08:48:13 INFO - PROCESS | 20692 | 08:48:16 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47812/tests/kraken/driver.html?testName=audio-dft) 08:48:16 INFO - PROCESS | 20692 | RSS: Main: 184463360 08:48:16 INFO - PROCESS | 20692 | 08:48:19 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47812/tests/kraken/driver.html?testName=audio-fft) 08:48:20 INFO - PROCESS | 20692 | RSS: Main: 168845312 08:48:20 INFO - PROCESS | 20692 | 08:48:22 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47812/tests/kraken/driver.html?testName=audio-oscillator) 08:48:23 INFO - PROCESS | 20692 | RSS: Main: 171388928 08:48:23 INFO - PROCESS | 20692 | 08:48:25 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:25 INFO - PROCESS | 20692 | RSS: Main: 172843008 08:48:25 INFO - PROCESS | 20692 | 08:48:29 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47812/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:29 INFO - PROCESS | 20692 | RSS: Main: 173608960 08:48:29 INFO - PROCESS | 20692 | 08:48:33 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47812/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:33 INFO - PROCESS | 20692 | RSS: Main: 173416448 08:48:33 INFO - PROCESS | 20692 | 08:48:36 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47812/tests/kraken/driver.html?testName=json-parse-financial) 08:48:37 INFO - PROCESS | 20692 | RSS: Main: 174358528 08:48:37 INFO - PROCESS | 20692 | 08:48:38 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:39 INFO - PROCESS | 20692 | RSS: Main: 183238656 08:48:39 INFO - PROCESS | 20692 | 08:48:41 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:41 INFO - PROCESS | 20692 | RSS: Main: 180961280 08:48:41 INFO - PROCESS | 20692 | 08:48:43 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:44 INFO - PROCESS | 20692 | RSS: Main: 191369216 08:48:44 INFO - PROCESS | 20692 | 08:48:47 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:47 INFO - PROCESS | 20692 | RSS: Main: 198021120 08:48:47 INFO - PROCESS | 20692 | 08:48:50 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:50 INFO - PROCESS | 20692 | RSS: Main: 197685248 08:48:50 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | Cycle 1(1): loaded http://localhost:47812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47812/tests/kraken/driver.html?testName=ai-astar) 08:48:52 INFO - PROCESS | 20692 | RSS: Main: 260091904 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | __start_tp_report 08:48:52 INFO - PROCESS | 20692 | _x_x_mozilla_page_load 08:48:52 INFO - PROCESS | 20692 | _x_x_mozilla_page_load_details 08:48:52 INFO - PROCESS | 20692 | |i|pagename|runs| 08:48:52 INFO - PROCESS | 20692 | |0;ai-astar;111;112;108;111;112;112;101;112;112;112 08:48:52 INFO - PROCESS | 20692 | |1;audio-beat-detection;179;132;161;179;134;158;162;138;185;133 08:48:52 INFO - PROCESS | 20692 | |2;audio-dft;159;160;160;164;161;162;162;162;161;162 08:48:52 INFO - PROCESS | 20692 | |3;audio-fft;74;74;112;99;74;74;73;130;94;77 08:48:52 INFO - PROCESS | 20692 | |4;audio-oscillator;94;94;136;94;94;93;136;95;94;144 08:48:52 INFO - PROCESS | 20692 | |5;imaging-gaussian-blur;117;117;117;116;116;116;116;117;116;116 08:48:52 INFO - PROCESS | 20692 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;146 08:48:52 INFO - PROCESS | 20692 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 08:48:52 INFO - PROCESS | 20692 | |8;json-parse-financial;65;64;67;66;65;65;66;75;64;64 08:48:52 INFO - PROCESS | 20692 | |9;json-stringify-tinderbox;65;63;64;63;64;64;66;64;65;64 08:48:52 INFO - PROCESS | 20692 | |10;stanford-crypto-aes;81;81;81;82;93;90;89;84;82;82 08:48:52 INFO - PROCESS | 20692 | |11;stanford-crypto-ccm;121;123;115;117;117;117;118;117;123;118 08:48:52 INFO - PROCESS | 20692 | |12;stanford-crypto-pbkdf2;142;130;141;139;149;130;143;141;145;154 08:48:52 INFO - PROCESS | 20692 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;67;68;67;67;67 08:48:52 INFO - PROCESS | 20692 | __end_tp_report 08:48:52 INFO - PROCESS | 20692 | __start_cc_report 08:48:52 INFO - PROCESS | 20692 | _x_x_mozilla_cycle_collect,1221 08:48:52 INFO - PROCESS | 20692 | __end_cc_report 08:48:52 INFO - PROCESS | 20692 | __startTimestamp1459871332774__endTimestamp 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | ------- Summary: start ------- 08:48:52 INFO - PROCESS | 20692 | Number of tests: 14 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:3.70 08:48:52 INFO - PROCESS | 20692 | Values: 111.0 112.0 108.0 111.0 112.0 112.0 101.0 112.0 112.0 112.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:161.50 stddev:20.75 (12.9%) stddev-sans-first:20.29 08:48:52 INFO - PROCESS | 20692 | Values: 179.0 132.0 161.0 179.0 134.0 158.0 162.0 138.0 185.0 133.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.24 08:48:52 INFO - PROCESS | 20692 | Values: 159.0 160.0 160.0 164.0 161.0 162.0 162.0 162.0 161.0 162.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#3] audio-fft Cycles:10 Average:88.10 Median:74.00 stddev:20.07 (27.1%) stddev-sans-first:20.63 08:48:52 INFO - PROCESS | 20692 | Values: 74.0 74.0 112.0 99.0 74.0 74.0 73.0 130.0 94.0 77.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.69 (23.1%) stddev-sans-first:22.46 08:48:52 INFO - PROCESS | 20692 | Values: 94.0 94.0 136.0 94.0 94.0 93.0 136.0 95.0 94.0 144.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:48:52 INFO - PROCESS | 20692 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 116.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:48:52 INFO - PROCESS | 20692 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:48:52 INFO - PROCESS | 20692 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.50 stddev:3.28 (5.0%) stddev-sans-first:3.46 08:48:52 INFO - PROCESS | 20692 | Values: 65.0 64.0 67.0 66.0 65.0 65.0 66.0 75.0 64.0 64.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 08:48:52 INFO - PROCESS | 20692 | Values: 65.0 63.0 64.0 63.0 64.0 64.0 66.0 64.0 65.0 64.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:4.45 (5.4%) stddev-sans-first:4.54 08:48:52 INFO - PROCESS | 20692 | Values: 81.0 81.0 81.0 82.0 93.0 90.0 89.0 84.0 82.0 82.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.00 stddev:2.76 (2.3%) stddev-sans-first:2.78 08:48:52 INFO - PROCESS | 20692 | Values: 121.0 123.0 115.0 117.0 117.0 117.0 118.0 117.0 123.0 118.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:142.50 stddev:7.44 (5.2%) stddev-sans-first:7.89 08:48:52 INFO - PROCESS | 20692 | Values: 142.0 130.0 141.0 139.0 149.0 130.0 143.0 141.0 145.0 154.0 08:48:52 INFO - PROCESS | 20692 | 08:48:52 INFO - PROCESS | 20692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 08:48:52 INFO - PROCESS | 20692 | Values: 66.0 66.0 68.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 08:48:52 INFO - PROCESS | 20692 | -------- Summary: end -------- 08:48:52 INFO - PROCESS | 20692 | 08:48:53 INFO - TEST-INFO | 20692: exit 0 08:48:53 INFO - TEST-OK | kraken | took 61522ms 08:48:53 INFO - SUITE-END | took 1177s 08:48:53 INFO - Completed test suite (00:19:38) 08:48:53 INFO - javascript benchmark 08:48:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2604.3749500119975, 2659.5877638965953, 2671.5992601109833, 2676.826006309591, 2693.9326516837077, 4529.977350113253, 4586.633069354452, 4617.607503362218, 4619.653525985552, 4628.328892310613, 4602.746848923308, 4624.237000894848, 4656.045510670313, 4690.460597031342, 4695.67130300879, 4237.87286381409, 4240.406343111967, 4271.081717430752, 4307.246231909403, 4377.4528183977, 4324.675649326313, 4346.130773845243, 4348.173846969065, 4381.0, 4395.758233297167, 4169.499660040784, 4208.642265407444, 4252.787360631987, 4270.252705776476, 4282.807273672693, 4251.043515209053, 4254.0, 4259.70182087254, 4289.6139347458875, 4310.978445107786, 4221.915561688749, 4236.449261596003, 4237.618614324695, 4251.3622956556455, 4280.1653677532895, 4412.161689279027, 4493.078918821634, 4505.868421447096, 4549.886252843672, 4594.494605593382, 4913.975430122862, 4919.483454237289, 4919.680220785637, 4926.827561035382, 4929.975350123226, 4933.876653083666, 4940.851774446773, 4941.629377796679, 4944.728039957801, 4989.401271847401, 4569.337446070301, 4578.9771051144535, 4657.906841863144, 4671.813127474931, 4675.719456832601, 5046.142155833517, 5052.444231134572, 5054.191329387354, 5068.290439338495, 5104.438511763703, 4852.902941941142, 4862.902741945141, 4863.489333619989, 4868.269759536098, 4884.975575122173, 4871.585915197177, 4875.926861097087, 4939.0, 4944.0, 4970.751462426864, 4912.852614421573, 4915.631327650441, 4925.285833554115, 4932.0135972804865, 4994.9500504994485, 4776.665633405698, 4928.507149285043, 4930.063287975345, 4937.136001199848, 4979.477154898684, 4133.256013917464, 4134.586541345841, 4137.97931010343, 4215.894602634959, 4224.91550169001, 3620.330238905758, 3633.6729694327637, 3639.0, 3672.0, 3676.3198808220563, 4242.151569686075, 4243.554426785205, 4243.809028593659, 4249.97875010623, 4288.09949910516, 4849.199882019428, 4938.753062346868, 4996.125678006334, 5040.1179793535985, 5040.546350828443, 4254.489461264606, 4263.275243208662, 4270.466191726035, 4273.273543497613, 4301.741895486281, 4366.71616344943, 4401.185780630593, 4442.2458075992445, 4446.3330500424545, 4469.843555475608, 4649.139909116824, 4713.0, 4720.669553131385, 4750.429948406213, 4752.049590082067, 4911.557959783637, 4933.235348520985, 4933.309336692938, 4952.356193694796, 4961.776720047535, 4578.793954272132, 4620.6303495719585, 4681.321208424827, 4685.4845966944295, 4733.840209148781, 4868.732219727949, 4899.16714158601, 4905.632077594123, 4907.754612269444, 4943.283223932582, 4946.897847506344, 4962.776675049559, 4965.30485732005, 4966.230234313687, 5017.874553136055, 4688.367070445583, 4784.497627749036, 4815.6388270880525, 4854.78153483087, 4872.4640289567415, 4788.353572267699, 4796.25658023007, 4800.231962885921, 4828.855134345975, 4858.076965376567, 4751.311059896365, 4751.83368582098, 4756.643251756202, 4758.595519380891, 4763.190257656138, 4716.457607375059, 4767.213409787346, 4817.156997525489, 4820.421549414093, 4901.852944411673, 4670.206064969031, 4777.522247775195, 4822.493638167942, 4825.95174048255, 4831.710097394168], "unit": "score", "name": "dojo.html", "value": 4544.628206596508}, {"lowerIsBetter": false, "replicates": [517.5730022731248, 527.2223470381188, 535.7642637239617, 540.0980362794133, 546.4835730234928, 27751.861240693794, 35219.4717079244, 35693.821530892375, 35743.64256357436, 35954.8202258989, 38781.612183878155, 39057.41413878794, 39180.804095979554, 39186.60813391865, 39252.21495570087, 7609.201033891431, 7778.4166187535875, 7783.688652453895, 7784.961075194616, 7791.4935529190425, 7673.309402153805, 7784.961075194645, 7797.610119494031, 7803.10264319602, 7985.441019128663, 7959.880601790977, 8025.478343907627, 8033.839323213532, 8042.3566114710975, 8046.114927357986, 7942.483738556975, 7993.0, 8014.078380986145, 8022.3983201260135, 8024.9197508025045, 7882.881756773653, 7924.167962363984, 7987.241212084843, 8016.478928869605, 8018.839623207503, 39246.60753392458, 39690.80154599238, 39725.80137099296, 39800.0, 39824.00439988994, 3076.5385192221124, 3188.5536024956523, 3204.375146846366, 3224.9355012899846, 3280.6063272407464, 29692.8515357424, 29719.70280297191, 29804.254893627614, 30295.091147265397, 30640.38719225603, 3355.5973283205926, 3500.1074725944723, 3536.7877927324444, 3554.751167418282, 3664.3404187246283, 180805.0, 181280.09359953247, 182588.0, 182613.0, 182759.0, 47594.5240547597, 54715.45284547104, 54796.0, 55227.72386138044, 55671.443285566624, 52188.95622087537, 52555.21167182495, 52568.474315257125, 52571.474285256656, 52650.0, 14811.407543698131, 15094.320755566026, 15109.697806043818, 15109.924450377677, 15132.697346053237, 9426.0, 11268.09855211581, 11342.546298148147, 11726.648200553826, 11954.282743035446, 18369.7244541332, 18381.81618183801, 18382.908085459756, 18389.264429422674, 18451.723224151647, 6342.682865856688, 6708.362705542965, 6800.863982720318, 6909.447244220451, 6934.271901450376, 905.1220316293185, 910.9134632210062, 913.6573784830689, 934.7149119518476, 980.8087422952456, 26888.32779180497, 27176.728232717815, 27704.584431233143, 27773.86113069422, 27782.0, 998.5321577281385, 1007.2848277722899, 1022.2333250062453, 1094.0481780850712, 1119.0767616716241, 14152.29238538069, 14432.639184020274, 14466.566003019927, 14483.855161448251, 14789.704205915821, 295096.0, 299207.0, 299320.0, 299636.0, 299862.0, 47651.285230721565, 49168.26247606289, 49190.0, 49206.261906071435, 49217.0, 1059.7880423915094, 1237.6843904804218, 1256.9748605027848, 1270.2568997136593, 1322.8677132286693, 24697.62953555662, 25142.24573262805, 25166.74833251644, 25190.370240744127, 25281.241562753148, 35444.29111417705, 35701.82149089238, 35726.821365894044, 35731.821340893126, 35764.821175895, 167830.0, 168229.0, 168513.0, 168775.0, 168926.0, 29412.852935736042, 30974.84512577513, 31351.686483134876, 31394.68605314009, 31421.685783141875, 39166.80416597899, 39700.0, 39951.40072898967, 40172.799136004134, 40574.79712601418, 33898.136990920415, 33921.66078339185, 34076.0, 34101.147471313416, 34584.48123278203, 33764.3247135051, 33960.0, 33988.0, 34001.82999085088, 34025.319493610485, 33004.1748956278, 33802.830985845896, 33849.15377115592, 33984.830075849466, 34182.65817341795, 28131.718682813727, 29950.855160207866, 30023.3995320088, 30052.0, 30053.0, 23789.405264868517, 24296.271111866674, 24313.418721747854, 24318.0, 24620.1382951603], "unit": "score", "name": "ext.html", "value": 16744.17560030324}, {"lowerIsBetter": false, "replicates": [339.54161881460027, 347.671450479297, 356.93039857227853, 360.9981950090249, 361.59862552566665, 15274.84725152748, 16013.359465621375, 16549.0, 17105.40131095412, 17110.657786844255, 10207.234457415687, 10569.577216911315, 13382.531611393579, 16738.41415550456, 16741.0, 4623.167829790645, 4799.064182484417, 4799.712017278975, 4806.495317991613, 4814.566688997989, 3331.133905184657, 3402.319536092779, 5214.556762675158, 5423.945760542383, 5434.184872269152, 5398.13629819229, 5412.91880621791, 5419.430959749228, 5435.483629055253, 5435.646682965615, 5276.445973172838, 5331.760070796823, 5386.811461598845, 5410.594205434589, 5457.263269458612, 5231.189165679326, 5240.9213861792105, 5242.895142097175, 5246.134387826004, 5257.053730328539, 11972.341521216329, 15202.543923682197, 19947.90026049875, 19970.60058798816, 19972.90013549923, 1909.9713504297447, 2014.7280117184139, 2220.877851718155, 2303.9424014399606, 2392.9401764956015, 9576.277489896569, 9578.904210957871, 9650.855237171449, 11257.380844053656, 13041.478340866353, 1729.144073683522, 1775.7070083436217, 1782.8484578810817, 1814.8820326678856, 1842.6959551674092, 44658.553414465765, 46855.604576385325, 54404.72797635986, 64623.0, 64737.0, 9289.489078100634, 9804.803903922024, 9889.851652225223, 9954.253430992705, 10004.249681273934, 13416.597502074954, 13522.256275904723, 13615.863841361657, 13616.65958351049, 13624.318784060757, 7260.854782904313, 7464.888026679604, 7504.399648028145, 7557.093148822067, 7591.4685971982535, 7143.9285607143265, 7253.782386528413, 7313.049303590499, 7316.268373162641, 7354.043974283309, 4250.681198910094, 4298.957010429918, 4334.21984042869, 4411.492678341968, 4413.1394378095965, 1606.598350412397, 1632.5755303620906, 1682.142107525171, 1694.1529235382309, 1700.761893334934, 850.8340873529602, 876.6361959786617, 898.8921329440378, 909.0273407454093, 929.6513807322254, 15901.443449479213, 16380.508584742476, 16502.504924852274, 16518.75221871673, 16580.253888575044, 852.3011130872625, 859.866720658299, 876.2114097312469, 877.3376101043672, 882.1046637662778, 9255.76860578491, 9292.628294868266, 9299.95350023259, 9403.811923761486, 9425.212768612684, 254599.0, 260799.0, 371477.0, 377542.0, 381091.0, 77675.0, 78126.6093669528, 78305.60847195728, 78633.60683196547, 79199.60400197962, 893.3121496447699, 960.7309953213112, 978.5987745024506, 1003.6186249225248, 1013.2521400583934, 14990.625234368792, 15018.023828451553, 15238.0, 15345.386184552493, 15421.84578154204, 32627.18432039218, 33423.0, 34388.65611343855, 35726.0, 37915.81042094772, 44518.554814452735, 45126.0, 45207.32189017233, 45347.773261134804, 45598.54401455943, 7561.621918903923, 7593.5823529706395, 7767.456278060482, 7854.1360450349275, 7857.960710196412, 8807.64769409242, 11549.0, 11765.47055382527, 11846.348450835287, 11977.041836652872, 9829.705108846745, 9929.106380425796, 9994.350367226107, 10102.69691909244, 10201.744956375853, 10035.849462258218, 10323.793524129625, 10495.842562361418, 10656.360618362924, 10676.786464270515, 9184.816303674022, 10194.847077293698, 10220.744481388025, 10236.385816851012, 10518.842217366593, 7416.9258307418395, 7633.12219094789, 7677.654505547375, 7678.5392876427595, 7733.961330193313, 9613.327067105236, 10043.698689039049, 10191.490425478845, 10191.898081019095, 10413.531391087268], "unit": "score", "name": "jquery.html", "value": 7957.998658371515}, {"lowerIsBetter": false, "replicates": [1372.6705590658241, 1422.5234546426943, 1547.7833103365524, 1700.761893334934, 1766.2140347545349, 7101.0413594164775, 7236.529625574334, 7295.671694773735, 7298.525595836267, 7335.413166946645, 6180.4746596539235, 6299.496040316775, 6313.021481670348, 6317.463015643664, 7228.0, 1918.9808101918977, 2136.2309568555306, 2181.182056728727, 2190.123950419837, 2199.175309259028, 2144.02446886667, 2182.639864422368, 2185.6940028395957, 2190.145843121184, 2193.901274442646, 1880.9623807523842, 2142.1859693316596, 2150.580636775829, 2151.3330867431146, 2157.6439887418555, 2134.423705599487, 2192.1998470558133, 2192.48476607997, 2193.352960876537, 2194.3416974907623, 2099.5276062885882, 2123.437289118385, 2132.477543001959, 2155.4503601581496, 2183.6069507488805, 7181.605011724353, 7186.1735900371605, 7217.92782072183, 7224.1692205396, 7240.13118425787, 4342.5874541918465, 4484.1928452878465, 4484.618807401374, 4486.439195100613, 4537.387452693877, 2839.5030869597945, 2863.9284017899718, 2970.287131088545, 2977.5831383606314, 2985.447692176954, 935.349931797401, 945.3146468810127, 961.7403301108661, 964.2719746591279, 975.0298453039201, 9627.037296270388, 9643.180329671986, 9648.179904708108, 9650.469224192666, 9663.323567350288, 3929.390944403622, 4082.4896887889013, 4130.793460326971, 4149.091417947718, 4152.91694166115, 8281.917180828235, 8343.374246931504, 8376.036755773164, 8377.204165604258, 8377.413581049268, 4502.977485112553, 4525.932111018337, 4549.27211646135, 4549.385832912581, 4554.385158003627, 4145.233131870614, 4147.585241475828, 4147.709660323749, 4152.875413737593, 4153.065560248981, 3135.90243414803, 3456.343294773985, 3519.486620753101, 3519.6449366993893, 3527.2592755521628, 1138.3738943580997, 1174.442139983501, 1176.505867535637, 1182.5100373529415, 1188.9821652675216, 1197.233770386953, 1201.2252097397304, 1203.9699007524707, 1213.3387303919385, 1227.5580790915262, 6689.531732778659, 6853.623050732258, 6884.311568843175, 6885.518013739091, 7015.508914375945, 1040.557762950743, 1046.2780681329857, 1068.8022715797601, 1072.8873468285717, 1083.3932997521413, 5405.945940540544, 5465.180222966507, 5473.28847249855, 5506.834794956158, 5507.0637991541535, 8447.873281900776, 8550.657973681107, 8650.78373040679, 8740.956295218482, 8748.037715851251, 8512.787180320542, 8532.402731808714, 8538.0, 8619.0, 8641.654333826702, 6690.933090669128, 6777.661116944231, 6825.590464572042, 6837.076994605664, 6896.586204827727, 6500.447461965597, 6501.089847421459, 6536.542442029012, 6565.113709649137, 6577.80266592003, 7563.73526926577, 7669.9616501917135, 7829.099653539915, 7922.366210703015, 7937.960310198412, 7851.254130857559, 7956.801079973047, 8076.515409075474, 8091.757247282591, 8095.635696393559, 6342.080398342122, 6374.617522948638, 6392.232932048184, 6401.135846660642, 6412.775552855627, 6817.488688348493, 7000.159980802337, 7000.824979375557, 7003.124609423822, 7014.263502332182, 6197.0, 6280.528960328085, 6286.5599408041, 6343.777967771106, 6393.424591786761, 6134.079888016655, 6182.505399568114, 6231.594946328474, 6329.082283068838, 6384.138141350858, 6464.191976003, 6503.837404064747, 6510.251321098134, 6516.120323756232, 6652.90020649681, 6180.6291622502795, 6256.906146407717, 6257.78097766576, 6265.8120256392385, 6267.373262673696, 5981.431763982415, 6152.507799376129, 6158.3841615838055, 6225.3774622537385, 6237.376262373727], "unit": "score", "name": "mootools.html", "value": 4220.3755305002305}, {"lowerIsBetter": false, "replicates": [310.2430070627667, 312.7466751930938, 315.263858889493, 315.70797012763194, 318.2219473387567, 5276.419593844679, 5291.338582677161, 5379.300690910176, 5387.811426600069, 5389.272448219499, 5293.9735301323435, 5296.364436267643, 5315.335583052119, 5317.5480084192795, 5317.893642127165, 3933.6263055009726, 4025.9597404025876, 4125.855595054174, 4133.421321015053, 4133.42132101506, 4113.362428823522, 4116.135611521584, 4124.958750412503, 4131.52487463941, 4135.6898232632675, 4084.1831633673237, 4088.4889388826396, 4089.0595163112503, 4094.2425651254466, 4102.856400025999, 3924.6075392460666, 4004.3993400989793, 4029.395590661395, 4041.232165888501, 4098.610631989956, 3540.7698499597445, 3633.8909832705062, 3637.0907273181706, 3640.7269454791, 3642.9453558196647, 5121.180611102243, 5122.487751224885, 5130.025295193938, 5135.820246291362, 5138.691678499302, 4753.786079626425, 4759.333693282943, 4761.333413322138, 4768.856934291942, 4778.068276686047, 5589.469000444951, 5593.8321850344555, 5595.524380427669, 5596.916046259309, 5601.29983752031, 4004.3593025115842, 4005.0387906902133, 4006.3389540725743, 4009.4787677602017, 4009.578994205596, 5591.6365436246515, 5758.79844205455, 5786.42135786418, 5792.275965504312, 5860.06239001762, 3955.3869150281753, 3971.3050216212046, 3987.800609969548, 3994.3409337458993, 4001.0197501612292, 4042.7776472293717, 4046.77742724153, 4047.0894048839364, 4048.6963477739287, 4056.634902858757, 4647.6281897448125, 4651.139539185194, 4658.114958157939, 4674.088552732184, 4677.883052923704, 5623.746931388097, 5626.549876009909, 5635.830925072254, 5637.577181711388, 5637.7181140942785, 1399.6920677450944, 1422.9612382960497, 1427.835798883121, 1428.0218050635349, 1428.4357678717056, 923.9260859131253, 933.7478880702308, 950.1163917556601, 960.8318544254728, 961.2790407194605, 4743.312219728189, 4829.5653391194965, 4833.540813622701, 4868.367112275381, 4933.901321973541, 5854.0, 5877.5591830612875, 5882.941170588325, 5889.352171261158, 5894.056950887837, 4940.308356830046, 4945.480724523945, 4950.356453661001, 4950.529699678525, 4953.529414705597, 3113.081640915935, 3155.2111972006996, 3155.826429546397, 3155.921101972469, 3159.273367125574, 5525.613207075547, 5526.088195447786, 5527.281453411031, 5528.944710552843, 5529.751161197756, 5884.6469211847425, 5954.196183515257, 5954.37479064692, 5997.310309314397, 6113.908291375633, 5527.39198688152, 5547.639403438763, 5551.583631227755, 5553.639013464192, 5556.444355564492, 5868.3251426086545, 5877.911831322448, 5878.882422351615, 5882.852928676817, 5897.882042359043, 5742.569307301886, 5787.36339002701, 5792.594518383673, 5796.59423840344, 5799.623024503394, 5530.557555395479, 5538.861528461821, 5545.279113715353, 5550.4449555044175, 5550.722463876871, 3860.3823388257742, 3963.56400795918, 3983.7609743415487, 4022.456968309241, 4031.415444760552, 5733.8566535836935, 5745.482906538432, 5748.655080695172, 5754.05058165398, 5763.625364351304, 5567.972160139173, 5588.6646801192055, 5594.720263986866, 5605.859853503532, 5606.551475881838, 5558.277423934863, 5563.944360556343, 5568.16477528374, 5569.777208911598, 5571.3592936811165, 5516.806911758069, 5523.116301391919, 5530.695811730394, 5536.695481748381, 5542.725173210104, 5466.83226897989, 5564.276644036249, 5632.802851900164, 5643.661380317194, 5647.802326918538, 5467.17992301158, 5491.478309560585, 5494.560435165257, 5496.148097044965, 5496.285482887199], "unit": "score", "name": "prototype.html", "value": 4209.654099167355}, {"lowerIsBetter": false, "replicates": [684.6097724297151, 705.6013352455863, 706.4489698035534, 723.8479919216965, 773.8684423647986, 12216.083793715474, 12415.56545520907, 12452.937735311321, 12472.750544989107, 12500.062495312864, 11808.940955295211, 11842.407879606028, 11855.22941008836, 11879.28724276544, 11886.167968242227, 629.2574761781119, 782.5617654113714, 792.132614786809, 810.5339429827843, 813.0081300812999, 816.1226681317578, 819.0253598218131, 820.3150369441523, 820.3683163963744, 821.3757544266371, 847.8558645030329, 853.2235665544356, 853.3855623950745, 853.90180129285, 854.2525290370926, 661.4476911778646, 837.6440012994453, 847.9745607631781, 848.8726690996339, 856.208007592974, 624.8063100438833, 625.4902254662436, 625.543353352051, 625.871696302257, 625.9687015649199, 11936.940315298454, 11953.521859125625, 11981.820272695917, 12030.759384812254, 12042.458089385998, 11782.057435405148, 12559.372031398394, 12578.308193049379, 12680.429380677891, 12935.611931642066, 9783.217342612574, 9834.213262938947, 9994.650187243411, 10116.291859569834, 10240.129588984944, 3240.303334783009, 3256.7068963793135, 3273.738100951918, 3361.8151001694896, 3372.426687463137, 43569.56430435718, 43653.345199822026, 43730.78134609338, 43819.342709859375, 44351.77824110859, 9975.850362244571, 10036.849447258297, 10201.489925503844, 10224.13094886928, 10432.634857780093, 17985.550361241072, 18017.459476215736, 18018.639627207383, 18020.459386218434, 18056.18747156381, 6445.1943507061615, 6580.670966451658, 6590.3080176581725, 6670.0, 6715.56348837324, 3753.399456087013, 3839.0, 3841.654251117413, 3889.5138107736534, 3906.7655940643654, 2787.567926971323, 2796.1751283371455, 2822.618946442204, 2826.081523504869, 2826.4488424756973, 462.6391414696542, 490.1300192158875, 490.7276461563795, 497.6591035140868, 498.40191769876293, 541.5586297167796, 614.913912052313, 619.4332186049714, 628.2272804450552, 645.4965127200791, 7315.30504602062, 7662.808809321915, 7936.4841285317425, 8018.198180181935, 8098.878516822252, 624.950003999679, 631.8072987738784, 632.3234139470723, 646.1309538670481, 656.9770058047945, 3498.265364273531, 3700.740948133605, 3719.256148770257, 3749.5875453700073, 3775.3581891078584, 48650.756746216044, 48657.27014094791, 48747.512524875005, 48946.0, 49316.50683493191, 44827.551724482335, 45089.32366014512, 45407.31889021667, 45619.0, 45674.54325456703, 41169.0, 43212.0, 43985.56014439814, 45463.318050229274, 46452.767736161106, 8008.1191068983535, 8270.090290068209, 8387.580620969049, 8500.787480313042, 8589.226969572768, 30744.84627576848, 30927.69072309248, 31495.0, 32123.51814722828, 32196.35607287888, 40360.1927961445, 40562.0, 40968.38547421851, 41865.0, 42203.57796422119, 10155.136813370946, 10175.86253188357, 10208.540615672164, 10409.219308551737, 10501.0, 11287.492062857027, 11465.713357166138, 11486.310821350746, 11552.480138393961, 11646.184767066225, 10500.527476263434, 10574.154067674413, 10795.596572445531, 10854.023137917626, 10888.0, 10067.798644026932, 10330.0, 10399.27205095636, 10692.518836652525, 10778.245522813328, 10357.948210259203, 10366.222533310183, 10418.635347762793, 10536.209784266057, 10908.072813810915, 9301.0, 9421.528923553931, 9479.19426848698, 9530.95234523823, 9726.319157658896, 9263.073692630684, 9331.86002209981, 9332.953335233551, 9414.764630884009, 9420.152186303265], "unit": "score", "name": "yui.html", "value": 5907.037970570593}], "name": "dromaeo_css", "value": 6317.269506886526}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 108.0, 111.0, 112.0, 112.0, 101.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [179.0, 132.0, 161.0, 179.0, 134.0, 158.0, 162.0, 138.0, 185.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 156.1}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 164.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 112.0, 99.0, 74.0, 74.0, 73.0, 130.0, 94.0, 77.0], "unit": "score", "name": "audio-fft", "value": 88.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 94.0, 94.0, 93.0, 136.0, 95.0, 94.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 67.0, 66.0, 65.0, 65.0, 66.0, 75.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 64.0, 66.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 82.0, 93.0, 90.0, 89.0, 84.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 115.0, 117.0, 117.0, 117.0, 118.0, 117.0, 123.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [142.0, 130.0, 141.0, 139.0, 149.0, 130.0, 143.0, 141.0, 145.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1522.6}]} 08:48:54 INFO - Return code: 0 08:48:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:48:54 ERROR - # TBPL SUCCESS # 08:48:54 INFO - Running post-action listener: _resource_record_post_action 08:48:54 INFO - Running post-run listener: _resource_record_post_run 08:48:55 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517849088; Read time: 12; Write time: 500388 08:48:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 214220800; Read time: 0; Write time: 248548 08:48:55 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284819456; Read time: 12; Write time: 248512 08:48:55 INFO - Running post-run listener: _upload_blobber_files 08:48:55 INFO - Blob upload gear active. 08:48:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:55 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 08:48:55 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'] 08:48:55 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 08:48:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:56 INFO - (blobuploader) - INFO - Done attempting. 08:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:57 INFO - (blobuploader) - INFO - Done attempting. 08:48:57 INFO - (blobuploader) - INFO - Iteration through files over. 08:48:57 INFO - Return code: 0 08:48:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:48:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:48:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b3b79eaa6011fb21abfa3e2d1e7c22374eead440ad8656439b6c07c55134cc95f218968653d3c6cddd48554a2e97416f18b1c46b15683fd79388906a8812914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8157a813e45ef0019866319d72b081b19a660a30e7e09c71f5dc419d6732851139b84c0b1df188cb689ea1041f40b0b21f7e080306c54a15106cbc06b42751fa"} 08:48:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:48:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:48:57 INFO - Contents: 08:48:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b3b79eaa6011fb21abfa3e2d1e7c22374eead440ad8656439b6c07c55134cc95f218968653d3c6cddd48554a2e97416f18b1c46b15683fd79388906a8812914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8157a813e45ef0019866319d72b081b19a660a30e7e09c71f5dc419d6732851139b84c0b1df188cb689ea1041f40b0b21f7e080306c54a15106cbc06b42751fa"} 08:48:57 INFO - Running post-run listener: copy_logs_to_upload_dir 08:48:57 INFO - Copying logs to upload dir... 08:48:57 INFO - mkdir: /builds/slave/test/build/upload/logs 08:48:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.576139 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-05 08:48:57.289782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 08:48:57.293112) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 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/9b3b79eaa6011fb21abfa3e2d1e7c22374eead440ad8656439b6c07c55134cc95f218968653d3c6cddd48554a2e97416f18b1c46b15683fd79388906a8812914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8157a813e45ef0019866319d72b081b19a660a30e7e09c71f5dc419d6732851139b84c0b1df188cb689ea1041f40b0b21f7e080306c54a15106cbc06b42751fa"} build_url:https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/SMcXi3MrRgOrwMaVzHT48w/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/9b3b79eaa6011fb21abfa3e2d1e7c22374eead440ad8656439b6c07c55134cc95f218968653d3c6cddd48554a2e97416f18b1c46b15683fd79388906a8812914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8157a813e45ef0019866319d72b081b19a660a30e7e09c71f5dc419d6732851139b84c0b1df188cb689ea1041f40b0b21f7e080306c54a15106cbc06b42751fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 08:48:57.325382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:48:57.325768) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459869029.162022-832178773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 08:48:57.384407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 08:48:57.384774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 08:48:57.385104) ========= ========= Total master_lag: 0.27 =========