builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1457089834.74 results: success (0) buildid: 20160304014526 builduid: 832f206eb44342ac85de1e940e33eae3 revision: 20d8879ac256a9c7ff81edc69748c37c3b310865 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.740417) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.740874) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.741171) ========= 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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.764714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.765038) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.778060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.778363) ========= 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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.827218) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.827532) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.827912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.828183) ========= 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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 03:10:35-- 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.7M=0s 2016-03-04 03:10:35 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.990287) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:34.990611) ========= 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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021808 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:35.040271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 03:10:35.040642) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20d8879ac256a9c7ff81edc69748c37c3b310865 --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 20d8879ac256a9c7ff81edc69748c37c3b310865 --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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 03:10:35,543 truncating revision to first 12 chars 2016-03-04 03:10:35,543 Setting DEBUG logging. 2016-03-04 03:10:35,543 attempt 1/10 2016-03-04 03:10:35,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20d8879ac256?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 03:10:36,255 unpacking tar archive at: mozilla-central-20d8879ac256/testing/mozharness/ program finished with exit code 0 elapsedTime=1.001064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 03:10:36.054734) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:36.055298) ========= echo 20d8879ac256a9c7ff81edc69748c37c3b310865 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'20d8879ac256a9c7ff81edc69748c37c3b310865'] 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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20d8879ac256a9c7ff81edc69748c37c3b310865 program finished with exit code 0 elapsedTime=0.004686 script_repo_revision: '20d8879ac256a9c7ff81edc69748c37c3b310865' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:36.106291) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:36.106680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 03:10:36.117727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-03-04 03:10:36.118133) ========= /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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:10:36 INFO - MultiFileLogger online at 20160304 03:10:36 in /builds/slave/test 03:10:36 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 03:10:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:10:36 INFO - {'append_to_log': False, 03:10:36 INFO - 'base_work_dir': '/builds/slave/test', 03:10:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:10:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:10:36 INFO - 'branch': 'Firefox-Non-PGO', 03:10:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:10:36 INFO - 'config_files': ('talos/linux_config.py',), 03:10:36 INFO - 'default_actions': ('clobber', 03:10:36 INFO - 'read-buildbot-config', 03:10:36 INFO - 'download-and-extract', 03:10:36 INFO - 'populate-webroot', 03:10:36 INFO - 'create-virtualenv', 03:10:36 INFO - 'install', 03:10:36 INFO - 'run-tests'), 03:10:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:10:36 INFO - 'download_minidump_stackwalk': True, 03:10:36 INFO - 'download_symbols': 'ondemand', 03:10:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:10:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:10:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:10:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:10:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:10:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:10:36 INFO - 'installer_path': 'installer.exe', 03:10:36 INFO - 'log_level': 'info', 03:10:36 INFO - 'log_name': 'talos', 03:10:36 INFO - 'log_to_console': True, 03:10:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:10:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:10:36 INFO - 'opt_config_files': (), 03:10:36 INFO - 'pip_index': False, 03:10:36 INFO - 'sps_profile': False, 03:10:36 INFO - 'sps_profile_interval': 0, 03:10:36 INFO - 'suite': 'dromaeojs-e10s', 03:10:36 INFO - 'system_bits': '32', 03:10:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:10:36 INFO - 'title': 'talos-linux64-ix-004', 03:10:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:10:36 INFO - 'use_talos_json': True, 03:10:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:10:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:10:36 INFO - 'work_dir': 'build'} 03:10:36 INFO - ##### 03:10:36 INFO - ##### Running clobber step. 03:10:36 INFO - ##### 03:10:36 INFO - Running pre-action listener: _resource_record_pre_action 03:10:36 INFO - Running main action method: clobber 03:10:36 INFO - rmtree: /builds/slave/test/build 03:10:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:10:37 INFO - Running post-action listener: _resource_record_post_action 03:10:37 INFO - ##### 03:10:37 INFO - ##### Running read-buildbot-config step. 03:10:37 INFO - ##### 03:10:37 INFO - Running pre-action listener: _resource_record_pre_action 03:10:37 INFO - Running main action method: read_buildbot_config 03:10:37 INFO - Using buildbot properties: 03:10:37 INFO - { 03:10:37 INFO - "project": "", 03:10:37 INFO - "product": "firefox", 03:10:37 INFO - "script_repo_revision": "production", 03:10:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:10:37 INFO - "repository": "", 03:10:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:10:37 INFO - "buildid": "20160304014526", 03:10:37 INFO - "pgo_build": "False", 03:10:37 INFO - "basedir": "/builds/slave/test", 03:10:37 INFO - "buildnumber": 235, 03:10:37 INFO - "slavename": "talos-linux64-ix-004", 03:10:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:10:37 INFO - "platform": "ubuntu64_hw", 03:10:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:10:37 INFO - "branch": "mozilla-central", 03:10:37 INFO - "repo_path": "mozilla-central", 03:10:37 INFO - "revision": "20d8879ac256a9c7ff81edc69748c37c3b310865", 03:10:37 INFO - "stage_platform": "linux64", 03:10:37 INFO - "builduid": "832f206eb44342ac85de1e940e33eae3", 03:10:37 INFO - "slavebuilddir": "test" 03:10:37 INFO - } 03:10:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 03:10:37 INFO - Running post-action listener: _resource_record_post_action 03:10:37 INFO - ##### 03:10:37 INFO - ##### Running download-and-extract step. 03:10:37 INFO - ##### 03:10:37 INFO - Running pre-action listener: _resource_record_pre_action 03:10:37 INFO - Running main action method: download_and_extract 03:10:37 INFO - mkdir: /builds/slave/test/build/tests 03:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:37 INFO - https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 03:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 03:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 03:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:10:37 INFO - Downloaded 1448 bytes. 03:10:37 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 03:10:37 INFO - Using the following test package requirements: 03:10:37 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:10:37 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:10:37 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:10:37 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'jsshell-linux-x86_64.zip'], 03:10:37 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:10:37 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:10:37 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:10:37 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:10:37 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:10:37 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:10:37 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:10:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:37 INFO - https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:39 INFO - Downloaded 22080740 bytes. 03:10:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:10:40 INFO - Return code: 0 03:10:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:40 INFO - https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:41 INFO - Downloaded 22080740 bytes. 03:10:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:10:42 INFO - Return code: 0 03:10: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')]} 03:10:42 INFO - https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:10:43 INFO - Downloaded 10808282 bytes. 03:10:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:10:43 INFO - Return code: 0 03:10: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')]} 03:10:43 INFO - https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:11:15 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 03:11:15 INFO - retry: attempt #1 caught exception: The read operation timed out 03:11:15 INFO - retry: Failed, sleeping 30 seconds before retrying 03:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:11:47 INFO - Downloaded 54376813 bytes. 03:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:11:47 INFO - mkdir: /builds/slave/test/properties 03:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:47 INFO - Contents: 03:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:11:48 INFO - Running post-action listener: _resource_record_post_action 03:11:48 INFO - Running post-action listener: set_extra_try_arguments 03:11:48 INFO - ##### 03:11:48 INFO - ##### Running populate-webroot step. 03:11:48 INFO - ##### 03:11:48 INFO - Running pre-action listener: _resource_record_pre_action 03:11:48 INFO - Running main action method: populate_webroot 03:11:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:48 INFO - '--tppagecycles', 03:11:48 INFO - '7'], 03:11:48 INFO - 'tests': ['tsvgm']}}, 03:11:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:11:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:11:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'tests': ['damp', 'tps']}, 03:11:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['damp', 'tps']}, 03:11:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:48 INFO - 'other': {'tests': ['a11yr', 03:11:48 INFO - 'ts_paint', 03:11:48 INFO - 'tpaint', 03:11:48 INFO - 'sessionrestore', 03:11:48 INFO - 'sessionrestore_no_auto_restore']}, 03:11:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['a11yr', 03:11:48 INFO - 'ts_paint', 03:11:48 INFO - 'tpaint', 03:11:48 INFO - 'sessionrestore', 03:11:48 INFO - 'sessionrestore_no_auto_restore']}, 03:11:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['a11yr', 03:11:48 INFO - 'ts_paint', 03:11:48 INFO - 'tpaint', 03:11:48 INFO - 'sessionrestore', 03:11:48 INFO - 'sessionrestore_no_auto_restore']}, 03:11:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['a11yr', 03:11:48 INFO - 'ts_paint', 03:11:48 INFO - 'tpaint', 03:11:48 INFO - 'sessionrestore', 03:11:48 INFO - 'sessionrestore_no_auto_restore']}, 03:11:48 INFO - 'other_l64': {'tests': ['a11yr', 03:11:48 INFO - 'ts_paint', 03:11:48 INFO - 'tpaint', 03:11:48 INFO - 'sessionrestore', 03:11:48 INFO - 'sessionrestore_no_auto_restore']}, 03:11:48 INFO - 'other_nol64': {'tests': ['a11yr', 03:11:48 INFO - 'ts_paint', 03:11:48 INFO - 'tpaint', 03:11:48 INFO - 'sessionrestore', 03:11:48 INFO - 'sessionrestore_no_auto_restore']}, 03:11:48 INFO - 'svgr': {'tests': ['tsvgx', 03:11:48 INFO - 'tsvgr_opacity', 03:11:48 INFO - 'tart', 03:11:48 INFO - 'tscrollx', 03:11:48 INFO - 'cart']}, 03:11:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['tsvgx', 03:11:48 INFO - 'tsvgr_opacity', 03:11:48 INFO - 'tart', 03:11:48 INFO - 'tscrollx', 03:11:48 INFO - 'cart']}, 03:11:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'tests': ['tp5o']}, 03:11:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'talos_options': ['--e10s'], 03:11:48 INFO - 'tests': ['tp5o']}, 03:11:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'talos_options': ['--xperf_path', 03:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:48 INFO - 'tests': ['tp5n']}, 03:11:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:48 INFO - 'talos_options': ['--e10s', 03:11:48 INFO - '--xperf_path', 03:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:48 INFO - 'tests': ['tp5n']}}, 03:11:48 INFO - 'talos.zip': {'path': '', 03:11:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:48 INFO - Running post-action listener: _resource_record_post_action 03:11:48 INFO - ##### 03:11:48 INFO - ##### Running create-virtualenv step. 03:11:48 INFO - ##### 03:11:48 INFO - Running pre-action listener: _resource_record_pre_action 03:11:48 INFO - Running main action method: create_virtualenv 03:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:48 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 03:11:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:48 INFO - Using real prefix '/usr' 03:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:50 INFO - Installing pip.................done. 03:11:50 INFO - Return code: 0 03:11:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:11:50 INFO - Using env: {'DISPLAY': ':0', 03:11:50 INFO - 'HOME': '/home/cltbld', 03:11:50 INFO - 'LANG': 'en_US.UTF-8', 03:11:50 INFO - 'LANGUAGE': 'en_US:en', 03:11:50 INFO - 'LOGNAME': 'cltbld', 03:11:50 INFO - 'MAIL': '/var/mail/cltbld', 03:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:50 INFO - 'MOZ_NO_REMOTE': '1', 03:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:50 INFO - 'NO_EM_RESTART': '1', 03:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:50 INFO - 'PWD': '/builds/slave/test', 03:11:50 INFO - 'SHELL': '/bin/bash', 03:11:50 INFO - 'SHLVL': '1', 03:11:50 INFO - 'TERM': 'linux', 03:11:50 INFO - 'TMOUT': '86400', 03:11:50 INFO - 'USER': 'cltbld', 03:11:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:50 INFO - '_': '/tools/buildbot/bin/python'} 03:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:50 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 03:11:50 INFO - Cleaning up... 03:11:50 INFO - Return code: 0 03:11:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:11:50 INFO - Using env: {'DISPLAY': ':0', 03:11:50 INFO - 'HOME': '/home/cltbld', 03:11:50 INFO - 'LANG': 'en_US.UTF-8', 03:11:50 INFO - 'LANGUAGE': 'en_US:en', 03:11:50 INFO - 'LOGNAME': 'cltbld', 03:11:50 INFO - 'MAIL': '/var/mail/cltbld', 03:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:50 INFO - 'MOZ_NO_REMOTE': '1', 03:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:50 INFO - 'NO_EM_RESTART': '1', 03:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:50 INFO - 'PWD': '/builds/slave/test', 03:11:50 INFO - 'SHELL': '/bin/bash', 03:11:50 INFO - 'SHLVL': '1', 03:11:50 INFO - 'TERM': 'linux', 03:11:50 INFO - 'TMOUT': '86400', 03:11:50 INFO - 'USER': 'cltbld', 03:11:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:50 INFO - '_': '/tools/buildbot/bin/python'} 03:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:51 INFO - Downloading/unpacking psutil>=0.7.1 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:52 INFO - Installing collected packages: psutil 03:11:52 INFO - Running setup.py install for psutil 03:11:53 INFO - building 'psutil._psutil_linux' extension 03:11:53 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 03:11:53 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 03:11:53 INFO - building 'psutil._psutil_posix' extension 03:11:53 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 03:11:53 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 03:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:53 INFO - Successfully installed psutil 03:11:53 INFO - Cleaning up... 03:11:53 INFO - Return code: 0 03:11:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:11:53 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 03:11:53 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 03:11:53 INFO - Using env: {'DISPLAY': ':0', 03:11:53 INFO - 'HOME': '/home/cltbld', 03:11:53 INFO - 'LANG': 'en_US.UTF-8', 03:11:53 INFO - 'LANGUAGE': 'en_US:en', 03:11:53 INFO - 'LOGNAME': 'cltbld', 03:11:53 INFO - 'MAIL': '/var/mail/cltbld', 03:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:53 INFO - 'MOZ_NO_REMOTE': '1', 03:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:53 INFO - 'NO_EM_RESTART': '1', 03:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:53 INFO - 'PWD': '/builds/slave/test', 03:11:53 INFO - 'SHELL': '/bin/bash', 03:11:53 INFO - 'SHLVL': '1', 03:11:53 INFO - 'TERM': 'linux', 03:11:53 INFO - 'TMOUT': '86400', 03:11:53 INFO - 'USER': 'cltbld', 03:11:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:53 INFO - '_': '/tools/buildbot/bin/python'} 03:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:11:55 INFO - Installing collected packages: mozsystemmonitor 03:11:55 INFO - Running setup.py install for mozsystemmonitor 03:11:55 INFO - Successfully installed mozsystemmonitor 03:11:55 INFO - Cleaning up... 03:11:55 INFO - Return code: 0 03:11:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:11:55 INFO - Using env: {'DISPLAY': ':0', 03:11:55 INFO - 'HOME': '/home/cltbld', 03:11:55 INFO - 'LANG': 'en_US.UTF-8', 03:11:55 INFO - 'LANGUAGE': 'en_US:en', 03:11:55 INFO - 'LOGNAME': 'cltbld', 03:11:55 INFO - 'MAIL': '/var/mail/cltbld', 03:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:55 INFO - 'MOZ_NO_REMOTE': '1', 03:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:55 INFO - 'NO_EM_RESTART': '1', 03:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:55 INFO - 'PWD': '/builds/slave/test', 03:11:55 INFO - 'SHELL': '/bin/bash', 03:11:55 INFO - 'SHLVL': '1', 03:11:55 INFO - 'TERM': 'linux', 03:11:55 INFO - 'TMOUT': '86400', 03:11:55 INFO - 'USER': 'cltbld', 03:11:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:55 INFO - '_': '/tools/buildbot/bin/python'} 03:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:58 INFO - Downloading docopt-0.6.1.tar.gz 03:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:58 INFO - Running setup.py install for blobuploader 03:11:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:58 INFO - Running setup.py install for requests 03:11:59 INFO - Running setup.py install for docopt 03:11:59 INFO - Successfully installed blobuploader requests docopt 03:11:59 INFO - Cleaning up... 03:11:59 INFO - Return code: 0 03:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:59 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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:11:59 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 03:11:59 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 03:11:59 INFO - Using env: {'DISPLAY': ':0', 03:11:59 INFO - 'HOME': '/home/cltbld', 03:11:59 INFO - 'LANG': 'en_US.UTF-8', 03:11:59 INFO - 'LANGUAGE': 'en_US:en', 03:11:59 INFO - 'LOGNAME': 'cltbld', 03:11:59 INFO - 'MAIL': '/var/mail/cltbld', 03:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:59 INFO - 'MOZ_NO_REMOTE': '1', 03:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:59 INFO - 'NO_EM_RESTART': '1', 03:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:59 INFO - 'PWD': '/builds/slave/test', 03:11:59 INFO - 'SHELL': '/bin/bash', 03:11:59 INFO - 'SHLVL': '1', 03:11:59 INFO - 'TERM': 'linux', 03:11:59 INFO - 'TMOUT': '86400', 03:11:59 INFO - 'USER': 'cltbld', 03:11:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:59 INFO - '_': '/tools/buildbot/bin/python'} 03:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:59 INFO - Running setup.py (path:/tmp/pip-wCrfTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:59 INFO - Running setup.py (path:/tmp/pip-RS_5c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:59 INFO - Running setup.py (path:/tmp/pip-OK3e2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:59 INFO - Running setup.py (path:/tmp/pip-myh7Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:59 INFO - Running setup.py (path:/tmp/pip-IALaMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:59 INFO - Running setup.py (path:/tmp/pip-BekVeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:59 INFO - Running setup.py (path:/tmp/pip-8J0SBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:59 INFO - Running setup.py (path:/tmp/pip-FMM1I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:59 INFO - Running setup.py (path:/tmp/pip-qLFAxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:00 INFO - Running setup.py (path:/tmp/pip-07PIrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:00 INFO - Running setup.py (path:/tmp/pip-mutRxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:00 INFO - Running setup.py (path:/tmp/pip-cFHom4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:00 INFO - Running setup.py (path:/tmp/pip-Wg1z4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:00 INFO - Running setup.py (path:/tmp/pip-8eZ7so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:00 INFO - Running setup.py (path:/tmp/pip-BwEitA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:00 INFO - Running setup.py (path:/tmp/pip-Fzo5Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:00 INFO - Running setup.py (path:/tmp/pip-unQwyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:12:00 INFO - Running setup.py install for manifestparser 03:12:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:12:00 INFO - Running setup.py install for mozcrash 03:12:00 INFO - Running setup.py install for mozdebug 03:12:00 INFO - Running setup.py install for mozdevice 03:12:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozfile 03:12:01 INFO - Running setup.py install for mozhttpd 03:12:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozinfo 03:12:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozInstall 03:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozleak 03:12:01 INFO - Running setup.py install for mozlog 03:12:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for moznetwork 03:12:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozprocess 03:12:01 INFO - Running setup.py install for mozprofile 03:12:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:12:01 INFO - Running setup.py install for mozrunner 03:12:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:12:02 INFO - Running setup.py install for mozscreenshot 03:12:02 INFO - Running setup.py install for moztest 03:12:02 INFO - Running setup.py install for mozversion 03:12:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:12:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:12:02 INFO - Cleaning up... 03:12:02 INFO - Return code: 0 03:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:02 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')]} 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:02 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')]} 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:02 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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:12:02 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 03:12:02 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 03:12:02 INFO - Using env: {'DISPLAY': ':0', 03:12:02 INFO - 'HOME': '/home/cltbld', 03:12:02 INFO - 'LANG': 'en_US.UTF-8', 03:12:02 INFO - 'LANGUAGE': 'en_US:en', 03:12:02 INFO - 'LOGNAME': 'cltbld', 03:12:02 INFO - 'MAIL': '/var/mail/cltbld', 03:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:02 INFO - 'MOZ_NO_REMOTE': '1', 03:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:02 INFO - 'NO_EM_RESTART': '1', 03:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:02 INFO - 'PWD': '/builds/slave/test', 03:12:02 INFO - 'SHELL': '/bin/bash', 03:12:02 INFO - 'SHLVL': '1', 03:12:02 INFO - 'TERM': 'linux', 03:12:02 INFO - 'TMOUT': '86400', 03:12:02 INFO - 'USER': 'cltbld', 03:12:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:02 INFO - '_': '/tools/buildbot/bin/python'} 03:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:02 INFO - Running setup.py (path:/tmp/pip-t7uBK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:02 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)) 03:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:02 INFO - Running setup.py (path:/tmp/pip-IoCgRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:02 INFO - Running setup.py (path:/tmp/pip-YMJO4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:02 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)) 03:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:02 INFO - Running setup.py (path:/tmp/pip-G5Pzyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:02 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)) 03:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:02 INFO - Running setup.py (path:/tmp/pip-l05gs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:02 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)) 03:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:02 INFO - Running setup.py (path:/tmp/pip-H4LK85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:03 INFO - Running setup.py (path:/tmp/pip-WE38Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:03 INFO - Running setup.py (path:/tmp/pip-n_jT_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:03 INFO - Running setup.py (path:/tmp/pip-CanMhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:03 INFO - Running setup.py (path:/tmp/pip-R_maBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:03 INFO - Running setup.py (path:/tmp/pip-uXGhb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:03 INFO - Running setup.py (path:/tmp/pip-4fepPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:03 INFO - Running setup.py (path:/tmp/pip-Rr7TGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:03 INFO - Running setup.py (path:/tmp/pip-7ocqew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:03 INFO - Running setup.py (path:/tmp/pip-yVEexV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:03 INFO - Running setup.py (path:/tmp/pip-_m75U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:03 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)) 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:03 INFO - Running setup.py (path:/tmp/pip-OFbpoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:03 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)) 03:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:03 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)) 03:12:03 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)) 03:12:03 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)) 03:12:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:05 INFO - Downloading blessings-1.6.tar.gz 03:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:12:05 INFO - Installing collected packages: blessings 03:12:05 INFO - Running setup.py install for blessings 03:12:05 INFO - Successfully installed blessings 03:12:05 INFO - Cleaning up... 03:12:05 INFO - Return code: 0 03:12:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:06 INFO - Reading from file tmpfile_stdout 03:12:06 INFO - Current package versions: 03:12:06 INFO - argparse == 1.2.1 03:12:06 INFO - blessings == 1.6 03:12:06 INFO - blobuploader == 1.2.4 03:12:06 INFO - docopt == 0.6.1 03:12:06 INFO - manifestparser == 1.1 03:12:06 INFO - mozInstall == 1.12 03:12:06 INFO - mozcrash == 0.16 03:12:06 INFO - mozdebug == 0.1 03:12:06 INFO - mozdevice == 0.48 03:12:06 INFO - mozfile == 1.2 03:12:06 INFO - mozhttpd == 0.7 03:12:06 INFO - mozinfo == 0.9 03:12:06 INFO - mozleak == 0.1 03:12:06 INFO - mozlog == 3.1 03:12:06 INFO - moznetwork == 0.27 03:12:06 INFO - mozprocess == 0.22 03:12:06 INFO - mozprofile == 0.28 03:12:06 INFO - mozrunner == 6.11 03:12:06 INFO - mozscreenshot == 0.1 03:12:06 INFO - mozsystemmonitor == 0.0 03:12:06 INFO - moztest == 0.7 03:12:06 INFO - mozversion == 1.4 03:12:06 INFO - psutil == 3.1.1 03:12:06 INFO - requests == 1.2.3 03:12:06 INFO - wsgiref == 0.1.2 03:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:06 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')]} 03:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:06 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')]} 03:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:06 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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:12:06 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 03:12:06 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 03:12:06 INFO - Using env: {'DISPLAY': ':0', 03:12:06 INFO - 'HOME': '/home/cltbld', 03:12:06 INFO - 'LANG': 'en_US.UTF-8', 03:12:06 INFO - 'LANGUAGE': 'en_US:en', 03:12:06 INFO - 'LOGNAME': 'cltbld', 03:12:06 INFO - 'MAIL': '/var/mail/cltbld', 03:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:06 INFO - 'MOZ_NO_REMOTE': '1', 03:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:06 INFO - 'NO_EM_RESTART': '1', 03:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:06 INFO - 'PWD': '/builds/slave/test', 03:12:06 INFO - 'SHELL': '/bin/bash', 03:12:06 INFO - 'SHLVL': '1', 03:12:06 INFO - 'TERM': 'linux', 03:12:06 INFO - 'TMOUT': '86400', 03:12:06 INFO - 'USER': 'cltbld', 03:12:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:06 INFO - '_': '/tools/buildbot/bin/python'} 03:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 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)) 03:12:06 INFO - Cleaning up... 03:12:06 INFO - Return code: 0 03:12:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:12:06 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')]} 03:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:06 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')]} 03:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:06 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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:12:06 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 03:12:06 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 03:12:06 INFO - Using env: {'DISPLAY': ':0', 03:12:06 INFO - 'HOME': '/home/cltbld', 03:12:06 INFO - 'LANG': 'en_US.UTF-8', 03:12:06 INFO - 'LANGUAGE': 'en_US:en', 03:12:06 INFO - 'LOGNAME': 'cltbld', 03:12:06 INFO - 'MAIL': '/var/mail/cltbld', 03:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:06 INFO - 'MOZ_NO_REMOTE': '1', 03:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:06 INFO - 'NO_EM_RESTART': '1', 03:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:06 INFO - 'PWD': '/builds/slave/test', 03:12:06 INFO - 'SHELL': '/bin/bash', 03:12:06 INFO - 'SHLVL': '1', 03:12:06 INFO - 'TERM': 'linux', 03:12:06 INFO - 'TMOUT': '86400', 03:12:06 INFO - 'USER': 'cltbld', 03:12:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:06 INFO - '_': '/tools/buildbot/bin/python'} 03:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:06 INFO - Downloading/unpacking jsonschema 03:12: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 03:12: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 03:12: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 03:12: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 03:12: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 03:12: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 03:12:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:12:08 INFO - Downloading/unpacking functools32 (from jsonschema) 03:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:12:08 INFO - warning: no files found matching '*.txt' 03:12:08 INFO - no previously-included directories found matching 'build' 03:12:08 INFO - no previously-included directories found matching 'dist' 03:12:08 INFO - no previously-included directories found matching '.git*' 03:12:08 INFO - Installing collected packages: jsonschema, functools32 03:12:08 INFO - Running setup.py install for functools32 03:12:08 INFO - warning: no files found matching '*.txt' 03:12:08 INFO - no previously-included directories found matching 'build' 03:12:08 INFO - no previously-included directories found matching 'dist' 03:12:08 INFO - no previously-included directories found matching '.git*' 03:12:08 INFO - Successfully installed jsonschema functools32 03:12:08 INFO - Cleaning up... 03:12:08 INFO - Return code: 0 03:12:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:12:08 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')]} 03:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:08 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')]} 03:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:08 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 0x7f1eb1405f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', '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 03:12:08 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 03:12:08 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 03:12:08 INFO - Using env: {'DISPLAY': ':0', 03:12:08 INFO - 'HOME': '/home/cltbld', 03:12:08 INFO - 'LANG': 'en_US.UTF-8', 03:12:08 INFO - 'LANGUAGE': 'en_US:en', 03:12:08 INFO - 'LOGNAME': 'cltbld', 03:12:08 INFO - 'MAIL': '/var/mail/cltbld', 03:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:08 INFO - 'MOZ_NO_REMOTE': '1', 03:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:08 INFO - 'NO_EM_RESTART': '1', 03:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:08 INFO - 'PWD': '/builds/slave/test', 03:12:08 INFO - 'SHELL': '/bin/bash', 03:12:08 INFO - 'SHLVL': '1', 03:12:08 INFO - 'TERM': 'linux', 03:12:08 INFO - 'TMOUT': '86400', 03:12:08 INFO - 'USER': 'cltbld', 03:12:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:08 INFO - '_': '/tools/buildbot/bin/python'} 03:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:09 INFO - Downloading/unpacking flake8 03:12: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 03:12: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 03:12: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 03:12: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 03:12: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 03:12: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 03:12:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:12:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:12:10 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 03:12:10 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 03:12:10 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 03:12:10 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 03:12:10 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 03:12:10 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 03:12:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:12:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 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 03:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:12:11 INFO - no previously-included directories found matching 'docs/_build' 03:12:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:12:11 INFO - Running setup.py install for pep8 03:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:12:11 INFO - no previously-included directories found matching 'docs/_build' 03:12:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:12:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:12:11 INFO - Cleaning up... 03:12:11 INFO - Return code: 0 03:12:11 INFO - Running post-action listener: _resource_record_post_action 03:12:11 INFO - Running post-action listener: _start_resource_monitoring 03:12:11 INFO - Starting resource monitoring. 03:12:11 INFO - ##### 03:12:11 INFO - ##### Running install step. 03:12:11 INFO - ##### 03:12:11 INFO - Running pre-action listener: _resource_record_pre_action 03:12:11 INFO - Running main action method: install 03:12:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:12 INFO - Reading from file tmpfile_stdout 03:12:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:12:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:12:12 INFO - Reading from file tmpfile_stdout 03:12:12 INFO - Output received: 03:12:12 INFO - Usage: mozinstall [options] installer 03:12:12 INFO - Options: 03:12:12 INFO - -h, --help show this help message and exit 03:12:12 INFO - -d DEST, --destination=DEST 03:12:12 INFO - Directory to install application into. [default: 03:12:12 INFO - "/builds/slave/test"] 03:12:12 INFO - --app=APP Application being installed. [default: firefox] 03:12:12 INFO - mkdir: /builds/slave/test/build/application 03:12:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:12:27 INFO - Reading from file tmpfile_stdout 03:12:27 INFO - Output received: 03:12:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:12:27 INFO - Running post-action listener: _resource_record_post_action 03:12:27 INFO - ##### 03:12:27 INFO - ##### Running run-tests step. 03:12:27 INFO - ##### 03:12:27 INFO - Running pre-action listener: _resource_record_pre_action 03:12:27 INFO - Running main action method: run_tests 03:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:27 INFO - Python 2.7.3 03:12:27 INFO - Return code: 0 03:12:27 INFO - grabbing minidump binary from tooltool 03:12:27 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')]} 03:12:27 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 0x16f3160>, '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 0x16f4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f44f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:27 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 03:12:27 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 03:12:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:27 INFO - Return code: 0 03:12:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:12:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:12:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:12:28 INFO - Return code: 0 03:12:28 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/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:12:28 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/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 03:12:28 INFO - Using env: {'DISPLAY': ':0', 03:12:28 INFO - 'HOME': '/home/cltbld', 03:12:28 INFO - 'LANG': 'en_US.UTF-8', 03:12:28 INFO - 'LANGUAGE': 'en_US:en', 03:12:28 INFO - 'LOGNAME': 'cltbld', 03:12:28 INFO - 'MAIL': '/var/mail/cltbld', 03:12:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:28 INFO - 'MOZ_NO_REMOTE': '1', 03:12:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:28 INFO - 'NO_EM_RESTART': '1', 03:12:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:28 INFO - 'PWD': '/builds/slave/test', 03:12:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:28 INFO - 'SHELL': '/bin/bash', 03:12:28 INFO - 'SHLVL': '1', 03:12:28 INFO - 'TERM': 'linux', 03:12:28 INFO - 'TMOUT': '86400', 03:12:28 INFO - 'USER': 'cltbld', 03:12:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340', 03:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:28 INFO - '_': '/tools/buildbot/bin/python'} 03:12:28 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/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:12:29 INFO - mozversion application_buildid: 20160304014526 03:12:29 INFO - mozversion application_changeset: 20d8879ac256a9c7ff81edc69748c37c3b310865 03:12:29 INFO - mozversion application_display_name: Nightly 03:12:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:29 INFO - mozversion application_name: Firefox 03:12:29 INFO - mozversion application_remotingname: firefox 03:12:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:12:29 INFO - mozversion application_vendor: Mozilla 03:12:29 INFO - mozversion application_version: 47.0a1 03:12:29 INFO - mozversion platform_buildid: 20160304014526 03:12:29 INFO - mozversion platform_changeset: 20d8879ac256a9c7ff81edc69748c37c3b310865 03:12:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:12:29 INFO - mozversion platform_version: 47.0a1 03:12:29 INFO - using testdate: 1457089949 03:12:29 INFO - actual date: 1457089949 03:12:29 INFO - starting webserver on 'localhost:55469' 03:12:29 INFO - SUITE-START | Running 2 tests 03:12:29 INFO - TEST-START | dromaeo_css 03:12:29 INFO - operating with platform_type : linux_ 03:12:29 INFO - Initialising browser for dromaeo_css test... 03:12:29 INFO - TEST-INFO | started process 4073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKbNHC9/profile http://localhost:55469/getInfo.html) 03:12:33 INFO - PROCESS | 4073 | 03:12:33 INFO - PROCESS | 4073 | (process:4155): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:12:34 INFO - PROCESS | 4073 | __metrics Screen width/height:1600/1200 03:12:34 INFO - PROCESS | 4073 | colorDepth:24 03:12:34 INFO - PROCESS | 4073 | Browser inner width/height: 1024/697 03:12:34 INFO - PROCESS | 4073 | __metrics 03:12:34 ERROR - PROCESS | 4073 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:12:35 INFO - TEST-INFO | 4073: exit 0 03:12:35 INFO - Browser initialized. 03:12:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:35 INFO - TEST-INFO | started process 4206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKbNHC9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:37 INFO - PROCESS | 4206 | 03:12:37 INFO - PROCESS | 4206 | (process:4262): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:12:47 INFO - PROCESS | 4206 | RSS: Main: 161509376 03:12:47 INFO - PROCESS | 4206 | 03:13:37 INFO - PROCESS | 4206 | 1457090017261 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] 03:15:48 INFO - PROCESS | 4206 | Cycle 1(1): loaded http://localhost:55469/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55469/tests/dromaeo/cssquery-ext.html) 03:15:49 INFO - PROCESS | 4206 | RSS: Main: 169033728 03:15:49 INFO - PROCESS | 4206 | 03:18:51 INFO - PROCESS | 4206 | Cycle 1(1): loaded http://localhost:55469/tests/dromaeo/cssquery-ext.html (next: http://localhost:55469/tests/dromaeo/cssquery-jquery.html) 03:18:52 INFO - PROCESS | 4206 | RSS: Main: 165052416 03:18:52 INFO - PROCESS | 4206 | 03:21:54 INFO - PROCESS | 4206 | Cycle 1(1): loaded http://localhost:55469/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55469/tests/dromaeo/cssquery-mootools.html) 03:21:54 INFO - PROCESS | 4206 | RSS: Main: 166424576 03:21:54 INFO - PROCESS | 4206 | 03:24:56 INFO - PROCESS | 4206 | Cycle 1(1): loaded http://localhost:55469/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55469/tests/dromaeo/cssquery-prototype.html) 03:24:57 INFO - PROCESS | 4206 | RSS: Main: 164233216 03:24:57 INFO - PROCESS | 4206 | 03:27:59 INFO - PROCESS | 4206 | Cycle 1(1): loaded http://localhost:55469/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55469/tests/dromaeo/cssquery-yui.html) 03:28:00 INFO - PROCESS | 4206 | RSS: Main: 164171776 03:28:00 INFO - PROCESS | 4206 | 03:31:02 INFO - PROCESS | 4206 | Cycle 1(1): loaded http://localhost:55469/tests/dromaeo/cssquery-yui.html (next: http://localhost:55469/tests/dromaeo/cssquery-dojo.html) 03:31:03 INFO - PROCESS | 4206 | RSS: Main: 168177664 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | __start_tp_report 03:31:03 INFO - PROCESS | 4206 | _x_x_mozilla_page_load 03:31:03 INFO - PROCESS | 4206 | _x_x_mozilla_page_load_details 03:31:03 INFO - PROCESS | 4206 | |i|pagename|runs| 03:31:03 INFO - PROCESS | 4206 | |0;dojo.html;2654.2833434972554;2661.7471340222673;2692.8518931458775;2695.528282550554;2707.1472486166854;4557.612602928747;4666.999999999995;4684.086603112386;4707.646926480515;4732.2428411454175;4691.319758635004;4723.645726570512;4740.407449068866;4749.643776716743;4786.688865223758;4338.9349159762705;4367.148406060819;4420.182266280748;4422.535633758457;4497.820087196525;4429.756363400012;4463.375127482155;4467.508574056851;4496.572825581565;4538.7503687297185;4225.2183346080765;4308.224519586473;4362.149380870732;4383.276759334706;4383.539728328544;4277.080427708027;4284.228838809013;4286.314189729628;4296.205202037601;4317.050248945258;4259.16946195492;4274.29474136767;4286.1337699761825;4320.589543993316;4321.956780432187;4439.445069366329;4577.061702351043;4614.146382919171;4665.253559430509;4666.789994450258;5012;5017.49825017499;5032.84901452957;5033.194688849767;5077.720725360104;4856.805727770885;5035.748212589392;5052.368453943257;5057.165567681365;5079.898402031976;4566;4696.060787842377;4704.247320428749;4704.529547045268;4767.4994125617;5066.240063990431;5102.030614183293;5120.359955005624;5130.358705161855;5186.273921650972;4790.808367665254;4905.852824415273;4914.754262286871;4932.235503496964;4979.402471703419;4883.413990321184;4964.429090654548;5011.3986321640905;5016.949830501721;5057.367829021372;5029.17018691919;5039.26930595069;5045.142325804549;5054.9241761373605;5071.822486212965;4756;4971.6022718183185;5009.073321435546;5014.197728363444;5069.264956581349;4168.624823765876;4204.831806727758;4214.852480163241;4251.171021650748;4252.4046633471335;3688.981555092207;3706.8517259309324;3715.6841668458483;3718.2563487302646;3751.099736063325;4183.058811767389;4295.484541854935;4370.322599997005;4376.212281789309;4395.164918665443;4930.260460930817;4957.652964292465;4960.454350021495;4977.850664480072;5022.171341728574;4291.141771645684;4291.463567054118;4295.957040429618;4305.590968857953;4338.197433474817;4334.501532323823;4418.491873434532;4427.335899615084;4465.866024019285;4478.104379124123;4806.303086052572;4819.445763737215;4840.249761287007;4846.854594362246;4858.95141048585;5098.362704661918;5139.563137133386;5155.871103222299;5156.845294641167;5159.767810448464;4543;4723.763811809465;4774.40319960005;4778.7849546769785;4804.735739534359;4979.904421027368;5004.024215277986;5019.52314530119;5030.874228144179;5069.366329208849;4890.535399137077;5025.39695236574;5068.797248110034;5107.438181799925;5139.203423469368;4737.786799594095;4769.260764581495;4869.342638743724;4924.310596516562;4971.453140154508;4888.5111488850835;4927.679700819435;4928.802847886044;4930.408350997904;4945.876353091202;4771.856844294677;4821.421429428491;4828.058528586892;4861.732604706775;4876.317315575893;4720.669553131248;4913.729744863924;4932.235503496964;4980.726060066731;4985.651004429655;4828.468868424541;4845.345878306524;4848.612111031039;4854.660173787942;4898.338724272177 03:31:03 INFO - PROCESS | 4206 | |1;ext.html;485.2914744473071;507.7486644111166;521.2233771680197;543.1038786003095;548.4351118348102;23890.40273993151;32996.175095622624;33275.66724332756;33301.500477492824;33469.16327091824;35562.28875422497;35595.82202088986;35608.64391356086;35847.2830543389;36032.45951310732;7530.472866899319;7579;7672.731454399097;7710.7686769397005;7721.691132354699;7643.808904777397;7776.30013298803;7860.764177074669;7867.7246296379635;8078.23256790604;7963.761087167365;8048.5170889746805;8066.193380661945;8088.716894908679;8123.675052997873;7959.482633628795;8015.198480151997;8032.39757018223;8056.073551541589;8092.514449133071;7873.330766884822;7906.407019473505;7919.920800792033;7921.485103468256;7996.28033476984;36064.819675901716;36811.447828282595;36819.263614727824;36850.63149368499;36855.4471682925;2613.3989182487944;2745.3960128771637;2824.7740180785486;3402.1494626343415;3416.265502916885;27429.725702742915;27691.446171076666;28148.962759310172;28275.293117672016;28881.277968050756;3399.5410619566287;3407;3435.2957643682985;3445.207602251471;3493.8777142800136;221599;222133.99999999837;222468;223291;223660;51700;51989;52227.21659175115;52243.77562243821;52342.73828630909;58617.12074318888;59205.40794591999;59654;59746.701266493386;59821.40178598158;11317.660470185907;11488.023518001064;11543.018843398406;11551.826722599168;11562.248453850472;8911.910880891108;9037.819243615091;9075.81848363029;9076.364654474124;9108.681196158102;18077.27690892376;18308.26766929308;18401.723974140397;18472;19318.806811931983;7613.314801667766;7708;7731.690732370755;7838.372930165573;7856.528608283407;883.7834730490943;887.8179973105498;959.6689142245914;969.2343048991218;1049.5959055763433;22214.001109849964;22345.776542234693;22571.322860314216;22855.885720571292;22954.65568016481;965.2615748952057;966.7534778631544;1014.4724743133529;1025.7589466475372;1060.649985504797;12544.498220071095;12758.9362053191;12765.553205637758;12844.48622055126;12941.935290323489;260363;262549;264295;265542;265891;44975.775121124185;45650;45675;45719.54280457219;45880.08239835251;1156.4738044189874;1166.6674997625637;1199.7480529088814;1214.3017764785284;1218.4638758946035;24326;25039.624405633567;25702.228933132035;25960;26166;39958.200835982534;39977.40033899552;40014.39978400268;40182.59817401788;40247.396289056276;243556;245135;246006;246101;247117;28598.14205573836;29210.269743256587;29326.560101598065;38293.234135317696;38971.415428769156;34309.82845085759;34475.82762086173;35190.824045879606;35213.64786352104;35247.11882202863;29796.55305170381;29877.253068673457;30154.09537713872;30593.694063059083;30907;29337.413251735274;29577;30122.69877301199;30123.246918827204;30203.546946796254;29634.703652963195;31659.84170079135;34197.65802341945;34734.131646708025;35690;25560.8721956389;27992.580111298754;28001.159965201077;28207.57688634631;28395.716042839307;22284.331470055924;22557.774422255567;22706.205282815023;22910.198143064914;24039 03:31:03 INFO - PROCESS | 4206 | |2;jquery.html;324.55373860941205;333.2718011145646;336.4549429923524;341.1947803184485;344.2151893682405;14765.114093154418;15364.001339912911;15904.125273109974;15912.840871591281;15935.282912268947;13271.402786874589;13429.194248345106;13629.114107583;14072.648183795385;14108.224047677373;4843.951560484403;5093.541581257686;5107.591392688594;5109.667871588354;5125.410577783547;4786.52134786522;4910.975445122769;5012.172991456406;5018.34761481007;5027.773750181251;4948.752562371885;4971.105201063807;4973.254011898226;4975.8258460953875;5000.924986125211;4814.301926220696;5009.699418034893;5057.519535644126;5064.772085256172;5066.493350664941;4769.093872164312;4863.294822250789;4866.02679464105;4870.09903167915;4875.9756201219125;11004.339739615649;11363.602273920456;11368.431578421047;11439.19925605208;11445.542178312857;1865.2632210277;1881.7835948865918;1892.9905350473298;1947.289239427613;2273.818094552448;8731.345149113842;8741.650333986632;8878.467291962503;9089.363744537884;9176.8623470648;1741.2599645150888;1766.2555382588866;1780.8842425242317;1817.836394724468;1844.5941892783567;40518.79740601307;50378;58471.41528584745;58830.411695882496;59088.11367829486;9630.133288004114;9764.707058788248;9839.114479696862;9920.030087689876;9955.80088398228;12693.984481241478;12771.169873958162;12780.360981950866;12813;12823.743525129445;6428.614283143026;6541.967290163519;6567.408933196035;6690.698918548677;6710.127683401127;6075.149479072933;6145.5698101133385;6160.630362178284;6204.224471941007;6226.6575338355915;4149.7095203335475;4156.625903668684;4205.179989902001;4274.038341373166;4277.957220427818;1714.1172296267432;1754.3684273661472;1782.5276301780038;1811.293595497757;1814.5100822777777;411.25973248153207;837.6984285657159;857.691231156783;859.4070091636751;905.5834316214483;9372.62509499626;9397.530123493798;9685.150562870464;9708.174805141502;10195.031472010147;405.94519739835334;419.6181474857865;419.72717733472876;421.1114548303139;423.5129600958922;5433.782648694087;5440.891182176334;5460.290162278879;5566.109422492463;5589.74846131925;382390;382420;385142;387422;394445;42359.78820105941;43411;65182.02226966599;66693.66653166703;69252;742.3133601418666;940.3088729783603;968.1093394077466;973.6640858903667;975.956081976327;14204.573862784133;14877.776833347725;15043.548693539211;15138.016028958082;15279.083255004734;29340.55989160207;29761.702382975895;30927.69072309248;32991.83504082464;33445.66554334426;42382.1523569533;42829.14341713086;42845.78577107094;43168;43381;6910.827229319308;6979.5114341997605;7088.539244949062;7130.679119439534;7145.785626431215;10474.52864621109;10606.310589811637;10637.893621063691;10721.946390267998;10886.23796334249;9385.38994965325;9396.812063758824;9519.52402379892;9738.464384458639;9928.553215105481;9142.862857057016;9474.194693451134;9480.810383792423;9638.132568068908;9642.71071867845;9435.05649435051;9673.467959262309;9711.581230540229;9755.609775608897;9923.702288931343;6918.169819621477;7040.823979400556;7120.857582848211;7134.500584959003;7228.530145540523;7402.33378995893;9522.523873806143;9817;9990.600375984879;10103.141232995278 03:31:03 INFO - PROCESS | 4206 | |3;mootools.html;1362.0601784768512;1363.706803037347;1477.2318394434894;1670.8997460152384;1697.0411717379673;6179.134921111048;7158.17680966689;7202.819929501758;7296;7346.4122870170395;7207;7243.89134162988;7303.30618591233;7303.744368947088;7306.305900939402;2076.6677331626943;2093.727815383998;2109.6940943563172;2111.3032699209225;2112.1973650012974;2062.5153089024066;2067.9276225332114;2075.107703687414;2123.50097727034;2124.1928067334393;2085.780992995729;2111.6938043983614;2123.150739704115;2143.2927134045804;2155.4288113649895;2099.191811152702;2101.2015434134933;2115.2808045264605;2116.5132019635494;2119.1311562259475;2036.1855257896812;2064.6593312103487;2078.1064142418754;2086.5201003769216;2092.06902928197;7243.89134162988;7300;7314.81712957175;7316.304951029643;7365.484416090876;4038.1116154445976;4062.695297852673;4083.836646534135;4138.213739389536;4150.045489537393;2655.8406495610325;2711.752593806851;2764.14311563416;2777.1390868830727;2819.1965289892487;877.6182360673064;1718.080826757691;1757.384915279642;1759.9472015839544;1811.1668632429098;9832.459214743187;9949.253805964581;9988.1510071644;10002.04980526856;10013.799724005552;3781.5273090863643;3861.2856621525107;3916.001419638031;3916.1971795781797;3948.0919388540224;7988.041435027834;7988.600569971478;8000.51996880189;8013.919860801434;8022;4198.832046718158;4213.578642135762;4218.49378074633;4225.429567008415;4276.636485898671;3149.622045354526;3644.781313121221;3678.9816050919576;3851.691864650821;3852.5184351956004;3203.3753418083716;3270.9509357359657;3303.0586282909258;3322.103032181346;3332.1169889979174;955.5604421965835;987.4865070163619;990.5146478225618;994.6966175316453;998.960041598328;951.2770294576034;951.9762005949907;967.9951600241953;1158.1661203933154;1158.675570840166;6666.899996500057;6734.764283250062;6736.831579210559;6740.325967403221;6900;402.0692097793598;413.2582015282575;413.4212103055686;414.834066373453;425.07121938564336;5193.636445448858;5238.449962753933;5247.501487358695;5255.18544625576;5266.578673706094;8740.606672699743;8987.41581797181;9208.171264586219;9272.119148680864;9277.304202184863;9090.090990900857;9118.133777291147;9172.44965302084;9177.587008584629;9220.262379009662;6666.033425153326;6828.556143850733;7011.544249623758;7079.646017699094;7171.713131474683;6793.52445328842;6807.319268073153;6810.795676129724;6830.45356371499;6853.1776186855905;7713.652885620048;7837.0987336454755;7876.448648594544;7897.881531776913;7900.3284720799375;7873.566953817366;8031.55826429552;8108.594570271345;8175.550344731097;8200.794980125545;5390.191471279182;6150.077488376779;6349.396807303298;6527.640979746159;6546.476281897341;6905.723771049102;7042.718291268292;7043;7048.330408611174;7049.7532586361285;5990.7903223386975;6045.879082418239;6089.117078023751;6113.724882380215;6172.043333283348;5902;5937.2578427696535;5961.940380596138;5967.224260846062;6037.15479832815;6380.553361264852;6603;6674.466042716474;6695.933040669531;6711.295313991961;5929.6145750526075;5959.91060134107;5967.76128954837;5991.970040149771;6012.819615411545;5963.821085367446;5982.850428739142;6051.4553690168095;6067.332593414632;6081.361457046946 03:31:03 INFO - PROCESS | 4206 | |4;prototype.html;304.32136335970785;305.502031688348;314.3524339859888;316.36568679797006;316.5915968400762;5631.971840140799;5657.886842263158;5811.418858114186;5824.767009319622;5836.795712150076;5651;5689.800856970007;5716.28546431696;5762.481376676098;5779.62432441892;4114.917701645965;4203.264428724976;4204.936925946114;4283.571642835715;4294.055307832287;4242.15156968606;4246.2356775780345;4250.681198910079;4250.723702959298;4270.57294270572;4196.643285320752;4198.349255865331;4202.3696445533105;4203.957960420403;4205.474315710536;4198.1393814268;4202.789860506962;4207.347861081537;4210.179015092058;4213.6839737019845;3607.783532988029;3610.8736194233074;3611.0972256935765;3612.6026137124895;3618.2220822523022;5407.513323800877;5419.214213938996;5426.9185962210595;5427.511523962823;5432.375276843174;4673.626109911199;4795.832145874878;4800.063987522434;4827.058723548909;4833.371661683994;5870.559708021916;5882.764689412418;5896.852578685524;5910.290765108171;5918.940810591882;3950.6839452843706;3954.7429417087797;3955.8417663293435;3956.7032472564674;3957.6635985940943;6143.846403839895;6224.3464436234;6276.184096067527;6277.121203031579;6288.434040936338;4054.614811592894;4082.9591704082577;4083.734557253769;4084.7957602119777;4085.4893138357706;4120.690948178899;4130.772807495617;4132.132252227006;4133.276676581586;4147.854825081168;4671.6262698984;4799.712017278975;4829.806807727722;4832.565069143724;4838.564529192389;5906.379830117776;5912.615679980788;5943.108533719977;5954.434328738763;5960.403959604005;1452.1504919621927;1461.1598330959741;1466.65533599604;1471.3967273417848;1475.992620036893;952.1906379577304;968.7626531499827;971.2327261463506;980.0640388429033;987.6000219910948;5114.769835357418;5119.48805119485;5124.15451450514;5124.948750512522;5130.92250627365;6144.539159563051;6149.723262453201;6160.383961603804;6167.96916015426;6182.69086545671;5090.414602320707;5103.540681338697;5132.101882170605;5135.922961155586;5143.254228136899;3217.324361883984;3245.789023713451;3304.801711897294;3305.7024867762016;3308.8676452942095;5768.163616275617;5805.767769289181;5808.6224395414165;5815.098659707752;5825.825225243249;6355.968220158869;6374.776882809079;6382;6429.54993150475;6434.324395938453;5797.130430435468;5802.82591522255;5805.796797112081;5811.389804070596;5828.679422631796;6013.278406591237;6209.2548894133;6217.129601855834;6218.782342617987;6227.470664993345;6067.089936509559;6073.089036644538;6104.298005729398;6108.694565271808;6119.724612392364;5778.248827652378;5784.045632470764;5811.215485909348;5811.912821307599;5821.068629019336;4000.319945609195;4003.2193722223888;4005.43923850667;4013.0569316210085;4028.254772867029;6154.1999540059505;6181.5363847710705;6185.969070154621;6203.379662033941;6222;5792.4497172768515;5973.850653733692;5979.133025711334;5993.880122397441;6003.549733769897;5973.731182096729;5989.101634754822;5996.700164991646;6012.939870601238;6054.939450605438;5802.071668533014;5819.476247137778;5836.358000620014;5849.415058494116;5853.2390789198835;5963.701814909324;5981.3420523743225;5983.7008149591475;6018.909716354171;6031.4270144336215;5641.887162256814;5839.386864379179;5869.119632055226;5876.882462350814;5888.646681199141 03:31:03 INFO - PROCESS | 4206 | |5;yui.html;562.7523889488623;566.9234653321803;608.3065305551672;637.9011253255745;667.7696194812788;10622.097121744651;10874.891251087476;10904.781904361907;10922.563097476092;10933.398663073538;11221.831672524899;11386.658400247985;11406.885931140687;11420.257683250584;11448.599299024516;738.47937204271;743.9702411903518;753.1827966656184;757.3373298363931;757.9090509138883;765.2538774694684;767.9116901556337;768.5849641193748;773.1147835728116;774.5004472115482;804.1395706593947;805.3034125481475;808.5431731071925;810.1088802317433;817.3216230528677;787.0633945604712;787.9015123109612;790.8260182759841;796.4862663581986;804.903411590607;588.4233451217788;591.724847945703;593.403629352498;598.6946657204813;599.4724642314735;10254;10296.176305895511;10347.534360953776;10375.273730838844;10513.053825155772;11714.53141874324;11864.288142711464;12013.279203247834;12133.211341262879;12346.135770496068;9099;9116.453012819253;9260.814783704356;9315.288997525895;9324.813503729954;3162.76279279055;3180.793248438844;3222.065600975714;3229.2411283348392;3321.70104690579;40527.18945621071;40919.795401023104;41178.79410602958;41180;41545.79227103875;9070.501122438329;9195.402298850553;9204.95397523008;9285.535723213812;9359.485228312507;15664.295106719997;15736.60658483547;15862.60343491422;15884.444044458389;15951.44169954046;6067.150598916155;6188.504919606421;6215.533834962396;6259.96870015647;6288.088227207121;3440.208751987057;3477.756557040983;3514.1566024154017;3566.7859928404378;3582.283543291352;2527.355524341318;2534.379077126116;2540.834845735021;2546.4525127097763;2552.4767422678306;450.981960721574;459.4716076512038;485.3229744506394;495.7397366382678;503.5468078729173;474.24358148752685;524.6773234460779;536.5612648221344;567.4920945753528;578.2656026845882;6887.139107611549;6970.825729356705;6985.336393042653;7100.68046937889;7169.924511323343;484.44010286876204;531.4340227657532;569.5500554561933;583.7839999200323;586.9735861886226;3309.6028476582483;3347.681970212826;3389.2374215801246;3392.2876195999115;3490.6560974025183;48095.51904480981;48249.75875120602;48258.758706206245;48317.75841120772;48620.27069593959;42171;43475.130497390506;43572.564274357486;44296.114077718266;44352.11295774066;39570.80214598909;39721.60278397237;39930.20139597192;40170.39744403836;40173.19653606912;7350.347287965071;7369.226231245856;7413.666385012795;7521.135069467081;7617.885731714139;30475;30730.38539229158;31133.377332453678;31555.52666709955;31582.842085789423;36497.452538211415;36520.26959460743;36523.81738091292;37272.627273728;37298.627013729514;8073.995949632815;8139.10469848328;8152.388570857328;8163.714270000759;8198.918010819816;10925.235233533576;10954.397508137128;10974.835377469184;10976.945115274373;11181.440927953407;10029.498525073863;10069.748256293651;10285.794284114425;10681.57273709043;10730.08794252466;9840.458774767456;10024.699259022242;10406.063454289151;10419.53112109972;10436.478176091317;9553.61785528571;9644.517774111126;9846.753831153992;10136.695899123039;10197.388156710622;8043.83912321762;8500.14998500145;8620.870686939576;8847.911520884709;8964.731058068268;8588.38288297254;8878.467291962503;9032.277417806428;9033.728988130366;9291.349605527548 03:31:03 INFO - PROCESS | 4206 | __end_tp_report 03:31:03 INFO - PROCESS | 4206 | __start_cc_report 03:31:03 INFO - PROCESS | 4206 | _x_x_mozilla_cycle_collect,353 03:31:03 INFO - PROCESS | 4206 | __end_cc_report 03:31:03 INFO - PROCESS | 4206 | __startTimestamp1457091063109__endTimestamp 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | ------- Summary: start ------- 03:31:03 INFO - PROCESS | 4206 | Number of tests: 6 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | [#0] dojo.html Cycles:165 Average:4646.97 Median:4778.78 stddev:482.66 (10.1%) stddev-sans-first:458.12 03:31:03 INFO - PROCESS | 4206 | Values: 2654.3 2661.7 2692.9 2695.5 2707.1 4557.6 4667.0 4684.1 4707.6 4732.2 4691.3 4723.6 4740.4 4749.6 4786.7 4338.9 4367.1 4420.2 4422.5 4497.8 4429.8 4463.4 4467.5 4496.6 4538.8 4225.2 4308.2 4362.1 4383.3 4383.5 4277.1 4284.2 4286.3 4296.2 4317.1 4259.2 4274.3 4286.1 4320.6 4322.0 4439.4 4577.1 4614.1 4665.3 4666.8 5012.0 5017.5 5032.8 5033.2 5077.7 4856.8 5035.7 5052.4 5057.2 5079.9 4566.0 4696.1 4704.2 4704.5 4767.5 5066.2 5102.0 5120.4 5130.4 5186.3 4790.8 4905.9 4914.8 4932.2 4979.4 4883.4 4964.4 5011.4 5016.9 5057.4 5029.2 5039.3 5045.1 5054.9 5071.8 4756.0 4971.6 5009.1 5014.2 5069.3 4168.6 4204.8 4214.9 4251.2 4252.4 3689.0 3706.9 3715.7 3718.3 3751.1 4183.1 4295.5 4370.3 4376.2 4395.2 4930.3 4957.7 4960.5 4977.9 5022.2 4291.1 4291.5 4296.0 4305.6 4338.2 4334.5 4418.5 4427.3 4465.9 4478.1 4806.3 4819.4 4840.2 4846.9 4859.0 5098.4 5139.6 5155.9 5156.8 5159.8 4543.0 4723.8 4774.4 4778.8 4804.7 4979.9 5004.0 5019.5 5030.9 5069.4 4890.5 5025.4 5068.8 5107.4 5139.2 4737.8 4769.3 4869.3 4924.3 4971.5 4888.5 4927.7 4928.8 4930.4 4945.9 4771.9 4821.4 4828.1 4861.7 4876.3 4720.7 4913.7 4932.2 4980.7 4985.7 4828.5 4845.3 4848.6 4854.7 4898.3 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | [#1] ext.html Cycles:180 Average:39717.04 Median:18806.96 stddev:63813.54 (339.3%) stddev-sans-first:63924.57 03:31:03 INFO - PROCESS | 4206 | Values: 485.3 507.7 521.2 543.1 548.4 23890.4 32996.2 33275.7 33301.5 33469.2 35562.3 35595.8 35608.6 35847.3 36032.5 7530.5 7579.0 7672.7 7710.8 7721.7 7643.8 7776.3 7860.8 7867.7 8078.2 7963.8 8048.5 8066.2 8088.7 8123.7 7959.5 8015.2 8032.4 8056.1 8092.5 7873.3 7906.4 7919.9 7921.5 7996.3 36064.8 36811.4 36819.3 36850.6 36855.4 2613.4 2745.4 2824.8 3402.1 3416.3 27429.7 27691.4 28149.0 28275.3 28881.3 3399.5 3407.0 3435.3 3445.2 3493.9 221599.0 222134.0 222468.0 223291.0 223660.0 51700.0 51989.0 52227.2 52243.8 52342.7 58617.1 59205.4 59654.0 59746.7 59821.4 11317.7 11488.0 11543.0 11551.8 11562.2 8911.9 9037.8 9075.8 9076.4 9108.7 18077.3 18308.3 18401.7 18472.0 19318.8 7613.3 7708.0 7731.7 7838.4 7856.5 883.8 887.8 959.7 969.2 1049.6 22214.0 22345.8 22571.3 22855.9 22954.7 965.3 966.8 1014.5 1025.8 1060.6 12544.5 12758.9 12765.6 12844.5 12941.9 260363.0 262549.0 264295.0 265542.0 265891.0 44975.8 45650.0 45675.0 45719.5 45880.1 1156.5 1166.7 1199.7 1214.3 1218.5 24326.0 25039.6 25702.2 25960.0 26166.0 39958.2 39977.4 40014.4 40182.6 40247.4 243556.0 245135.0 246006.0 246101.0 247117.0 28598.1 29210.3 29326.6 38293.2 38971.4 34309.8 34475.8 35190.8 35213.6 35247.1 29796.6 29877.3 30154.1 30593.7 30907.0 29337.4 29577.0 30122.7 30123.2 30203.5 29634.7 31659.8 34197.7 34734.1 35690.0 25560.9 27992.6 28001.2 28207.6 28395.7 22284.3 22557.8 22706.2 22910.2 24039.0 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | [#2] jquery.html Cycles:180 Average:21842.83 Median:4959.93 stddev:63278.12 (1275.8%) stddev-sans-first:63435.00 03:31:03 INFO - PROCESS | 4206 | Values: 324.6 333.3 336.5 341.2 344.2 14765.1 15364.0 15904.1 15912.8 15935.3 13271.4 13429.2 13629.1 14072.6 14108.2 4844.0 5093.5 5107.6 5109.7 5125.4 4786.5 4911.0 5012.2 5018.3 5027.8 4948.8 4971.1 4973.3 4975.8 5000.9 4814.3 5009.7 5057.5 5064.8 5066.5 4769.1 4863.3 4866.0 4870.1 4876.0 11004.3 11363.6 11368.4 11439.2 11445.5 1865.3 1881.8 1893.0 1947.3 2273.8 8731.3 8741.7 8878.5 9089.4 9176.9 1741.3 1766.3 1780.9 1817.8 1844.6 40518.8 50378.0 58471.4 58830.4 59088.1 9630.1 9764.7 9839.1 9920.0 9955.8 12694.0 12771.2 12780.4 12813.0 12823.7 6428.6 6542.0 6567.4 6690.7 6710.1 6075.1 6145.6 6160.6 6204.2 6226.7 4149.7 4156.6 4205.2 4274.0 4278.0 1714.1 1754.4 1782.5 1811.3 1814.5 411.3 837.7 857.7 859.4 905.6 9372.6 9397.5 9685.2 9708.2 10195.0 405.9 419.6 419.7 421.1 423.5 5433.8 5440.9 5460.3 5566.1 5589.7 382390.0 382420.0 385142.0 387422.0 394445.0 42359.8 43411.0 65182.0 66693.7 69252.0 742.3 940.3 968.1 973.7 976.0 14204.6 14877.8 15043.5 15138.0 15279.1 29340.6 29761.7 30927.7 32991.8 33445.7 42382.2 42829.1 42845.8 43168.0 43381.0 6910.8 6979.5 7088.5 7130.7 7145.8 10474.5 10606.3 10637.9 10721.9 10886.2 9385.4 9396.8 9519.5 9738.5 9928.6 9142.9 9474.2 9480.8 9638.1 9642.7 9435.1 9673.5 9711.6 9755.6 9923.7 6918.2 7040.8 7120.9 7134.5 7228.5 7402.3 9522.5 9817.0 9990.6 10103.1 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | [#3] mootools.html Cycles:180 Average:5035.96 Median:6024.99 stddev:2665.13 (44.2%) stddev-sans-first:2658.30 03:31:03 INFO - PROCESS | 4206 | Values: 1362.1 1363.7 1477.2 1670.9 1697.0 6179.1 7158.2 7202.8 7296.0 7346.4 7207.0 7243.9 7303.3 7303.7 7306.3 2076.7 2093.7 2109.7 2111.3 2112.2 2062.5 2067.9 2075.1 2123.5 2124.2 2085.8 2111.7 2123.2 2143.3 2155.4 2099.2 2101.2 2115.3 2116.5 2119.1 2036.2 2064.7 2078.1 2086.5 2092.1 7243.9 7300.0 7314.8 7316.3 7365.5 4038.1 4062.7 4083.8 4138.2 4150.0 2655.8 2711.8 2764.1 2777.1 2819.2 877.6 1718.1 1757.4 1759.9 1811.2 9832.5 9949.3 9988.2 10002.0 10013.8 3781.5 3861.3 3916.0 3916.2 3948.1 7988.0 7988.6 8000.5 8013.9 8022.0 4198.8 4213.6 4218.5 4225.4 4276.6 3149.6 3644.8 3679.0 3851.7 3852.5 3203.4 3271.0 3303.1 3322.1 3332.1 955.6 987.5 990.5 994.7 999.0 951.3 952.0 968.0 1158.2 1158.7 6666.9 6734.8 6736.8 6740.3 6900.0 402.1 413.3 413.4 414.8 425.1 5193.6 5238.4 5247.5 5255.2 5266.6 8740.6 8987.4 9208.2 9272.1 9277.3 9090.1 9118.1 9172.4 9177.6 9220.3 6666.0 6828.6 7011.5 7079.6 7171.7 6793.5 6807.3 6810.8 6830.5 6853.2 7713.7 7837.1 7876.4 7897.9 7900.3 7873.6 8031.6 8108.6 8175.6 8200.8 5390.2 6150.1 6349.4 6527.6 6546.5 6905.7 7042.7 7043.0 7048.3 7049.8 5990.8 6045.9 6089.1 6113.7 6172.0 5902.0 5937.3 5961.9 5967.2 6037.2 6380.6 6603.0 6674.5 6695.9 6711.3 5929.6 5959.9 5967.8 5992.0 6012.8 5963.8 5982.9 6051.5 6067.3 6081.4 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | [#4] prototype.html Cycles:180 Average:4875.68 Median:5739.38 stddev:1488.45 (25.9%) stddev-sans-first:1452.54 03:31:03 INFO - PROCESS | 4206 | Values: 304.3 305.5 314.4 316.4 316.6 5632.0 5657.9 5811.4 5824.8 5836.8 5651.0 5689.8 5716.3 5762.5 5779.6 4114.9 4203.3 4204.9 4283.6 4294.1 4242.2 4246.2 4250.7 4250.7 4270.6 4196.6 4198.3 4202.4 4204.0 4205.5 4198.1 4202.8 4207.3 4210.2 4213.7 3607.8 3610.9 3611.1 3612.6 3618.2 5407.5 5419.2 5426.9 5427.5 5432.4 4673.6 4795.8 4800.1 4827.1 4833.4 5870.6 5882.8 5896.9 5910.3 5918.9 3950.7 3954.7 3955.8 3956.7 3957.7 6143.8 6224.3 6276.2 6277.1 6288.4 4054.6 4083.0 4083.7 4084.8 4085.5 4120.7 4130.8 4132.1 4133.3 4147.9 4671.6 4799.7 4829.8 4832.6 4838.6 5906.4 5912.6 5943.1 5954.4 5960.4 1452.2 1461.2 1466.7 1471.4 1476.0 952.2 968.8 971.2 980.1 987.6 5114.8 5119.5 5124.2 5124.9 5130.9 6144.5 6149.7 6160.4 6168.0 6182.7 5090.4 5103.5 5132.1 5135.9 5143.3 3217.3 3245.8 3304.8 3305.7 3308.9 5768.2 5805.8 5808.6 5815.1 5825.8 6356.0 6374.8 6382.0 6429.5 6434.3 5797.1 5802.8 5805.8 5811.4 5828.7 6013.3 6209.3 6217.1 6218.8 6227.5 6067.1 6073.1 6104.3 6108.7 6119.7 5778.2 5784.0 5811.2 5811.9 5821.1 4000.3 4003.2 4005.4 4013.1 4028.3 6154.2 6181.5 6186.0 6203.4 6222.0 5792.4 5973.9 5979.1 5993.9 6003.5 5973.7 5989.1 5996.7 6012.9 6054.9 5802.1 5819.5 5836.4 5849.4 5853.2 5963.7 5981.3 5983.7 6018.9 6031.4 5641.9 5839.4 5869.1 5876.9 5888.6 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - PROCESS | 4206 | [#5] yui.html Cycles:180 Average:11834.93 Median:48254.26 stddev:13529.02 (28.0%) stddev-sans-first:13540.49 03:31:03 INFO - PROCESS | 4206 | Values: 562.8 566.9 608.3 637.9 667.8 10622.1 10874.9 10904.8 10922.6 10933.4 11221.8 11386.7 11406.9 11420.3 11448.6 738.5 744.0 753.2 757.3 757.9 765.3 767.9 768.6 773.1 774.5 804.1 805.3 808.5 810.1 817.3 787.1 787.9 790.8 796.5 804.9 588.4 591.7 593.4 598.7 599.5 10254.0 10296.2 10347.5 10375.3 10513.1 11714.5 11864.3 12013.3 12133.2 12346.1 9099.0 9116.5 9260.8 9315.3 9324.8 3162.8 3180.8 3222.1 3229.2 3321.7 40527.2 40919.8 41178.8 41180.0 41545.8 9070.5 9195.4 9205.0 9285.5 9359.5 15664.3 15736.6 15862.6 15884.4 15951.4 6067.2 6188.5 6215.5 6260.0 6288.1 3440.2 3477.8 3514.2 3566.8 3582.3 2527.4 2534.4 2540.8 2546.5 2552.5 451.0 459.5 485.3 495.7 503.5 474.2 524.7 536.6 567.5 578.3 6887.1 6970.8 6985.3 7100.7 7169.9 484.4 531.4 569.6 583.8 587.0 3309.6 3347.7 3389.2 3392.3 3490.7 48095.5 48249.8 48258.8 48317.8 48620.3 42171.0 43475.1 43572.6 44296.1 44352.1 39570.8 39721.6 39930.2 40170.4 40173.2 7350.3 7369.2 7413.7 7521.1 7617.9 30475.0 30730.4 31133.4 31555.5 31582.8 36497.5 36520.3 36523.8 37272.6 37298.6 8074.0 8139.1 8152.4 8163.7 8198.9 10925.2 10954.4 10974.8 10976.9 11181.4 10029.5 10069.7 10285.8 10681.6 10730.1 9840.5 10024.7 10406.1 10419.5 10436.5 9553.6 9644.5 9846.8 10136.7 10197.4 8043.8 8500.1 8620.9 8847.9 8964.7 8588.4 8878.5 9032.3 9033.7 9291.3 03:31:03 INFO - PROCESS | 4206 | -------- Summary: end -------- 03:31:03 INFO - PROCESS | 4206 | 03:31:03 INFO - TEST-INFO | 4206: exit 0 03:31:03 INFO - TEST-OK | dromaeo_css | took 1114655ms 03:31:03 INFO - TEST-START | kraken 03:31:03 INFO - operating with platform_type : linux_ 03:31:03 INFO - Initialising browser for kraken test... 03:31:03 INFO - TEST-INFO | started process 4443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAcA5_/profile http://localhost:55469/getInfo.html) 03:31:07 INFO - PROCESS | 4443 | 03:31:07 INFO - PROCESS | 4443 | (process:4512): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:08 INFO - PROCESS | 4443 | __metrics Screen width/height:1600/1200 03:31:08 INFO - PROCESS | 4443 | colorDepth:24 03:31:08 INFO - PROCESS | 4443 | Browser inner width/height: 1024/697 03:31:08 INFO - PROCESS | 4443 | __metrics 03:31:09 ERROR - PROCESS | 4443 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:31:10 INFO - TEST-INFO | 4443: exit 0 03:31:10 INFO - Browser initialized. 03:31:10 INFO - Running cycle 1/1 for kraken test... 03:31:10 INFO - TEST-INFO | started process 4563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAcA5_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:11 INFO - PROCESS | 4563 | 03:31:11 INFO - PROCESS | 4563 | (process:4619): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:22 INFO - PROCESS | 4563 | RSS: Main: 161542144 03:31:22 INFO - PROCESS | 4563 | 03:31:25 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55469/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:25 INFO - PROCESS | 4563 | RSS: Main: 167276544 03:31:25 INFO - PROCESS | 4563 | 03:31:28 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55469/tests/kraken/driver.html?testName=audio-dft) 03:31:29 INFO - PROCESS | 4563 | RSS: Main: 171171840 03:31:29 INFO - PROCESS | 4563 | 03:31:32 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55469/tests/kraken/driver.html?testName=audio-fft) 03:31:32 INFO - PROCESS | 4563 | RSS: Main: 165429248 03:31:32 INFO - PROCESS | 4563 | 03:31:34 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55469/tests/kraken/driver.html?testName=audio-oscillator) 03:31:35 INFO - PROCESS | 4563 | RSS: Main: 164560896 03:31:35 INFO - PROCESS | 4563 | 03:31:37 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55469/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:38 INFO - PROCESS | 4563 | RSS: Main: 166670336 03:31:38 INFO - PROCESS | 4563 | 03:31:41 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55469/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:41 INFO - PROCESS | 4563 | RSS: Main: 166469632 03:31:41 INFO - PROCESS | 4563 | 03:31:45 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55469/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:46 INFO - PROCESS | 4563 | RSS: Main: 164130816 03:31:46 INFO - PROCESS | 4563 | 03:31:48 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55469/tests/kraken/driver.html?testName=json-parse-financial) 03:31:49 INFO - PROCESS | 4563 | RSS: Main: 164691968 03:31:49 INFO - PROCESS | 4563 | 03:31:51 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55469/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:51 INFO - PROCESS | 4563 | RSS: Main: 165117952 03:31:51 INFO - PROCESS | 4563 | 03:31:53 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:54 INFO - PROCESS | 4563 | RSS: Main: 163561472 03:31:54 INFO - PROCESS | 4563 | 03:31:56 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:57 INFO - PROCESS | 4563 | RSS: Main: 165773312 03:31:57 INFO - PROCESS | 4563 | 03:31:59 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:32:00 INFO - PROCESS | 4563 | RSS: Main: 163897344 03:32:00 INFO - PROCESS | 4563 | 03:32:03 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:32:03 INFO - PROCESS | 4563 | RSS: Main: 165679104 03:32:03 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:55469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55469/tests/kraken/driver.html?testName=ai-astar) 03:32:05 INFO - PROCESS | 4563 | RSS: Main: 165916672 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | __start_tp_report 03:32:05 INFO - PROCESS | 4563 | _x_x_mozilla_page_load 03:32:05 INFO - PROCESS | 4563 | _x_x_mozilla_page_load_details 03:32:05 INFO - PROCESS | 4563 | |i|pagename|runs| 03:32:05 INFO - PROCESS | 4563 | |0;ai-astar;113;110;115;114;116;126;114;114;114;114 03:32:05 INFO - PROCESS | 4563 | |1;audio-beat-detection;160;137;159;170;132;156;158;140;183;134 03:32:05 INFO - PROCESS | 4563 | |2;audio-dft;162;163;163;163;164;174;163;163;164;162 03:32:05 INFO - PROCESS | 4563 | |3;audio-fft;75;75;74;168;74;74;74;75;151;76 03:32:05 INFO - PROCESS | 4563 | |4;audio-oscillator;95;97;140;95;102;95;141;96;96;138 03:32:05 INFO - PROCESS | 4563 | |5;imaging-gaussian-blur;117;118;120;118;118;118;118;118;118;120 03:32:05 INFO - PROCESS | 4563 | |6;imaging-darkroom;148;148;148;148;148;149;149;147;148;147 03:32:05 INFO - PROCESS | 4563 | |7;imaging-desaturate;96;97;96;97;97;96;97;96;97;96 03:32:05 INFO - PROCESS | 4563 | |8;json-parse-financial;67;68;68;68;68;70;71;75;66;66 03:32:05 INFO - PROCESS | 4563 | |9;json-stringify-tinderbox;70;71;71;71;71;71;71;71;71;71 03:32:05 INFO - PROCESS | 4563 | |10;stanford-crypto-aes;83;84;95;85;85;87;88;86;88;86 03:32:05 INFO - PROCESS | 4563 | |11;stanford-crypto-ccm;138;138;125;128;131;133;126;122;129;122 03:32:05 INFO - PROCESS | 4563 | |12;stanford-crypto-pbkdf2;142;172;157;157;155;142;153;154;157;144 03:32:05 INFO - PROCESS | 4563 | |13;stanford-crypto-sha256-iterative;74;73;78;73;73;73;80;71;71;71 03:32:05 INFO - PROCESS | 4563 | __end_tp_report 03:32:05 INFO - PROCESS | 4563 | __start_cc_report 03:32:05 INFO - PROCESS | 4563 | _x_x_mozilla_cycle_collect,897 03:32:05 INFO - PROCESS | 4563 | __end_cc_report 03:32:05 INFO - PROCESS | 4563 | __startTimestamp1457091125842__endTimestamp 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | ------- Summary: start ------- 03:32:05 INFO - PROCESS | 4563 | Number of tests: 14 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:4.16 (3.7%) stddev-sans-first:4.35 03:32:05 INFO - PROCESS | 4563 | Values: 113.0 110.0 115.0 114.0 116.0 126.0 114.0 114.0 114.0 114.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:158.50 stddev:16.78 (10.6%) stddev-sans-first:17.60 03:32:05 INFO - PROCESS | 4563 | Values: 160.0 137.0 159.0 170.0 132.0 156.0 158.0 140.0 183.0 134.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:3.54 (2.2%) stddev-sans-first:3.67 03:32:05 INFO - PROCESS | 4563 | Values: 162.0 163.0 163.0 163.0 164.0 174.0 163.0 163.0 164.0 162.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.50 stddev:36.02 (48.3%) stddev-sans-first:37.70 03:32:05 INFO - PROCESS | 4563 | Values: 75.0 75.0 74.0 168.0 74.0 74.0 74.0 75.0 151.0 76.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.00 stddev:20.93 (22.0%) stddev-sans-first:21.53 03:32:05 INFO - PROCESS | 4563 | Values: 95.0 97.0 140.0 95.0 102.0 95.0 141.0 96.0 96.0 138.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.88 03:32:05 INFO - PROCESS | 4563 | Values: 117.0 118.0 120.0 118.0 118.0 118.0 118.0 118.0 118.0 120.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:32:05 INFO - PROCESS | 4563 | Values: 148.0 148.0 148.0 148.0 148.0 149.0 149.0 147.0 148.0 147.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:32:05 INFO - PROCESS | 4563 | Values: 96.0 97.0 96.0 97.0 97.0 96.0 97.0 96.0 97.0 96.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:68.00 stddev:2.71 (4.0%) stddev-sans-first:2.80 03:32:05 INFO - PROCESS | 4563 | Values: 67.0 68.0 68.0 68.0 68.0 70.0 71.0 75.0 66.0 66.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 03:32:05 INFO - PROCESS | 4563 | Values: 70.0 71.0 71.0 71.0 71.0 71.0 71.0 71.0 71.0 71.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.50 stddev:3.33 (3.9%) stddev-sans-first:3.26 03:32:05 INFO - PROCESS | 4563 | Values: 83.0 84.0 95.0 85.0 85.0 87.0 88.0 86.0 88.0 86.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:130.00 stddev:5.83 (4.5%) stddev-sans-first:5.24 03:32:05 INFO - PROCESS | 4563 | Values: 138.0 138.0 125.0 128.0 131.0 133.0 126.0 122.0 129.0 122.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:156.00 stddev:9.04 (5.8%) stddev-sans-first:8.62 03:32:05 INFO - PROCESS | 4563 | Values: 142.0 172.0 157.0 157.0 155.0 142.0 153.0 154.0 157.0 144.0 03:32:05 INFO - PROCESS | 4563 | 03:32:05 INFO - PROCESS | 4563 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:73.00 stddev:3.02 (4.1%) stddev-sans-first:3.20 03:32:05 INFO - PROCESS | 4563 | Values: 74.0 73.0 78.0 73.0 73.0 73.0 80.0 71.0 71.0 71.0 03:32:05 INFO - PROCESS | 4563 | -------- Summary: end -------- 03:32:05 INFO - PROCESS | 4563 | 03:32:06 INFO - TEST-INFO | 4563: exit 0 03:32:06 INFO - TEST-OK | kraken | took 63022ms 03:32:06 INFO - SUITE-END | took 1177s 03:32:07 INFO - Completed test suite (00:19:37) 03:32:07 INFO - Working with test: dromaeo_css 03:32:07 INFO - Generating results file: dromaeo_css 03:32:07 INFO - Working with test: kraken 03:32:07 INFO - Generating results file: kraken 03:32:07 INFO - javascript benchmark 03:32:07 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:32:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 03:32:07 INFO - process_Request line: dromaeo_css 6116.59 graph.html#tests=[[72,94,43]] 03:32:07 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:32:07 INFO - process_Request line: kraken 1578.40 graph.html#tests=[[232,94,43]] 03:32:07 INFO - RETURN: dromaeo_css: 6116.59 03:32:07 INFO - RETURN: kraken: 1578.40 03:32:07 INFO - javascript benchmark 03:32:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2654.2833434972554, 2661.7471340222673, 2692.8518931458775, 2695.528282550554, 2707.1472486166854, 4557.612602928747, 4666.999999999995, 4684.086603112386, 4707.646926480515, 4732.2428411454175, 4691.319758635004, 4723.645726570512, 4740.407449068866, 4749.643776716743, 4786.688865223758, 4338.9349159762705, 4367.148406060819, 4420.182266280748, 4422.535633758457, 4497.820087196525, 4429.756363400012, 4463.375127482155, 4467.508574056851, 4496.572825581565, 4538.7503687297185, 4225.2183346080765, 4308.224519586473, 4362.149380870732, 4383.276759334706, 4383.539728328544, 4277.080427708027, 4284.228838809013, 4286.314189729628, 4296.205202037601, 4317.050248945258, 4259.16946195492, 4274.29474136767, 4286.1337699761825, 4320.589543993316, 4321.956780432187, 4439.445069366329, 4577.061702351043, 4614.146382919171, 4665.253559430509, 4666.789994450258, 5012.0, 5017.49825017499, 5032.84901452957, 5033.194688849767, 5077.720725360104, 4856.805727770885, 5035.748212589392, 5052.368453943257, 5057.165567681365, 5079.898402031976, 4566.0, 4696.060787842377, 4704.247320428749, 4704.529547045268, 4767.4994125617, 5066.240063990431, 5102.030614183293, 5120.359955005624, 5130.358705161855, 5186.273921650972, 4790.808367665254, 4905.852824415273, 4914.754262286871, 4932.235503496964, 4979.402471703419, 4883.413990321184, 4964.429090654548, 5011.3986321640905, 5016.949830501721, 5057.367829021372, 5029.17018691919, 5039.26930595069, 5045.142325804549, 5054.9241761373605, 5071.822486212965, 4756.0, 4971.6022718183185, 5009.073321435546, 5014.197728363444, 5069.264956581349, 4168.624823765876, 4204.831806727758, 4214.852480163241, 4251.171021650748, 4252.4046633471335, 3688.981555092207, 3706.8517259309324, 3715.6841668458483, 3718.2563487302646, 3751.099736063325, 4183.058811767389, 4295.484541854935, 4370.322599997005, 4376.212281789309, 4395.164918665443, 4930.260460930817, 4957.652964292465, 4960.454350021495, 4977.850664480072, 5022.171341728574, 4291.141771645684, 4291.463567054118, 4295.957040429618, 4305.590968857953, 4338.197433474817, 4334.501532323823, 4418.491873434532, 4427.335899615084, 4465.866024019285, 4478.104379124123, 4806.303086052572, 4819.445763737215, 4840.249761287007, 4846.854594362246, 4858.95141048585, 5098.362704661918, 5139.563137133386, 5155.871103222299, 5156.845294641167, 5159.767810448464, 4543.0, 4723.763811809465, 4774.40319960005, 4778.7849546769785, 4804.735739534359, 4979.904421027368, 5004.024215277986, 5019.52314530119, 5030.874228144179, 5069.366329208849, 4890.535399137077, 5025.39695236574, 5068.797248110034, 5107.438181799925, 5139.203423469368, 4737.786799594095, 4769.260764581495, 4869.342638743724, 4924.310596516562, 4971.453140154508, 4888.5111488850835, 4927.679700819435, 4928.802847886044, 4930.408350997904, 4945.876353091202, 4771.856844294677, 4821.421429428491, 4828.058528586892, 4861.732604706775, 4876.317315575893, 4720.669553131248, 4913.729744863924, 4932.235503496964, 4980.726060066731, 4985.651004429655, 4828.468868424541, 4845.345878306524, 4848.612111031039, 4854.660173787942, 4898.338724272177], "unit": "score", "name": "dojo.html", "value": 4616.947779450846}, {"lowerIsBetter": false, "replicates": [485.2914744473071, 507.7486644111166, 521.2233771680197, 543.1038786003095, 548.4351118348102, 23890.40273993151, 32996.175095622624, 33275.66724332756, 33301.500477492824, 33469.16327091824, 35562.28875422497, 35595.82202088986, 35608.64391356086, 35847.2830543389, 36032.45951310732, 7530.472866899319, 7579.0, 7672.731454399097, 7710.7686769397005, 7721.691132354699, 7643.808904777397, 7776.30013298803, 7860.764177074669, 7867.7246296379635, 8078.23256790604, 7963.761087167365, 8048.5170889746805, 8066.193380661945, 8088.716894908679, 8123.675052997873, 7959.482633628795, 8015.198480151997, 8032.39757018223, 8056.073551541589, 8092.514449133071, 7873.330766884822, 7906.407019473505, 7919.920800792033, 7921.485103468256, 7996.28033476984, 36064.819675901716, 36811.447828282595, 36819.263614727824, 36850.63149368499, 36855.4471682925, 2613.3989182487944, 2745.3960128771637, 2824.7740180785486, 3402.1494626343415, 3416.265502916885, 27429.725702742915, 27691.446171076666, 28148.962759310172, 28275.293117672016, 28881.277968050756, 3399.5410619566287, 3407.0, 3435.2957643682985, 3445.207602251471, 3493.8777142800136, 221599.0, 222133.99999999837, 222468.0, 223291.0, 223660.0, 51700.0, 51989.0, 52227.21659175115, 52243.77562243821, 52342.73828630909, 58617.12074318888, 59205.40794591999, 59654.0, 59746.701266493386, 59821.40178598158, 11317.660470185907, 11488.023518001064, 11543.018843398406, 11551.826722599168, 11562.248453850472, 8911.910880891108, 9037.819243615091, 9075.81848363029, 9076.364654474124, 9108.681196158102, 18077.27690892376, 18308.26766929308, 18401.723974140397, 18472.0, 19318.806811931983, 7613.314801667766, 7708.0, 7731.690732370755, 7838.372930165573, 7856.528608283407, 883.7834730490943, 887.8179973105498, 959.6689142245914, 969.2343048991218, 1049.5959055763433, 22214.001109849964, 22345.776542234693, 22571.322860314216, 22855.885720571292, 22954.65568016481, 965.2615748952057, 966.7534778631544, 1014.4724743133529, 1025.7589466475372, 1060.649985504797, 12544.498220071095, 12758.9362053191, 12765.553205637758, 12844.48622055126, 12941.935290323489, 260363.0, 262549.0, 264295.0, 265542.0, 265891.0, 44975.775121124185, 45650.0, 45675.0, 45719.54280457219, 45880.08239835251, 1156.4738044189874, 1166.6674997625637, 1199.7480529088814, 1214.3017764785284, 1218.4638758946035, 24326.0, 25039.624405633567, 25702.228933132035, 25960.0, 26166.0, 39958.200835982534, 39977.40033899552, 40014.39978400268, 40182.59817401788, 40247.396289056276, 243556.0, 245135.0, 246006.0, 246101.0, 247117.0, 28598.14205573836, 29210.269743256587, 29326.560101598065, 38293.234135317696, 38971.415428769156, 34309.82845085759, 34475.82762086173, 35190.824045879606, 35213.64786352104, 35247.11882202863, 29796.55305170381, 29877.253068673457, 30154.09537713872, 30593.694063059083, 30907.0, 29337.413251735274, 29577.0, 30122.69877301199, 30123.246918827204, 30203.546946796254, 29634.703652963195, 31659.84170079135, 34197.65802341945, 34734.131646708025, 35690.0, 25560.8721956389, 27992.580111298754, 28001.159965201077, 28207.57688634631, 28395.716042839307, 22284.331470055924, 22557.774422255567, 22706.205282815023, 22910.198143064914, 24039.0], "unit": "score", "name": "ext.html", "value": 16288.51768696953}, {"lowerIsBetter": false, "replicates": [324.55373860941205, 333.2718011145646, 336.4549429923524, 341.1947803184485, 344.2151893682405, 14765.114093154418, 15364.001339912911, 15904.125273109974, 15912.840871591281, 15935.282912268947, 13271.402786874589, 13429.194248345106, 13629.114107583, 14072.648183795385, 14108.224047677373, 4843.951560484403, 5093.541581257686, 5107.591392688594, 5109.667871588354, 5125.410577783547, 4786.52134786522, 4910.975445122769, 5012.172991456406, 5018.34761481007, 5027.773750181251, 4948.752562371885, 4971.105201063807, 4973.254011898226, 4975.8258460953875, 5000.924986125211, 4814.301926220696, 5009.699418034893, 5057.519535644126, 5064.772085256172, 5066.493350664941, 4769.093872164312, 4863.294822250789, 4866.02679464105, 4870.09903167915, 4875.9756201219125, 11004.339739615649, 11363.602273920456, 11368.431578421047, 11439.19925605208, 11445.542178312857, 1865.2632210277, 1881.7835948865918, 1892.9905350473298, 1947.289239427613, 2273.818094552448, 8731.345149113842, 8741.650333986632, 8878.467291962503, 9089.363744537884, 9176.8623470648, 1741.2599645150888, 1766.2555382588866, 1780.8842425242317, 1817.836394724468, 1844.5941892783567, 40518.79740601307, 50378.0, 58471.41528584745, 58830.411695882496, 59088.11367829486, 9630.133288004114, 9764.707058788248, 9839.114479696862, 9920.030087689876, 9955.80088398228, 12693.984481241478, 12771.169873958162, 12780.360981950866, 12813.0, 12823.743525129445, 6428.614283143026, 6541.967290163519, 6567.408933196035, 6690.698918548677, 6710.127683401127, 6075.149479072933, 6145.5698101133385, 6160.630362178284, 6204.224471941007, 6226.6575338355915, 4149.7095203335475, 4156.625903668684, 4205.179989902001, 4274.038341373166, 4277.957220427818, 1714.1172296267432, 1754.3684273661472, 1782.5276301780038, 1811.293595497757, 1814.5100822777777, 411.25973248153207, 837.6984285657159, 857.691231156783, 859.4070091636751, 905.5834316214483, 9372.62509499626, 9397.530123493798, 9685.150562870464, 9708.174805141502, 10195.031472010147, 405.94519739835334, 419.6181474857865, 419.72717733472876, 421.1114548303139, 423.5129600958922, 5433.782648694087, 5440.891182176334, 5460.290162278879, 5566.109422492463, 5589.74846131925, 382390.0, 382420.0, 385142.0, 387422.0, 394445.0, 42359.78820105941, 43411.0, 65182.02226966599, 66693.66653166703, 69252.0, 742.3133601418666, 940.3088729783603, 968.1093394077466, 973.6640858903667, 975.956081976327, 14204.573862784133, 14877.776833347725, 15043.548693539211, 15138.016028958082, 15279.083255004734, 29340.55989160207, 29761.702382975895, 30927.69072309248, 32991.83504082464, 33445.66554334426, 42382.1523569533, 42829.14341713086, 42845.78577107094, 43168.0, 43381.0, 6910.827229319308, 6979.5114341997605, 7088.539244949062, 7130.679119439534, 7145.785626431215, 10474.52864621109, 10606.310589811637, 10637.893621063691, 10721.946390267998, 10886.23796334249, 9385.38994965325, 9396.812063758824, 9519.52402379892, 9738.464384458639, 9928.553215105481, 9142.862857057016, 9474.194693451134, 9480.810383792423, 9638.132568068908, 9642.71071867845, 9435.05649435051, 9673.467959262309, 9711.581230540229, 9755.609775608897, 9923.702288931343, 6918.169819621477, 7040.823979400556, 7120.857582848211, 7134.500584959003, 7228.530145540523, 7402.33378995893, 9522.523873806143, 9817.0, 9990.600375984879, 10103.141232995278], "unit": "score", "name": "jquery.html", "value": 7120.755121205383}, {"lowerIsBetter": false, "replicates": [1362.0601784768512, 1363.706803037347, 1477.2318394434894, 1670.8997460152384, 1697.0411717379673, 6179.134921111048, 7158.17680966689, 7202.819929501758, 7296.0, 7346.4122870170395, 7207.0, 7243.89134162988, 7303.30618591233, 7303.744368947088, 7306.305900939402, 2076.6677331626943, 2093.727815383998, 2109.6940943563172, 2111.3032699209225, 2112.1973650012974, 2062.5153089024066, 2067.9276225332114, 2075.107703687414, 2123.50097727034, 2124.1928067334393, 2085.780992995729, 2111.6938043983614, 2123.150739704115, 2143.2927134045804, 2155.4288113649895, 2099.191811152702, 2101.2015434134933, 2115.2808045264605, 2116.5132019635494, 2119.1311562259475, 2036.1855257896812, 2064.6593312103487, 2078.1064142418754, 2086.5201003769216, 2092.06902928197, 7243.89134162988, 7300.0, 7314.81712957175, 7316.304951029643, 7365.484416090876, 4038.1116154445976, 4062.695297852673, 4083.836646534135, 4138.213739389536, 4150.045489537393, 2655.8406495610325, 2711.752593806851, 2764.14311563416, 2777.1390868830727, 2819.1965289892487, 877.6182360673064, 1718.080826757691, 1757.384915279642, 1759.9472015839544, 1811.1668632429098, 9832.459214743187, 9949.253805964581, 9988.1510071644, 10002.04980526856, 10013.799724005552, 3781.5273090863643, 3861.2856621525107, 3916.001419638031, 3916.1971795781797, 3948.0919388540224, 7988.041435027834, 7988.600569971478, 8000.51996880189, 8013.919860801434, 8022.0, 4198.832046718158, 4213.578642135762, 4218.49378074633, 4225.429567008415, 4276.636485898671, 3149.622045354526, 3644.781313121221, 3678.9816050919576, 3851.691864650821, 3852.5184351956004, 3203.3753418083716, 3270.9509357359657, 3303.0586282909258, 3322.103032181346, 3332.1169889979174, 955.5604421965835, 987.4865070163619, 990.5146478225618, 994.6966175316453, 998.960041598328, 951.2770294576034, 951.9762005949907, 967.9951600241953, 1158.1661203933154, 1158.675570840166, 6666.899996500057, 6734.764283250062, 6736.831579210559, 6740.325967403221, 6900.0, 402.0692097793598, 413.2582015282575, 413.4212103055686, 414.834066373453, 425.07121938564336, 5193.636445448858, 5238.449962753933, 5247.501487358695, 5255.18544625576, 5266.578673706094, 8740.606672699743, 8987.41581797181, 9208.171264586219, 9272.119148680864, 9277.304202184863, 9090.090990900857, 9118.133777291147, 9172.44965302084, 9177.587008584629, 9220.262379009662, 6666.033425153326, 6828.556143850733, 7011.544249623758, 7079.646017699094, 7171.713131474683, 6793.52445328842, 6807.319268073153, 6810.795676129724, 6830.45356371499, 6853.1776186855905, 7713.652885620048, 7837.0987336454755, 7876.448648594544, 7897.881531776913, 7900.3284720799375, 7873.566953817366, 8031.55826429552, 8108.594570271345, 8175.550344731097, 8200.794980125545, 5390.191471279182, 6150.077488376779, 6349.396807303298, 6527.640979746159, 6546.476281897341, 6905.723771049102, 7042.718291268292, 7043.0, 7048.330408611174, 7049.7532586361285, 5990.7903223386975, 6045.879082418239, 6089.117078023751, 6113.724882380215, 6172.043333283348, 5902.0, 5937.2578427696535, 5961.940380596138, 5967.224260846062, 6037.15479832815, 6380.553361264852, 6603.0, 6674.466042716474, 6695.933040669531, 6711.295313991961, 5929.6145750526075, 5959.91060134107, 5967.76128954837, 5991.970040149771, 6012.819615411545, 5963.821085367446, 5982.850428739142, 6051.4553690168095, 6067.332593414632, 6081.361457046946], "unit": "score", "name": "mootools.html", "value": 4073.262648135841}, {"lowerIsBetter": false, "replicates": [304.32136335970785, 305.502031688348, 314.3524339859888, 316.36568679797006, 316.5915968400762, 5631.971840140799, 5657.886842263158, 5811.418858114186, 5824.767009319622, 5836.795712150076, 5651.0, 5689.800856970007, 5716.28546431696, 5762.481376676098, 5779.62432441892, 4114.917701645965, 4203.264428724976, 4204.936925946114, 4283.571642835715, 4294.055307832287, 4242.15156968606, 4246.2356775780345, 4250.681198910079, 4250.723702959298, 4270.57294270572, 4196.643285320752, 4198.349255865331, 4202.3696445533105, 4203.957960420403, 4205.474315710536, 4198.1393814268, 4202.789860506962, 4207.347861081537, 4210.179015092058, 4213.6839737019845, 3607.783532988029, 3610.8736194233074, 3611.0972256935765, 3612.6026137124895, 3618.2220822523022, 5407.513323800877, 5419.214213938996, 5426.9185962210595, 5427.511523962823, 5432.375276843174, 4673.626109911199, 4795.832145874878, 4800.063987522434, 4827.058723548909, 4833.371661683994, 5870.559708021916, 5882.764689412418, 5896.852578685524, 5910.290765108171, 5918.940810591882, 3950.6839452843706, 3954.7429417087797, 3955.8417663293435, 3956.7032472564674, 3957.6635985940943, 6143.846403839895, 6224.3464436234, 6276.184096067527, 6277.121203031579, 6288.434040936338, 4054.614811592894, 4082.9591704082577, 4083.734557253769, 4084.7957602119777, 4085.4893138357706, 4120.690948178899, 4130.772807495617, 4132.132252227006, 4133.276676581586, 4147.854825081168, 4671.6262698984, 4799.712017278975, 4829.806807727722, 4832.565069143724, 4838.564529192389, 5906.379830117776, 5912.615679980788, 5943.108533719977, 5954.434328738763, 5960.403959604005, 1452.1504919621927, 1461.1598330959741, 1466.65533599604, 1471.3967273417848, 1475.992620036893, 952.1906379577304, 968.7626531499827, 971.2327261463506, 980.0640388429033, 987.6000219910948, 5114.769835357418, 5119.48805119485, 5124.15451450514, 5124.948750512522, 5130.92250627365, 6144.539159563051, 6149.723262453201, 6160.383961603804, 6167.96916015426, 6182.69086545671, 5090.414602320707, 5103.540681338697, 5132.101882170605, 5135.922961155586, 5143.254228136899, 3217.324361883984, 3245.789023713451, 3304.801711897294, 3305.7024867762016, 3308.8676452942095, 5768.163616275617, 5805.767769289181, 5808.6224395414165, 5815.098659707752, 5825.825225243249, 6355.968220158869, 6374.776882809079, 6382.0, 6429.54993150475, 6434.324395938453, 5797.130430435468, 5802.82591522255, 5805.796797112081, 5811.389804070596, 5828.679422631796, 6013.278406591237, 6209.2548894133, 6217.129601855834, 6218.782342617987, 6227.470664993345, 6067.089936509559, 6073.089036644538, 6104.298005729398, 6108.694565271808, 6119.724612392364, 5778.248827652378, 5784.045632470764, 5811.215485909348, 5811.912821307599, 5821.068629019336, 4000.319945609195, 4003.2193722223888, 4005.43923850667, 4013.0569316210085, 4028.254772867029, 6154.1999540059505, 6181.5363847710705, 6185.969070154621, 6203.379662033941, 6222.0, 5792.4497172768515, 5973.850653733692, 5979.133025711334, 5993.880122397441, 6003.549733769897, 5973.731182096729, 5989.101634754822, 5996.700164991646, 6012.939870601238, 6054.939450605438, 5802.071668533014, 5819.476247137778, 5836.358000620014, 5849.415058494116, 5853.2390789198835, 5963.701814909324, 5981.3420523743225, 5983.7008149591475, 6018.909716354171, 6031.4270144336215, 5641.887162256814, 5839.386864379179, 5869.119632055226, 5876.882462350814, 5888.646681199141], "unit": "score", "name": "prototype.html", "value": 4392.136832314501}, {"lowerIsBetter": false, "replicates": [562.7523889488623, 566.9234653321803, 608.3065305551672, 637.9011253255745, 667.7696194812788, 10622.097121744651, 10874.891251087476, 10904.781904361907, 10922.563097476092, 10933.398663073538, 11221.831672524899, 11386.658400247985, 11406.885931140687, 11420.257683250584, 11448.599299024516, 738.47937204271, 743.9702411903518, 753.1827966656184, 757.3373298363931, 757.9090509138883, 765.2538774694684, 767.9116901556337, 768.5849641193748, 773.1147835728116, 774.5004472115482, 804.1395706593947, 805.3034125481475, 808.5431731071925, 810.1088802317433, 817.3216230528677, 787.0633945604712, 787.9015123109612, 790.8260182759841, 796.4862663581986, 804.903411590607, 588.4233451217788, 591.724847945703, 593.403629352498, 598.6946657204813, 599.4724642314735, 10254.0, 10296.176305895511, 10347.534360953776, 10375.273730838844, 10513.053825155772, 11714.53141874324, 11864.288142711464, 12013.279203247834, 12133.211341262879, 12346.135770496068, 9099.0, 9116.453012819253, 9260.814783704356, 9315.288997525895, 9324.813503729954, 3162.76279279055, 3180.793248438844, 3222.065600975714, 3229.2411283348392, 3321.70104690579, 40527.18945621071, 40919.795401023104, 41178.79410602958, 41180.0, 41545.79227103875, 9070.501122438329, 9195.402298850553, 9204.95397523008, 9285.535723213812, 9359.485228312507, 15664.295106719997, 15736.60658483547, 15862.60343491422, 15884.444044458389, 15951.44169954046, 6067.150598916155, 6188.504919606421, 6215.533834962396, 6259.96870015647, 6288.088227207121, 3440.208751987057, 3477.756557040983, 3514.1566024154017, 3566.7859928404378, 3582.283543291352, 2527.355524341318, 2534.379077126116, 2540.834845735021, 2546.4525127097763, 2552.4767422678306, 450.981960721574, 459.4716076512038, 485.3229744506394, 495.7397366382678, 503.5468078729173, 474.24358148752685, 524.6773234460779, 536.5612648221344, 567.4920945753528, 578.2656026845882, 6887.139107611549, 6970.825729356705, 6985.336393042653, 7100.68046937889, 7169.924511323343, 484.44010286876204, 531.4340227657532, 569.5500554561933, 583.7839999200323, 586.9735861886226, 3309.6028476582483, 3347.681970212826, 3389.2374215801246, 3392.2876195999115, 3490.6560974025183, 48095.51904480981, 48249.75875120602, 48258.758706206245, 48317.75841120772, 48620.27069593959, 42171.0, 43475.130497390506, 43572.564274357486, 44296.114077718266, 44352.11295774066, 39570.80214598909, 39721.60278397237, 39930.20139597192, 40170.39744403836, 40173.19653606912, 7350.347287965071, 7369.226231245856, 7413.666385012795, 7521.135069467081, 7617.885731714139, 30475.0, 30730.38539229158, 31133.377332453678, 31555.52666709955, 31582.842085789423, 36497.452538211415, 36520.26959460743, 36523.81738091292, 37272.627273728, 37298.627013729514, 8073.995949632815, 8139.10469848328, 8152.388570857328, 8163.714270000759, 8198.918010819816, 10925.235233533576, 10954.397508137128, 10974.835377469184, 10976.945115274373, 11181.440927953407, 10029.498525073863, 10069.748256293651, 10285.794284114425, 10681.57273709043, 10730.08794252466, 9840.458774767456, 10024.699259022242, 10406.063454289151, 10419.53112109972, 10436.478176091317, 9553.61785528571, 9644.517774111126, 9846.753831153992, 10136.695899123039, 10197.388156710622, 8043.83912321762, 8500.14998500145, 8620.870686939576, 8847.911520884709, 8964.731058068268, 8588.38288297254, 8878.467291962503, 9032.277417806428, 9033.728988130366, 9291.349605527548], "unit": "score", "name": "yui.html", "value": 5465.5394345813065}], "name": "dromaeo_css", "value": 6116.586042249646}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 115.0, 114.0, 116.0, 126.0, 114.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [160.0, 137.0, 159.0, 170.0, 132.0, 156.0, 158.0, 140.0, 183.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 164.0, 174.0, 163.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 74.0, 168.0, 74.0, 74.0, 74.0, 75.0, 151.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 140.0, 95.0, 102.0, 95.0, 141.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 120.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 120.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 70.0, 71.0, 75.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.9}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 95.0, 85.0, 85.0, 87.0, 88.0, 86.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 125.0, 128.0, 131.0, 133.0, 126.0, 122.0, 129.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [142.0, 172.0, 157.0, 157.0, 155.0, 142.0, 153.0, 154.0, 157.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 78.0, 73.0, 73.0, 73.0, 80.0, 71.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.7}], "name": "kraken", "value": 1578.4}]} 03:32:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1578.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6116.59"}}} 03:32:07 INFO - Return code: 0 03:32:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:32:07 ERROR - # TBPL SUCCESS # 03:32:07 INFO - Running post-action listener: _resource_record_post_action 03:32:07 INFO - Running post-run listener: _resource_record_post_run 03:32:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299061248; Read time: 8; Write time: 271260 03:32:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15486976; Read time: 0; Write time: 4356 03:32:08 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283574272; Read time: 8; Write time: 266904 03:32:08 INFO - Running post-run listener: _upload_blobber_files 03:32:08 INFO - Blob upload gear active. 03:32:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:32:08 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 03:32:08 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'] 03:32:08 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 03:32:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:09 INFO - (blobuploader) - INFO - Done attempting. 03:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:10 INFO - (blobuploader) - INFO - Done attempting. 03:32:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:32:10 INFO - Return code: 0 03:32:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:32:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:32:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/267dfc62b50387ea56063525f872a648e4bfbccec6d3a2e96b8e46645e1ff55d9d9ace95f27b4df8a704778936f226a1004247478a614236391b616d5f5a6b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4865d50b75feed4f381a217ffbeae570483d4d69beb9b2edd1266327e1e4d5e349da58597360e17338f9e5b87f25a30d08316b068a361f01d411f01e434d3de8"} 03:32:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:32:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:32:10 INFO - Contents: 03:32:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/267dfc62b50387ea56063525f872a648e4bfbccec6d3a2e96b8e46645e1ff55d9d9ace95f27b4df8a704778936f226a1004247478a614236391b616d5f5a6b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4865d50b75feed4f381a217ffbeae570483d4d69beb9b2edd1266327e1e4d5e349da58597360e17338f9e5b87f25a30d08316b068a361f01d411f01e434d3de8"} 03:32:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:32:10 INFO - Copying logs to upload dir... 03:32:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:32:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.791278 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-03-04 03:32:09.925923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 03:32:09.929505) ========= 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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 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/267dfc62b50387ea56063525f872a648e4bfbccec6d3a2e96b8e46645e1ff55d9d9ace95f27b4df8a704778936f226a1004247478a614236391b616d5f5a6b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4865d50b75feed4f381a217ffbeae570483d4d69beb9b2edd1266327e1e4d5e349da58597360e17338f9e5b87f25a30d08316b068a361f01d411f01e434d3de8"} build_url:https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/AhMMHyZ9SfepmfxmHBCtxQ/artifacts/public/build/firefox-47.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/267dfc62b50387ea56063525f872a648e4bfbccec6d3a2e96b8e46645e1ff55d9d9ace95f27b4df8a704778936f226a1004247478a614236391b616d5f5a6b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4865d50b75feed4f381a217ffbeae570483d4d69beb9b2edd1266327e1e4d5e349da58597360e17338f9e5b87f25a30d08316b068a361f01d411f01e434d3de8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 03:32:09.954167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:32:09.954499) ========= 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=c6927cf182745ad25b1d38b9000001fe-1457088625.656409-182332340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 03:32:10.037286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 03:32:10.037602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 03:32:10.037933) ========= ========= Total master_lag: 0.27 =========