builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1460505558.61 results: success (0) buildid: 20160412153553 builduid: a1e5fd02f99f48d7a1492791d16e2a7a revision: fb921246e2d60f521f83defed54e30a38df1be3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.607018) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.607616) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.607946) ========= 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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.634463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.634776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.655039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.655406) ========= 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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.715387) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.715752) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.716127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.716453) ========= 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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 16:59:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2016-04-12 16:59:19 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.832710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.833024) ========= 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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020731 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:18.887914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 16:59:18.888271) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb921246e2d60f521f83defed54e30a38df1be3e --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 fb921246e2d60f521f83defed54e30a38df1be3e --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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 16:59:19,582 truncating revision to first 12 chars 2016-04-12 16:59:19,582 Setting DEBUG logging. 2016-04-12 16:59:19,582 attempt 1/10 2016-04-12 16:59:19,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb921246e2d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 16:59:20,493 unpacking tar archive at: mozilla-central-fb921246e2d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 16:59:20.175021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:20.175410) ========= echo fb921246e2d60f521f83defed54e30a38df1be3e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fb921246e2d60f521f83defed54e30a38df1be3e'] 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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fb921246e2d60f521f83defed54e30a38df1be3e program finished with exit code 0 elapsedTime=0.004746 script_repo_revision: 'fb921246e2d60f521f83defed54e30a38df1be3e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:20.229183) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:20.229550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 16:59:20.242189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-12 16:59:20.242926) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:21 INFO - MultiFileLogger online at 20160412 16:59:21 in /builds/slave/test 16:59:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:59:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:21 INFO - {'append_to_log': False, 16:59:21 INFO - 'base_work_dir': '/builds/slave/test', 16:59:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:59:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:21 INFO - 'branch': 'Firefox-Non-PGO', 16:59:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:21 INFO - 'config_files': ('talos/linux_config.py',), 16:59:21 INFO - 'default_actions': ('clobber', 16:59:21 INFO - 'read-buildbot-config', 16:59:21 INFO - 'download-and-extract', 16:59:21 INFO - 'populate-webroot', 16:59:21 INFO - 'create-virtualenv', 16:59:21 INFO - 'install', 16:59:21 INFO - 'run-tests'), 16:59:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:21 INFO - 'download_minidump_stackwalk': True, 16:59:21 INFO - 'download_symbols': 'ondemand', 16:59:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:21 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:21 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:21 INFO - 'installer_path': 'installer.exe', 16:59:21 INFO - 'log_level': 'info', 16:59:21 INFO - 'log_name': 'talos', 16:59:21 INFO - 'log_to_console': True, 16:59:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:21 INFO - 'opt_config_files': (), 16:59:21 INFO - 'pip_index': False, 16:59:21 INFO - 'sps_profile': False, 16:59:21 INFO - 'sps_profile_interval': 0, 16:59:21 INFO - 'suite': 'dromaeojs-e10s', 16:59:21 INFO - 'system_bits': '32', 16:59:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:21 INFO - 'title': 'talos-linux64-ix-029', 16:59:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:21 INFO - 'use_talos_json': True, 16:59:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:21 INFO - 'work_dir': 'build'} 16:59:21 INFO - ##### 16:59:21 INFO - ##### Running clobber step. 16:59:21 INFO - ##### 16:59:21 INFO - Running pre-action listener: _resource_record_pre_action 16:59:21 INFO - Running main action method: clobber 16:59:21 INFO - rmtree: /builds/slave/test/build 16:59:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:21 INFO - Running post-action listener: _resource_record_post_action 16:59:21 INFO - ##### 16:59:21 INFO - ##### Running read-buildbot-config step. 16:59:21 INFO - ##### 16:59:21 INFO - Running pre-action listener: _resource_record_pre_action 16:59:21 INFO - Running main action method: read_buildbot_config 16:59:21 INFO - Using buildbot properties: 16:59:21 INFO - { 16:59:21 INFO - "project": "", 16:59:21 INFO - "product": "firefox", 16:59:21 INFO - "script_repo_revision": "production", 16:59:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:59:21 INFO - "repository": "", 16:59:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:59:21 INFO - "buildid": "20160412153553", 16:59:21 INFO - "pgo_build": "False", 16:59:21 INFO - "basedir": "/builds/slave/test", 16:59:21 INFO - "buildnumber": 27, 16:59:21 INFO - "slavename": "talos-linux64-ix-029", 16:59:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:59:21 INFO - "platform": "ubuntu64_hw", 16:59:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:59:21 INFO - "branch": "mozilla-central", 16:59:21 INFO - "repo_path": "mozilla-central", 16:59:21 INFO - "revision": "fb921246e2d60f521f83defed54e30a38df1be3e", 16:59:21 INFO - "stage_platform": "linux64", 16:59:21 INFO - "builduid": "a1e5fd02f99f48d7a1492791d16e2a7a", 16:59:21 INFO - "slavebuilddir": "test" 16:59:21 INFO - } 16:59:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:59:21 INFO - Running post-action listener: _resource_record_post_action 16:59:21 INFO - ##### 16:59:21 INFO - ##### Running download-and-extract step. 16:59:21 INFO - ##### 16:59:21 INFO - Running pre-action listener: _resource_record_pre_action 16:59:21 INFO - Running main action method: download_and_extract 16:59:21 INFO - mkdir: /builds/slave/test/build/tests 16:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:21 INFO - https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:59:28 INFO - Downloaded 1361 bytes. 16:59:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:28 INFO - Using the following test package requirements: 16:59:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:59:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:59:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'jsshell-linux-x86_64.zip'], 16:59:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:59:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:59:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:59:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:59:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:59:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:28 INFO - https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:59:32 INFO - Downloaded 22197346 bytes. 16:59:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:59:33 INFO - Return code: 0 16:59:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:59: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')]} 16:59:33 INFO - https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:59:40 INFO - Downloaded 22197346 bytes. 16:59:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:59:42 INFO - Return code: 0 16:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:42 INFO - https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:59:43 INFO - Downloaded 10841076 bytes. 16:59:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:59:43 INFO - Return code: 0 16:59: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')]} 16:59:43 INFO - https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:59:45 INFO - Downloaded 54117807 bytes. 16:59:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:45 INFO - mkdir: /builds/slave/test/properties 16:59:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:45 INFO - Contents: 16:59:45 INFO - build_url:https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:46 INFO - Running post-action listener: _resource_record_post_action 16:59:46 INFO - Running post-action listener: set_extra_try_arguments 16:59:46 INFO - ##### 16:59:46 INFO - ##### Running populate-webroot step. 16:59:46 INFO - ##### 16:59:46 INFO - Running pre-action listener: _resource_record_pre_action 16:59:46 INFO - Running main action method: populate_webroot 16:59:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:46 INFO - '--tppagecycles', 16:59:46 INFO - '7'], 16:59:46 INFO - 'tests': ['tsvgm']}}, 16:59:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['damp', 'tps']}, 16:59:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'tests': ['damp', 'tps']}, 16:59:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['dromaeo_dom']}, 16:59:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['a11yr', 16:59:46 INFO - 'ts_paint', 16:59:46 INFO - 'tpaint', 16:59:46 INFO - 'sessionrestore', 16:59:46 INFO - 'sessionrestore_no_auto_restore', 16:59:46 INFO - 'tabpaint']}, 16:59:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:46 INFO - 'ts_paint', 16:59:46 INFO - 'tpaint', 16:59:46 INFO - 'sessionrestore', 16:59:46 INFO - 'sessionrestore_no_auto_restore', 16:59:46 INFO - 'tabpaint']}, 16:59:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:59:46 INFO - 'ts_paint', 16:59:46 INFO - 'tpaint', 16:59:46 INFO - 'sessionrestore', 16:59:46 INFO - 'sessionrestore_no_auto_restore', 16:59:46 INFO - 'tabpaint']}, 16:59:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:59:46 INFO - 'ts_paint', 16:59:46 INFO - 'tpaint', 16:59:46 INFO - 'sessionrestore', 16:59:46 INFO - 'sessionrestore_no_auto_restore', 16:59:46 INFO - 'tabpaint']}, 16:59:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['a11yr', 16:59:46 INFO - 'ts_paint', 16:59:46 INFO - 'tpaint', 16:59:46 INFO - 'sessionrestore', 16:59:46 INFO - 'sessionrestore_no_auto_restore', 16:59:46 INFO - 'tabpaint']}, 16:59:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['a11yr', 16:59:46 INFO - 'ts_paint', 16:59:46 INFO - 'tpaint', 16:59:46 INFO - 'sessionrestore', 16:59:46 INFO - 'sessionrestore_no_auto_restore', 16:59:46 INFO - 'tabpaint']}, 16:59:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['tsvgx', 16:59:46 INFO - 'tsvgr_opacity', 16:59:46 INFO - 'tart', 16:59:46 INFO - 'tscrollx', 16:59:46 INFO - 'cart']}, 16:59:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:46 INFO - 'tsvgr_opacity', 16:59:46 INFO - 'tart', 16:59:46 INFO - 'tscrollx', 16:59:46 INFO - 'cart']}, 16:59:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'talos_options': ['--disable-e10s'], 16:59:46 INFO - 'tests': ['tp5o']}, 16:59:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'tests': ['tp5o']}, 16:59:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'talos_options': ['--disable-e10s', 16:59:46 INFO - '--xperf_path', 16:59:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:46 INFO - 'tests': ['tp5n']}, 16:59:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:46 INFO - 'talos_options': ['--xperf_path', 16:59:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:46 INFO - 'tests': ['tp5n']}}, 16:59:46 INFO - 'talos.zip': {'path': '', 16:59:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:46 INFO - Running post-action listener: _resource_record_post_action 16:59:46 INFO - ##### 16:59:46 INFO - ##### Running create-virtualenv step. 16:59:46 INFO - ##### 16:59:46 INFO - Running pre-action listener: _resource_record_pre_action 16:59:46 INFO - Running main action method: create_virtualenv 16:59:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:59:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:59:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:46 INFO - Using real prefix '/usr' 16:59:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:48 INFO - Installing pip.................done. 16:59:48 INFO - Return code: 0 16:59:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:48 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:59:48 INFO - Using env: {'DISPLAY': ':0', 16:59:48 INFO - 'HOME': '/home/cltbld', 16:59:48 INFO - 'LANG': 'en_US.UTF-8', 16:59:48 INFO - 'LANGUAGE': 'en_US:en', 16:59:48 INFO - 'LOGNAME': 'cltbld', 16:59:48 INFO - 'MAIL': '/var/mail/cltbld', 16:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:48 INFO - 'MOZ_NO_REMOTE': '1', 16:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:48 INFO - 'NO_EM_RESTART': '1', 16:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:48 INFO - 'PWD': '/builds/slave/test', 16:59:48 INFO - 'SHELL': '/bin/bash', 16:59:48 INFO - 'SHLVL': '1', 16:59:48 INFO - 'TERM': 'linux', 16:59:48 INFO - 'TMOUT': '86400', 16:59:48 INFO - 'USER': 'cltbld', 16:59:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 16:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:48 INFO - '_': '/tools/buildbot/bin/python'} 16:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:59:48 INFO - Cleaning up... 16:59:48 INFO - Return code: 0 16:59:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:48 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:59:48 INFO - Using env: {'DISPLAY': ':0', 16:59:48 INFO - 'HOME': '/home/cltbld', 16:59:48 INFO - 'LANG': 'en_US.UTF-8', 16:59:48 INFO - 'LANGUAGE': 'en_US:en', 16:59:48 INFO - 'LOGNAME': 'cltbld', 16:59:48 INFO - 'MAIL': '/var/mail/cltbld', 16:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:48 INFO - 'MOZ_NO_REMOTE': '1', 16:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:48 INFO - 'NO_EM_RESTART': '1', 16:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:48 INFO - 'PWD': '/builds/slave/test', 16:59:48 INFO - 'SHELL': '/bin/bash', 16:59:48 INFO - 'SHLVL': '1', 16:59:48 INFO - 'TERM': 'linux', 16:59:48 INFO - 'TMOUT': '86400', 16:59:48 INFO - 'USER': 'cltbld', 16:59:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 16:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:48 INFO - '_': '/tools/buildbot/bin/python'} 16:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:49 INFO - Downloading/unpacking psutil>=0.7.1 16:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:51 INFO - Installing collected packages: psutil 16:59:51 INFO - Running setup.py install for psutil 16:59:51 INFO - building 'psutil._psutil_linux' extension 16:59:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:59:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:59:51 INFO - building 'psutil._psutil_posix' extension 16:59:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:59:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:51 INFO - Successfully installed psutil 16:59:51 INFO - Cleaning up... 16:59:51 INFO - Return code: 0 16:59:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:51 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:59:51 INFO - Using env: {'DISPLAY': ':0', 16:59:51 INFO - 'HOME': '/home/cltbld', 16:59:51 INFO - 'LANG': 'en_US.UTF-8', 16:59:51 INFO - 'LANGUAGE': 'en_US:en', 16:59:51 INFO - 'LOGNAME': 'cltbld', 16:59:51 INFO - 'MAIL': '/var/mail/cltbld', 16:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:51 INFO - 'MOZ_NO_REMOTE': '1', 16:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:51 INFO - 'NO_EM_RESTART': '1', 16:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:51 INFO - 'PWD': '/builds/slave/test', 16:59:51 INFO - 'SHELL': '/bin/bash', 16:59:51 INFO - 'SHLVL': '1', 16:59:51 INFO - 'TERM': 'linux', 16:59:51 INFO - 'TMOUT': '86400', 16:59:51 INFO - 'USER': 'cltbld', 16:59:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 16:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:51 INFO - '_': '/tools/buildbot/bin/python'} 16:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:59:53 INFO - Installing collected packages: mozsystemmonitor 16:59:53 INFO - Running setup.py install for mozsystemmonitor 16:59:53 INFO - Successfully installed mozsystemmonitor 16:59:53 INFO - Cleaning up... 16:59:54 INFO - Return code: 0 16:59:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:54 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:59:54 INFO - Using env: {'DISPLAY': ':0', 16:59:54 INFO - 'HOME': '/home/cltbld', 16:59:54 INFO - 'LANG': 'en_US.UTF-8', 16:59:54 INFO - 'LANGUAGE': 'en_US:en', 16:59:54 INFO - 'LOGNAME': 'cltbld', 16:59:54 INFO - 'MAIL': '/var/mail/cltbld', 16:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:54 INFO - 'MOZ_NO_REMOTE': '1', 16:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:54 INFO - 'NO_EM_RESTART': '1', 16:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:54 INFO - 'PWD': '/builds/slave/test', 16:59:54 INFO - 'SHELL': '/bin/bash', 16:59:54 INFO - 'SHLVL': '1', 16:59:54 INFO - 'TERM': 'linux', 16:59:54 INFO - 'TMOUT': '86400', 16:59:54 INFO - 'USER': 'cltbld', 16:59:54 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 16:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:54 INFO - '_': '/tools/buildbot/bin/python'} 16:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:59:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:56 INFO - Downloading docopt-0.6.1.tar.gz 16:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:56 INFO - Running setup.py install for blobuploader 16:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:59:56 INFO - Running setup.py install for requests 16:59:57 INFO - Running setup.py install for docopt 16:59:57 INFO - Successfully installed blobuploader requests docopt 16:59:57 INFO - Cleaning up... 16:59:57 INFO - Return code: 0 16:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:57 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:59:57 INFO - Using env: {'DISPLAY': ':0', 16:59:57 INFO - 'HOME': '/home/cltbld', 16:59:57 INFO - 'LANG': 'en_US.UTF-8', 16:59:57 INFO - 'LANGUAGE': 'en_US:en', 16:59:57 INFO - 'LOGNAME': 'cltbld', 16:59:57 INFO - 'MAIL': '/var/mail/cltbld', 16:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:57 INFO - 'MOZ_NO_REMOTE': '1', 16:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:57 INFO - 'NO_EM_RESTART': '1', 16:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:57 INFO - 'PWD': '/builds/slave/test', 16:59:57 INFO - 'SHELL': '/bin/bash', 16:59:57 INFO - 'SHLVL': '1', 16:59:57 INFO - 'TERM': 'linux', 16:59:57 INFO - 'TMOUT': '86400', 16:59:57 INFO - 'USER': 'cltbld', 16:59:57 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 16:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:57 INFO - '_': '/tools/buildbot/bin/python'} 16:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:57 INFO - Running setup.py (path:/tmp/pip-vgvlzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:57 INFO - Running setup.py (path:/tmp/pip-c5zTjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:57 INFO - Running setup.py (path:/tmp/pip-pediZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:57 INFO - Running setup.py (path:/tmp/pip-zuvjI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:57 INFO - Running setup.py (path:/tmp/pip-ysBVCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:58 INFO - Running setup.py (path:/tmp/pip-khIGbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:58 INFO - Running setup.py (path:/tmp/pip-ZRZWrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:58 INFO - Running setup.py (path:/tmp/pip-D7hCRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:58 INFO - Running setup.py (path:/tmp/pip-oV0FaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:58 INFO - Running setup.py (path:/tmp/pip-8dDEpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:58 INFO - Running setup.py (path:/tmp/pip-ictIyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:58 INFO - Running setup.py (path:/tmp/pip-53JLjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:58 INFO - Running setup.py (path:/tmp/pip-J0n7NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:58 INFO - Running setup.py (path:/tmp/pip-KKFuSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:58 INFO - Running setup.py (path:/tmp/pip-W_GJvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:58 INFO - Running setup.py (path:/tmp/pip-Dsg9hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:58 INFO - Running setup.py (path:/tmp/pip-btDfDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:58 INFO - Running setup.py install for manifestparser 16:59:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozcrash 16:59:59 INFO - Running setup.py install for mozdebug 16:59:59 INFO - Running setup.py install for mozdevice 16:59:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozfile 16:59:59 INFO - Running setup.py install for mozhttpd 16:59:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozinfo 16:59:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozInstall 16:59:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for mozleak 16:59:59 INFO - Running setup.py install for mozlog 16:59:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:59:59 INFO - Running setup.py install for moznetwork 17:00:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Running setup.py install for mozprocess 17:00:00 INFO - Running setup.py install for mozprofile 17:00:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Running setup.py install for mozrunner 17:00:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Running setup.py install for mozscreenshot 17:00:00 INFO - Running setup.py install for moztest 17:00:00 INFO - Running setup.py install for mozversion 17:00:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:00 INFO - Cleaning up... 17:00:00 INFO - Return code: 0 17:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:00 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', '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 17:00:00 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 17:00:00 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 17:00:00 INFO - Using env: {'DISPLAY': ':0', 17:00:00 INFO - 'HOME': '/home/cltbld', 17:00:00 INFO - 'LANG': 'en_US.UTF-8', 17:00:00 INFO - 'LANGUAGE': 'en_US:en', 17:00:00 INFO - 'LOGNAME': 'cltbld', 17:00:00 INFO - 'MAIL': '/var/mail/cltbld', 17:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:00 INFO - 'MOZ_NO_REMOTE': '1', 17:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:00 INFO - 'NO_EM_RESTART': '1', 17:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:00 INFO - 'PWD': '/builds/slave/test', 17:00:00 INFO - 'SHELL': '/bin/bash', 17:00:00 INFO - 'SHLVL': '1', 17:00:00 INFO - 'TERM': 'linux', 17:00:00 INFO - 'TMOUT': '86400', 17:00:00 INFO - 'USER': 'cltbld', 17:00:00 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 17:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:00 INFO - '_': '/tools/buildbot/bin/python'} 17:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:00 INFO - Running setup.py (path:/tmp/pip-nAqwWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:00 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)) 17:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:00 INFO - Running setup.py (path:/tmp/pip-NAmJWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:01 INFO - Running setup.py (path:/tmp/pip-tKpKkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:01 INFO - Running setup.py (path:/tmp/pip-3dgpWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:01 INFO - Running setup.py (path:/tmp/pip-_RCHUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:01 INFO - Running setup.py (path:/tmp/pip-4x2oWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:01 INFO - Running setup.py (path:/tmp/pip-TPIE2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:01 INFO - Running setup.py (path:/tmp/pip-XExuc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:01 INFO - Running setup.py (path:/tmp/pip-OXveGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:01 INFO - Running setup.py (path:/tmp/pip-DF0zYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:01 INFO - Running setup.py (path:/tmp/pip-GlPZvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:01 INFO - Running setup.py (path:/tmp/pip-h0YUPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:01 INFO - Running setup.py (path:/tmp/pip-KcTRov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:01 INFO - Running setup.py (path:/tmp/pip-WhwGC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:01 INFO - Running setup.py (path:/tmp/pip-0xpOhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:01 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)) 17:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:01 INFO - Running setup.py (path:/tmp/pip-7WDq9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:02 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)) 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:02 INFO - Running setup.py (path:/tmp/pip-nnHseZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:02 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)) 17:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:02 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)) 17:00:02 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)) 17:00:02 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)) 17:00:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:04 INFO - Downloading blessings-1.6.tar.gz 17:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:04 INFO - Installing collected packages: blessings 17:00:04 INFO - Running setup.py install for blessings 17:00:04 INFO - Successfully installed blessings 17:00:04 INFO - Cleaning up... 17:00:04 INFO - Return code: 0 17:00:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:04 INFO - Reading from file tmpfile_stdout 17:00:04 INFO - Current package versions: 17:00:04 INFO - argparse == 1.2.1 17:00:04 INFO - blessings == 1.6 17:00:04 INFO - blobuploader == 1.2.4 17:00:04 INFO - docopt == 0.6.1 17:00:04 INFO - manifestparser == 1.1 17:00:04 INFO - mozInstall == 1.12 17:00:04 INFO - mozcrash == 0.17 17:00:04 INFO - mozdebug == 0.1 17:00:04 INFO - mozdevice == 0.48 17:00:04 INFO - mozfile == 1.2 17:00:04 INFO - mozhttpd == 0.7 17:00:04 INFO - mozinfo == 0.9 17:00:04 INFO - mozleak == 0.1 17:00:04 INFO - mozlog == 3.1 17:00:04 INFO - moznetwork == 0.27 17:00:04 INFO - mozprocess == 0.22 17:00:04 INFO - mozprofile == 0.28 17:00:04 INFO - mozrunner == 6.11 17:00:04 INFO - mozscreenshot == 0.1 17:00:04 INFO - mozsystemmonitor == 0.0 17:00:04 INFO - moztest == 0.7 17:00:04 INFO - mozversion == 1.4 17:00:04 INFO - psutil == 3.1.1 17:00:04 INFO - requests == 1.2.3 17:00:04 INFO - wsgiref == 0.1.2 17:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:04 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', '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 17:00:04 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 17:00:04 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 17:00:04 INFO - Using env: {'DISPLAY': ':0', 17:00:04 INFO - 'HOME': '/home/cltbld', 17:00:04 INFO - 'LANG': 'en_US.UTF-8', 17:00:04 INFO - 'LANGUAGE': 'en_US:en', 17:00:04 INFO - 'LOGNAME': 'cltbld', 17:00:04 INFO - 'MAIL': '/var/mail/cltbld', 17:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:04 INFO - 'MOZ_NO_REMOTE': '1', 17:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:04 INFO - 'NO_EM_RESTART': '1', 17:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:04 INFO - 'PWD': '/builds/slave/test', 17:00:04 INFO - 'SHELL': '/bin/bash', 17:00:04 INFO - 'SHLVL': '1', 17:00:04 INFO - 'TERM': 'linux', 17:00:04 INFO - 'TMOUT': '86400', 17:00:04 INFO - 'USER': 'cltbld', 17:00:04 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 17:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:04 INFO - '_': '/tools/buildbot/bin/python'} 17:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 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)) 17:00:04 INFO - Cleaning up... 17:00:04 INFO - Return code: 0 17:00:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:04 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', '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 17:00:04 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 17:00:04 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 17:00:04 INFO - Using env: {'DISPLAY': ':0', 17:00:04 INFO - 'HOME': '/home/cltbld', 17:00:04 INFO - 'LANG': 'en_US.UTF-8', 17:00:04 INFO - 'LANGUAGE': 'en_US:en', 17:00:04 INFO - 'LOGNAME': 'cltbld', 17:00:04 INFO - 'MAIL': '/var/mail/cltbld', 17:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:04 INFO - 'MOZ_NO_REMOTE': '1', 17:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:04 INFO - 'NO_EM_RESTART': '1', 17:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:04 INFO - 'PWD': '/builds/slave/test', 17:00:04 INFO - 'SHELL': '/bin/bash', 17:00:04 INFO - 'SHLVL': '1', 17:00:04 INFO - 'TERM': 'linux', 17:00:04 INFO - 'TMOUT': '86400', 17:00:04 INFO - 'USER': 'cltbld', 17:00:04 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 17:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:04 INFO - '_': '/tools/buildbot/bin/python'} 17:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:04 INFO - Downloading/unpacking jsonschema 17:00:04 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 17:00:04 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 17:00:04 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 17:00:04 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 17:00:04 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 17:00:04 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 17:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:06 INFO - Downloading/unpacking functools32 (from jsonschema) 17:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:07 INFO - warning: no files found matching '*.txt' 17:00:07 INFO - no previously-included directories found matching 'build' 17:00:07 INFO - no previously-included directories found matching 'dist' 17:00:07 INFO - no previously-included directories found matching '.git*' 17:00:07 INFO - Installing collected packages: jsonschema, functools32 17:00:07 INFO - Running setup.py install for functools32 17:00:07 INFO - warning: no files found matching '*.txt' 17:00:07 INFO - no previously-included directories found matching 'build' 17:00:07 INFO - no previously-included directories found matching 'dist' 17:00:07 INFO - no previously-included directories found matching '.git*' 17:00:07 INFO - Successfully installed jsonschema functools32 17:00:07 INFO - Cleaning up... 17:00:07 INFO - Return code: 0 17:00:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:00:07 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')]} 17:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:07 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')]} 17:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:07 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 0x7f251dd04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, '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': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', '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 17:00:07 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 17:00:07 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 17:00:07 INFO - Using env: {'DISPLAY': ':0', 17:00:07 INFO - 'HOME': '/home/cltbld', 17:00:07 INFO - 'LANG': 'en_US.UTF-8', 17:00:07 INFO - 'LANGUAGE': 'en_US:en', 17:00:07 INFO - 'LOGNAME': 'cltbld', 17:00:07 INFO - 'MAIL': '/var/mail/cltbld', 17:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:07 INFO - 'MOZ_NO_REMOTE': '1', 17:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:07 INFO - 'NO_EM_RESTART': '1', 17:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:07 INFO - 'PWD': '/builds/slave/test', 17:00:07 INFO - 'SHELL': '/bin/bash', 17:00:07 INFO - 'SHLVL': '1', 17:00:07 INFO - 'TERM': 'linux', 17:00:07 INFO - 'TMOUT': '86400', 17:00:07 INFO - 'USER': 'cltbld', 17:00:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 17:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:07 INFO - '_': '/tools/buildbot/bin/python'} 17:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:07 INFO - Downloading/unpacking flake8 17:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:00:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:00:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:10 INFO - no previously-included directories found matching 'docs/_build' 17:00:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:00:10 INFO - Running setup.py install for pep8 17:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:10 INFO - no previously-included directories found matching 'docs/_build' 17:00:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:00:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:00:10 INFO - Cleaning up... 17:00:10 INFO - Return code: 0 17:00:10 INFO - Running post-action listener: _resource_record_post_action 17:00:10 INFO - Running post-action listener: _start_resource_monitoring 17:00:10 INFO - Starting resource monitoring. 17:00:10 INFO - ##### 17:00:10 INFO - ##### Running install step. 17:00:10 INFO - ##### 17:00:10 INFO - Running pre-action listener: _resource_record_pre_action 17:00:10 INFO - Running main action method: install 17:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:10 INFO - Reading from file tmpfile_stdout 17:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:10 INFO - Reading from file tmpfile_stdout 17:00:10 INFO - Output received: 17:00:10 INFO - Usage: mozinstall [options] installer 17:00:10 INFO - Options: 17:00:10 INFO - -h, --help show this help message and exit 17:00:10 INFO - -d DEST, --destination=DEST 17:00:10 INFO - Directory to install application into. [default: 17:00:10 INFO - "/builds/slave/test"] 17:00:10 INFO - --app=APP Application being installed. [default: firefox] 17:00:10 INFO - mkdir: /builds/slave/test/build/application 17:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:00:26 INFO - Reading from file tmpfile_stdout 17:00:26 INFO - Output received: 17:00:26 INFO - /builds/slave/test/build/application/firefox/firefox 17:00:26 INFO - Running post-action listener: _resource_record_post_action 17:00:26 INFO - ##### 17:00:26 INFO - ##### Running run-tests step. 17:00:26 INFO - ##### 17:00:26 INFO - Running pre-action listener: _resource_record_pre_action 17:00:26 INFO - Running main action method: run_tests 17:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:26 INFO - Python 2.7.3 17:00:26 INFO - Return code: 0 17:00:26 INFO - grabbing minidump binary from tooltool 17:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:26 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 0x2ce4410>, '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 0x2ce5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00:26 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 17:00:26 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 17:00:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:26 INFO - Return code: 0 17:00:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:00:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:00:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:00:27 INFO - Return code: 0 17:00:27 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:00:27 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:00:27 INFO - Using env: {'DISPLAY': ':0', 17:00:27 INFO - 'HOME': '/home/cltbld', 17:00:27 INFO - 'LANG': 'en_US.UTF-8', 17:00:27 INFO - 'LANGUAGE': 'en_US:en', 17:00:27 INFO - 'LOGNAME': 'cltbld', 17:00:27 INFO - 'MAIL': '/var/mail/cltbld', 17:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:27 INFO - 'MOZ_NO_REMOTE': '1', 17:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:27 INFO - 'NO_EM_RESTART': '1', 17:00:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:27 INFO - 'PWD': '/builds/slave/test', 17:00:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:27 INFO - 'SHELL': '/bin/bash', 17:00:27 INFO - 'SHLVL': '1', 17:00:27 INFO - 'TERM': 'linux', 17:00:27 INFO - 'TMOUT': '86400', 17:00:27 INFO - 'USER': 'cltbld', 17:00:27 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010', 17:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:27 INFO - '_': '/tools/buildbot/bin/python'} 17:00:27 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:00:27 INFO - mozversion application_buildid: 20160412153553 17:00:27 INFO - mozversion application_changeset: fb921246e2d60f521f83defed54e30a38df1be3e 17:00:27 INFO - mozversion application_display_name: Nightly 17:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:27 INFO - mozversion application_name: Firefox 17:00:27 INFO - mozversion application_remotingname: firefox 17:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:00:27 INFO - mozversion application_vendor: Mozilla 17:00:27 INFO - mozversion application_version: 48.0a1 17:00:27 INFO - mozversion platform_buildid: 20160412153553 17:00:27 INFO - mozversion platform_changeset: fb921246e2d60f521f83defed54e30a38df1be3e 17:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:00:27 INFO - mozversion platform_version: 48.0a1 17:00:27 INFO - using testdate: 1460505627 17:00:27 INFO - actual date: 1460505627 17:00:27 INFO - starting webserver on 'localhost:37822' 17:00:27 INFO - SUITE-START | Running 2 tests 17:00:27 INFO - TEST-START | dromaeo_css 17:00:27 INFO - operating with platform_type : linux_ 17:00:27 INFO - Initialising browser for dromaeo_css test... 17:00:27 INFO - TEST-INFO | started process 4311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbzkx8/profile http://localhost:37822/getInfo.html) 17:00:31 INFO - PROCESS | 4311 | 17:00:31 INFO - PROCESS | 4311 | (process:4377): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:00:31 INFO - PROCESS | 4311 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:00:31 INFO - PROCESS | 4311 | __metrics Screen width/height:1600/1200 17:00:31 INFO - PROCESS | 4311 | colorDepth:24 17:00:31 INFO - PROCESS | 4311 | Browser inner width/height: 1024/697 17:00:31 INFO - PROCESS | 4311 | __metrics 17:00:32 ERROR - PROCESS | 4311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:00:33 INFO - TEST-INFO | 4311: exit 0 17:00:33 INFO - Browser initialized. 17:00:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:33 INFO - TEST-INFO | started process 4428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbzkx8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:35 INFO - PROCESS | 4428 | 17:00:35 INFO - PROCESS | 4428 | (process:4486): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:00:45 INFO - PROCESS | 4428 | RSS: Main: 164483072 17:00:45 INFO - PROCESS | 4428 | 17:01:34 INFO - PROCESS | 4428 | 1460505694680 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] 17:03:46 INFO - PROCESS | 4428 | Cycle 1(1): loaded http://localhost:37822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37822/tests/dromaeo/cssquery-ext.html) 17:03:47 INFO - PROCESS | 4428 | RSS: Main: 169336832 17:03:47 INFO - PROCESS | 4428 | 17:06:49 INFO - PROCESS | 4428 | Cycle 1(1): loaded http://localhost:37822/tests/dromaeo/cssquery-ext.html (next: http://localhost:37822/tests/dromaeo/cssquery-jquery.html) 17:06:50 INFO - PROCESS | 4428 | RSS: Main: 166768640 17:06:50 INFO - PROCESS | 4428 | 17:09:51 INFO - PROCESS | 4428 | Cycle 1(1): loaded http://localhost:37822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37822/tests/dromaeo/cssquery-mootools.html) 17:09:52 INFO - PROCESS | 4428 | RSS: Main: 166617088 17:09:52 INFO - PROCESS | 4428 | 17:12:54 INFO - PROCESS | 4428 | Cycle 1(1): loaded http://localhost:37822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37822/tests/dromaeo/cssquery-prototype.html) 17:12:55 INFO - PROCESS | 4428 | RSS: Main: 164511744 17:12:55 INFO - PROCESS | 4428 | 17:15:57 INFO - PROCESS | 4428 | Cycle 1(1): loaded http://localhost:37822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37822/tests/dromaeo/cssquery-yui.html) 17:15:58 INFO - PROCESS | 4428 | RSS: Main: 166146048 17:15:58 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | Cycle 1(1): loaded http://localhost:37822/tests/dromaeo/cssquery-yui.html (next: http://localhost:37822/tests/dromaeo/cssquery-dojo.html) 17:19:00 INFO - PROCESS | 4428 | RSS: Main: 168087552 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | __start_tp_report 17:19:00 INFO - PROCESS | 4428 | _x_x_mozilla_page_load 17:19:00 INFO - PROCESS | 4428 | _x_x_mozilla_page_load_details 17:19:00 INFO - PROCESS | 4428 | |i|pagename|runs| 17:19:00 INFO - PROCESS | 4428 | |0;dojo.html;2603.9869800650995;2690.3408664877106;2738.4796888591177;2740.6985231624517;2747.8351298922066;4768.713877167373;4781.163296423129;4790.592799612033;4802.32767412562;4838.032393521301;4644.97677511612;4742.762861856902;4768.880777980552;4784.306275590037;4857.052874689437;4321.654267658596;4379.912401751963;4415.050764085721;4418.801153948064;4446.97776511117;628.4240338370734;4244.80898359573;4280.272353699863;4347.1088426872575;4382.97808510957;4333.804978775931;4348.217320882224;4349.151915376503;4355.629771469429;4389.626881715026;4254.170436764832;4404.4054052702795;4425.358323043173;4434.68957172998;4459.487158976694;4244.936325955113;4301.634361079312;4310.741355518648;4317.395564620955;4330.307150855848;4622.745748983804;4656.301554766778;4658;4662.860114196579;4716.38686970695;5073.619478539124;5088.643794934356;5098.719570423626;5105.463926287724;5174.249733788617;5059.367579052619;5062.924056139161;5066.544011038987;5076.466970968069;5111.05445492585;4714.245720684674;4717.980492484812;4750.548697873765;4755.043941081817;4782.115308667908;5040.924386134211;5227.3465816772905;5231.319928409359;5300.734963251899;5350.411454739976;4959.677620954626;4975.029869175476;4980.05378977993;4989.675671081368;5017.9247311290355;5050.444451110375;5056.646034777604;5057.620678449131;5064.392272927273;5070.442251352349;4912.214045752662;5055.545000949932;5100.668456550312;5105.591552675777;5134.178531434953;4893.266010098442;5001;5019.899602007939;5079.74601269935;5123.641345105807;4189.7695626740215;4189.874303770892;4191.7484950903045;4195.223883581547;4233.576642335804;3589.2462582857893;3660.4143337065943;3670.46778217157;3703.6851867591017;3752.3433399155037;4487.169873573399;4493.191225579361;4518.751468669189;4519.231730605805;4521.683482156283;5060.873478163002;5063.316452278968;5072.82245121419;5085.084684756779;5115.565176959925;4370.497392799869;4430.689851710414;4483.417155769729;4524.615407690318;4529.365888775574;4525.773711314421;4536.56902594253;4540.228161212602;4581.2440947243995;4590.449146102423;4813.687110337817;4814.301926220678;4818.253170758538;4827.879303017453;4864.975675121602;4994.650374473752;5053.115704751727;5082.923756143587;5120.590352771695;5161.406438259498;4794.376731024944;4835.419749630067;4861.562459378673;4868.659193856396;4905.8037678492465;5050.621203409685;5094.5669618082875;5097.566706829813;5101.846944591668;5128.8461346159675;4877.707337559757;5072.137736584716;5138.280640710378;5148.9227661584355;5163.509466600667;4941;4998.725070121032;5003.374578177728;5005.874853128701;5013.373328333958;4771.141194585008;4990.700557966534;4993.523605341886;4995.375578052744;4999.950000499948;4750.287456881357;4781.402324709411;4827.613790896649;4914.795875010645;4921.163402221559;4942.233953737176;4969.751512424292;4979.726115063706;4980.750962451935;4981.6014718823135;4865.172920603435;4876.292937523968;4878.682885612424;4884.780184891617;4893.877653058702 17:19:00 INFO - PROCESS | 4428 | |1;ext.html;591.1635036423459;605.8031139879539;613.0773186354536;624.2321944008869;639.5523133806337;33032;33723;33733.66266337336;34048.489272660896;34121.488177677355;35957.101072473204;36058.819705901435;36376.45435318466;36547;36750.26499470009;7467.8879816802655;7594.620268986529;7621.618919054053;7623.123340815794;7627.847443051136;7518.624068796566;7627.961860190719;7630.732924347649;7694.192109828444;7750;7650.885236721454;7791.844163116734;7815.765527034198;7821.4133939954445;7832.921670783305;7696.846063078735;7713.537187768752;7721.53670779755;7728.111267204259;7732.265434783687;7678.347340476066;7752.612369381508;7774.300312971804;7787.338076263524;7787.766367008999;37099.25801483955;37349.626503734886;37389;37525.437118443246;37555.06112347186;2518.25711415133;3015.3969206158854;3038.498647723123;3147.291859331655;3215.839208039589;25233;25330.1134460293;25348.619770703455;26011;26356.60465093006;3120.7659425543175;3126.9218269543444;3141.198994256473;3171.698688624577;3220.6618305077864;149772;149815;151230;151789;193496;32497.51253731196;33539.832300838825;33553.328933421195;48209.5179048212;48574.27138592924;31601.36797264042;31607;31661.683383165873;31683.84158079241;31700.20749481235;10980.505877235544;11149.498272577754;11181.888181118247;11185;11186.720331991603;8948.060453652402;8967.461952282883;9013.459192448474;9042.231410330063;9064.773380665405;7846.882296765553;7930.920690793134;7943.523388596587;7963.8805417918775;8047.557384343917;3207.246297120175;3246.1397729601676;3253.560769296115;3262.314913868114;3275.7051865332232;934.2946075712794;946.1531928923575;1023.6263763726336;1024.7643042100358;1027.8920713324994;27566.310842229104;27962.161135165978;27975;28174;28507;995.6067353395368;1002.8946960569181;1039.6361273554196;1047.3349423116376;1117.2626066795876;14460.20468874222;14967.401303947938;15025.173615451255;15041.398344066334;15075.170865602497;153922.23038884733;155986;155986;156059;156826.2158689199;46956;47782;47818;47825.521744782105;47830.760846195546;1219.5121951219583;1258.3959699344366;1264.2730430002784;1264.9114561980573;1388.0769288423287;26343.341416463976;27497;27867.721322787325;28021;28182.43635127327;41216;41334.586654133076;41500.58499414967;41550.584494154675;41619.7919010403;239835;241538;243076;290366;291415;24628.753712462647;25002.37494062663;25107.372315692253;25199.496010080064;38423.615763843125;40159.3976090353;40395.79802100971;40977;41093.79453102715;41589;33618.44515062499;34395.484067739504;34455.655443446245;34545.48181777326;34915.12712182114;33728.66271337353;34607;34765;34768;35078.12304692403;30035.699643004165;34997.82501087478;35024.29951401009;35120;36820.26359472742;27961.300967475974;29290.267743306587;29549.409011819214;29732.85133574405;32085;24131.75868241295;24471.75528244766;24577.877110614332;24789.752102478746;24984 17:19:00 INFO - PROCESS | 4428 | |2;jquery.html;376.5334023976611;380.1617433559003;389.1516494042985;389.71356053300804;391.67295308417476;15666.138362390078;15940.282687279072;16476.505704828858;16480.917595412007;16488.42290519832;15431.768523472158;16175.43385981491;16472.83527164728;16475.58811029725;16483.67032659346;5069;5219.817306394277;5247.658902171346;5261.289725886994;5270.657407268534;3633.872814451495;5737.684427356494;5967.403259674042;6033.48715359195;6036.637801731888;4892.706437613737;5970;5978.701064946757;6003.249593800775;6017.037274036155;5149.510796474329;5161.664491808039;5196.480351964792;5199.090159222121;5207.973960130194;4491.505934347219;4781.426228852525;4783.617310615143;4817.951820481785;5015.172496538067;11698.766024679458;11847.348395838226;11917.94041029798;17106.743398849027;18369.44891653239;1895.5450691833998;1965.7149713291635;1990.1243452880685;2015.9294424695213;2093.037202886674;8515.48907065578;8690.695825646135;8714.564271786448;9245.491497967609;9279.304052196045;1730.4203091964207;1740.9042502662348;1757.8505827004592;1843.612841303328;1851.2132343753985;63890.68054659743;66468;66869.3313066868;67745.6612716943;68639;10025.548850301753;10040.849387259197;10202.183825293958;10205.234607404474;10208.489575521195;14181;14210.85789142116;14235.644108897153;14250.643733906529;14308.928455357656;6755.121834161528;6873.140857392826;6874.209465911485;6990.685419156151;7000.579965202104;6270.811875643738;6287.528435367366;6363.61818290904;6378.234611846516;6407.647579383085;4309.569043095666;4310.89222769427;4393.253146965024;4426.535213802569;4443.733375997386;1709.8717596180336;1783.4293026231742;1849.842763365129;1877.1646617255462;1878.4364690592768;877.7630039889194;878.4026861733954;922.1654402765374;937.3438592984937;1007.450939238117;15744.370225191093;15784.301073133902;16347.591310217102;16487.505374838773;16674.83325166757;838.714836955438;856.7258477287209;870.629982257538;903.6520939438232;976.1068622210739;9228.8615670765;9374.718758437259;9381.624735010522;9401.012893646206;9444.669436569688;367924;370126;375077;393922;396376;75868;78943.21056789474;79304.20695793083;80122.59938700269;81127.59436202899;934.6915517879083;940.5485367023867;942.9339946203837;954.355809828363;959.4866746290701;14628.780568291697;14667.339969701603;14768.18774967387;14902.925485372503;14981.850181498481;30823.38353232878;31261;31879.52180717245;33665.66334336625;36708.26583468369;46954.530454695014;47129.52870471252;47322.21422286278;47347;47968.28047579219;7527.16644600439;7650.579218143055;7764.456488045783;7782.88325675104;7792.88310675329;11258.7748245033;11404.372759498307;11443.542258309575;11486.597969071043;11521.135914806591;10016.749581260236;10399.820193292393;10410.583576656849;10423.270371073952;10446;10111.292209545556;10119.291649584458;10166.694999150037;10247.692569222936;10473.581056757645;10335.379877207391;10402.479876006018;10416.843747343948;10468.371897686164;10528.473576321307;7723.382129429745;7890.210978902293;7908.52548847071;7946.125926148235;7987.16134805837;7724.034495688039;9679.66121185755;9947.950260248652;9954.850677239703;10188.286819922534 17:19:00 INFO - PROCESS | 4428 | |3;mootools.html;1424.843267240603;1474.4028668389303;1607.8392160783924;1775.1745438371154;1801.720733286341;7013.263607321222;7466.4773465857415;7591.5445073295505;7787.143414224431;7837.21627837216;7564.62176891156;7615.8857617135645;7640.968469256649;7649.196834332399;7665.271799179083;2234.474898398879;2255.289583781112;2257.1761307122865;2260.8078313343303;2260.954780904381;2210.8784016879067;2227.2984010036785;2243.080337061797;2264.1396269417683;2265.1732117776974;2176.6082105221053;2217.9778202218013;2222.5999320122373;2253.4704344479114;2276.8747718875456;2159.4493404181835;2178.063432723928;2182.7271591051117;2190.8904554772357;2195.8133558647455;2085.447356450542;2096.9475763105893;2104.705341252226;2111.2082968886666;2123.1082945162916;7587.848243035163;7736.265054819839;7745.148033716287;7763.883541746878;7807.804804879924;4388.407564978751;4508.481524624677;4536.591706746409;4541.931871021938;4554.157480866017;2890.3496713239565;2953.8523073846222;3003.6996300370006;3058.525928481089;3069.309405383771;900.8873890763655;903.9954800226022;907.6369452219166;907.9546022698838;940.4545363689112;10395.792084158275;10409.79180416395;10436.112930400925;10449.216308776871;10488.108510776594;4210.326347784401;4216.978915105405;4374.321980093091;4374.650027997753;4400.295952647625;8931.464112153291;8953.910460895439;9002.68490602839;9016.8647470288;9043.547822608843;4519.751413672214;4579.427571553556;4579.6794224403975;4580;4598.034412773288;3579.8568057277416;3939.6060393960947;4051.716379853441;4131.710780245354;4138.0689344897155;3671.30245253401;3725.2177042820767;3773.509443772292;3783.2244389900006;3791.829367678461;1201.9098567607464;1213.8725433829497;1216.3857252087817;1220.365409986802;1225.2281062930297;936.8454205056225;965.5558443116105;966.5988614724951;1005.6128390569684;1185.6324539392815;7092.645367731593;7320.926790732131;7397.926020739724;7411.85176296471;7421.1094668639025;443.6317856179363;1098.2038022433671;1130.0733398613058;1139.1854823800857;1148.5520646947698;5727.914081288784;5749.683767392834;5781.8554536136935;5816.941830581724;5833;9212.677556285498;9379.953100234456;9425.764355891157;9464.1009104135;9496.287778416508;9571;9594.760130996781;9605.759856003655;9677.225821934227;9700.466474343979;7288.854222915618;7309.415246780245;7344.081989751281;7347.7795666130105;7392;7127.572345659277;7156.713731450684;7161.498695091502;7196.10048743907;7212.4951253411755;8694.652213911626;8780.648774048967;8854.203121719076;8961.193492585699;8984;8899.911000889908;8996.955015224881;9067.90932090697;9138.13187747163;9193.862092068759;5814.912776308274;6124.724387402666;6350.904736428864;6351.618902865843;6379.298277189599;7216.494845360774;7217.639118043971;7219.711211551479;7306.232845551141;7312.634368281459;6421.871562568629;6521.67391630426;6616.073749675145;6673.632950187786;6753.797386078426;6433.420992110732;6513.7068831903625;6515.837104072436;6563.967180164069;6615.867682646224;6904.171499420102;6962.512624116263;6973.163220413583;7016.26329235423;7028.226895041439;6259.78090766821;6406.5515413920575;6437.903431448438;6446.258680251643;6451.967740161269;6418.6469744164515;6483.610983341015;6502.934970650233;6508.642024688687;6515.315891831289 17:19:00 INFO - PROCESS | 4428 | |4;prototype.html;312.36745590179885;313.28570858442754;319.06354848519584;320.12286335440893;323.53088022367575;5164.509371609695;5326.387465441476;5374.086405311096;5410.188471729242;5423.83728488146;5214.113600687882;5291.153415453518;5300.416954135042;5307.283516725241;5314.388845282793;3848.826802793867;3944.349182384903;4082.163156552907;4091.3249313863325;4091.8363265469347;4071.9389209161886;4083.5712250213746;4101;4111.033907031845;4115.362118871565;4070.837166513336;4080.469823816069;4081.1837632473475;4091.7954102294916;4093.283675356801;3776.490173826553;4051.6556092732153;4084.387341898724;4091.4476545666253;4094.549599544048;3517.7537572369943;3518.8592456301717;3520.559930008749;3534.285871352392;3535;4955.380577427822;4969.279454479117;4983.626228032912;5005.149124648782;5009.749512524396;4550.13547425988;4617.168909596271;4627.930581041287;4641.907161856778;4652.255639097728;5443.292371991655;5511.980283647538;5513.889722205574;5535.972320138373;5550.805721799758;3833.0609000794707;3844.9231015379814;3867.9806600967095;3868;3893.805309734502;5699.686517241592;5732.942670573282;5817.447342502455;5834.154047663107;5838.328592211865;3952.4268980998168;3965.18713663704;3970.4441378207075;3970.722049456568;3973.8410463581713;3997.760694184812;4024;4033.5966403360017;4035.878923632296;4037.7375470594316;4634.2585186370015;4642.79107440166;4643.326717625925;4647.256438969748;4655.464621568563;5387.865303367369;5473.616846820764;5563.805266815642;5575.4424557543925;5576.972115139399;1383.522684673786;1405.1077565745825;1406.978895316571;1408.837983631875;1414.4271570014162;858.6865793985276;910.2899738204211;930.4975313330725;948.2603569216022;951.1439704266215;4783.043391321749;4959.305697202394;4963;4978.551930326288;4989.750512474362;5774.942250577525;5790.10253410722;5792.102224155263;5795.913061304083;5827;4869.440014398318;4936.67911585753;4949.663590830455;4960.727160006234;4978.925316120261;3030.2272920405157;3082.5955754511515;3083.02884591353;3086.6141732283463;3087.8919237826567;5422.864428389322;5430;5442.782288708487;5454.181872719124;5480.739429931138;5712.857178570486;5915.438033386821;5932.2584676915385;5956.52347812174;5961.374055724174;5458.317710286215;5460.798624302647;5461.863453413696;5481.945180548223;5482.972585137129;5484.2596249505805;5760.423957604374;5781.277340332458;5804.65172089676;5811.593188476766;5631.324241091095;5705.600607957404;5708.372079071381;5713.428657134419;5725.141228815711;5423.864403389789;5448.373437054631;5452.454754524516;5490.341159060778;5501.972490137684;3888.3195440798313;3930.7248492605245;3943.132510847609;3970.642642162219;3994.940075898922;5792.942070579409;5802.5357971361345;5804.984127777707;5812.6630874898165;5813.709314534171;5518.586106041983;5543.611947163821;5556.861078473071;5609.74756135983;5615.803446879339;5333.679979201261;5554.6944918028275;5555.666660000413;5569.972150139223;5573.7213139343685;5375.301210842722;5379.838604841861;5402.75687594067;5454.4545545445135;5498.945010549844;5285.048691235615;5435;5594.9720251398485;5612.438756124355;5613.550915926634;5400.810971615974;5419.430959749169;5443.183522471661;5465.398806131243;5467.617266791286 17:19:00 INFO - PROCESS | 4428 | |5;yui.html;737.1044181319695;745.4148493432655;750.40717832912;769.4998251136764;776.2160218179644;12185.268883866964;12347.50609975601;13043.999999999987;13603.863961360383;13638.38627261773;13678.658033549165;13689.247091409969;13693.794593081111;13714.382852771625;13781.931090344558;646.4375992886196;826.7065191856894;835.9582020898931;842.0274582856811;845.7843249971248;808.3815880851154;843.3674743942044;844.6114787197896;844.6156998565668;846.0439703135448;855.8545047341967;863.4991704811226;863.6286396849383;866.1208872993916;867.4751775176022;855.1875718067861;856.4689892266804;857.0101532729707;857.8241460500583;860.1484530314974;626.7586979013113;629.4115002472657;631.1353445779266;632.5983000794482;632.9430351268362;13288.86711132886;13304.268265245408;13331.733365332737;13336.86663133366;13355.599332019958;12400.379981000913;12641.620751377473;12693.365331733376;12694;12805.167664101804;9875.90124098757;10139.847902281472;10188.134008609277;10491.73770655732;10543.73640658982;3340.265141668829;3366.394049071166;3386.3904497190497;3400.081977865987;3415.4023045967106;48141;48486.27270590944;49028.75485622549;49072.75463622695;49476.50523494791;9438.433693978383;9832.557534910946;9972.551235194434;10013.449260290754;10172.847407288897;17482.388116415863;17573.47279581589;17702.203400846993;17733.556661083578;17746.733798993024;6778.661066946633;6851.45188384928;6900.2409734929115;6944.166699996033;6951.582905025714;3974.4435778990965;4056.9594304057173;4092;4118.670506359484;4119.0937993641355;2722.986385068062;2767.266674331304;2777.9444411111663;2795.1614515645224;2812.198523420856;522.1515038063147;522.4905716926042;524.2320001198186;528.0679600505111;537.674706802379;618.8607563298222;621.6332363905318;651.879402310574;656.0552803962279;676.942459890905;7280.526765760209;7640.617969101522;7673.462857600026;8097.863714019585;8233.46482478637;603.9305479869784;609.2384519350811;619.5409809897716;627.7583130494793;635.6821589205397;3370.814605196738;3505.666961638691;3570.732195085379;3570.8750193743094;3592;49333;50064.24903626448;50459.49540504621;50759.23861142086;50813;44693;44922.55077449249;45083.77458112754;45209.321860172124;45584.3162352565;41543.37684934728;41714.58285417107;41801;42062.15875682469;42743.14513709708;6844.452443804584;6860.588364698134;7026.2271150174465;7060.1880783708475;7089.255628158969;27926.094417175857;28065.158045257856;28246.576301355086;28449.43101138007;28551.714482854906;33809.154771129935;34151.487727683605;37610.62389376071;37610.62389376071;38092.80953595214;8615.095414981337;8625.784355391166;8723.258523025614;9367.625294988124;9399.906000939904;10768;11645.301281922773;11720.70698232551;11770.117241206772;11947.522099115939;10724.410157441103;10900.509477073392;10910.181736369963;10970.890291096986;11140.832887506856;10059.949700251453;10202.234832387452;10486.26596138263;10933.180011499011;11184.94407527957;10558.894411056099;11358;11388.658340249805;11765.411729413323;11942.164048516868;9686.418814871131;9710.805783884141;9862.654807081717;9923.40459572428;10036.799264014824;9283.814323713623;9564.95217523908;9892.802143957224;9910.950445247727;9984.650537231162 17:19:00 INFO - PROCESS | 4428 | __end_tp_report 17:19:00 INFO - PROCESS | 4428 | __start_cc_report 17:19:00 INFO - PROCESS | 4428 | _x_x_mozilla_cycle_collect,359 17:19:00 INFO - PROCESS | 4428 | __end_cc_report 17:19:00 INFO - PROCESS | 4428 | __startTimestamp1460506740826__endTimestamp 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | ------- Summary: start ------- 17:19:00 INFO - PROCESS | 4428 | Number of tests: 6 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | [#0] dojo.html Cycles:165 Average:4675.50 Median:4838.03 stddev:587.25 (12.1%) stddev-sans-first:566.12 17:19:00 INFO - PROCESS | 4428 | Values: 2604.0 2690.3 2738.5 2740.7 2747.8 4768.7 4781.2 4790.6 4802.3 4838.0 4645.0 4742.8 4768.9 4784.3 4857.1 4321.7 4379.9 4415.1 4418.8 4447.0 628.4 4244.8 4280.3 4347.1 4383.0 4333.8 4348.2 4349.2 4355.6 4389.6 4254.2 4404.4 4425.4 4434.7 4459.5 4244.9 4301.6 4310.7 4317.4 4330.3 4622.7 4656.3 4658.0 4662.9 4716.4 5073.6 5088.6 5098.7 5105.5 5174.2 5059.4 5062.9 5066.5 5076.5 5111.1 4714.2 4718.0 4750.5 4755.0 4782.1 5040.9 5227.3 5231.3 5300.7 5350.4 4959.7 4975.0 4980.1 4989.7 5017.9 5050.4 5056.6 5057.6 5064.4 5070.4 4912.2 5055.5 5100.7 5105.6 5134.2 4893.3 5001.0 5019.9 5079.7 5123.6 4189.8 4189.9 4191.7 4195.2 4233.6 3589.2 3660.4 3670.5 3703.7 3752.3 4487.2 4493.2 4518.8 4519.2 4521.7 5060.9 5063.3 5072.8 5085.1 5115.6 4370.5 4430.7 4483.4 4524.6 4529.4 4525.8 4536.6 4540.2 4581.2 4590.4 4813.7 4814.3 4818.3 4827.9 4865.0 4994.7 5053.1 5082.9 5120.6 5161.4 4794.4 4835.4 4861.6 4868.7 4905.8 5050.6 5094.6 5097.6 5101.8 5128.8 4877.7 5072.1 5138.3 5148.9 5163.5 4941.0 4998.7 5003.4 5005.9 5013.4 4771.1 4990.7 4993.5 4995.4 5000.0 4750.3 4781.4 4827.6 4914.8 4921.2 4942.2 4969.8 4979.7 4980.8 4981.6 4865.2 4876.3 4878.7 4884.8 4893.9 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | [#1] ext.html Cycles:180 Average:34610.53 Median:33585.89 stddev:51948.03 (154.7%) stddev-sans-first:52030.95 17:19:00 INFO - PROCESS | 4428 | Values: 591.2 605.8 613.1 624.2 639.6 33032.0 33723.0 33733.7 34048.5 34121.5 35957.1 36058.8 36376.5 36547.0 36750.3 7467.9 7594.6 7621.6 7623.1 7627.8 7518.6 7628.0 7630.7 7694.2 7750.0 7650.9 7791.8 7815.8 7821.4 7832.9 7696.8 7713.5 7721.5 7728.1 7732.3 7678.3 7752.6 7774.3 7787.3 7787.8 37099.3 37349.6 37389.0 37525.4 37555.1 2518.3 3015.4 3038.5 3147.3 3215.8 25233.0 25330.1 25348.6 26011.0 26356.6 3120.8 3126.9 3141.2 3171.7 3220.7 149772.0 149815.0 151230.0 151789.0 193496.0 32497.5 33539.8 33553.3 48209.5 48574.3 31601.4 31607.0 31661.7 31683.8 31700.2 10980.5 11149.5 11181.9 11185.0 11186.7 8948.1 8967.5 9013.5 9042.2 9064.8 7846.9 7930.9 7943.5 7963.9 8047.6 3207.2 3246.1 3253.6 3262.3 3275.7 934.3 946.2 1023.6 1024.8 1027.9 27566.3 27962.2 27975.0 28174.0 28507.0 995.6 1002.9 1039.6 1047.3 1117.3 14460.2 14967.4 15025.2 15041.4 15075.2 153922.2 155986.0 155986.0 156059.0 156826.2 46956.0 47782.0 47818.0 47825.5 47830.8 1219.5 1258.4 1264.3 1264.9 1388.1 26343.3 27497.0 27867.7 28021.0 28182.4 41216.0 41334.6 41500.6 41550.6 41619.8 239835.0 241538.0 243076.0 290366.0 291415.0 24628.8 25002.4 25107.4 25199.5 38423.6 40159.4 40395.8 40977.0 41093.8 41589.0 33618.4 34395.5 34455.7 34545.5 34915.1 33728.7 34607.0 34765.0 34768.0 35078.1 30035.7 34997.8 35024.3 35120.0 36820.3 27961.3 29290.3 29549.4 29732.9 32085.0 24131.8 24471.8 24577.9 24789.8 24984.0 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | [#2] jquery.html Cycles:180 Average:23533.99 Median:4409.89 stddev:62930.99 (1427.0%) stddev-sans-first:63083.50 17:19:00 INFO - PROCESS | 4428 | Values: 376.5 380.2 389.2 389.7 391.7 15666.1 15940.3 16476.5 16480.9 16488.4 15431.8 16175.4 16472.8 16475.6 16483.7 5069.0 5219.8 5247.7 5261.3 5270.7 3633.9 5737.7 5967.4 6033.5 6036.6 4892.7 5970.0 5978.7 6003.2 6017.0 5149.5 5161.7 5196.5 5199.1 5208.0 4491.5 4781.4 4783.6 4818.0 5015.2 11698.8 11847.3 11917.9 17106.7 18369.4 1895.5 1965.7 1990.1 2015.9 2093.0 8515.5 8690.7 8714.6 9245.5 9279.3 1730.4 1740.9 1757.9 1843.6 1851.2 63890.7 66468.0 66869.3 67745.7 68639.0 10025.5 10040.8 10202.2 10205.2 10208.5 14181.0 14210.9 14235.6 14250.6 14308.9 6755.1 6873.1 6874.2 6990.7 7000.6 6270.8 6287.5 6363.6 6378.2 6407.6 4309.6 4310.9 4393.3 4426.5 4443.7 1709.9 1783.4 1849.8 1877.2 1878.4 877.8 878.4 922.2 937.3 1007.5 15744.4 15784.3 16347.6 16487.5 16674.8 838.7 856.7 870.6 903.7 976.1 9228.9 9374.7 9381.6 9401.0 9444.7 367924.0 370126.0 375077.0 393922.0 396376.0 75868.0 78943.2 79304.2 80122.6 81127.6 934.7 940.5 942.9 954.4 959.5 14628.8 14667.3 14768.2 14902.9 14981.9 30823.4 31261.0 31879.5 33665.7 36708.3 46954.5 47129.5 47322.2 47347.0 47968.3 7527.2 7650.6 7764.5 7782.9 7792.9 11258.8 11404.4 11443.5 11486.6 11521.1 10016.7 10399.8 10410.6 10423.3 10446.0 10111.3 10119.3 10166.7 10247.7 10473.6 10335.4 10402.5 10416.8 10468.4 10528.5 7723.4 7890.2 7908.5 7946.1 7987.2 7724.0 9679.7 9948.0 9954.9 10188.3 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | [#3] mootools.html Cycles:180 Average:5394.18 Median:6427.65 stddev:2846.18 (44.3%) stddev-sans-first:2838.53 17:19:00 INFO - PROCESS | 4428 | Values: 1424.8 1474.4 1607.8 1775.2 1801.7 7013.3 7466.5 7591.5 7787.1 7837.2 7564.6 7615.9 7641.0 7649.2 7665.3 2234.5 2255.3 2257.2 2260.8 2261.0 2210.9 2227.3 2243.1 2264.1 2265.2 2176.6 2218.0 2222.6 2253.5 2276.9 2159.4 2178.1 2182.7 2190.9 2195.8 2085.4 2096.9 2104.7 2111.2 2123.1 7587.8 7736.3 7745.1 7763.9 7807.8 4388.4 4508.5 4536.6 4541.9 4554.2 2890.3 2953.9 3003.7 3058.5 3069.3 900.9 904.0 907.6 908.0 940.5 10395.8 10409.8 10436.1 10449.2 10488.1 4210.3 4217.0 4374.3 4374.7 4400.3 8931.5 8953.9 9002.7 9016.9 9043.5 4519.8 4579.4 4579.7 4580.0 4598.0 3579.9 3939.6 4051.7 4131.7 4138.1 3671.3 3725.2 3773.5 3783.2 3791.8 1201.9 1213.9 1216.4 1220.4 1225.2 936.8 965.6 966.6 1005.6 1185.6 7092.6 7320.9 7397.9 7411.9 7421.1 443.6 1098.2 1130.1 1139.2 1148.6 5727.9 5749.7 5781.9 5816.9 5833.0 9212.7 9380.0 9425.8 9464.1 9496.3 9571.0 9594.8 9605.8 9677.2 9700.5 7288.9 7309.4 7344.1 7347.8 7392.0 7127.6 7156.7 7161.5 7196.1 7212.5 8694.7 8780.6 8854.2 8961.2 8984.0 8899.9 8997.0 9067.9 9138.1 9193.9 5814.9 6124.7 6350.9 6351.6 6379.3 7216.5 7217.6 7219.7 7306.2 7312.6 6421.9 6521.7 6616.1 6673.6 6753.8 6433.4 6513.7 6515.8 6564.0 6615.9 6904.2 6962.5 6973.2 7016.3 7028.2 6259.8 6406.6 6437.9 6446.3 6452.0 6418.6 6483.6 6502.9 6508.6 6515.3 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | [#4] prototype.html Cycles:180 Average:4599.06 Median:5310.84 stddev:1360.98 (25.6%) stddev-sans-first:1326.22 17:19:00 INFO - PROCESS | 4428 | Values: 312.4 313.3 319.1 320.1 323.5 5164.5 5326.4 5374.1 5410.2 5423.8 5214.1 5291.2 5300.4 5307.3 5314.4 3848.8 3944.3 4082.2 4091.3 4091.8 4071.9 4083.6 4101.0 4111.0 4115.4 4070.8 4080.5 4081.2 4091.8 4093.3 3776.5 4051.7 4084.4 4091.4 4094.5 3517.8 3518.9 3520.6 3534.3 3535.0 4955.4 4969.3 4983.6 5005.1 5009.7 4550.1 4617.2 4627.9 4641.9 4652.3 5443.3 5512.0 5513.9 5536.0 5550.8 3833.1 3844.9 3868.0 3868.0 3893.8 5699.7 5732.9 5817.4 5834.2 5838.3 3952.4 3965.2 3970.4 3970.7 3973.8 3997.8 4024.0 4033.6 4035.9 4037.7 4634.3 4642.8 4643.3 4647.3 4655.5 5387.9 5473.6 5563.8 5575.4 5577.0 1383.5 1405.1 1407.0 1408.8 1414.4 858.7 910.3 930.5 948.3 951.1 4783.0 4959.3 4963.0 4978.6 4989.8 5774.9 5790.1 5792.1 5795.9 5827.0 4869.4 4936.7 4949.7 4960.7 4978.9 3030.2 3082.6 3083.0 3086.6 3087.9 5422.9 5430.0 5442.8 5454.2 5480.7 5712.9 5915.4 5932.3 5956.5 5961.4 5458.3 5460.8 5461.9 5481.9 5483.0 5484.3 5760.4 5781.3 5804.7 5811.6 5631.3 5705.6 5708.4 5713.4 5725.1 5423.9 5448.4 5452.5 5490.3 5502.0 3888.3 3930.7 3943.1 3970.6 3994.9 5792.9 5802.5 5805.0 5812.7 5813.7 5518.6 5543.6 5556.9 5609.7 5615.8 5333.7 5554.7 5555.7 5570.0 5573.7 5375.3 5379.8 5402.8 5454.5 5498.9 5285.0 5435.0 5595.0 5612.4 5613.6 5400.8 5419.4 5443.2 5465.4 5467.6 17:19:00 INFO - PROCESS | 4428 | 17:19:00 INFO - PROCESS | 4428 | [#5] yui.html Cycles:180 Average:12668.18 Median:45396.82 stddev:14215.63 (31.3%) stddev-sans-first:14227.27 17:19:00 INFO - PROCESS | 4428 | Values: 737.1 745.4 750.4 769.5 776.2 12185.3 12347.5 13044.0 13603.9 13638.4 13678.7 13689.2 13693.8 13714.4 13781.9 646.4 826.7 836.0 842.0 845.8 808.4 843.4 844.6 844.6 846.0 855.9 863.5 863.6 866.1 867.5 855.2 856.5 857.0 857.8 860.1 626.8 629.4 631.1 632.6 632.9 13288.9 13304.3 13331.7 13336.9 13355.6 12400.4 12641.6 12693.4 12694.0 12805.2 9875.9 10139.8 10188.1 10491.7 10543.7 3340.3 3366.4 3386.4 3400.1 3415.4 48141.0 48486.3 49028.8 49072.8 49476.5 9438.4 9832.6 9972.6 10013.4 10172.8 17482.4 17573.5 17702.2 17733.6 17746.7 6778.7 6851.5 6900.2 6944.2 6951.6 3974.4 4057.0 4092.0 4118.7 4119.1 2723.0 2767.3 2777.9 2795.2 2812.2 522.2 522.5 524.2 528.1 537.7 618.9 621.6 651.9 656.1 676.9 7280.5 7640.6 7673.5 8097.9 8233.5 603.9 609.2 619.5 627.8 635.7 3370.8 3505.7 3570.7 3570.9 3592.0 49333.0 50064.2 50459.5 50759.2 50813.0 44693.0 44922.6 45083.8 45209.3 45584.3 41543.4 41714.6 41801.0 42062.2 42743.1 6844.5 6860.6 7026.2 7060.2 7089.3 27926.1 28065.2 28246.6 28449.4 28551.7 33809.2 34151.5 37610.6 37610.6 38092.8 8615.1 8625.8 8723.3 9367.6 9399.9 10768.0 11645.3 11720.7 11770.1 11947.5 10724.4 10900.5 10910.2 10970.9 11140.8 10059.9 10202.2 10486.3 10933.2 11184.9 10558.9 11358.0 11388.7 11765.4 11942.2 9686.4 9710.8 9862.7 9923.4 10036.8 9283.8 9565.0 9892.8 9911.0 9984.7 17:19:00 INFO - PROCESS | 4428 | -------- Summary: end -------- 17:19:00 INFO - PROCESS | 4428 | 17:19:01 INFO - TEST-INFO | 4428: exit 0 17:19:01 INFO - TEST-OK | dromaeo_css | took 1113943ms 17:19:01 INFO - TEST-START | kraken 17:19:01 INFO - operating with platform_type : linux_ 17:19:01 INFO - Initialising browser for kraken test... 17:19:01 INFO - TEST-INFO | started process 4660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCqdQj/profile http://localhost:37822/getInfo.html) 17:19:05 INFO - PROCESS | 4660 | 17:19:05 INFO - PROCESS | 4660 | (process:4726): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:05 INFO - PROCESS | 4660 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:19:05 INFO - PROCESS | 4660 | __metrics Screen width/height:1600/1200 17:19:05 INFO - PROCESS | 4660 | colorDepth:24 17:19:05 INFO - PROCESS | 4660 | Browser inner width/height: 1024/697 17:19:05 INFO - PROCESS | 4660 | __metrics 17:19:06 ERROR - PROCESS | 4660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:19:07 INFO - TEST-INFO | 4660: exit 0 17:19:07 INFO - Browser initialized. 17:19:07 INFO - Running cycle 1/1 for kraken test... 17:19:07 INFO - TEST-INFO | started process 4777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCqdQj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:09 INFO - PROCESS | 4777 | 17:19:09 INFO - PROCESS | 4777 | (process:4838): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:19 INFO - PROCESS | 4777 | RSS: Main: 164470784 17:19:19 INFO - PROCESS | 4777 | 17:19:21 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37822/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:22 INFO - PROCESS | 4777 | RSS: Main: 168857600 17:19:22 INFO - PROCESS | 4777 | 17:19:25 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37822/tests/kraken/driver.html?testName=audio-dft) 17:19:26 INFO - PROCESS | 4777 | RSS: Main: 172154880 17:19:26 INFO - PROCESS | 4777 | 17:19:29 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37822/tests/kraken/driver.html?testName=audio-fft) 17:19:29 INFO - PROCESS | 4777 | RSS: Main: 163926016 17:19:29 INFO - PROCESS | 4777 | 17:19:31 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37822/tests/kraken/driver.html?testName=audio-oscillator) 17:19:32 INFO - PROCESS | 4777 | RSS: Main: 163659776 17:19:32 INFO - PROCESS | 4777 | 17:19:34 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:35 INFO - PROCESS | 4777 | RSS: Main: 164052992 17:19:35 INFO - PROCESS | 4777 | 17:19:38 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37822/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:39 INFO - PROCESS | 4777 | RSS: Main: 164323328 17:19:39 INFO - PROCESS | 4777 | 17:19:42 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37822/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:43 INFO - PROCESS | 4777 | RSS: Main: 163864576 17:19:43 INFO - PROCESS | 4777 | 17:19:46 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37822/tests/kraken/driver.html?testName=json-parse-financial) 17:19:46 INFO - PROCESS | 4777 | RSS: Main: 165056512 17:19:46 INFO - PROCESS | 4777 | 17:19:48 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:49 INFO - PROCESS | 4777 | RSS: Main: 165548032 17:19:49 INFO - PROCESS | 4777 | 17:19:50 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:51 INFO - PROCESS | 4777 | RSS: Main: 165830656 17:19:51 INFO - PROCESS | 4777 | 17:19:53 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:54 INFO - PROCESS | 4777 | RSS: Main: 165814272 17:19:54 INFO - PROCESS | 4777 | 17:19:57 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:58 INFO - PROCESS | 4777 | RSS: Main: 166465536 17:19:58 INFO - PROCESS | 4777 | 17:20:01 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:01 INFO - PROCESS | 4777 | RSS: Main: 166080512 17:20:01 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:37822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37822/tests/kraken/driver.html?testName=ai-astar) 17:20:03 INFO - PROCESS | 4777 | RSS: Main: 167546880 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | __start_tp_report 17:20:03 INFO - PROCESS | 4777 | _x_x_mozilla_page_load 17:20:03 INFO - PROCESS | 4777 | _x_x_mozilla_page_load_details 17:20:03 INFO - PROCESS | 4777 | |i|pagename|runs| 17:20:03 INFO - PROCESS | 4777 | |0;ai-astar;116;109;116;114;115;125;115;117;113;114 17:20:03 INFO - PROCESS | 4777 | |1;audio-beat-detection;159;135;162;194;135;157;164;139;181;133 17:20:03 INFO - PROCESS | 4777 | |2;audio-dft;164;163;163;164;168;163;162;162;168;163 17:20:03 INFO - PROCESS | 4777 | |3;audio-fft;75;74;74;157;74;75;74;73;153;77 17:20:03 INFO - PROCESS | 4777 | |4;audio-oscillator;94;94;150;94;96;94;142;94;94;146 17:20:03 INFO - PROCESS | 4777 | |5;imaging-gaussian-blur;117;118;117;118;118;117;117;117;119;118 17:20:03 INFO - PROCESS | 4777 | |6;imaging-darkroom;149;147;147;147;148;147;148;147;149;147 17:20:03 INFO - PROCESS | 4777 | |7;imaging-desaturate;96;96;96;96;95;97;96;95;98;96 17:20:03 INFO - PROCESS | 4777 | |8;json-parse-financial;66;64;64;69;73;65;65;82;63;62 17:20:03 INFO - PROCESS | 4777 | |9;json-stringify-tinderbox;65;65;65;64;65;64;65;64;64;65 17:20:03 INFO - PROCESS | 4777 | |10;stanford-crypto-aes;86;93;83;94;86;94;85;86;86;86 17:20:03 INFO - PROCESS | 4777 | |11;stanford-crypto-ccm;140;138;140;145;150;146;147;141;169;142 17:20:03 INFO - PROCESS | 4777 | |12;stanford-crypto-pbkdf2;176;180;176;182;183;174;176;176;174;171 17:20:03 INFO - PROCESS | 4777 | |13;stanford-crypto-sha256-iterative;81;76;73;74;74;73;73;81;74;74 17:20:03 INFO - PROCESS | 4777 | __end_tp_report 17:20:03 INFO - PROCESS | 4777 | __start_cc_report 17:20:03 INFO - PROCESS | 4777 | _x_x_mozilla_cycle_collect,897 17:20:03 INFO - PROCESS | 4777 | __end_cc_report 17:20:03 INFO - PROCESS | 4777 | __startTimestamp1460506803705__endTimestamp 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | ------- Summary: start ------- 17:20:03 INFO - PROCESS | 4777 | Number of tests: 14 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.50 stddev:4.03 (3.5%) stddev-sans-first:4.27 17:20:03 INFO - PROCESS | 4777 | Values: 116.0 109.0 116.0 114.0 115.0 125.0 115.0 117.0 113.0 114.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:160.50 stddev:20.76 (12.9%) stddev-sans-first:21.99 17:20:03 INFO - PROCESS | 4777 | Values: 159.0 135.0 162.0 194.0 135.0 157.0 164.0 139.0 181.0 133.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.21 (1.4%) stddev-sans-first:2.35 17:20:03 INFO - PROCESS | 4777 | Values: 164.0 163.0 163.0 164.0 168.0 163.0 162.0 162.0 168.0 163.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#3] audio-fft Cycles:10 Average:90.60 Median:74.00 stddev:33.97 (45.9%) stddev-sans-first:35.56 17:20:03 INFO - PROCESS | 4777 | Values: 75.0 74.0 74.0 157.0 74.0 75.0 74.0 73.0 153.0 77.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.00 stddev:25.06 (26.7%) stddev-sans-first:25.92 17:20:03 INFO - PROCESS | 4777 | Values: 94.0 94.0 150.0 94.0 96.0 94.0 142.0 94.0 94.0 146.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 17:20:03 INFO - PROCESS | 4777 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 119.0 118.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 17:20:03 INFO - PROCESS | 4777 | Values: 149.0 147.0 147.0 147.0 148.0 147.0 148.0 147.0 149.0 147.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 17:20:03 INFO - PROCESS | 4777 | Values: 96.0 96.0 96.0 96.0 95.0 97.0 96.0 95.0 98.0 96.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:65.50 stddev:6.07 (9.3%) stddev-sans-first:6.42 17:20:03 INFO - PROCESS | 4777 | Values: 66.0 64.0 64.0 69.0 73.0 65.0 65.0 82.0 63.0 62.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 17:20:03 INFO - PROCESS | 4777 | Values: 65.0 65.0 65.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:86.00 stddev:4.09 (4.8%) stddev-sans-first:4.28 17:20:03 INFO - PROCESS | 4777 | Values: 86.0 93.0 83.0 94.0 86.0 94.0 85.0 86.0 86.0 86.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:145.50 stddev:8.97 (6.2%) stddev-sans-first:9.26 17:20:03 INFO - PROCESS | 4777 | Values: 140.0 138.0 140.0 145.0 150.0 146.0 147.0 141.0 169.0 142.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:176.00 stddev:3.77 (2.1%) stddev-sans-first:3.98 17:20:03 INFO - PROCESS | 4777 | Values: 176.0 180.0 176.0 182.0 183.0 174.0 176.0 176.0 174.0 171.0 17:20:03 INFO - PROCESS | 4777 | 17:20:03 INFO - PROCESS | 4777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:74.00 stddev:3.13 (4.2%) stddev-sans-first:2.55 17:20:03 INFO - PROCESS | 4777 | Values: 81.0 76.0 73.0 74.0 74.0 73.0 73.0 81.0 74.0 74.0 17:20:03 INFO - PROCESS | 4777 | -------- Summary: end -------- 17:20:03 INFO - PROCESS | 4777 | 17:20:04 INFO - TEST-INFO | 4777: exit 0 17:20:04 INFO - TEST-OK | kraken | took 63190ms 17:20:04 INFO - SUITE-END | took 1177s 17:20:04 INFO - Completed test suite (00:19:37) 17:20:04 INFO - javascript benchmark 17:20:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.9869800650995, 2690.3408664877106, 2738.4796888591177, 2740.6985231624517, 2747.8351298922066, 4768.713877167373, 4781.163296423129, 4790.592799612033, 4802.32767412562, 4838.032393521301, 4644.97677511612, 4742.762861856902, 4768.880777980552, 4784.306275590037, 4857.052874689437, 4321.654267658596, 4379.912401751963, 4415.050764085721, 4418.801153948064, 4446.97776511117, 628.4240338370734, 4244.80898359573, 4280.272353699863, 4347.1088426872575, 4382.97808510957, 4333.804978775931, 4348.217320882224, 4349.151915376503, 4355.629771469429, 4389.626881715026, 4254.170436764832, 4404.4054052702795, 4425.358323043173, 4434.68957172998, 4459.487158976694, 4244.936325955113, 4301.634361079312, 4310.741355518648, 4317.395564620955, 4330.307150855848, 4622.745748983804, 4656.301554766778, 4658.0, 4662.860114196579, 4716.38686970695, 5073.619478539124, 5088.643794934356, 5098.719570423626, 5105.463926287724, 5174.249733788617, 5059.367579052619, 5062.924056139161, 5066.544011038987, 5076.466970968069, 5111.05445492585, 4714.245720684674, 4717.980492484812, 4750.548697873765, 4755.043941081817, 4782.115308667908, 5040.924386134211, 5227.3465816772905, 5231.319928409359, 5300.734963251899, 5350.411454739976, 4959.677620954626, 4975.029869175476, 4980.05378977993, 4989.675671081368, 5017.9247311290355, 5050.444451110375, 5056.646034777604, 5057.620678449131, 5064.392272927273, 5070.442251352349, 4912.214045752662, 5055.545000949932, 5100.668456550312, 5105.591552675777, 5134.178531434953, 4893.266010098442, 5001.0, 5019.899602007939, 5079.74601269935, 5123.641345105807, 4189.7695626740215, 4189.874303770892, 4191.7484950903045, 4195.223883581547, 4233.576642335804, 3589.2462582857893, 3660.4143337065943, 3670.46778217157, 3703.6851867591017, 3752.3433399155037, 4487.169873573399, 4493.191225579361, 4518.751468669189, 4519.231730605805, 4521.683482156283, 5060.873478163002, 5063.316452278968, 5072.82245121419, 5085.084684756779, 5115.565176959925, 4370.497392799869, 4430.689851710414, 4483.417155769729, 4524.615407690318, 4529.365888775574, 4525.773711314421, 4536.56902594253, 4540.228161212602, 4581.2440947243995, 4590.449146102423, 4813.687110337817, 4814.301926220678, 4818.253170758538, 4827.879303017453, 4864.975675121602, 4994.650374473752, 5053.115704751727, 5082.923756143587, 5120.590352771695, 5161.406438259498, 4794.376731024944, 4835.419749630067, 4861.562459378673, 4868.659193856396, 4905.8037678492465, 5050.621203409685, 5094.5669618082875, 5097.566706829813, 5101.846944591668, 5128.8461346159675, 4877.707337559757, 5072.137736584716, 5138.280640710378, 5148.9227661584355, 5163.509466600667, 4941.0, 4998.725070121032, 5003.374578177728, 5005.874853128701, 5013.373328333958, 4771.141194585008, 4990.700557966534, 4993.523605341886, 4995.375578052744, 4999.950000499948, 4750.287456881357, 4781.402324709411, 4827.613790896649, 4914.795875010645, 4921.163402221559, 4942.233953737176, 4969.751512424292, 4979.726115063706, 4980.750962451935, 4981.6014718823135, 4865.172920603435, 4876.292937523968, 4878.682885612424, 4884.780184891617, 4893.877653058702], "value": 4640.015792423215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1635036423459, 605.8031139879539, 613.0773186354536, 624.2321944008869, 639.5523133806337, 33032.0, 33723.0, 33733.66266337336, 34048.489272660896, 34121.488177677355, 35957.101072473204, 36058.819705901435, 36376.45435318466, 36547.0, 36750.26499470009, 7467.8879816802655, 7594.620268986529, 7621.618919054053, 7623.123340815794, 7627.847443051136, 7518.624068796566, 7627.961860190719, 7630.732924347649, 7694.192109828444, 7750.0, 7650.885236721454, 7791.844163116734, 7815.765527034198, 7821.4133939954445, 7832.921670783305, 7696.846063078735, 7713.537187768752, 7721.53670779755, 7728.111267204259, 7732.265434783687, 7678.347340476066, 7752.612369381508, 7774.300312971804, 7787.338076263524, 7787.766367008999, 37099.25801483955, 37349.626503734886, 37389.0, 37525.437118443246, 37555.06112347186, 2518.25711415133, 3015.3969206158854, 3038.498647723123, 3147.291859331655, 3215.839208039589, 25233.0, 25330.1134460293, 25348.619770703455, 26011.0, 26356.60465093006, 3120.7659425543175, 3126.9218269543444, 3141.198994256473, 3171.698688624577, 3220.6618305077864, 149772.0, 149815.0, 151230.0, 151789.0, 193496.0, 32497.51253731196, 33539.832300838825, 33553.328933421195, 48209.5179048212, 48574.27138592924, 31601.36797264042, 31607.0, 31661.683383165873, 31683.84158079241, 31700.20749481235, 10980.505877235544, 11149.498272577754, 11181.888181118247, 11185.0, 11186.720331991603, 8948.060453652402, 8967.461952282883, 9013.459192448474, 9042.231410330063, 9064.773380665405, 7846.882296765553, 7930.920690793134, 7943.523388596587, 7963.8805417918775, 8047.557384343917, 3207.246297120175, 3246.1397729601676, 3253.560769296115, 3262.314913868114, 3275.7051865332232, 934.2946075712794, 946.1531928923575, 1023.6263763726336, 1024.7643042100358, 1027.8920713324994, 27566.310842229104, 27962.161135165978, 27975.0, 28174.0, 28507.0, 995.6067353395368, 1002.8946960569181, 1039.6361273554196, 1047.3349423116376, 1117.2626066795876, 14460.20468874222, 14967.401303947938, 15025.173615451255, 15041.398344066334, 15075.170865602497, 153922.23038884733, 155986.0, 155986.0, 156059.0, 156826.2158689199, 46956.0, 47782.0, 47818.0, 47825.521744782105, 47830.760846195546, 1219.5121951219583, 1258.3959699344366, 1264.2730430002784, 1264.9114561980573, 1388.0769288423287, 26343.341416463976, 27497.0, 27867.721322787325, 28021.0, 28182.43635127327, 41216.0, 41334.586654133076, 41500.58499414967, 41550.584494154675, 41619.7919010403, 239835.0, 241538.0, 243076.0, 290366.0, 291415.0, 24628.753712462647, 25002.37494062663, 25107.372315692253, 25199.496010080064, 38423.615763843125, 40159.3976090353, 40395.79802100971, 40977.0, 41093.79453102715, 41589.0, 33618.44515062499, 34395.484067739504, 34455.655443446245, 34545.48181777326, 34915.12712182114, 33728.66271337353, 34607.0, 34765.0, 34768.0, 35078.12304692403, 30035.699643004165, 34997.82501087478, 35024.29951401009, 35120.0, 36820.26359472742, 27961.300967475974, 29290.267743306587, 29549.409011819214, 29732.85133574405, 32085.0, 24131.75868241295, 24471.75528244766, 24577.877110614332, 24789.752102478746, 24984.0], "value": 15245.442918209124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.5334023976611, 380.1617433559003, 389.1516494042985, 389.71356053300804, 391.67295308417476, 15666.138362390078, 15940.282687279072, 16476.505704828858, 16480.917595412007, 16488.42290519832, 15431.768523472158, 16175.43385981491, 16472.83527164728, 16475.58811029725, 16483.67032659346, 5069.0, 5219.817306394277, 5247.658902171346, 5261.289725886994, 5270.657407268534, 3633.872814451495, 5737.684427356494, 5967.403259674042, 6033.48715359195, 6036.637801731888, 4892.706437613737, 5970.0, 5978.701064946757, 6003.249593800775, 6017.037274036155, 5149.510796474329, 5161.664491808039, 5196.480351964792, 5199.090159222121, 5207.973960130194, 4491.505934347219, 4781.426228852525, 4783.617310615143, 4817.951820481785, 5015.172496538067, 11698.766024679458, 11847.348395838226, 11917.94041029798, 17106.743398849027, 18369.44891653239, 1895.5450691833998, 1965.7149713291635, 1990.1243452880685, 2015.9294424695213, 2093.037202886674, 8515.48907065578, 8690.695825646135, 8714.564271786448, 9245.491497967609, 9279.304052196045, 1730.4203091964207, 1740.9042502662348, 1757.8505827004592, 1843.612841303328, 1851.2132343753985, 63890.68054659743, 66468.0, 66869.3313066868, 67745.6612716943, 68639.0, 10025.548850301753, 10040.849387259197, 10202.183825293958, 10205.234607404474, 10208.489575521195, 14181.0, 14210.85789142116, 14235.644108897153, 14250.643733906529, 14308.928455357656, 6755.121834161528, 6873.140857392826, 6874.209465911485, 6990.685419156151, 7000.579965202104, 6270.811875643738, 6287.528435367366, 6363.61818290904, 6378.234611846516, 6407.647579383085, 4309.569043095666, 4310.89222769427, 4393.253146965024, 4426.535213802569, 4443.733375997386, 1709.8717596180336, 1783.4293026231742, 1849.842763365129, 1877.1646617255462, 1878.4364690592768, 877.7630039889194, 878.4026861733954, 922.1654402765374, 937.3438592984937, 1007.450939238117, 15744.370225191093, 15784.301073133902, 16347.591310217102, 16487.505374838773, 16674.83325166757, 838.714836955438, 856.7258477287209, 870.629982257538, 903.6520939438232, 976.1068622210739, 9228.8615670765, 9374.718758437259, 9381.624735010522, 9401.012893646206, 9444.669436569688, 367924.0, 370126.0, 375077.0, 393922.0, 396376.0, 75868.0, 78943.21056789474, 79304.20695793083, 80122.59938700269, 81127.59436202899, 934.6915517879083, 940.5485367023867, 942.9339946203837, 954.355809828363, 959.4866746290701, 14628.780568291697, 14667.339969701603, 14768.18774967387, 14902.925485372503, 14981.850181498481, 30823.38353232878, 31261.0, 31879.52180717245, 33665.66334336625, 36708.26583468369, 46954.530454695014, 47129.52870471252, 47322.21422286278, 47347.0, 47968.28047579219, 7527.16644600439, 7650.579218143055, 7764.456488045783, 7782.88325675104, 7792.88310675329, 11258.7748245033, 11404.372759498307, 11443.542258309575, 11486.597969071043, 11521.135914806591, 10016.749581260236, 10399.820193292393, 10410.583576656849, 10423.270371073952, 10446.0, 10111.292209545556, 10119.291649584458, 10166.694999150037, 10247.692569222936, 10473.581056757645, 10335.379877207391, 10402.479876006018, 10416.843747343948, 10468.371897686164, 10528.473576321307, 7723.382129429745, 7890.210978902293, 7908.52548847071, 7946.125926148235, 7987.16134805837, 7724.034495688039, 9679.66121185755, 9947.950260248652, 9954.850677239703, 10188.286819922534], "value": 8030.794279921142, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.843267240603, 1474.4028668389303, 1607.8392160783924, 1775.1745438371154, 1801.720733286341, 7013.263607321222, 7466.4773465857415, 7591.5445073295505, 7787.143414224431, 7837.21627837216, 7564.62176891156, 7615.8857617135645, 7640.968469256649, 7649.196834332399, 7665.271799179083, 2234.474898398879, 2255.289583781112, 2257.1761307122865, 2260.8078313343303, 2260.954780904381, 2210.8784016879067, 2227.2984010036785, 2243.080337061797, 2264.1396269417683, 2265.1732117776974, 2176.6082105221053, 2217.9778202218013, 2222.5999320122373, 2253.4704344479114, 2276.8747718875456, 2159.4493404181835, 2178.063432723928, 2182.7271591051117, 2190.8904554772357, 2195.8133558647455, 2085.447356450542, 2096.9475763105893, 2104.705341252226, 2111.2082968886666, 2123.1082945162916, 7587.848243035163, 7736.265054819839, 7745.148033716287, 7763.883541746878, 7807.804804879924, 4388.407564978751, 4508.481524624677, 4536.591706746409, 4541.931871021938, 4554.157480866017, 2890.3496713239565, 2953.8523073846222, 3003.6996300370006, 3058.525928481089, 3069.309405383771, 900.8873890763655, 903.9954800226022, 907.6369452219166, 907.9546022698838, 940.4545363689112, 10395.792084158275, 10409.79180416395, 10436.112930400925, 10449.216308776871, 10488.108510776594, 4210.326347784401, 4216.978915105405, 4374.321980093091, 4374.650027997753, 4400.295952647625, 8931.464112153291, 8953.910460895439, 9002.68490602839, 9016.8647470288, 9043.547822608843, 4519.751413672214, 4579.427571553556, 4579.6794224403975, 4580.0, 4598.034412773288, 3579.8568057277416, 3939.6060393960947, 4051.716379853441, 4131.710780245354, 4138.0689344897155, 3671.30245253401, 3725.2177042820767, 3773.509443772292, 3783.2244389900006, 3791.829367678461, 1201.9098567607464, 1213.8725433829497, 1216.3857252087817, 1220.365409986802, 1225.2281062930297, 936.8454205056225, 965.5558443116105, 966.5988614724951, 1005.6128390569684, 1185.6324539392815, 7092.645367731593, 7320.926790732131, 7397.926020739724, 7411.85176296471, 7421.1094668639025, 443.6317856179363, 1098.2038022433671, 1130.0733398613058, 1139.1854823800857, 1148.5520646947698, 5727.914081288784, 5749.683767392834, 5781.8554536136935, 5816.941830581724, 5833.0, 9212.677556285498, 9379.953100234456, 9425.764355891157, 9464.1009104135, 9496.287778416508, 9571.0, 9594.760130996781, 9605.759856003655, 9677.225821934227, 9700.466474343979, 7288.854222915618, 7309.415246780245, 7344.081989751281, 7347.7795666130105, 7392.0, 7127.572345659277, 7156.713731450684, 7161.498695091502, 7196.10048743907, 7212.4951253411755, 8694.652213911626, 8780.648774048967, 8854.203121719076, 8961.193492585699, 8984.0, 8899.911000889908, 8996.955015224881, 9067.90932090697, 9138.13187747163, 9193.862092068759, 5814.912776308274, 6124.724387402666, 6350.904736428864, 6351.618902865843, 6379.298277189599, 7216.494845360774, 7217.639118043971, 7219.711211551479, 7306.232845551141, 7312.634368281459, 6421.871562568629, 6521.67391630426, 6616.073749675145, 6673.632950187786, 6753.797386078426, 6433.420992110732, 6513.7068831903625, 6515.837104072436, 6563.967180164069, 6615.867682646224, 6904.171499420102, 6962.512624116263, 6973.163220413583, 7016.26329235423, 7028.226895041439, 6259.78090766821, 6406.5515413920575, 6437.903431448438, 6446.258680251643, 6451.967740161269, 6418.6469744164515, 6483.610983341015, 6502.934970650233, 6508.642024688687, 6515.315891831289], "value": 4394.898785033183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.36745590179885, 313.28570858442754, 319.06354848519584, 320.12286335440893, 323.53088022367575, 5164.509371609695, 5326.387465441476, 5374.086405311096, 5410.188471729242, 5423.83728488146, 5214.113600687882, 5291.153415453518, 5300.416954135042, 5307.283516725241, 5314.388845282793, 3848.826802793867, 3944.349182384903, 4082.163156552907, 4091.3249313863325, 4091.8363265469347, 4071.9389209161886, 4083.5712250213746, 4101.0, 4111.033907031845, 4115.362118871565, 4070.837166513336, 4080.469823816069, 4081.1837632473475, 4091.7954102294916, 4093.283675356801, 3776.490173826553, 4051.6556092732153, 4084.387341898724, 4091.4476545666253, 4094.549599544048, 3517.7537572369943, 3518.8592456301717, 3520.559930008749, 3534.285871352392, 3535.0, 4955.380577427822, 4969.279454479117, 4983.626228032912, 5005.149124648782, 5009.749512524396, 4550.13547425988, 4617.168909596271, 4627.930581041287, 4641.907161856778, 4652.255639097728, 5443.292371991655, 5511.980283647538, 5513.889722205574, 5535.972320138373, 5550.805721799758, 3833.0609000794707, 3844.9231015379814, 3867.9806600967095, 3868.0, 3893.805309734502, 5699.686517241592, 5732.942670573282, 5817.447342502455, 5834.154047663107, 5838.328592211865, 3952.4268980998168, 3965.18713663704, 3970.4441378207075, 3970.722049456568, 3973.8410463581713, 3997.760694184812, 4024.0, 4033.5966403360017, 4035.878923632296, 4037.7375470594316, 4634.2585186370015, 4642.79107440166, 4643.326717625925, 4647.256438969748, 4655.464621568563, 5387.865303367369, 5473.616846820764, 5563.805266815642, 5575.4424557543925, 5576.972115139399, 1383.522684673786, 1405.1077565745825, 1406.978895316571, 1408.837983631875, 1414.4271570014162, 858.6865793985276, 910.2899738204211, 930.4975313330725, 948.2603569216022, 951.1439704266215, 4783.043391321749, 4959.305697202394, 4963.0, 4978.551930326288, 4989.750512474362, 5774.942250577525, 5790.10253410722, 5792.102224155263, 5795.913061304083, 5827.0, 4869.440014398318, 4936.67911585753, 4949.663590830455, 4960.727160006234, 4978.925316120261, 3030.2272920405157, 3082.5955754511515, 3083.02884591353, 3086.6141732283463, 3087.8919237826567, 5422.864428389322, 5430.0, 5442.782288708487, 5454.181872719124, 5480.739429931138, 5712.857178570486, 5915.438033386821, 5932.2584676915385, 5956.52347812174, 5961.374055724174, 5458.317710286215, 5460.798624302647, 5461.863453413696, 5481.945180548223, 5482.972585137129, 5484.2596249505805, 5760.423957604374, 5781.277340332458, 5804.65172089676, 5811.593188476766, 5631.324241091095, 5705.600607957404, 5708.372079071381, 5713.428657134419, 5725.141228815711, 5423.864403389789, 5448.373437054631, 5452.454754524516, 5490.341159060778, 5501.972490137684, 3888.3195440798313, 3930.7248492605245, 3943.132510847609, 3970.642642162219, 3994.940075898922, 5792.942070579409, 5802.5357971361345, 5804.984127777707, 5812.6630874898165, 5813.709314534171, 5518.586106041983, 5543.611947163821, 5556.861078473071, 5609.74756135983, 5615.803446879339, 5333.679979201261, 5554.6944918028275, 5555.666660000413, 5569.972150139223, 5573.7213139343685, 5375.301210842722, 5379.838604841861, 5402.75687594067, 5454.4545545445135, 5498.945010549844, 5285.048691235615, 5435.0, 5594.9720251398485, 5612.438756124355, 5613.550915926634, 5400.810971615974, 5419.430959749169, 5443.183522471661, 5465.398806131243, 5467.617266791286], "value": 4163.067932344147, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.1044181319695, 745.4148493432655, 750.40717832912, 769.4998251136764, 776.2160218179644, 12185.268883866964, 12347.50609975601, 13043.999999999987, 13603.863961360383, 13638.38627261773, 13678.658033549165, 13689.247091409969, 13693.794593081111, 13714.382852771625, 13781.931090344558, 646.4375992886196, 826.7065191856894, 835.9582020898931, 842.0274582856811, 845.7843249971248, 808.3815880851154, 843.3674743942044, 844.6114787197896, 844.6156998565668, 846.0439703135448, 855.8545047341967, 863.4991704811226, 863.6286396849383, 866.1208872993916, 867.4751775176022, 855.1875718067861, 856.4689892266804, 857.0101532729707, 857.8241460500583, 860.1484530314974, 626.7586979013113, 629.4115002472657, 631.1353445779266, 632.5983000794482, 632.9430351268362, 13288.86711132886, 13304.268265245408, 13331.733365332737, 13336.86663133366, 13355.599332019958, 12400.379981000913, 12641.620751377473, 12693.365331733376, 12694.0, 12805.167664101804, 9875.90124098757, 10139.847902281472, 10188.134008609277, 10491.73770655732, 10543.73640658982, 3340.265141668829, 3366.394049071166, 3386.3904497190497, 3400.081977865987, 3415.4023045967106, 48141.0, 48486.27270590944, 49028.75485622549, 49072.75463622695, 49476.50523494791, 9438.433693978383, 9832.557534910946, 9972.551235194434, 10013.449260290754, 10172.847407288897, 17482.388116415863, 17573.47279581589, 17702.203400846993, 17733.556661083578, 17746.733798993024, 6778.661066946633, 6851.45188384928, 6900.2409734929115, 6944.166699996033, 6951.582905025714, 3974.4435778990965, 4056.9594304057173, 4092.0, 4118.670506359484, 4119.0937993641355, 2722.986385068062, 2767.266674331304, 2777.9444411111663, 2795.1614515645224, 2812.198523420856, 522.1515038063147, 522.4905716926042, 524.2320001198186, 528.0679600505111, 537.674706802379, 618.8607563298222, 621.6332363905318, 651.879402310574, 656.0552803962279, 676.942459890905, 7280.526765760209, 7640.617969101522, 7673.462857600026, 8097.863714019585, 8233.46482478637, 603.9305479869784, 609.2384519350811, 619.5409809897716, 627.7583130494793, 635.6821589205397, 3370.814605196738, 3505.666961638691, 3570.732195085379, 3570.8750193743094, 3592.0, 49333.0, 50064.24903626448, 50459.49540504621, 50759.23861142086, 50813.0, 44693.0, 44922.55077449249, 45083.77458112754, 45209.321860172124, 45584.3162352565, 41543.37684934728, 41714.58285417107, 41801.0, 42062.15875682469, 42743.14513709708, 6844.452443804584, 6860.588364698134, 7026.2271150174465, 7060.1880783708475, 7089.255628158969, 27926.094417175857, 28065.158045257856, 28246.576301355086, 28449.43101138007, 28551.714482854906, 33809.154771129935, 34151.487727683605, 37610.62389376071, 37610.62389376071, 38092.80953595214, 8615.095414981337, 8625.784355391166, 8723.258523025614, 9367.625294988124, 9399.906000939904, 10768.0, 11645.301281922773, 11720.70698232551, 11770.117241206772, 11947.522099115939, 10724.410157441103, 10900.509477073392, 10910.181736369963, 10970.890291096986, 11140.832887506856, 10059.949700251453, 10202.234832387452, 10486.26596138263, 10933.180011499011, 11184.94407527957, 10558.894411056099, 11358.0, 11388.658340249805, 11765.411729413323, 11942.164048516868, 9686.418814871131, 9710.805783884141, 9862.654807081717, 9923.40459572428, 10036.799264014824, 9283.814323713623, 9564.95217523908, 9892.802143957224, 9910.950445247727, 9984.650537231162], "value": 5966.082262948565, "unit": "score"}], "name": "dromaeo_css", "value": 6291.457317137955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 116.0, 114.0, 115.0, 125.0, 115.0, 117.0, 113.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 162.0, 194.0, 135.0, 157.0, 164.0, 139.0, 181.0, 133.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 164.0, 168.0, 163.0, 162.0, 162.0, 168.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 157.0, 74.0, 75.0, 74.0, 73.0, 153.0, 77.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 150.0, 94.0, 96.0, 94.0, 142.0, 94.0, 94.0, 146.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0, 98.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 69.0, 73.0, 65.0, 65.0, 82.0, 63.0, 62.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 93.0, 83.0, 94.0, 86.0, 94.0, 85.0, 86.0, 86.0, 86.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 140.0, 145.0, 150.0, 146.0, 147.0, 141.0, 169.0, 142.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 176.0, 182.0, 183.0, 174.0, 176.0, 176.0, 174.0, 171.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 73.0, 74.0, 74.0, 73.0, 73.0, 81.0, 74.0, 74.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1614.6999999999998, "alertThreshold": 2.0}]} 17:20:04 INFO - Return code: 0 17:20:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:20:04 ERROR - # TBPL SUCCESS # 17:20:04 INFO - Running post-action listener: _resource_record_post_action 17:20:04 INFO - Running post-run listener: _resource_record_post_run 17:20:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520843264; Read time: 12; Write time: 451848 17:20:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233025536; Read time: 0; Write time: 275248 17:20:06 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287219712; Read time: 12; Write time: 176600 17:20:06 INFO - Running post-run listener: _upload_blobber_files 17:20:06 INFO - Blob upload gear active. 17:20:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:20:06 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:07 INFO - (blobuploader) - INFO - Done attempting. 17:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:08 INFO - (blobuploader) - INFO - Done attempting. 17:20:08 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:08 INFO - Return code: 0 17:20:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6116ffc5cf3094b168df6087ca1abc1d099b59627c4f4bfb151b45b828c0e88725c22c45d023a077f46daeb8807ff9e51e40f759621793a9f3821631c41bbb15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e179802871913e7827a62a058a5b618d8f51970844ad344fa40879ee5cffc9bfdb2321aa9772ea2f0198b5e2e6cf897e45f9a761603db5d1e1d7665c83d93d2"} 17:20:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:08 INFO - Contents: 17:20:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6116ffc5cf3094b168df6087ca1abc1d099b59627c4f4bfb151b45b828c0e88725c22c45d023a077f46daeb8807ff9e51e40f759621793a9f3821631c41bbb15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e179802871913e7827a62a058a5b618d8f51970844ad344fa40879ee5cffc9bfdb2321aa9772ea2f0198b5e2e6cf897e45f9a761603db5d1e1d7665c83d93d2"} 17:20:08 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:08 INFO - Copying logs to upload dir... 17:20:08 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.293396 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-12 17:20:07.555054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 17:20:07.558640) ========= 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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6116ffc5cf3094b168df6087ca1abc1d099b59627c4f4bfb151b45b828c0e88725c22c45d023a077f46daeb8807ff9e51e40f759621793a9f3821631c41bbb15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e179802871913e7827a62a058a5b618d8f51970844ad344fa40879ee5cffc9bfdb2321aa9772ea2f0198b5e2e6cf897e45f9a761603db5d1e1d7665c83d93d2"} build_url:https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/ON0Ql4EZS8yVDuhKQRGDwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6116ffc5cf3094b168df6087ca1abc1d099b59627c4f4bfb151b45b828c0e88725c22c45d023a077f46daeb8807ff9e51e40f759621793a9f3821631c41bbb15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e179802871913e7827a62a058a5b618d8f51970844ad344fa40879ee5cffc9bfdb2321aa9772ea2f0198b5e2e6cf897e45f9a761603db5d1e1d7665c83d93d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 17:20:07.586658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:20:07.586986) ========= 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=0274524eba3bdaad075c2247000001d4-1460505210.153199-1084803010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:20:07.675162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 17:20:07.675493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 17:20:07.675796) ========= ========= Total master_lag: 0.31 =========