builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1457025951.42 results: success (0) buildid: 20160301053641 builduid: 4ed4d0b337e24c078facd395c588a4a4 revision: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.418879) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.419316) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.419621) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006503 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.472704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.473005) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.495809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.496083) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.550688) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.550995) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.551363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.551637) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 09:25:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-03-03 09:25:51 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.724776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.725048) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.774026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:51.774389) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a4929411c0aa3ec6b727e2bc2fc050c8199c6573 --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 a4929411c0aa3ec6b727e2bc2fc050c8199c6573 --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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 09:25:51,907 truncating revision to first 12 chars 2016-03-03 09:25:51,907 Setting DEBUG logging. 2016-03-03 09:25:51,907 attempt 1/10 2016-03-03 09:25:51,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a4929411c0aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 09:25:52,536 unpacking tar archive at: mozilla-central-a4929411c0aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.932107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:52.718845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:52.719184) ========= echo a4929411c0aa3ec6b727e2bc2fc050c8199c6573 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a4929411c0aa3ec6b727e2bc2fc050c8199c6573'] 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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a4929411c0aa3ec6b727e2bc2fc050c8199c6573 program finished with exit code 0 elapsedTime=0.003769 script_repo_revision: 'a4929411c0aa3ec6b727e2bc2fc050c8199c6573' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:52.769430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:52.769814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 09:25:52.779932) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-03 09:25:52.780358) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:25:52 INFO - MultiFileLogger online at 20160303 09:25:52 in /builds/slave/test 09:25:52 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 09:25:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:25:53 INFO - {'append_to_log': False, 09:25:53 INFO - 'base_work_dir': '/builds/slave/test', 09:25:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:25:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:25:53 INFO - 'branch': 'Firefox-Non-PGO', 09:25:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:53 INFO - 'config_files': ('talos/linux_config.py',), 09:25:53 INFO - 'default_actions': ('clobber', 09:25:53 INFO - 'read-buildbot-config', 09:25:53 INFO - 'download-and-extract', 09:25:53 INFO - 'populate-webroot', 09:25:53 INFO - 'create-virtualenv', 09:25:53 INFO - 'install', 09:25:53 INFO - 'run-tests'), 09:25:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:53 INFO - 'download_minidump_stackwalk': True, 09:25:53 INFO - 'download_symbols': 'ondemand', 09:25:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:53 INFO - 'installer_path': 'installer.exe', 09:25:53 INFO - 'log_level': 'info', 09:25:53 INFO - 'log_name': 'talos', 09:25:53 INFO - 'log_to_console': True, 09:25:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:25:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:25:53 INFO - 'opt_config_files': (), 09:25:53 INFO - 'pip_index': False, 09:25:53 INFO - 'sps_profile': False, 09:25:53 INFO - 'sps_profile_interval': 0, 09:25:53 INFO - 'suite': 'dromaeojs', 09:25:53 INFO - 'system_bits': '32', 09:25:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:53 INFO - 'title': 'talos-linux64-ix-012', 09:25:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:53 INFO - 'use_talos_json': True, 09:25:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:25:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:53 INFO - 'work_dir': 'build'} 09:25:53 INFO - ##### 09:25:53 INFO - ##### Running clobber step. 09:25:53 INFO - ##### 09:25:53 INFO - Running pre-action listener: _resource_record_pre_action 09:25:53 INFO - Running main action method: clobber 09:25:53 INFO - rmtree: /builds/slave/test/build 09:25:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:25:53 INFO - Running post-action listener: _resource_record_post_action 09:25:53 INFO - ##### 09:25:53 INFO - ##### Running read-buildbot-config step. 09:25:53 INFO - ##### 09:25:53 INFO - Running pre-action listener: _resource_record_pre_action 09:25:53 INFO - Running main action method: read_buildbot_config 09:25:53 INFO - Using buildbot properties: 09:25:53 INFO - { 09:25:53 INFO - "project": "", 09:25:53 INFO - "product": "firefox", 09:25:53 INFO - "script_repo_revision": "production", 09:25:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:25:53 INFO - "repository": "", 09:25:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:25:53 INFO - "buildid": "20160301053641", 09:25:53 INFO - "pgo_build": "False", 09:25:53 INFO - "basedir": "/builds/slave/test", 09:25:53 INFO - "buildnumber": 12, 09:25:53 INFO - "slavename": "talos-linux64-ix-012", 09:25:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:25:53 INFO - "platform": "ubuntu64_hw", 09:25:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:25:53 INFO - "branch": "mozilla-central", 09:25:53 INFO - "repo_path": "mozilla-central", 09:25:53 INFO - "revision": "a4929411c0aa3ec6b727e2bc2fc050c8199c6573", 09:25:53 INFO - "stage_platform": "linux64", 09:25:53 INFO - "builduid": "4ed4d0b337e24c078facd395c588a4a4", 09:25:53 INFO - "slavebuilddir": "test" 09:25:53 INFO - } 09:25:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:25:53 INFO - Running post-action listener: _resource_record_post_action 09:25:53 INFO - ##### 09:25:53 INFO - ##### Running download-and-extract step. 09:25:53 INFO - ##### 09:25:53 INFO - Running pre-action listener: _resource_record_pre_action 09:25:53 INFO - Running main action method: download_and_extract 09:25:53 INFO - mkdir: /builds/slave/test/build/tests 09:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:53 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:25:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:25:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:25:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:26:04 INFO - Downloaded 1448 bytes. 09:26:04 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:26:04 INFO - Using the following test package requirements: 09:26:04 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:26:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:26:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:26:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'jsshell-linux-x86_64.zip'], 09:26:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:26:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:26:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:26:04 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:26:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:26:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:26:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:26:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:26:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:04 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:26:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:26:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:26:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:26:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:26:09 INFO - Downloaded 22077766 bytes. 09:26:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:26:10 INFO - Return code: 0 09:26:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:10 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:26:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:26:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:26:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:26:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:26:32 INFO - Downloaded 22077766 bytes. 09:26:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:26:33 INFO - Return code: 0 09:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:33 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:26:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:26:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:26:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:26:34 INFO - Downloaded 10713413 bytes. 09:26:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:26:34 INFO - Return code: 0 09:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:34 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:26:36 INFO - Downloaded 54835652 bytes. 09:26:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:36 INFO - mkdir: /builds/slave/test/properties 09:26:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:26:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:26:36 INFO - Contents: 09:26:36 INFO - build_url:https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:26:37 INFO - Running post-action listener: _resource_record_post_action 09:26:37 INFO - Running post-action listener: set_extra_try_arguments 09:26:37 INFO - ##### 09:26:37 INFO - ##### Running populate-webroot step. 09:26:37 INFO - ##### 09:26:37 INFO - Running pre-action listener: _resource_record_pre_action 09:26:37 INFO - Running main action method: populate_webroot 09:26:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:26:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:26:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:26:37 INFO - '--tppagecycles', 09:26:37 INFO - '7'], 09:26:37 INFO - 'tests': ['tsvgm']}}, 09:26:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:26:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:26:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:26:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:26:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'tests': ['damp', 'tps']}, 09:26:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['damp', 'tps']}, 09:26:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:26:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:26:37 INFO - 'other': {'tests': ['a11yr', 09:26:37 INFO - 'ts_paint', 09:26:37 INFO - 'tpaint', 09:26:37 INFO - 'sessionrestore', 09:26:37 INFO - 'sessionrestore_no_auto_restore']}, 09:26:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['a11yr', 09:26:37 INFO - 'ts_paint', 09:26:37 INFO - 'tpaint', 09:26:37 INFO - 'sessionrestore', 09:26:37 INFO - 'sessionrestore_no_auto_restore']}, 09:26:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['a11yr', 09:26:37 INFO - 'ts_paint', 09:26:37 INFO - 'tpaint', 09:26:37 INFO - 'sessionrestore', 09:26:37 INFO - 'sessionrestore_no_auto_restore']}, 09:26:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['a11yr', 09:26:37 INFO - 'ts_paint', 09:26:37 INFO - 'tpaint', 09:26:37 INFO - 'sessionrestore', 09:26:37 INFO - 'sessionrestore_no_auto_restore']}, 09:26:37 INFO - 'other_l64': {'tests': ['a11yr', 09:26:37 INFO - 'ts_paint', 09:26:37 INFO - 'tpaint', 09:26:37 INFO - 'sessionrestore', 09:26:37 INFO - 'sessionrestore_no_auto_restore']}, 09:26:37 INFO - 'other_nol64': {'tests': ['a11yr', 09:26:37 INFO - 'ts_paint', 09:26:37 INFO - 'tpaint', 09:26:37 INFO - 'sessionrestore', 09:26:37 INFO - 'sessionrestore_no_auto_restore']}, 09:26:37 INFO - 'svgr': {'tests': ['tsvgx', 09:26:37 INFO - 'tsvgr_opacity', 09:26:37 INFO - 'tart', 09:26:37 INFO - 'tscrollx', 09:26:37 INFO - 'cart']}, 09:26:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['tsvgx', 09:26:37 INFO - 'tsvgr_opacity', 09:26:37 INFO - 'tart', 09:26:37 INFO - 'tscrollx', 09:26:37 INFO - 'cart']}, 09:26:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'tests': ['tp5o']}, 09:26:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'talos_options': ['--e10s'], 09:26:37 INFO - 'tests': ['tp5o']}, 09:26:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'talos_options': ['--xperf_path', 09:26:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:37 INFO - 'tests': ['tp5n']}, 09:26:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:37 INFO - 'talos_options': ['--e10s', 09:26:37 INFO - '--xperf_path', 09:26:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:37 INFO - 'tests': ['tp5n']}}, 09:26:37 INFO - 'talos.zip': {'path': '', 09:26:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:26:37 INFO - Running post-action listener: _resource_record_post_action 09:26:37 INFO - ##### 09:26:37 INFO - ##### Running create-virtualenv step. 09:26:37 INFO - ##### 09:26:37 INFO - Running pre-action listener: _resource_record_pre_action 09:26:37 INFO - Running main action method: create_virtualenv 09:26:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:26:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:26:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:26:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:26:37 INFO - Using real prefix '/usr' 09:26:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:26:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:26:40 INFO - Installing pip.................done. 09:26:40 INFO - Return code: 0 09:26:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:40 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:26:40 INFO - Using env: {'DISPLAY': ':0', 09:26:40 INFO - 'HOME': '/home/cltbld', 09:26:40 INFO - 'LANG': 'en_US.UTF-8', 09:26:40 INFO - 'LANGUAGE': 'en_US:en', 09:26:40 INFO - 'LOGNAME': 'cltbld', 09:26:40 INFO - 'MAIL': '/var/mail/cltbld', 09:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:40 INFO - 'MOZ_NO_REMOTE': '1', 09:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:40 INFO - 'NO_EM_RESTART': '1', 09:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:40 INFO - 'PWD': '/builds/slave/test', 09:26:40 INFO - 'SHELL': '/bin/bash', 09:26:40 INFO - 'SHLVL': '1', 09:26:40 INFO - 'TERM': 'linux', 09:26:40 INFO - 'TMOUT': '86400', 09:26:40 INFO - 'USER': 'cltbld', 09:26:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:40 INFO - '_': '/tools/buildbot/bin/python'} 09:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:26:40 INFO - Cleaning up... 09:26:40 INFO - Return code: 0 09:26:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:40 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:26:40 INFO - Using env: {'DISPLAY': ':0', 09:26:40 INFO - 'HOME': '/home/cltbld', 09:26:40 INFO - 'LANG': 'en_US.UTF-8', 09:26:40 INFO - 'LANGUAGE': 'en_US:en', 09:26:40 INFO - 'LOGNAME': 'cltbld', 09:26:40 INFO - 'MAIL': '/var/mail/cltbld', 09:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:40 INFO - 'MOZ_NO_REMOTE': '1', 09:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:40 INFO - 'NO_EM_RESTART': '1', 09:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:40 INFO - 'PWD': '/builds/slave/test', 09:26:40 INFO - 'SHELL': '/bin/bash', 09:26:40 INFO - 'SHLVL': '1', 09:26:40 INFO - 'TERM': 'linux', 09:26:40 INFO - 'TMOUT': '86400', 09:26:40 INFO - 'USER': 'cltbld', 09:26:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:40 INFO - '_': '/tools/buildbot/bin/python'} 09:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:40 INFO - Downloading/unpacking psutil>=0.7.1 09:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:42 INFO - Installing collected packages: psutil 09:26:42 INFO - Running setup.py install for psutil 09:26:42 INFO - building 'psutil._psutil_linux' extension 09:26:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:26:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:26:43 INFO - building 'psutil._psutil_posix' extension 09:26:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:26:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:26:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:43 INFO - Successfully installed psutil 09:26:43 INFO - Cleaning up... 09:26:43 INFO - Return code: 0 09:26:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:43 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:26:43 INFO - Using env: {'DISPLAY': ':0', 09:26:43 INFO - 'HOME': '/home/cltbld', 09:26:43 INFO - 'LANG': 'en_US.UTF-8', 09:26:43 INFO - 'LANGUAGE': 'en_US:en', 09:26:43 INFO - 'LOGNAME': 'cltbld', 09:26:43 INFO - 'MAIL': '/var/mail/cltbld', 09:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:43 INFO - 'MOZ_NO_REMOTE': '1', 09:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:43 INFO - 'NO_EM_RESTART': '1', 09:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:43 INFO - 'PWD': '/builds/slave/test', 09:26:43 INFO - 'SHELL': '/bin/bash', 09:26:43 INFO - 'SHLVL': '1', 09:26:43 INFO - 'TERM': 'linux', 09:26:43 INFO - 'TMOUT': '86400', 09:26:43 INFO - 'USER': 'cltbld', 09:26:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:43 INFO - '_': '/tools/buildbot/bin/python'} 09:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:26:45 INFO - Installing collected packages: mozsystemmonitor 09:26:45 INFO - Running setup.py install for mozsystemmonitor 09:26:45 INFO - Successfully installed mozsystemmonitor 09:26:45 INFO - Cleaning up... 09:26:45 INFO - Return code: 0 09:26:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:26: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')]} 09:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:45 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:26:45 INFO - Using env: {'DISPLAY': ':0', 09:26:45 INFO - 'HOME': '/home/cltbld', 09:26:45 INFO - 'LANG': 'en_US.UTF-8', 09:26:45 INFO - 'LANGUAGE': 'en_US:en', 09:26:45 INFO - 'LOGNAME': 'cltbld', 09:26:45 INFO - 'MAIL': '/var/mail/cltbld', 09:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:45 INFO - 'MOZ_NO_REMOTE': '1', 09:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:45 INFO - 'NO_EM_RESTART': '1', 09:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:45 INFO - 'PWD': '/builds/slave/test', 09:26:45 INFO - 'SHELL': '/bin/bash', 09:26:45 INFO - 'SHLVL': '1', 09:26:45 INFO - 'TERM': 'linux', 09:26:45 INFO - 'TMOUT': '86400', 09:26:45 INFO - 'USER': 'cltbld', 09:26:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:45 INFO - '_': '/tools/buildbot/bin/python'} 09:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:26:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:48 INFO - Downloading docopt-0.6.1.tar.gz 09:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:48 INFO - Running setup.py install for blobuploader 09:26:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:26:48 INFO - Running setup.py install for requests 09:26:48 INFO - Running setup.py install for docopt 09:26:48 INFO - Successfully installed blobuploader requests docopt 09:26:48 INFO - Cleaning up... 09:26:48 INFO - Return code: 0 09:26:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26: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')]} 09:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:48 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:26:48 INFO - Using env: {'DISPLAY': ':0', 09:26:48 INFO - 'HOME': '/home/cltbld', 09:26:48 INFO - 'LANG': 'en_US.UTF-8', 09:26:48 INFO - 'LANGUAGE': 'en_US:en', 09:26:48 INFO - 'LOGNAME': 'cltbld', 09:26:48 INFO - 'MAIL': '/var/mail/cltbld', 09:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:48 INFO - 'MOZ_NO_REMOTE': '1', 09:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:48 INFO - 'NO_EM_RESTART': '1', 09:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:48 INFO - 'PWD': '/builds/slave/test', 09:26:48 INFO - 'SHELL': '/bin/bash', 09:26:48 INFO - 'SHLVL': '1', 09:26:48 INFO - 'TERM': 'linux', 09:26:48 INFO - 'TMOUT': '86400', 09:26:48 INFO - 'USER': 'cltbld', 09:26:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:48 INFO - '_': '/tools/buildbot/bin/python'} 09:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:49 INFO - Running setup.py (path:/tmp/pip-_SZGB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:49 INFO - Running setup.py (path:/tmp/pip-Tt1H9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:49 INFO - Running setup.py (path:/tmp/pip-rgcgy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:49 INFO - Running setup.py (path:/tmp/pip-GloKcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:49 INFO - Running setup.py (path:/tmp/pip-WDuURZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:49 INFO - Running setup.py (path:/tmp/pip-D_ukYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:49 INFO - Running setup.py (path:/tmp/pip-0l5Sjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:49 INFO - Running setup.py (path:/tmp/pip-JdRFf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:49 INFO - Running setup.py (path:/tmp/pip-3HTjhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:49 INFO - Running setup.py (path:/tmp/pip-afNaoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:49 INFO - Running setup.py (path:/tmp/pip-7h3pOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:49 INFO - Running setup.py (path:/tmp/pip-DkF6kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:49 INFO - Running setup.py (path:/tmp/pip-se8vLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:50 INFO - Running setup.py (path:/tmp/pip-HNuSC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:50 INFO - Running setup.py (path:/tmp/pip-Z_WVvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:50 INFO - Running setup.py (path:/tmp/pip-VAi15L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:50 INFO - Running setup.py (path:/tmp/pip-sRE5d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:50 INFO - Running setup.py install for manifestparser 09:26:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:26:50 INFO - Running setup.py install for mozcrash 09:26:50 INFO - Running setup.py install for mozdebug 09:26:50 INFO - Running setup.py install for mozdevice 09:26:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:26:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:26:50 INFO - Running setup.py install for mozfile 09:26:50 INFO - Running setup.py install for mozhttpd 09:26:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:26:50 INFO - Running setup.py install for mozinfo 09:26:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Running setup.py install for mozInstall 09:26:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Running setup.py install for mozleak 09:26:51 INFO - Running setup.py install for mozlog 09:26:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Running setup.py install for moznetwork 09:26:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Running setup.py install for mozprocess 09:26:51 INFO - Running setup.py install for mozprofile 09:26:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Running setup.py install for mozrunner 09:26:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:26:51 INFO - Running setup.py install for mozscreenshot 09:26:51 INFO - Running setup.py install for moztest 09:26:52 INFO - Running setup.py install for mozversion 09:26:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:26:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:52 INFO - Cleaning up... 09:26:52 INFO - Return code: 0 09:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26: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')]} 09:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:52 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:26:52 INFO - Using env: {'DISPLAY': ':0', 09:26:52 INFO - 'HOME': '/home/cltbld', 09:26:52 INFO - 'LANG': 'en_US.UTF-8', 09:26:52 INFO - 'LANGUAGE': 'en_US:en', 09:26:52 INFO - 'LOGNAME': 'cltbld', 09:26:52 INFO - 'MAIL': '/var/mail/cltbld', 09:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:52 INFO - 'MOZ_NO_REMOTE': '1', 09:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:52 INFO - 'NO_EM_RESTART': '1', 09:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:52 INFO - 'PWD': '/builds/slave/test', 09:26:52 INFO - 'SHELL': '/bin/bash', 09:26:52 INFO - 'SHLVL': '1', 09:26:52 INFO - 'TERM': 'linux', 09:26:52 INFO - 'TMOUT': '86400', 09:26:52 INFO - 'USER': 'cltbld', 09:26:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:52 INFO - '_': '/tools/buildbot/bin/python'} 09:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:52 INFO - Running setup.py (path:/tmp/pip-eZfrBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:52 INFO - Running setup.py (path:/tmp/pip-iSLUf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:52 INFO - Running setup.py (path:/tmp/pip-zdipkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:52 INFO - Running setup.py (path:/tmp/pip-B35mC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:52 INFO - Running setup.py (path:/tmp/pip-KvK3tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:52 INFO - Running setup.py (path:/tmp/pip-_r6x62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:52 INFO - Running setup.py (path:/tmp/pip-lIjbGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:52 INFO - Running setup.py (path:/tmp/pip-QwGEu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:52 INFO - Running setup.py (path:/tmp/pip-O961vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:53 INFO - Running setup.py (path:/tmp/pip-FdmSbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:53 INFO - Running setup.py (path:/tmp/pip-H10w1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:53 INFO - Running setup.py (path:/tmp/pip-O4S9d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:53 INFO - Running setup.py (path:/tmp/pip-fvpOQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:53 INFO - Running setup.py (path:/tmp/pip-hP8PDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:53 INFO - Running setup.py (path:/tmp/pip-0hcEj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:53 INFO - Running setup.py (path:/tmp/pip-unSZhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:53 INFO - Running setup.py (path:/tmp/pip-H_31iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:26:53 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:53 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:26:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:55 INFO - Downloading blessings-1.6.tar.gz 09:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:26:55 INFO - Installing collected packages: blessings 09:26:55 INFO - Running setup.py install for blessings 09:26:55 INFO - Successfully installed blessings 09:26:55 INFO - Cleaning up... 09:26:55 INFO - Return code: 0 09:26:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:26:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:55 INFO - Reading from file tmpfile_stdout 09:26:55 INFO - Current package versions: 09:26:55 INFO - argparse == 1.2.1 09:26:55 INFO - blessings == 1.6 09:26:55 INFO - blobuploader == 1.2.4 09:26:55 INFO - docopt == 0.6.1 09:26:55 INFO - manifestparser == 1.1 09:26:55 INFO - mozInstall == 1.12 09:26:55 INFO - mozcrash == 0.16 09:26:55 INFO - mozdebug == 0.1 09:26:55 INFO - mozdevice == 0.48 09:26:55 INFO - mozfile == 1.2 09:26:55 INFO - mozhttpd == 0.7 09:26:55 INFO - mozinfo == 0.9 09:26:55 INFO - mozleak == 0.1 09:26:55 INFO - mozlog == 3.1 09:26:55 INFO - moznetwork == 0.27 09:26:55 INFO - mozprocess == 0.22 09:26:55 INFO - mozprofile == 0.28 09:26:55 INFO - mozrunner == 6.11 09:26:55 INFO - mozscreenshot == 0.1 09:26:55 INFO - mozsystemmonitor == 0.0 09:26:55 INFO - moztest == 0.7 09:26:55 INFO - mozversion == 1.4 09:26:55 INFO - psutil == 3.1.1 09:26:55 INFO - requests == 1.2.3 09:26:55 INFO - wsgiref == 0.1.2 09:26:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26: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')]} 09:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:55 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:26:55 INFO - Using env: {'DISPLAY': ':0', 09:26:55 INFO - 'HOME': '/home/cltbld', 09:26:55 INFO - 'LANG': 'en_US.UTF-8', 09:26:55 INFO - 'LANGUAGE': 'en_US:en', 09:26:55 INFO - 'LOGNAME': 'cltbld', 09:26:55 INFO - 'MAIL': '/var/mail/cltbld', 09:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:55 INFO - 'MOZ_NO_REMOTE': '1', 09:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:55 INFO - 'NO_EM_RESTART': '1', 09:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:55 INFO - 'PWD': '/builds/slave/test', 09:26:55 INFO - 'SHELL': '/bin/bash', 09:26:55 INFO - 'SHLVL': '1', 09:26:55 INFO - 'TERM': 'linux', 09:26:55 INFO - 'TMOUT': '86400', 09:26:55 INFO - 'USER': 'cltbld', 09:26:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:55 INFO - '_': '/tools/buildbot/bin/python'} 09:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:26:56 INFO - Cleaning up... 09:26:56 INFO - Return code: 0 09:26:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:56 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:26:56 INFO - Using env: {'DISPLAY': ':0', 09:26:56 INFO - 'HOME': '/home/cltbld', 09:26:56 INFO - 'LANG': 'en_US.UTF-8', 09:26:56 INFO - 'LANGUAGE': 'en_US:en', 09:26:56 INFO - 'LOGNAME': 'cltbld', 09:26:56 INFO - 'MAIL': '/var/mail/cltbld', 09:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:56 INFO - 'MOZ_NO_REMOTE': '1', 09:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:56 INFO - 'NO_EM_RESTART': '1', 09:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:56 INFO - 'PWD': '/builds/slave/test', 09:26:56 INFO - 'SHELL': '/bin/bash', 09:26:56 INFO - 'SHLVL': '1', 09:26:56 INFO - 'TERM': 'linux', 09:26:56 INFO - 'TMOUT': '86400', 09:26:56 INFO - 'USER': 'cltbld', 09:26:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:56 INFO - '_': '/tools/buildbot/bin/python'} 09:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:56 INFO - Downloading/unpacking jsonschema 09:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:26:58 INFO - Downloading/unpacking functools32 (from jsonschema) 09:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:26:58 INFO - warning: no files found matching '*.txt' 09:26:58 INFO - no previously-included directories found matching 'build' 09:26:58 INFO - no previously-included directories found matching 'dist' 09:26:58 INFO - no previously-included directories found matching '.git*' 09:26:58 INFO - Installing collected packages: jsonschema, functools32 09:26:58 INFO - Running setup.py install for functools32 09:26:58 INFO - warning: no files found matching '*.txt' 09:26:58 INFO - no previously-included directories found matching 'build' 09:26:58 INFO - no previously-included directories found matching 'dist' 09:26:58 INFO - no previously-included directories found matching '.git*' 09:26:58 INFO - Successfully installed jsonschema functools32 09:26:58 INFO - Cleaning up... 09:26:58 INFO - Return code: 0 09:26:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:58 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 0x7fbce7054f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a22410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:26:58 INFO - Using env: {'DISPLAY': ':0', 09:26:58 INFO - 'HOME': '/home/cltbld', 09:26:58 INFO - 'LANG': 'en_US.UTF-8', 09:26:58 INFO - 'LANGUAGE': 'en_US:en', 09:26:58 INFO - 'LOGNAME': 'cltbld', 09:26:58 INFO - 'MAIL': '/var/mail/cltbld', 09:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:58 INFO - 'MOZ_NO_REMOTE': '1', 09:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:58 INFO - 'NO_EM_RESTART': '1', 09:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:58 INFO - 'PWD': '/builds/slave/test', 09:26:58 INFO - 'SHELL': '/bin/bash', 09:26:58 INFO - 'SHLVL': '1', 09:26:58 INFO - 'TERM': 'linux', 09:26:58 INFO - 'TMOUT': '86400', 09:26:58 INFO - 'USER': 'cltbld', 09:26:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:58 INFO - '_': '/tools/buildbot/bin/python'} 09:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:58 INFO - Downloading/unpacking flake8 09:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:27:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:27:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:27:01 INFO - no previously-included directories found matching 'docs/_build' 09:27:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:27:01 INFO - Running setup.py install for pep8 09:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:27:01 INFO - no previously-included directories found matching 'docs/_build' 09:27:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:27:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:27:01 INFO - Cleaning up... 09:27:01 INFO - Return code: 0 09:27:01 INFO - Running post-action listener: _resource_record_post_action 09:27:01 INFO - Running post-action listener: _start_resource_monitoring 09:27:01 INFO - Starting resource monitoring. 09:27:01 INFO - ##### 09:27:01 INFO - ##### Running install step. 09:27:01 INFO - ##### 09:27:01 INFO - Running pre-action listener: _resource_record_pre_action 09:27:01 INFO - Running main action method: install 09:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:01 INFO - Reading from file tmpfile_stdout 09:27:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:27:01 INFO - Reading from file tmpfile_stdout 09:27:01 INFO - Output received: 09:27:01 INFO - Usage: mozinstall [options] installer 09:27:01 INFO - Options: 09:27:01 INFO - -h, --help show this help message and exit 09:27:01 INFO - -d DEST, --destination=DEST 09:27:01 INFO - Directory to install application into. [default: 09:27:01 INFO - "/builds/slave/test"] 09:27:01 INFO - --app=APP Application being installed. [default: firefox] 09:27:01 INFO - mkdir: /builds/slave/test/build/application 09:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:27:17 INFO - Reading from file tmpfile_stdout 09:27:17 INFO - Output received: 09:27:17 INFO - /builds/slave/test/build/application/firefox/firefox 09:27:17 INFO - Running post-action listener: _resource_record_post_action 09:27:17 INFO - ##### 09:27:17 INFO - ##### Running run-tests step. 09:27:17 INFO - ##### 09:27:17 INFO - Running pre-action listener: _resource_record_pre_action 09:27:17 INFO - Running main action method: run_tests 09:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:27:17 INFO - Python 2.7.3 09:27:17 INFO - Return code: 0 09:27:17 INFO - grabbing minidump binary from tooltool 09:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:27:17 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 0x1ab1160>, '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 0x1ab2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab24f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:27:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:27:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:27:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:27:17 INFO - Return code: 0 09:27:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:27:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:27:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:27:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:27:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:27:18 INFO - Return code: 0 09:27:18 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/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:27:18 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/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:27:18 INFO - Using env: {'DISPLAY': ':0', 09:27:18 INFO - 'HOME': '/home/cltbld', 09:27:18 INFO - 'LANG': 'en_US.UTF-8', 09:27:18 INFO - 'LANGUAGE': 'en_US:en', 09:27:18 INFO - 'LOGNAME': 'cltbld', 09:27:18 INFO - 'MAIL': '/var/mail/cltbld', 09:27:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:27:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:18 INFO - 'MOZ_NO_REMOTE': '1', 09:27:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:18 INFO - 'NO_EM_RESTART': '1', 09:27:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:18 INFO - 'PWD': '/builds/slave/test', 09:27:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:27:18 INFO - 'SHELL': '/bin/bash', 09:27:18 INFO - 'SHLVL': '1', 09:27:18 INFO - 'TERM': 'linux', 09:27:18 INFO - 'TMOUT': '86400', 09:27:18 INFO - 'USER': 'cltbld', 09:27:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986', 09:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:18 INFO - '_': '/tools/buildbot/bin/python'} 09:27:18 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/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:27:19 INFO - mozversion application_buildid: 20160301053641 09:27:19 INFO - mozversion application_changeset: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 09:27:19 INFO - mozversion application_display_name: Nightly 09:27:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:27:19 INFO - mozversion application_name: Firefox 09:27:19 INFO - mozversion application_remotingname: firefox 09:27:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:27:19 INFO - mozversion application_vendor: Mozilla 09:27:19 INFO - mozversion application_version: 47.0a1 09:27:19 INFO - mozversion platform_buildid: 20160301053641 09:27:19 INFO - mozversion platform_changeset: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 09:27:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:27:19 INFO - mozversion platform_version: 47.0a1 09:27:19 INFO - using testdate: 1457026039 09:27:19 INFO - actual date: 1457026039 09:27:19 INFO - starting webserver on 'localhost:53742' 09:27:19 INFO - SUITE-START | Running 2 tests 09:27:19 INFO - TEST-START | dromaeo_css 09:27:19 INFO - operating with platform_type : linux_ 09:27:19 INFO - Initialising browser for dromaeo_css test... 09:27:19 INFO - TEST-INFO | started process 13289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2myHB/profile http://localhost:53742/getInfo.html) 09:27:23 INFO - PROCESS | 13289 | __metrics Screen width/height:1600/1200 09:27:23 INFO - PROCESS | 13289 | colorDepth:24 09:27:23 INFO - PROCESS | 13289 | Browser inner width/height: 1024/697 09:27:23 INFO - PROCESS | 13289 | __metrics 09:27:24 INFO - PROCESS | 13289 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:27:24 INFO - PROCESS | 13289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:24 INFO - PROCESS | 13289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:24 INFO - PROCESS | 13289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:24 INFO - PROCESS | 13289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:24 INFO - PROCESS | 13289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:24 INFO - PROCESS | 13289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:24 INFO - PROCESS | 13289 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:27:25 INFO - TEST-INFO | 13289: exit 0 09:27:25 INFO - Browser initialized. 09:27:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:27:25 INFO - TEST-INFO | started process 13383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2myHB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:37 INFO - PROCESS | 13383 | RSS: Main: 153616384 09:27:37 INFO - PROCESS | 13383 | 09:28:28 INFO - PROCESS | 13383 | 1457026108308 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:30:39 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53742/tests/dromaeo/cssquery-ext.html) 09:30:40 INFO - PROCESS | 13383 | RSS: Main: 231190528 09:30:40 INFO - PROCESS | 13383 | 09:33:42 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-ext.html (next: http://localhost:53742/tests/dromaeo/cssquery-jquery.html) 09:33:43 INFO - PROCESS | 13383 | RSS: Main: 243916800 09:33:43 INFO - PROCESS | 13383 | 09:36:45 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53742/tests/dromaeo/cssquery-mootools.html) 09:36:45 INFO - PROCESS | 13383 | RSS: Main: 234569728 09:36:45 INFO - PROCESS | 13383 | 09:39:47 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53742/tests/dromaeo/cssquery-prototype.html) 09:39:48 INFO - PROCESS | 13383 | RSS: Main: 213934080 09:39:48 INFO - PROCESS | 13383 | 09:42:51 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53742/tests/dromaeo/cssquery-yui.html) 09:42:52 INFO - PROCESS | 13383 | RSS: Main: 225288192 09:42:52 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-yui.html (next: http://localhost:53742/tests/dromaeo/cssquery-dojo.html) 09:45:54 INFO - PROCESS | 13383 | RSS: Main: 272453632 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | __start_tp_report 09:45:54 INFO - PROCESS | 13383 | _x_x_mozilla_page_load 09:45:54 INFO - PROCESS | 13383 | _x_x_mozilla_page_load_details 09:45:54 INFO - PROCESS | 13383 | |i|pagename|runs| 09:45:54 INFO - PROCESS | 13383 | |0;dojo.html;2607.504574130915;2654.707982121965;2691.676998760149;2699.838009719416;2707.9458410831785;4315.568443155683;4401.867943961686;4487.3942017827585;4510.07543453592;4533.569310915462;4441.356003379508;4476.597106260436;4501.459824821018;4507.639388848893;4531.071130418264;4075.32757095079;4104.733192342503;4128.8761337159785;4139.027328577782;4160.667146628278;4055.9391609125887;4095.815688294019;4172.97913510432;4184.8744537663915;4196.370544418346;4044.1102957349335;4082.5917408259234;4131.5248746394245;4145.585441455845;4170.854020109282;4126.236646220459;4135.710500264982;4149.585041495826;4153.480814898137;4175.269327867611;4112.383142528614;4115.814788334532;4122.752634841919;4150.688698347636;4157.833686652531;4299.871003869889;4370.8033138508845;4446.244138496463;4465.129299786543;4472.217361961676;4691.5308469152815;4703.717776933395;4708.058388322315;4729.763511824395;4749.62003039756;4734.455537613149;4735.408073990751;4742.691725037862;4746.881327966794;4784.641151913585;4323.416338794285;4369.257226271541;4416.84541041062;4449.644028477714;4469.910601787946;4853.272009198648;4855.975720121377;4874.488178741252;4878.292647566083;4922.310876477296;4516.548345165457;4664.137134630104;4667.463241727245;4669.766511674471;4716.009637975995;4704.294355846582;4735.360726301974;4735.668503204812;4785.832495862628;4786.2581299898575;4748.0978614063215;4803.18345881201;4811.639127065414;4820.6143508519235;4844.079624871334;4581.587657110876;4683.531646835358;4756.619470442356;4776.188048031843;4827.662063655511;3986.5016872890887;3988.960110398917;4006.1386801837743;4025.074232926385;4027.2146931348107;3476.0962149840716;3501.5272938153025;3510.543629328222;3531.9293614128087;3539.592946811098;4032.838686452568;4094.774787386663;4111.1366613011605;4141.689373296955;4194.2869712149;4787.569118779326;4794.089123066607;4795.496472870368;4796.160671882407;4838.612910967114;4111.403846442249;4146.170765846843;4148.128892932518;4170.541240463546;4185.455890734185;4123.299039163349;4210.2842516772225;4262.42457268271;4292.892677683083;4310.547392523803;4557.475890272661;4567.862964111082;4590.036092420562;4590.495045545054;4606.792694328763;4771.498992605865;4781.808727650855;4790.0419916016235;4791.880202994953;4828.4688684244;4426.601605855489;4509.909801804011;4563.429571303587;4565.7717114144825;4591.747453890068;4664.3469914211355;4678.60231880294;4703.600193983413;4713.57577817998;4732.621390288838;4755.405574303212;4756.096341695067;4758.904821903473;4762.785674644719;4820.903581928412;4530.048689775184;4558.88602784933;4609.354690343288;4616.6306695464955;4648.465426475998;4625.514320996382;4645;4646.326282689059;4670.906581868276;4696.342512048384;4552.021315417069;4567.566081222279;4569.543045695404;4569.725816451024;4610.677252592421;4483.282674772021;4615.423072115986;4631.58315751584;4653.302004699322;4690.085433340466;4457.375967364636;4461.843835465743;4480.753558554311;4481.798319075584;4524.343970124248 09:45:54 INFO - PROCESS | 13383 | |1;ext.html;471.2507113689234;472.6596850267806;481.71578768526587;493.53361073785277;516.382922407723;23726.762732372692;24220.27339179825;24330.391740206505;24725.752742472592;30384.24039399016;34089;34484.82757586209;34554;34660.30679386417;34806.65193348066;7539.698412063511;7705.6917723291;7726.536407815521;7730.111037230734;7732.381409487228;7428.739994100208;7491.213422590604;7500.924990750077;7506.024216851802;7536.660850261751;7494.587797671154;7744.419168562352;7748.41886858485;7752.302292793647;7752.651130699132;7632;7713.6914523419;7730.458867879251;7734.458587898821;7778.6888524458955;7750.108737495148;7854.8821767673535;7872.291493765589;7873.842523149562;7874.330681892046;34448.82775586131;34879.651203488145;34905;34936;34946.45696059521;2429.4047958250167;2444.181199298237;2537.378342306147;2578.1105518596055;2586.9870650646812;26577.335566610796;26617.733822661914;26878.5968210477;27859.16422507328;28021.85989070062;3336.5495658086093;3441.6214216436174;3443.4146195146886;3524.665156810099;3529.6117427083;225412.99999999837;225987;227776;227843;229091;44576.10847783026;50494.24258636124;51162.744186279575;52267;52291.73854130705;45185.32222016672;45456.318155227695;45533.54466455293;45560.3165952511;45654;11944.402779860971;12134;12180.147389682637;12187;12197.878021219853;7561.432892533082;9068.773280667903;9073.274138068939;9149.359544831797;9305.302102342352;16324.183790810412;16420.425285114965;16591.502254932373;16626.83373166277;16644.334226631043;6315.747370105236;6949.2008419031445;6983.790486285419;7015.61414122218;7058.505904586629;807.0839597057383;817.852786498436;840.6889450903205;927.3971918253054;977.9804403912025;22177;22341.664875026887;22350.888245558668;22382.55234895293;22434.59110409098;835.7701632051235;841.5707988925692;909.3089252168268;914.5061666700041;929.3494553812224;11393.778213248503;11583.710407239887;11691.532338706356;11743.354115523558;11770.88229117715;283679;287500;289007;289582;290312;42425.57574424278;42799.35800962988;42839.357409638884;42924.785376073545;43054;1068.625980906692;1076.7738774857369;1083.312096818526;1112.471576001409;1116.8380584815318;22560.548789024455;23108.653370199125;23393.181238656565;23705;23749;34363.82818085894;34709.47935780915;34804.129896752784;34809.30381392307;34932.82533587417;180410;181649.0917545404;181859;182055.08972455052;182323.08838455722;23775.405614859767;27475.725242747318;28051.158465246077;28131.296717582223;28286.43427131487;31927.201819953756;32162;32345.676543235208;32588.674113258563;32936.67063329336;28277.43445131127;28769.56845647359;29820;30591.54112688356;31321.8433907829;29561.384349621472;29858.253543661584;30491.54262686017;30893;31020.22449438692;29258.853705731333;29415.411691765617;29517;29779.702202977693;29920.102396928127;26154.215373538824;26363.868180658974;26892.865535672197;26925;27485.725142749117;22815;22890;23065;23086.653700194845;23269.3019209424 09:45:54 INFO - PROCESS | 13383 | |2;jquery.html;308.14028859482045;308.8594689416316;316.0486934327674;317.2639476414719;319.1765245666181;10566.814566095052;14894.404223831061;15355.846441535581;15984.120873351962;15992.520224393287;9863.506824658756;12081.395930203498;12491.625251242454;12593.433295501702;12733.872661273384;4380.2115619188535;4739.31279964405;4957.851264462072;4960.305557221992;4963.4540200578085;4907.043126590316;4926.926096108561;4947.727874966876;4953.702777833323;4957.776900039489;3418.418868792299;5300.416954135042;5428.240046393508;5454.127339625641;5516.889662206753;5396.703181325026;5414.214938833847;5420.674759514442;5425.430329815372;5474.91787623186;4767.1419144553965;4804.279358096279;4880.194767863334;4884;4887.560119589254;16210.918945405316;16770.32918683251;16952.491425257263;17015.319387224496;17115.828841711547;1687.4178408449066;1779.146009915235;1853.7497437845852;1913.655542002439;2448.5592593333195;8808.251298639623;9770.853437198448;11334.943325283402;11508.539658413654;12220.633380998584;1751.6409136127063;1762.9911850440665;1798.6762382771096;1800.3608718904732;1818.254515648591;53745.731271343786;55396.446035539535;56445.43554564443;57226.713866430815;57665.42334576642;9371.812563748686;9497.525123743786;9514.33399662017;9527.190188834027;9639.469829159463;12007.51969921211;12107.757844843054;12114.878851211552;12122.575709850113;12138.757224855453;6037.486813620892;6103.6032657877095;6104.847378815565;6180.938190618036;6199.132121502993;5007.148784706608;5307.920381194285;5395.433479484597;5480.451954804487;5487.2317875497465;3851.5378154621626;3908.1402091539817;3916.6083391660604;3948.3090459170103;3999.420084087791;1603.4548253593834;1687.9409220677217;1694;1699.1504247876062;1701.6001239708658;788.4520258420342;844.4173520270994;882.2280504558511;910.8178364327161;930.9115634014757;14181.432742690176;14490.275486225646;14678.651415773425;14768.335424905905;15089.698206035819;777.7277952716504;787.2009909941414;818.8362327534517;850.0946491986015;860.2043110123111;8348.624311905978;8401.915980840236;8437.114103019094;8462.915370846213;8657.826843463095;277274;280996;349520;351677;353553;57258;59661.40338596558;64016.35983640197;66827;67557.66221168863;771.0131032278692;772.4669977715358;775.4920527054788;777.4946284914738;801.2748462641202;13362.732745344843;13469.595912122651;13649.795253071014;13871.86128138746;13978.370973306022;30454.84772576123;31083.668724845276;31495;31971.200719982186;32205.838970804994;43208.56791432171;44193.33709994417;44316.55683443124;44344.778276108416;44650.77674611606;6555.344465553407;6655.567388119756;6736.966315168393;6753.561018533779;6767.898481522682;9858.408495490294;10034.347767395097;10104.797904042025;10336.852889832826;10357.326773759682;8690.174433428814;9023.233025192669;9338.486383248986;9353.017933116926;9492.57283422234;8926.375153739436;9116.225120864801;9246.9537652314;9385.671501497414;9483.715488535356;9061.501617410842;9095.045020272775;9143.817123657356;9615.423074615546;9824.754381140528;6317.7157027932935;6389.648569328731;6392.52056095804;6394.840128996626;6411.743530258737;9149.588268528065;9630.181434578139;9650.324477286522;9681.951590242004;9810.607575696893 09:45:54 INFO - PROCESS | 13383 | |3;mootools.html;1092.7486678064045;1096.7422655675914;1113.7494063835643;1127.7180704823795;1413.7949997250405;6751.561148525342;6937.861242775141;6939.201991770948;6944.270851560589;6945.617991010492;6597.538172327939;6719.126513553231;6727.058211850345;6750.662466876661;6754.189497260336;1703.139914343255;1842.3275504440849;1877.1646617255326;1986.294865322815;2011.979880201194;2034.338839877046;2041.3059559749681;2042.0912693851242;2043.2542122125392;2043.3665563675233;1956.031764276685;1970.7930667279945;2045.5704302096503;2047.1299697628522;2048.672212446009;1978.6933025381088;2011.7083022961735;2013.1846602126163;2022.6662600670873;2027.0472877747436;1922.9807701923082;1932.391296741522;1933.419974007806;1934.4680212941553;1934.7775005874364;6965.233824279325;7027.683754231072;7038.542494737877;7055.823604409879;7065.858682826366;3807.162424266657;3906.2187562487616;3906.687465002793;3909.9218015639813;3913.5695073541888;2448.277758061376;2619.371350875776;2668.2662267876294;2671.7595416412614;2672.398710290189;815.229608020421;885.7298523950193;886.0784783824814;1651.900885946847;1687.173285090297;9196.356255062148;9304.906950930472;9331.813363732688;9334.813303733956;9337.486438245895;3364.747643926715;3520.2431477232517;3598.9100272493397;3599.6400359963795;3601.3157500075426;7501.924980750232;7513.248675132552;7516.549007059484;7520.247975202436;7528.623568821537;3290.588676415448;3762.6425489578446;3832.3868181091448;3847.499825022785;3869.806509674505;3416.79499230047;3471.3404453154326;3485.546878905726;3495.5106285120105;3495.94756078659;2967.9109626711233;3039.3313471036336;3055.908322750321;3071.032624723205;3089.7682673799104;913.2374467319729;915.9542022898828;928.1229238369676;933.9112784285481;935.7613808478794;907.7231444409518;914.2366124286162;921.8202450522218;923.6720964057797;932.6409332407072;5987.191729116514;6013.729382177812;6039.1545183674325;6044.093385992136;6056.424639659225;371.209324139581;381.4088163346801;384.42528420012263;384.45983393332415;385.4545817667968;4859.271109333557;4925.4335751388335;4928.581070608967;4967.230079337708;4973.726445045485;7961.6019199040975;8222.712205072794;8470.364722645827;8666.696665616673;8756.03683594804;8231.506109633441;8320.875186872201;8361.665533378718;8368.246857782708;8383.790405239917;6238.313785483593;6282.685865706696;6296.212973378328;6369;6375.374279558683;6315.147455093504;6322.178116844781;6405.327440618668;6408.455281300955;6427.357264273535;7443.665035073326;7490.325870671666;7583.734569290048;7649.732259370895;7810.531368117704;7780.49426787257;7991.2807847294025;8041.758747237593;8046.436749427484;8077.990251218597;5163.09645811989;5622.465865742748;5982.700864956648;6082.878342433215;6099.573029887865;6188.350223226496;6213.130161777445;6250.1874756281395;6256.280527739368;6257.342978987141;5521.199426083276;5568.331800184003;5677.977963966526;5698.8290351289525;5703.971480142573;5485.204645326485;5564.666120032811;5599.496045355774;5648.15277708347;5686.289213848269;5980.671063091398;5982.282126144891;5982.46157845796;6017.759289628366;6052.909206361996;5552.028395030934;5590.161475778503;5618.494335509824;5623.8875222496135;5631.3242410909315;5666;5675.517581005661;5687.232223649919;5689.800856969986;5700.743466543932 09:45:54 INFO - PROCESS | 13383 | |4;prototype.html;279.66440271673997;281.29675810473816;281.3079823633861;286.6288156836895;287.39503345457797;5009.14844476439;5138.922916156261;5188.896222075561;5197.246399272103;5203.609729270305;5043.31915191449;5156.742162891859;5156.896862062757;5175.792968281274;5189.091908915943;3814.2371525694834;3911.6088391160797;3998.6801055915603;4038.777867217309;4071.5724848890886;4034.0721634024194;4036.1725846201457;4039.899002524946;4049.5343035550995;4055.2092341993325;3996.6403023727858;4010.1177740896956;4014.6386825185728;4015.437838702584;4026.7382620129742;3972.324704800191;4006.258842114218;4007.6192761687885;4013.337799263118;4016.417619445179;3501.369753444379;3502.4396096624673;3520.366334059868;3528.8764893228613;3537.204129070964;4999.75001249936;5011.824586139468;5032.572231360339;5035.219540971156;5043.268726034705;4592.609628181609;4602.171609110359;4603.700759450659;4604.562566556172;4608.9308660370125;5236.293100431431;5445.591580631469;5458.317710286215;5458.61789674723;5461.69960652164;3832.540095188567;3847.961520384816;3852.0562462196663;3852.306584814732;3852.4221366795205;5506;5627.746751396197;5685.289338832646;5712.285964254468;5717.971410142923;3781.0736369589627;3803.1823158021157;3807.7334586578672;3811.6188381162215;3817.1793064491267;3852.5184351956004;3858.2090671412293;3869.2068126034096;3871.728978971445;3876.321643712339;4467.508574056851;4486.528914463935;4488.236999710057;4488.506264310923;4493.7977790999485;5166.974165129151;5297.8145764898045;5435.592330575223;5440.782368705208;5442.374126975448;1390.2492653966947;1410.6614412540916;1411.1885665742238;1414.0384538513704;1414.7170565886863;949.6438835436711;955.2883102088849;968.41894863083;976.272676855747;980.294188184506;4764.094821983812;4769.976150119227;4775.73733444657;4779.689320194177;4782.784774685148;5595.496405323541;5597.692126933058;5598.384177740445;5606.495415412633;5606.97196514023;4764.2615394613895;4768.451628062748;4769.332293478916;4774.904501910012;4779.856604301876;2977.791554591158;3008.2178633554995;3013.9849300753795;3015.6833532479213;3017.4266889290966;5330.067238233293;5343.812966546152;5344.091504444254;5346.304980352529;5353.411124776271;5648.378678345379;5758.798442054508;5833.591648584558;5834.533237341003;5838.79564215259;5345.423100185455;5381.973090134525;5383.353997520323;5394.595405344537;5398.4871437213405;5648.09630459141;5648.124540696199;5656.971715141398;5661.858453538694;5662.122371032497;5534.924403348744;5542.944570554404;5543.695096769717;5544.7782088716;5548.278723765885;5379.838604841861;5391.75737091824;5396.0556902542685;5396.811111611075;5400.270963419888;3632.4369722693023;3758.379867321861;3777.7544459610035;3790.2608991247544;3817.866374676873;5386.730663466733;5506.146547285177;5561.082421400585;5607.074832652566;5610.579206559606;5431.2667789847865;5445.237666726583;5457.072297709319;5458.399576046711;5465.781368745205;5432.945670543244;5435.646682965595;5437.592180586393;5440.945590544202;5445.455454454523;5318.840434786963;5322.920156197582;5326.8014696692935;5327.813526526708;5333.306670132858;5473.863153421196;5476.315460567429;5482.23248745184;5488.56091512686;5490.423505532021;5143.871403214949;5299;5307.230451584576;5313.787448502017;5313.814016509404 09:45:54 INFO - PROCESS | 13383 | |5;yui.html;499.527946090944;534.4468475128243;599.0834023943369;609.0438012320657;619.3465893482376;10049.397036177834;10164.237682173829;10633.893661063386;10689.412082335468;10885.564577416913;8830.426022308546;9071.365004449692;9670.661526846561;10015.349002314844;10114;643.1735220241978;649.3928177154376;656.1797752808989;679.0832376291991;682.0825989044752;647.9967600162016;650.74946145734;650.9739610415578;651.6318280171712;656.1273506236694;669.7153709673394;674.5109795398322;674.8177991942173;683.5488577538825;702.8805103132454;658.06554692337;662.2880403566162;663.3366633366634;665;665.2017578905333;491.8229437402532;492.27635375997227;495.3857217050867;496.26800469307483;502.5828562293288;9171.816563668755;9218.492982885939;9224.769380765467;9287.164155226063;9310.301727370474;7890.368770498347;8530.658773649047;8744.956275218647;8896.466212027299;9160.129787670161;7964.084130325029;8005.559694216816;8137.877931831027;8214.876776848352;9400.858987115198;3442.345954268681;3490.528778614905;3492.0571445709516;3498.1954150545516;3581.230035542345;36273;36723.81638091819;37264.25471490582;41377.172456551;42186.94532636678;8436.873446898302;8694.478331300143;8706.52114133716;8715.389922705477;8754.343424243207;11439.485223164978;13774;13974.301284935713;14033.71932561343;14038.087524310888;5914.822555323347;5939.910901336483;5966.254218222723;6036.6679832609625;6201.782937597162;3435.914102147416;3602.0814692253307;3621.27574485104;3626.188362279633;3700.9444858327147;2464.3592665906995;2466.1491785334033;2488.875556222182;2489.751024897496;2492.8130390220804;441.7150937645201;443.39698010705416;451.04828811208324;460.3233247126718;461.79911738393906;399.43306274964846;450.07060420232114;476.4068734425662;485.922252439608;493.6248451177131;6566.638834864033;6663.233728121231;6699.129113215348;6835.350641689031;6917.031615573824;452.6672895421862;472.6856640334208;474.27199249152386;488.97310647914;495.85868027611957;3167.319026409333;3211.341674956675;3306.5040243963117;3341.665833416639;3385.170633194834;48976.755116224194;49286.75356623194;49436.50563494319;49645.25532116949;49722.502774971785;44450.33324500071;45010.999999999345;45238.54761452409;45784.77107614507;46049;41083.58916410858;41617.37573936393;43263.13473730571;43639.781801090794;44252;7048.365647091787;7339.229380914927;7361.374283185989;7417.109946806202;7517;31058.378832423678;31406.685933140376;31465;31657.20856978594;31672;36989;38254.23491530209;39313.820585382484;40766.79616601898;41606.37590436085;9132.908670913206;9329.486878221764;9441.952790236004;9444.95277523608;9486.905130948602;10484.580616775549;10624.256302058782;10634.41510716918;10808.945955270174;10852.45737713127;8933.15135062168;9157.221636161;9694;9764.511774411108;10243.282970192015;9633.32566720351;9706.75733106678;9913.801723965336;9952.154066904104;10027.649032283834;9073.183413492818;9243.676471323472;9354.95322523383;9388.57751401175;9750.902490975282;8464.280536154496;8524.763909233003;8570.74287771368;8759.562021898751;8815.294776417742;8260.380471464545;8320.625571849161;8467.36494762883;8602.311815054905;8649.524276164871 09:45:54 INFO - PROCESS | 13383 | __end_tp_report 09:45:54 INFO - PROCESS | 13383 | __start_cc_report 09:45:54 INFO - PROCESS | 13383 | _x_x_mozilla_cycle_collect,1006 09:45:54 INFO - PROCESS | 13383 | __end_cc_report 09:45:54 INFO - PROCESS | 13383 | __startTimestamp1457027154782__endTimestamp 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | ------- Summary: start ------- 09:45:54 INFO - PROCESS | 13383 | Number of tests: 6 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | [#0] dojo.html Cycles:165 Average:4408.52 Median:4530.05 stddev:435.07 (9.6%) stddev-sans-first:412.83 09:45:54 INFO - PROCESS | 13383 | Values: 2607.5 2654.7 2691.7 2699.8 2707.9 4315.6 4401.9 4487.4 4510.1 4533.6 4441.4 4476.6 4501.5 4507.6 4531.1 4075.3 4104.7 4128.9 4139.0 4160.7 4055.9 4095.8 4173.0 4184.9 4196.4 4044.1 4082.6 4131.5 4145.6 4170.9 4126.2 4135.7 4149.6 4153.5 4175.3 4112.4 4115.8 4122.8 4150.7 4157.8 4299.9 4370.8 4446.2 4465.1 4472.2 4691.5 4703.7 4708.1 4729.8 4749.6 4734.5 4735.4 4742.7 4746.9 4784.6 4323.4 4369.3 4416.8 4449.6 4469.9 4853.3 4856.0 4874.5 4878.3 4922.3 4516.5 4664.1 4667.5 4669.8 4716.0 4704.3 4735.4 4735.7 4785.8 4786.3 4748.1 4803.2 4811.6 4820.6 4844.1 4581.6 4683.5 4756.6 4776.2 4827.7 3986.5 3989.0 4006.1 4025.1 4027.2 3476.1 3501.5 3510.5 3531.9 3539.6 4032.8 4094.8 4111.1 4141.7 4194.3 4787.6 4794.1 4795.5 4796.2 4838.6 4111.4 4146.2 4148.1 4170.5 4185.5 4123.3 4210.3 4262.4 4292.9 4310.5 4557.5 4567.9 4590.0 4590.5 4606.8 4771.5 4781.8 4790.0 4791.9 4828.5 4426.6 4509.9 4563.4 4565.8 4591.7 4664.3 4678.6 4703.6 4713.6 4732.6 4755.4 4756.1 4758.9 4762.8 4820.9 4530.0 4558.9 4609.4 4616.6 4648.5 4625.5 4645.0 4646.3 4670.9 4696.3 4552.0 4567.6 4569.5 4569.7 4610.7 4483.3 4615.4 4631.6 4653.3 4690.1 4457.4 4461.8 4480.8 4481.8 4524.3 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | [#1] ext.html Cycles:180 Average:37235.43 Median:32044.60 stddev:61831.41 (193.0%) stddev-sans-first:61943.24 09:45:54 INFO - PROCESS | 13383 | Values: 471.3 472.7 481.7 493.5 516.4 23726.8 24220.3 24330.4 24725.8 30384.2 34089.0 34484.8 34554.0 34660.3 34806.7 7539.7 7705.7 7726.5 7730.1 7732.4 7428.7 7491.2 7500.9 7506.0 7536.7 7494.6 7744.4 7748.4 7752.3 7752.7 7632.0 7713.7 7730.5 7734.5 7778.7 7750.1 7854.9 7872.3 7873.8 7874.3 34448.8 34879.7 34905.0 34936.0 34946.5 2429.4 2444.2 2537.4 2578.1 2587.0 26577.3 26617.7 26878.6 27859.2 28021.9 3336.5 3441.6 3443.4 3524.7 3529.6 225413.0 225987.0 227776.0 227843.0 229091.0 44576.1 50494.2 51162.7 52267.0 52291.7 45185.3 45456.3 45533.5 45560.3 45654.0 11944.4 12134.0 12180.1 12187.0 12197.9 7561.4 9068.8 9073.3 9149.4 9305.3 16324.2 16420.4 16591.5 16626.8 16644.3 6315.7 6949.2 6983.8 7015.6 7058.5 807.1 817.9 840.7 927.4 978.0 22177.0 22341.7 22350.9 22382.6 22434.6 835.8 841.6 909.3 914.5 929.3 11393.8 11583.7 11691.5 11743.4 11770.9 283679.0 287500.0 289007.0 289582.0 290312.0 42425.6 42799.4 42839.4 42924.8 43054.0 1068.6 1076.8 1083.3 1112.5 1116.8 22560.5 23108.7 23393.2 23705.0 23749.0 34363.8 34709.5 34804.1 34809.3 34932.8 180410.0 181649.1 181859.0 182055.1 182323.1 23775.4 27475.7 28051.2 28131.3 28286.4 31927.2 32162.0 32345.7 32588.7 32936.7 28277.4 28769.6 29820.0 30591.5 31321.8 29561.4 29858.3 30491.5 30893.0 31020.2 29258.9 29415.4 29517.0 29779.7 29920.1 26154.2 26363.9 26892.9 26925.0 27485.7 22815.0 22890.0 23065.0 23086.7 23269.3 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | [#2] jquery.html Cycles:180 Average:20526.13 Median:4961.88 stddev:53501.57 (1078.3%) stddev-sans-first:53630.12 09:45:54 INFO - PROCESS | 13383 | Values: 308.1 308.9 316.0 317.3 319.2 10566.8 14894.4 15355.8 15984.1 15992.5 9863.5 12081.4 12491.6 12593.4 12733.9 4380.2 4739.3 4957.9 4960.3 4963.5 4907.0 4926.9 4947.7 4953.7 4957.8 3418.4 5300.4 5428.2 5454.1 5516.9 5396.7 5414.2 5420.7 5425.4 5474.9 4767.1 4804.3 4880.2 4884.0 4887.6 16210.9 16770.3 16952.5 17015.3 17115.8 1687.4 1779.1 1853.7 1913.7 2448.6 8808.3 9770.9 11334.9 11508.5 12220.6 1751.6 1763.0 1798.7 1800.4 1818.3 53745.7 55396.4 56445.4 57226.7 57665.4 9371.8 9497.5 9514.3 9527.2 9639.5 12007.5 12107.8 12114.9 12122.6 12138.8 6037.5 6103.6 6104.8 6180.9 6199.1 5007.1 5307.9 5395.4 5480.5 5487.2 3851.5 3908.1 3916.6 3948.3 3999.4 1603.5 1687.9 1694.0 1699.2 1701.6 788.5 844.4 882.2 910.8 930.9 14181.4 14490.3 14678.7 14768.3 15089.7 777.7 787.2 818.8 850.1 860.2 8348.6 8401.9 8437.1 8462.9 8657.8 277274.0 280996.0 349520.0 351677.0 353553.0 57258.0 59661.4 64016.4 66827.0 67557.7 771.0 772.5 775.5 777.5 801.3 13362.7 13469.6 13649.8 13871.9 13978.4 30454.8 31083.7 31495.0 31971.2 32205.8 43208.6 44193.3 44316.6 44344.8 44650.8 6555.3 6655.6 6737.0 6753.6 6767.9 9858.4 10034.3 10104.8 10336.9 10357.3 8690.2 9023.2 9338.5 9353.0 9492.6 8926.4 9116.2 9247.0 9385.7 9483.7 9061.5 9095.0 9143.8 9615.4 9824.8 6317.7 6389.6 6392.5 6394.8 6411.7 9149.6 9630.2 9650.3 9682.0 9810.6 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | [#3] mootools.html Cycles:180 Average:4686.85 Median:5694.31 stddev:2516.72 (44.2%) stddev-sans-first:2509.28 09:45:54 INFO - PROCESS | 13383 | Values: 1092.7 1096.7 1113.7 1127.7 1413.8 6751.6 6937.9 6939.2 6944.3 6945.6 6597.5 6719.1 6727.1 6750.7 6754.2 1703.1 1842.3 1877.2 1986.3 2012.0 2034.3 2041.3 2042.1 2043.3 2043.4 1956.0 1970.8 2045.6 2047.1 2048.7 1978.7 2011.7 2013.2 2022.7 2027.0 1923.0 1932.4 1933.4 1934.5 1934.8 6965.2 7027.7 7038.5 7055.8 7065.9 3807.2 3906.2 3906.7 3909.9 3913.6 2448.3 2619.4 2668.3 2671.8 2672.4 815.2 885.7 886.1 1651.9 1687.2 9196.4 9304.9 9331.8 9334.8 9337.5 3364.7 3520.2 3598.9 3599.6 3601.3 7501.9 7513.2 7516.5 7520.2 7528.6 3290.6 3762.6 3832.4 3847.5 3869.8 3416.8 3471.3 3485.5 3495.5 3495.9 2967.9 3039.3 3055.9 3071.0 3089.8 913.2 916.0 928.1 933.9 935.8 907.7 914.2 921.8 923.7 932.6 5987.2 6013.7 6039.2 6044.1 6056.4 371.2 381.4 384.4 384.5 385.5 4859.3 4925.4 4928.6 4967.2 4973.7 7961.6 8222.7 8470.4 8666.7 8756.0 8231.5 8320.9 8361.7 8368.2 8383.8 6238.3 6282.7 6296.2 6369.0 6375.4 6315.1 6322.2 6405.3 6408.5 6427.4 7443.7 7490.3 7583.7 7649.7 7810.5 7780.5 7991.3 8041.8 8046.4 8078.0 5163.1 5622.5 5982.7 6082.9 6099.6 6188.4 6213.1 6250.2 6256.3 6257.3 5521.2 5568.3 5678.0 5698.8 5704.0 5485.2 5564.7 5599.5 5648.2 5686.3 5980.7 5982.3 5982.5 6017.8 6052.9 5552.0 5590.2 5618.5 5623.9 5631.3 5666.0 5675.5 5687.2 5689.8 5700.7 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | [#4] prototype.html Cycles:180 Average:4501.56 Median:5161.94 stddev:1324.05 (25.7%) stddev-sans-first:1289.29 09:45:54 INFO - PROCESS | 13383 | Values: 279.7 281.3 281.3 286.6 287.4 5009.1 5138.9 5188.9 5197.2 5203.6 5043.3 5156.7 5156.9 5175.8 5189.1 3814.2 3911.6 3998.7 4038.8 4071.6 4034.1 4036.2 4039.9 4049.5 4055.2 3996.6 4010.1 4014.6 4015.4 4026.7 3972.3 4006.3 4007.6 4013.3 4016.4 3501.4 3502.4 3520.4 3528.9 3537.2 4999.8 5011.8 5032.6 5035.2 5043.3 4592.6 4602.2 4603.7 4604.6 4608.9 5236.3 5445.6 5458.3 5458.6 5461.7 3832.5 3848.0 3852.1 3852.3 3852.4 5506.0 5627.7 5685.3 5712.3 5718.0 3781.1 3803.2 3807.7 3811.6 3817.2 3852.5 3858.2 3869.2 3871.7 3876.3 4467.5 4486.5 4488.2 4488.5 4493.8 5167.0 5297.8 5435.6 5440.8 5442.4 1390.2 1410.7 1411.2 1414.0 1414.7 949.6 955.3 968.4 976.3 980.3 4764.1 4770.0 4775.7 4779.7 4782.8 5595.5 5597.7 5598.4 5606.5 5607.0 4764.3 4768.5 4769.3 4774.9 4779.9 2977.8 3008.2 3014.0 3015.7 3017.4 5330.1 5343.8 5344.1 5346.3 5353.4 5648.4 5758.8 5833.6 5834.5 5838.8 5345.4 5382.0 5383.4 5394.6 5398.5 5648.1 5648.1 5657.0 5661.9 5662.1 5534.9 5542.9 5543.7 5544.8 5548.3 5379.8 5391.8 5396.1 5396.8 5400.3 3632.4 3758.4 3777.8 3790.3 3817.9 5386.7 5506.1 5561.1 5607.1 5610.6 5431.3 5445.2 5457.1 5458.4 5465.8 5432.9 5435.6 5437.6 5440.9 5445.5 5318.8 5322.9 5326.8 5327.8 5333.3 5473.9 5476.3 5482.2 5488.6 5490.4 5143.9 5299.0 5307.2 5313.8 5313.8 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | [#5] yui.html Cycles:180 Average:11650.77 Median:3224.63 stddev:13967.75 (433.2%) stddev-sans-first:13981.83 09:45:54 INFO - PROCESS | 13383 | Values: 499.5 534.4 599.1 609.0 619.3 10049.4 10164.2 10633.9 10689.4 10885.6 8830.4 9071.4 9670.7 10015.3 10114.0 643.2 649.4 656.2 679.1 682.1 648.0 650.7 651.0 651.6 656.1 669.7 674.5 674.8 683.5 702.9 658.1 662.3 663.3 665.0 665.2 491.8 492.3 495.4 496.3 502.6 9171.8 9218.5 9224.8 9287.2 9310.3 7890.4 8530.7 8745.0 8896.5 9160.1 7964.1 8005.6 8137.9 8214.9 9400.9 3442.3 3490.5 3492.1 3498.2 3581.2 36273.0 36723.8 37264.3 41377.2 42186.9 8436.9 8694.5 8706.5 8715.4 8754.3 11439.5 13774.0 13974.3 14033.7 14038.1 5914.8 5939.9 5966.3 6036.7 6201.8 3435.9 3602.1 3621.3 3626.2 3700.9 2464.4 2466.1 2488.9 2489.8 2492.8 441.7 443.4 451.0 460.3 461.8 399.4 450.1 476.4 485.9 493.6 6566.6 6663.2 6699.1 6835.4 6917.0 452.7 472.7 474.3 489.0 495.9 3167.3 3211.3 3306.5 3341.7 3385.2 48976.8 49286.8 49436.5 49645.3 49722.5 44450.3 45011.0 45238.5 45784.8 46049.0 41083.6 41617.4 43263.1 43639.8 44252.0 7048.4 7339.2 7361.4 7417.1 7517.0 31058.4 31406.7 31465.0 31657.2 31672.0 36989.0 38254.2 39313.8 40766.8 41606.4 9132.9 9329.5 9442.0 9445.0 9486.9 10484.6 10624.3 10634.4 10808.9 10852.5 8933.2 9157.2 9694.0 9764.5 10243.3 9633.3 9706.8 9913.8 9952.2 10027.6 9073.2 9243.7 9355.0 9388.6 9750.9 8464.3 8524.8 8570.7 8759.6 8815.3 8260.4 8320.6 8467.4 8602.3 8649.5 09:45:54 INFO - PROCESS | 13383 | -------- Summary: end -------- 09:45:54 INFO - PROCESS | 13383 | 09:45:54 INFO - PROCESS | 13383 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:54 INFO - PROCESS | 13383 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:54 INFO - PROCESS | 13383 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:54 INFO - PROCESS | 13383 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:54 INFO - PROCESS | 13383 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:54 INFO - PROCESS | 13383 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:54 INFO - PROCESS | 13383 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:45:55 INFO - TEST-INFO | 13383: exit 0 09:45:55 INFO - TEST-OK | dromaeo_css | took 1116378ms 09:45:55 INFO - TEST-START | kraken 09:45:55 INFO - operating with platform_type : linux_ 09:45:55 INFO - Initialising browser for kraken test... 09:45:55 INFO - TEST-INFO | started process 13564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHYNfoV/profile http://localhost:53742/getInfo.html) 09:45:59 INFO - PROCESS | 13564 | __metrics Screen width/height:1600/1200 09:45:59 INFO - PROCESS | 13564 | colorDepth:24 09:45:59 INFO - PROCESS | 13564 | Browser inner width/height: 1024/697 09:45:59 INFO - PROCESS | 13564 | __metrics 09:46:00 INFO - PROCESS | 13564 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:00 INFO - PROCESS | 13564 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:00 INFO - PROCESS | 13564 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:00 INFO - PROCESS | 13564 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:00 INFO - PROCESS | 13564 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:00 INFO - PROCESS | 13564 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:00 INFO - PROCESS | 13564 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:00 INFO - PROCESS | 13564 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:46:01 INFO - TEST-INFO | 13564: exit 0 09:46:01 INFO - Browser initialized. 09:46:01 INFO - Running cycle 1/1 for kraken test... 09:46:01 INFO - TEST-INFO | started process 13645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHYNfoV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:13 INFO - PROCESS | 13645 | RSS: Main: 153546752 09:46:13 INFO - PROCESS | 13645 | 09:46:15 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-beat-detection) 09:46:16 INFO - PROCESS | 13645 | RSS: Main: 195284992 09:46:16 INFO - PROCESS | 13645 | 09:46:19 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-dft) 09:46:19 INFO - PROCESS | 13645 | RSS: Main: 185253888 09:46:19 INFO - PROCESS | 13645 | 09:46:22 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-fft) 09:46:23 INFO - PROCESS | 13645 | RSS: Main: 173228032 09:46:23 INFO - PROCESS | 13645 | 09:46:25 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-oscillator) 09:46:25 INFO - PROCESS | 13645 | RSS: Main: 172453888 09:46:25 INFO - PROCESS | 13645 | 09:46:28 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:46:28 INFO - PROCESS | 13645 | RSS: Main: 174260224 09:46:28 INFO - PROCESS | 13645 | 09:46:31 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53742/tests/kraken/driver.html?testName=imaging-darkroom) 09:46:32 INFO - PROCESS | 13645 | RSS: Main: 176041984 09:46:32 INFO - PROCESS | 13645 | 09:46:35 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53742/tests/kraken/driver.html?testName=imaging-desaturate) 09:46:36 INFO - PROCESS | 13645 | RSS: Main: 176345088 09:46:36 INFO - PROCESS | 13645 | 09:46:39 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53742/tests/kraken/driver.html?testName=json-parse-financial) 09:46:39 INFO - PROCESS | 13645 | RSS: Main: 177270784 09:46:39 INFO - PROCESS | 13645 | 09:46:41 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:46:42 INFO - PROCESS | 13645 | RSS: Main: 185028608 09:46:42 INFO - PROCESS | 13645 | 09:46:44 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:46:44 INFO - PROCESS | 13645 | RSS: Main: 184033280 09:46:44 INFO - PROCESS | 13645 | 09:46:46 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:46:47 INFO - PROCESS | 13645 | RSS: Main: 194822144 09:46:47 INFO - PROCESS | 13645 | 09:46:49 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:50 INFO - PROCESS | 13645 | RSS: Main: 200294400 09:46:50 INFO - PROCESS | 13645 | 09:46:53 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:53 INFO - PROCESS | 13645 | RSS: Main: 199172096 09:46:53 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53742/tests/kraken/driver.html?testName=ai-astar) 09:46:55 INFO - PROCESS | 13645 | RSS: Main: 259538944 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | __start_tp_report 09:46:55 INFO - PROCESS | 13645 | _x_x_mozilla_page_load 09:46:55 INFO - PROCESS | 13645 | _x_x_mozilla_page_load_details 09:46:55 INFO - PROCESS | 13645 | |i|pagename|runs| 09:46:55 INFO - PROCESS | 13645 | |0;ai-astar;112;114;107;113;114;116;103;112;113;114 09:46:55 INFO - PROCESS | 13645 | |1;audio-beat-detection;155;135;157;165;133;156;165;136;174;136 09:46:55 INFO - PROCESS | 13645 | |2;audio-dft;162;161;162;165;160;160;162;161;161;159 09:46:55 INFO - PROCESS | 13645 | |3;audio-fft;74;76;113;95;75;74;73;109;92;73 09:46:55 INFO - PROCESS | 13645 | |4;audio-oscillator;95;95;142;95;94;95;135;94;94;130 09:46:55 INFO - PROCESS | 13645 | |5;imaging-gaussian-blur;118;117;116;118;117;116;116;116;116;117 09:46:55 INFO - PROCESS | 13645 | |6;imaging-darkroom;147;147;148;148;148;147;146;146;147;147 09:46:55 INFO - PROCESS | 13645 | |7;imaging-desaturate;96;96;95;96;95;96;96;95;95;95 09:46:55 INFO - PROCESS | 13645 | |8;json-parse-financial;67;67;76;66;66;67;67;77;65;63 09:46:55 INFO - PROCESS | 13645 | |9;json-stringify-tinderbox;70;71;70;70;72;71;70;71;70;70 09:46:55 INFO - PROCESS | 13645 | |10;stanford-crypto-aes;82;83;83;92;83;82;98;83;84;82 09:46:55 INFO - PROCESS | 13645 | |11;stanford-crypto-ccm;122;118;121;118;121;123;123;123;120;130 09:46:55 INFO - PROCESS | 13645 | |12;stanford-crypto-pbkdf2;146;139;148;147;148;135;149;147;146;147 09:46:55 INFO - PROCESS | 13645 | |13;stanford-crypto-sha256-iterative;73;72;70;70;72;68;71;71;70;69 09:46:55 INFO - PROCESS | 13645 | __end_tp_report 09:46:55 INFO - PROCESS | 13645 | __start_cc_report 09:46:55 INFO - PROCESS | 13645 | _x_x_mozilla_cycle_collect,1196 09:46:55 INFO - PROCESS | 13645 | __end_cc_report 09:46:55 INFO - PROCESS | 13645 | __startTimestamp1457027215872__endTimestamp 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | ------- Summary: start ------- 09:46:55 INFO - PROCESS | 13645 | Number of tests: 14 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:3.88 (3.4%) stddev-sans-first:4.12 09:46:55 INFO - PROCESS | 13645 | Values: 112.0 114.0 107.0 113.0 114.0 116.0 103.0 112.0 113.0 114.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:156.50 stddev:15.01 (9.6%) stddev-sans-first:15.86 09:46:55 INFO - PROCESS | 13645 | Values: 155.0 135.0 157.0 165.0 133.0 156.0 165.0 136.0 174.0 136.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.64 (1.0%) stddev-sans-first:1.72 09:46:55 INFO - PROCESS | 13645 | Values: 162.0 161.0 162.0 165.0 160.0 160.0 162.0 161.0 161.0 159.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#3] audio-fft Cycles:10 Average:85.40 Median:74.50 stddev:15.70 (21.1%) stddev-sans-first:16.10 09:46:55 INFO - PROCESS | 13645 | Values: 74.0 76.0 113.0 95.0 75.0 74.0 73.0 109.0 92.0 73.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:94.50 stddev:20.06 (21.2%) stddev-sans-first:20.81 09:46:55 INFO - PROCESS | 13645 | Values: 95.0 95.0 142.0 95.0 94.0 95.0 135.0 94.0 94.0 130.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 09:46:55 INFO - PROCESS | 13645 | Values: 118.0 117.0 116.0 118.0 117.0 116.0 116.0 116.0 116.0 117.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:46:55 INFO - PROCESS | 13645 | Values: 147.0 147.0 148.0 148.0 148.0 147.0 146.0 146.0 147.0 147.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:46:55 INFO - PROCESS | 13645 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:67.00 stddev:4.61 (6.9%) stddev-sans-first:4.87 09:46:55 INFO - PROCESS | 13645 | Values: 67.0 67.0 76.0 66.0 66.0 67.0 67.0 77.0 65.0 63.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 09:46:55 INFO - PROCESS | 13645 | Values: 70.0 71.0 70.0 70.0 72.0 71.0 70.0 71.0 70.0 70.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.00 stddev:5.39 (6.5%) stddev-sans-first:5.59 09:46:55 INFO - PROCESS | 13645 | Values: 82.0 83.0 83.0 92.0 83.0 82.0 98.0 83.0 84.0 82.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:122.50 stddev:3.41 (2.8%) stddev-sans-first:3.62 09:46:55 INFO - PROCESS | 13645 | Values: 122.0 118.0 121.0 118.0 121.0 123.0 123.0 123.0 120.0 130.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:147.00 stddev:4.52 (3.1%) stddev-sans-first:4.78 09:46:55 INFO - PROCESS | 13645 | Values: 146.0 139.0 148.0 147.0 148.0 135.0 149.0 147.0 146.0 147.0 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.51 (2.1%) stddev-sans-first:1.32 09:46:55 INFO - PROCESS | 13645 | Values: 73.0 72.0 70.0 70.0 72.0 68.0 71.0 71.0 70.0 69.0 09:46:55 INFO - PROCESS | 13645 | -------- Summary: end -------- 09:46:55 INFO - PROCESS | 13645 | 09:46:55 INFO - PROCESS | 13645 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:55 INFO - PROCESS | 13645 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:55 INFO - PROCESS | 13645 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:55 INFO - PROCESS | 13645 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:55 INFO - PROCESS | 13645 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:46:56 INFO - TEST-INFO | 13645: exit 0 09:46:56 INFO - TEST-OK | kraken | took 61301ms 09:46:56 INFO - SUITE-END | took 1177s 09:46:57 INFO - Completed test suite (00:19:37) 09:46:57 INFO - Working with test: dromaeo_css 09:46:57 INFO - Generating results file: dromaeo_css 09:46:57 INFO - Working with test: kraken 09:46:57 INFO - Generating results file: kraken 09:46:57 INFO - javascript benchmark 09:46:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 09:46:57 INFO - process_Request line: dromaeo_css 5805.94 graph.html#tests=[[72,94,35]] 09:46:57 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:57 INFO - process_Request line: kraken 1537.40 graph.html#tests=[[232,94,35]] 09:46:57 INFO - RETURN: dromaeo_css: 5805.94 09:46:57 INFO - RETURN: kraken: 1537.40 09:46:57 INFO - javascript benchmark 09:46:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2607.504574130915, 2654.707982121965, 2691.676998760149, 2699.838009719416, 2707.9458410831785, 4315.568443155683, 4401.867943961686, 4487.3942017827585, 4510.07543453592, 4533.569310915462, 4441.356003379508, 4476.597106260436, 4501.459824821018, 4507.639388848893, 4531.071130418264, 4075.32757095079, 4104.733192342503, 4128.8761337159785, 4139.027328577782, 4160.667146628278, 4055.9391609125887, 4095.815688294019, 4172.97913510432, 4184.8744537663915, 4196.370544418346, 4044.1102957349335, 4082.5917408259234, 4131.5248746394245, 4145.585441455845, 4170.854020109282, 4126.236646220459, 4135.710500264982, 4149.585041495826, 4153.480814898137, 4175.269327867611, 4112.383142528614, 4115.814788334532, 4122.752634841919, 4150.688698347636, 4157.833686652531, 4299.871003869889, 4370.8033138508845, 4446.244138496463, 4465.129299786543, 4472.217361961676, 4691.5308469152815, 4703.717776933395, 4708.058388322315, 4729.763511824395, 4749.62003039756, 4734.455537613149, 4735.408073990751, 4742.691725037862, 4746.881327966794, 4784.641151913585, 4323.416338794285, 4369.257226271541, 4416.84541041062, 4449.644028477714, 4469.910601787946, 4853.272009198648, 4855.975720121377, 4874.488178741252, 4878.292647566083, 4922.310876477296, 4516.548345165457, 4664.137134630104, 4667.463241727245, 4669.766511674471, 4716.009637975995, 4704.294355846582, 4735.360726301974, 4735.668503204812, 4785.832495862628, 4786.2581299898575, 4748.0978614063215, 4803.18345881201, 4811.639127065414, 4820.6143508519235, 4844.079624871334, 4581.587657110876, 4683.531646835358, 4756.619470442356, 4776.188048031843, 4827.662063655511, 3986.5016872890887, 3988.960110398917, 4006.1386801837743, 4025.074232926385, 4027.2146931348107, 3476.0962149840716, 3501.5272938153025, 3510.543629328222, 3531.9293614128087, 3539.592946811098, 4032.838686452568, 4094.774787386663, 4111.1366613011605, 4141.689373296955, 4194.2869712149, 4787.569118779326, 4794.089123066607, 4795.496472870368, 4796.160671882407, 4838.612910967114, 4111.403846442249, 4146.170765846843, 4148.128892932518, 4170.541240463546, 4185.455890734185, 4123.299039163349, 4210.2842516772225, 4262.42457268271, 4292.892677683083, 4310.547392523803, 4557.475890272661, 4567.862964111082, 4590.036092420562, 4590.495045545054, 4606.792694328763, 4771.498992605865, 4781.808727650855, 4790.0419916016235, 4791.880202994953, 4828.4688684244, 4426.601605855489, 4509.909801804011, 4563.429571303587, 4565.7717114144825, 4591.747453890068, 4664.3469914211355, 4678.60231880294, 4703.600193983413, 4713.57577817998, 4732.621390288838, 4755.405574303212, 4756.096341695067, 4758.904821903473, 4762.785674644719, 4820.903581928412, 4530.048689775184, 4558.88602784933, 4609.354690343288, 4616.6306695464955, 4648.465426475998, 4625.514320996382, 4645.0, 4646.326282689059, 4670.906581868276, 4696.342512048384, 4552.021315417069, 4567.566081222279, 4569.543045695404, 4569.725816451024, 4610.677252592421, 4483.282674772021, 4615.423072115986, 4631.58315751584, 4653.302004699322, 4690.085433340466, 4457.375967364636, 4461.843835465743, 4480.753558554311, 4481.798319075584, 4524.343970124248], "unit": "score", "name": "dojo.html", "value": 4383.270731801629}, {"lowerIsBetter": false, "replicates": [471.2507113689234, 472.6596850267806, 481.71578768526587, 493.53361073785277, 516.382922407723, 23726.762732372692, 24220.27339179825, 24330.391740206505, 24725.752742472592, 30384.24039399016, 34089.0, 34484.82757586209, 34554.0, 34660.30679386417, 34806.65193348066, 7539.698412063511, 7705.6917723291, 7726.536407815521, 7730.111037230734, 7732.381409487228, 7428.739994100208, 7491.213422590604, 7500.924990750077, 7506.024216851802, 7536.660850261751, 7494.587797671154, 7744.419168562352, 7748.41886858485, 7752.302292793647, 7752.651130699132, 7632.0, 7713.6914523419, 7730.458867879251, 7734.458587898821, 7778.6888524458955, 7750.108737495148, 7854.8821767673535, 7872.291493765589, 7873.842523149562, 7874.330681892046, 34448.82775586131, 34879.651203488145, 34905.0, 34936.0, 34946.45696059521, 2429.4047958250167, 2444.181199298237, 2537.378342306147, 2578.1105518596055, 2586.9870650646812, 26577.335566610796, 26617.733822661914, 26878.5968210477, 27859.16422507328, 28021.85989070062, 3336.5495658086093, 3441.6214216436174, 3443.4146195146886, 3524.665156810099, 3529.6117427083, 225412.99999999837, 225987.0, 227776.0, 227843.0, 229091.0, 44576.10847783026, 50494.24258636124, 51162.744186279575, 52267.0, 52291.73854130705, 45185.32222016672, 45456.318155227695, 45533.54466455293, 45560.3165952511, 45654.0, 11944.402779860971, 12134.0, 12180.147389682637, 12187.0, 12197.878021219853, 7561.432892533082, 9068.773280667903, 9073.274138068939, 9149.359544831797, 9305.302102342352, 16324.183790810412, 16420.425285114965, 16591.502254932373, 16626.83373166277, 16644.334226631043, 6315.747370105236, 6949.2008419031445, 6983.790486285419, 7015.61414122218, 7058.505904586629, 807.0839597057383, 817.852786498436, 840.6889450903205, 927.3971918253054, 977.9804403912025, 22177.0, 22341.664875026887, 22350.888245558668, 22382.55234895293, 22434.59110409098, 835.7701632051235, 841.5707988925692, 909.3089252168268, 914.5061666700041, 929.3494553812224, 11393.778213248503, 11583.710407239887, 11691.532338706356, 11743.354115523558, 11770.88229117715, 283679.0, 287500.0, 289007.0, 289582.0, 290312.0, 42425.57574424278, 42799.35800962988, 42839.357409638884, 42924.785376073545, 43054.0, 1068.625980906692, 1076.7738774857369, 1083.312096818526, 1112.471576001409, 1116.8380584815318, 22560.548789024455, 23108.653370199125, 23393.181238656565, 23705.0, 23749.0, 34363.82818085894, 34709.47935780915, 34804.129896752784, 34809.30381392307, 34932.82533587417, 180410.0, 181649.0917545404, 181859.0, 182055.08972455052, 182323.08838455722, 23775.405614859767, 27475.725242747318, 28051.158465246077, 28131.296717582223, 28286.43427131487, 31927.201819953756, 32162.0, 32345.676543235208, 32588.674113258563, 32936.67063329336, 28277.43445131127, 28769.56845647359, 29820.0, 30591.54112688356, 31321.8433907829, 29561.384349621472, 29858.253543661584, 30491.54262686017, 30893.0, 31020.22449438692, 29258.853705731333, 29415.411691765617, 29517.0, 29779.702202977693, 29920.102396928127, 26154.215373538824, 26363.868180658974, 26892.865535672197, 26925.0, 27485.725142749117, 22815.0, 22890.0, 23065.0, 23086.653700194845, 23269.3019209424], "unit": "score", "name": "ext.html", "value": 15192.377690029938}, {"lowerIsBetter": false, "replicates": [308.14028859482045, 308.8594689416316, 316.0486934327674, 317.2639476414719, 319.1765245666181, 10566.814566095052, 14894.404223831061, 15355.846441535581, 15984.120873351962, 15992.520224393287, 9863.506824658756, 12081.395930203498, 12491.625251242454, 12593.433295501702, 12733.872661273384, 4380.2115619188535, 4739.31279964405, 4957.851264462072, 4960.305557221992, 4963.4540200578085, 4907.043126590316, 4926.926096108561, 4947.727874966876, 4953.702777833323, 4957.776900039489, 3418.418868792299, 5300.416954135042, 5428.240046393508, 5454.127339625641, 5516.889662206753, 5396.703181325026, 5414.214938833847, 5420.674759514442, 5425.430329815372, 5474.91787623186, 4767.1419144553965, 4804.279358096279, 4880.194767863334, 4884.0, 4887.560119589254, 16210.918945405316, 16770.32918683251, 16952.491425257263, 17015.319387224496, 17115.828841711547, 1687.4178408449066, 1779.146009915235, 1853.7497437845852, 1913.655542002439, 2448.5592593333195, 8808.251298639623, 9770.853437198448, 11334.943325283402, 11508.539658413654, 12220.633380998584, 1751.6409136127063, 1762.9911850440665, 1798.6762382771096, 1800.3608718904732, 1818.254515648591, 53745.731271343786, 55396.446035539535, 56445.43554564443, 57226.713866430815, 57665.42334576642, 9371.812563748686, 9497.525123743786, 9514.33399662017, 9527.190188834027, 9639.469829159463, 12007.51969921211, 12107.757844843054, 12114.878851211552, 12122.575709850113, 12138.757224855453, 6037.486813620892, 6103.6032657877095, 6104.847378815565, 6180.938190618036, 6199.132121502993, 5007.148784706608, 5307.920381194285, 5395.433479484597, 5480.451954804487, 5487.2317875497465, 3851.5378154621626, 3908.1402091539817, 3916.6083391660604, 3948.3090459170103, 3999.420084087791, 1603.4548253593834, 1687.9409220677217, 1694.0, 1699.1504247876062, 1701.6001239708658, 788.4520258420342, 844.4173520270994, 882.2280504558511, 910.8178364327161, 930.9115634014757, 14181.432742690176, 14490.275486225646, 14678.651415773425, 14768.335424905905, 15089.698206035819, 777.7277952716504, 787.2009909941414, 818.8362327534517, 850.0946491986015, 860.2043110123111, 8348.624311905978, 8401.915980840236, 8437.114103019094, 8462.915370846213, 8657.826843463095, 277274.0, 280996.0, 349520.0, 351677.0, 353553.0, 57258.0, 59661.40338596558, 64016.35983640197, 66827.0, 67557.66221168863, 771.0131032278692, 772.4669977715358, 775.4920527054788, 777.4946284914738, 801.2748462641202, 13362.732745344843, 13469.595912122651, 13649.795253071014, 13871.86128138746, 13978.370973306022, 30454.84772576123, 31083.668724845276, 31495.0, 31971.200719982186, 32205.838970804994, 43208.56791432171, 44193.33709994417, 44316.55683443124, 44344.778276108416, 44650.77674611606, 6555.344465553407, 6655.567388119756, 6736.966315168393, 6753.561018533779, 6767.898481522682, 9858.408495490294, 10034.347767395097, 10104.797904042025, 10336.852889832826, 10357.326773759682, 8690.174433428814, 9023.233025192669, 9338.486383248986, 9353.017933116926, 9492.57283422234, 8926.375153739436, 9116.225120864801, 9246.9537652314, 9385.671501497414, 9483.715488535356, 9061.501617410842, 9095.045020272775, 9143.817123657356, 9615.423074615546, 9824.754381140528, 6317.7157027932935, 6389.648569328731, 6392.52056095804, 6394.840128996626, 6411.743530258737, 9149.588268528065, 9630.181434578139, 9650.324477286522, 9681.951590242004, 9810.607575696893], "unit": "score", "name": "jquery.html", "value": 7316.7549724483815}, {"lowerIsBetter": false, "replicates": [1092.7486678064045, 1096.7422655675914, 1113.7494063835643, 1127.7180704823795, 1413.7949997250405, 6751.561148525342, 6937.861242775141, 6939.201991770948, 6944.270851560589, 6945.617991010492, 6597.538172327939, 6719.126513553231, 6727.058211850345, 6750.662466876661, 6754.189497260336, 1703.139914343255, 1842.3275504440849, 1877.1646617255326, 1986.294865322815, 2011.979880201194, 2034.338839877046, 2041.3059559749681, 2042.0912693851242, 2043.2542122125392, 2043.3665563675233, 1956.031764276685, 1970.7930667279945, 2045.5704302096503, 2047.1299697628522, 2048.672212446009, 1978.6933025381088, 2011.7083022961735, 2013.1846602126163, 2022.6662600670873, 2027.0472877747436, 1922.9807701923082, 1932.391296741522, 1933.419974007806, 1934.4680212941553, 1934.7775005874364, 6965.233824279325, 7027.683754231072, 7038.542494737877, 7055.823604409879, 7065.858682826366, 3807.162424266657, 3906.2187562487616, 3906.687465002793, 3909.9218015639813, 3913.5695073541888, 2448.277758061376, 2619.371350875776, 2668.2662267876294, 2671.7595416412614, 2672.398710290189, 815.229608020421, 885.7298523950193, 886.0784783824814, 1651.900885946847, 1687.173285090297, 9196.356255062148, 9304.906950930472, 9331.813363732688, 9334.813303733956, 9337.486438245895, 3364.747643926715, 3520.2431477232517, 3598.9100272493397, 3599.6400359963795, 3601.3157500075426, 7501.924980750232, 7513.248675132552, 7516.549007059484, 7520.247975202436, 7528.623568821537, 3290.588676415448, 3762.6425489578446, 3832.3868181091448, 3847.499825022785, 3869.806509674505, 3416.79499230047, 3471.3404453154326, 3485.546878905726, 3495.5106285120105, 3495.94756078659, 2967.9109626711233, 3039.3313471036336, 3055.908322750321, 3071.032624723205, 3089.7682673799104, 913.2374467319729, 915.9542022898828, 928.1229238369676, 933.9112784285481, 935.7613808478794, 907.7231444409518, 914.2366124286162, 921.8202450522218, 923.6720964057797, 932.6409332407072, 5987.191729116514, 6013.729382177812, 6039.1545183674325, 6044.093385992136, 6056.424639659225, 371.209324139581, 381.4088163346801, 384.42528420012263, 384.45983393332415, 385.4545817667968, 4859.271109333557, 4925.4335751388335, 4928.581070608967, 4967.230079337708, 4973.726445045485, 7961.6019199040975, 8222.712205072794, 8470.364722645827, 8666.696665616673, 8756.03683594804, 8231.506109633441, 8320.875186872201, 8361.665533378718, 8368.246857782708, 8383.790405239917, 6238.313785483593, 6282.685865706696, 6296.212973378328, 6369.0, 6375.374279558683, 6315.147455093504, 6322.178116844781, 6405.327440618668, 6408.455281300955, 6427.357264273535, 7443.665035073326, 7490.325870671666, 7583.734569290048, 7649.732259370895, 7810.531368117704, 7780.49426787257, 7991.2807847294025, 8041.758747237593, 8046.436749427484, 8077.990251218597, 5163.09645811989, 5622.465865742748, 5982.700864956648, 6082.878342433215, 6099.573029887865, 6188.350223226496, 6213.130161777445, 6250.1874756281395, 6256.280527739368, 6257.342978987141, 5521.199426083276, 5568.331800184003, 5677.977963966526, 5698.8290351289525, 5703.971480142573, 5485.204645326485, 5564.666120032811, 5599.496045355774, 5648.15277708347, 5686.289213848269, 5980.671063091398, 5982.282126144891, 5982.46157845796, 6017.759289628366, 6052.909206361996, 5552.028395030934, 5590.161475778503, 5618.494335509824, 5623.8875222496135, 5631.3242410909315, 5666.0, 5675.517581005661, 5687.232223649919, 5689.800856969986, 5700.743466543932], "unit": "score", "name": "mootools.html", "value": 3754.937961698183}, {"lowerIsBetter": false, "replicates": [279.66440271673997, 281.29675810473816, 281.3079823633861, 286.6288156836895, 287.39503345457797, 5009.14844476439, 5138.922916156261, 5188.896222075561, 5197.246399272103, 5203.609729270305, 5043.31915191449, 5156.742162891859, 5156.896862062757, 5175.792968281274, 5189.091908915943, 3814.2371525694834, 3911.6088391160797, 3998.6801055915603, 4038.777867217309, 4071.5724848890886, 4034.0721634024194, 4036.1725846201457, 4039.899002524946, 4049.5343035550995, 4055.2092341993325, 3996.6403023727858, 4010.1177740896956, 4014.6386825185728, 4015.437838702584, 4026.7382620129742, 3972.324704800191, 4006.258842114218, 4007.6192761687885, 4013.337799263118, 4016.417619445179, 3501.369753444379, 3502.4396096624673, 3520.366334059868, 3528.8764893228613, 3537.204129070964, 4999.75001249936, 5011.824586139468, 5032.572231360339, 5035.219540971156, 5043.268726034705, 4592.609628181609, 4602.171609110359, 4603.700759450659, 4604.562566556172, 4608.9308660370125, 5236.293100431431, 5445.591580631469, 5458.317710286215, 5458.61789674723, 5461.69960652164, 3832.540095188567, 3847.961520384816, 3852.0562462196663, 3852.306584814732, 3852.4221366795205, 5506.0, 5627.746751396197, 5685.289338832646, 5712.285964254468, 5717.971410142923, 3781.0736369589627, 3803.1823158021157, 3807.7334586578672, 3811.6188381162215, 3817.1793064491267, 3852.5184351956004, 3858.2090671412293, 3869.2068126034096, 3871.728978971445, 3876.321643712339, 4467.508574056851, 4486.528914463935, 4488.236999710057, 4488.506264310923, 4493.7977790999485, 5166.974165129151, 5297.8145764898045, 5435.592330575223, 5440.782368705208, 5442.374126975448, 1390.2492653966947, 1410.6614412540916, 1411.1885665742238, 1414.0384538513704, 1414.7170565886863, 949.6438835436711, 955.2883102088849, 968.41894863083, 976.272676855747, 980.294188184506, 4764.094821983812, 4769.976150119227, 4775.73733444657, 4779.689320194177, 4782.784774685148, 5595.496405323541, 5597.692126933058, 5598.384177740445, 5606.495415412633, 5606.97196514023, 4764.2615394613895, 4768.451628062748, 4769.332293478916, 4774.904501910012, 4779.856604301876, 2977.791554591158, 3008.2178633554995, 3013.9849300753795, 3015.6833532479213, 3017.4266889290966, 5330.067238233293, 5343.812966546152, 5344.091504444254, 5346.304980352529, 5353.411124776271, 5648.378678345379, 5758.798442054508, 5833.591648584558, 5834.533237341003, 5838.79564215259, 5345.423100185455, 5381.973090134525, 5383.353997520323, 5394.595405344537, 5398.4871437213405, 5648.09630459141, 5648.124540696199, 5656.971715141398, 5661.858453538694, 5662.122371032497, 5534.924403348744, 5542.944570554404, 5543.695096769717, 5544.7782088716, 5548.278723765885, 5379.838604841861, 5391.75737091824, 5396.0556902542685, 5396.811111611075, 5400.270963419888, 3632.4369722693023, 3758.379867321861, 3777.7544459610035, 3790.2608991247544, 3817.866374676873, 5386.730663466733, 5506.146547285177, 5561.082421400585, 5607.074832652566, 5610.579206559606, 5431.2667789847865, 5445.237666726583, 5457.072297709319, 5458.399576046711, 5465.781368745205, 5432.945670543244, 5435.646682965595, 5437.592180586393, 5440.945590544202, 5445.455454454523, 5318.840434786963, 5322.920156197582, 5326.8014696692935, 5327.813526526708, 5333.306670132858, 5473.863153421196, 5476.315460567429, 5482.23248745184, 5488.56091512686, 5490.423505532021, 5143.871403214949, 5299.0, 5307.230451584576, 5313.787448502017, 5313.814016509404], "unit": "score", "name": "prototype.html", "value": 4073.915341726527}, {"lowerIsBetter": false, "replicates": [499.527946090944, 534.4468475128243, 599.0834023943369, 609.0438012320657, 619.3465893482376, 10049.397036177834, 10164.237682173829, 10633.893661063386, 10689.412082335468, 10885.564577416913, 8830.426022308546, 9071.365004449692, 9670.661526846561, 10015.349002314844, 10114.0, 643.1735220241978, 649.3928177154376, 656.1797752808989, 679.0832376291991, 682.0825989044752, 647.9967600162016, 650.74946145734, 650.9739610415578, 651.6318280171712, 656.1273506236694, 669.7153709673394, 674.5109795398322, 674.8177991942173, 683.5488577538825, 702.8805103132454, 658.06554692337, 662.2880403566162, 663.3366633366634, 665.0, 665.2017578905333, 491.8229437402532, 492.27635375997227, 495.3857217050867, 496.26800469307483, 502.5828562293288, 9171.816563668755, 9218.492982885939, 9224.769380765467, 9287.164155226063, 9310.301727370474, 7890.368770498347, 8530.658773649047, 8744.956275218647, 8896.466212027299, 9160.129787670161, 7964.084130325029, 8005.559694216816, 8137.877931831027, 8214.876776848352, 9400.858987115198, 3442.345954268681, 3490.528778614905, 3492.0571445709516, 3498.1954150545516, 3581.230035542345, 36273.0, 36723.81638091819, 37264.25471490582, 41377.172456551, 42186.94532636678, 8436.873446898302, 8694.478331300143, 8706.52114133716, 8715.389922705477, 8754.343424243207, 11439.485223164978, 13774.0, 13974.301284935713, 14033.71932561343, 14038.087524310888, 5914.822555323347, 5939.910901336483, 5966.254218222723, 6036.6679832609625, 6201.782937597162, 3435.914102147416, 3602.0814692253307, 3621.27574485104, 3626.188362279633, 3700.9444858327147, 2464.3592665906995, 2466.1491785334033, 2488.875556222182, 2489.751024897496, 2492.8130390220804, 441.7150937645201, 443.39698010705416, 451.04828811208324, 460.3233247126718, 461.79911738393906, 399.43306274964846, 450.07060420232114, 476.4068734425662, 485.922252439608, 493.6248451177131, 6566.638834864033, 6663.233728121231, 6699.129113215348, 6835.350641689031, 6917.031615573824, 452.6672895421862, 472.6856640334208, 474.27199249152386, 488.97310647914, 495.85868027611957, 3167.319026409333, 3211.341674956675, 3306.5040243963117, 3341.665833416639, 3385.170633194834, 48976.755116224194, 49286.75356623194, 49436.50563494319, 49645.25532116949, 49722.502774971785, 44450.33324500071, 45010.999999999345, 45238.54761452409, 45784.77107614507, 46049.0, 41083.58916410858, 41617.37573936393, 43263.13473730571, 43639.781801090794, 44252.0, 7048.365647091787, 7339.229380914927, 7361.374283185989, 7417.109946806202, 7517.0, 31058.378832423678, 31406.685933140376, 31465.0, 31657.20856978594, 31672.0, 36989.0, 38254.23491530209, 39313.820585382484, 40766.79616601898, 41606.37590436085, 9132.908670913206, 9329.486878221764, 9441.952790236004, 9444.95277523608, 9486.905130948602, 10484.580616775549, 10624.256302058782, 10634.41510716918, 10808.945955270174, 10852.45737713127, 8933.15135062168, 9157.221636161, 9694.0, 9764.511774411108, 10243.282970192015, 9633.32566720351, 9706.75733106678, 9913.801723965336, 9952.154066904104, 10027.649032283834, 9073.183413492818, 9243.676471323472, 9354.95322523383, 9388.57751401175, 9750.902490975282, 8464.280536154496, 8524.763909233003, 8570.74287771368, 8759.562021898751, 8815.294776417742, 8260.380471464545, 8320.625571849161, 8467.36494762883, 8602.311815054905, 8649.524276164871], "unit": "score", "name": "yui.html", "value": 5138.44541468286}], "name": "dromaeo_css", "value": 5805.937299183199}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 107.0, 113.0, 114.0, 116.0, 103.0, 112.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [155.0, 135.0, 157.0, 165.0, 133.0, 156.0, 165.0, 136.0, 174.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 165.0, 160.0, 160.0, 162.0, 161.0, 161.0, 159.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 113.0, 95.0, 75.0, 74.0, 73.0, 109.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 142.0, 95.0, 94.0, 95.0, 135.0, 94.0, 94.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 116.0, 118.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 76.0, 66.0, 66.0, 67.0, 67.0, 77.0, 65.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 68.1}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 70.0, 72.0, 71.0, 70.0, 71.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.5}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 92.0, 83.0, 82.0, 98.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [122.0, 118.0, 121.0, 118.0, 121.0, 123.0, 123.0, 123.0, 120.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [146.0, 139.0, 148.0, 147.0, 148.0, 135.0, 149.0, 147.0, 146.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 70.0, 70.0, 72.0, 68.0, 71.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1537.4}]} 09:46:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1537.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5805.94"}}} 09:46:57 INFO - Return code: 0 09:46:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:46:57 INFO - # TBPL SUCCESS # 09:46:57 INFO - Running post-action listener: _resource_record_post_action 09:46:57 INFO - Running post-run listener: _resource_record_post_run 09:46:58 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 77824; Write bytes: 533741568; Read time: 52; Write time: 571012 09:46:58 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240148480; Read time: 0; Write time: 365720 09:46:58 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 77824; Write bytes: 293593088; Read time: 52; Write time: 205292 09:46:58 INFO - Running post-run listener: _upload_blobber_files 09:46:58 INFO - Blob upload gear active. 09:46:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:46:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:46:58 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'] 09:46:58 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 09:46:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:59 INFO - (blobuploader) - INFO - Done attempting. 09:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:00 INFO - (blobuploader) - INFO - Done attempting. 09:47:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:47:00 INFO - Return code: 0 09:47:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:47:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:47:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98abfee9c172b95f500038a67d3424611c03aa2a76a129c5858ffc08803bc15ba9aa9f80505c2e1961bb0ce3433be466633971e7289322e6e339c9eafa3b7baf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330c9c1b183c662353f79cd1261422131947977ef06c34c7ef29a8284e22b0f904268e02471dd80b83013e3c3ae669281febb353bdde724db5a11460832332e2"} 09:47:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:47:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:47:00 INFO - Contents: 09:47:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98abfee9c172b95f500038a67d3424611c03aa2a76a129c5858ffc08803bc15ba9aa9f80505c2e1961bb0ce3433be466633971e7289322e6e339c9eafa3b7baf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330c9c1b183c662353f79cd1261422131947977ef06c34c7ef29a8284e22b0f904268e02471dd80b83013e3c3ae669281febb353bdde724db5a11460832332e2"} 09:47:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:47:00 INFO - Copying logs to upload dir... 09:47:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:47:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.591291 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-03 09:47:00.388803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 09:47:00.392639) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 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/98abfee9c172b95f500038a67d3424611c03aa2a76a129c5858ffc08803bc15ba9aa9f80505c2e1961bb0ce3433be466633971e7289322e6e339c9eafa3b7baf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330c9c1b183c662353f79cd1261422131947977ef06c34c7ef29a8284e22b0f904268e02471dd80b83013e3c3ae669281febb353bdde724db5a11460832332e2"} build_url:https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.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/98abfee9c172b95f500038a67d3424611c03aa2a76a129c5858ffc08803bc15ba9aa9f80505c2e1961bb0ce3433be466633971e7289322e6e339c9eafa3b7baf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330c9c1b183c662353f79cd1261422131947977ef06c34c7ef29a8284e22b0f904268e02471dd80b83013e3c3ae669281febb353bdde724db5a11460832332e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 09:47:00.417406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:47:00.417764) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457025404.935885-2036547986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:47:00.503136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:47:00.503454) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:47:00.503745) ========= ========= Total master_lag: 0.31 =========