builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1457318730.33 results: success (0) buildid: 20160306175510 builduid: 083419698deb47aa93cf1f73425dc6e0 revision: 6f37ab432cf08ea6d729161d205d686ffacbff0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.331646) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.332071) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.332384) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.008956 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.357711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.358044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.373989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.374364) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.425666) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.425960) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.426325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.426644) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 18:45:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-03-06 18:45:30 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.535037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.535346) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020912 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:30.591938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-06 18:45:30.592283) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f37ab432cf08ea6d729161d205d686ffacbff0b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6f37ab432cf08ea6d729161d205d686ffacbff0b --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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 18:45:30,839 truncating revision to first 12 chars 2016-03-06 18:45:30,839 Setting DEBUG logging. 2016-03-06 18:45:30,839 attempt 1/10 2016-03-06 18:45:30,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f37ab432cf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 18:45:31,774 unpacking tar archive at: fx-team-6f37ab432cf0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.261232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-06 18:45:31.871027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:31.871867) ========= echo 6f37ab432cf08ea6d729161d205d686ffacbff0b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6f37ab432cf08ea6d729161d205d686ffacbff0b'] 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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6f37ab432cf08ea6d729161d205d686ffacbff0b program finished with exit code 0 elapsedTime=0.004702 script_repo_revision: '6f37ab432cf08ea6d729161d205d686ffacbff0b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:31.926394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:31.926719) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 18:45:31.937498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-03-06 18:45:31.938160) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:45:32 INFO - MultiFileLogger online at 20160306 18:45:32 in /builds/slave/test 18:45:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:45:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:45:32 INFO - {'append_to_log': False, 18:45:32 INFO - 'base_work_dir': '/builds/slave/test', 18:45:32 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:45:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:45:32 INFO - 'branch': 'Fx-Team-Non-PGO', 18:45:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:45:32 INFO - 'config_files': ('talos/linux_config.py',), 18:45:32 INFO - 'default_actions': ('clobber', 18:45:32 INFO - 'read-buildbot-config', 18:45:32 INFO - 'download-and-extract', 18:45:32 INFO - 'populate-webroot', 18:45:32 INFO - 'create-virtualenv', 18:45:32 INFO - 'install', 18:45:32 INFO - 'run-tests'), 18:45:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:45:32 INFO - 'download_minidump_stackwalk': True, 18:45:32 INFO - 'download_symbols': 'ondemand', 18:45:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:45:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:45:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:45:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:45:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:45:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:45:32 INFO - 'installer_path': 'installer.exe', 18:45:32 INFO - 'log_level': 'info', 18:45:32 INFO - 'log_name': 'talos', 18:45:32 INFO - 'log_to_console': True, 18:45:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:45:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:45:32 INFO - 'opt_config_files': (), 18:45:32 INFO - 'pip_index': False, 18:45:32 INFO - 'sps_profile': False, 18:45:32 INFO - 'sps_profile_interval': 0, 18:45:32 INFO - 'suite': 'dromaeojs-e10s', 18:45:32 INFO - 'system_bits': '32', 18:45:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:45:32 INFO - 'title': 'talos-linux64-ix-047', 18:45:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:45:32 INFO - 'use_talos_json': True, 18:45:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:45:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:45:32 INFO - 'work_dir': 'build'} 18:45:32 INFO - ##### 18:45:32 INFO - ##### Running clobber step. 18:45:32 INFO - ##### 18:45:32 INFO - Running pre-action listener: _resource_record_pre_action 18:45:32 INFO - Running main action method: clobber 18:45:32 INFO - rmtree: /builds/slave/test/build 18:45:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:45:33 INFO - Running post-action listener: _resource_record_post_action 18:45:33 INFO - ##### 18:45:33 INFO - ##### Running read-buildbot-config step. 18:45:33 INFO - ##### 18:45:33 INFO - Running pre-action listener: _resource_record_pre_action 18:45:33 INFO - Running main action method: read_buildbot_config 18:45:33 INFO - Using buildbot properties: 18:45:33 INFO - { 18:45:33 INFO - "project": "", 18:45:33 INFO - "product": "firefox", 18:45:33 INFO - "script_repo_revision": "production", 18:45:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:45:33 INFO - "repository": "", 18:45:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:45:33 INFO - "buildid": "20160306175510", 18:45:33 INFO - "pgo_build": "False", 18:45:33 INFO - "basedir": "/builds/slave/test", 18:45:33 INFO - "buildnumber": 1200, 18:45:33 INFO - "slavename": "talos-linux64-ix-047", 18:45:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:45:33 INFO - "platform": "ubuntu64_hw", 18:45:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:45:33 INFO - "branch": "fx-team", 18:45:33 INFO - "repo_path": "integration/fx-team", 18:45:33 INFO - "revision": "6f37ab432cf08ea6d729161d205d686ffacbff0b", 18:45:33 INFO - "stage_platform": "linux64", 18:45:33 INFO - "builduid": "083419698deb47aa93cf1f73425dc6e0", 18:45:33 INFO - "slavebuilddir": "test" 18:45:33 INFO - } 18:45:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 18:45:33 INFO - Running post-action listener: _resource_record_post_action 18:45:33 INFO - ##### 18:45:33 INFO - ##### Running download-and-extract step. 18:45:33 INFO - ##### 18:45:33 INFO - Running pre-action listener: _resource_record_pre_action 18:45:33 INFO - Running main action method: download_and_extract 18:45:33 INFO - mkdir: /builds/slave/test/build/tests 18:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:33 INFO - https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:45:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 18:45:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 18:45:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:34 INFO - Downloaded 1448 bytes. 18:45:34 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 18:45:34 INFO - Using the following test package requirements: 18:45:34 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:45:34 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:45:34 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:45:34 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'jsshell-linux-x86_64.zip'], 18:45:34 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:45:34 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:45:34 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:45:34 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:45:34 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:45:34 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:45:34 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:45:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:45:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:34 INFO - https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:36 INFO - Downloaded 22091821 bytes. 18:45:36 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'] 18:45:36 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 18:45:37 INFO - Return code: 0 18:45:37 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 18:45: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')]} 18:45:37 INFO - https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:45:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:45:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:45:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:39 INFO - Downloaded 22091821 bytes. 18:45: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'] 18:45: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 18:45:40 INFO - Return code: 0 18:45: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')]} 18:45:40 INFO - https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:41 INFO - Downloaded 10845161 bytes. 18:45:41 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'] 18:45:41 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 18:45:41 INFO - Return code: 0 18:45:41 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')]} 18:45:41 INFO - https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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 18:45:43 INFO - Downloaded 54411437 bytes. 18:45:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:45:43 INFO - mkdir: /builds/slave/test/properties 18:45:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:45:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:45:43 INFO - Contents: 18:45:43 INFO - build_url:https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:45:44 INFO - Running post-action listener: _resource_record_post_action 18:45:44 INFO - Running post-action listener: set_extra_try_arguments 18:45:44 INFO - ##### 18:45:44 INFO - ##### Running populate-webroot step. 18:45:44 INFO - ##### 18:45:44 INFO - Running pre-action listener: _resource_record_pre_action 18:45:44 INFO - Running main action method: populate_webroot 18:45:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:45:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:45:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:45:44 INFO - '--tppagecycles', 18:45:44 INFO - '7'], 18:45:44 INFO - 'tests': ['tsvgm']}}, 18:45:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:45:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:45:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:45:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:45:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'tests': ['damp', 'tps']}, 18:45:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['damp', 'tps']}, 18:45:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:45:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:45:44 INFO - 'other': {'tests': ['a11yr', 18:45:44 INFO - 'ts_paint', 18:45:44 INFO - 'tpaint', 18:45:44 INFO - 'sessionrestore', 18:45:44 INFO - 'sessionrestore_no_auto_restore', 18:45:44 INFO - 'tabpaint']}, 18:45:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['a11yr', 18:45:44 INFO - 'ts_paint', 18:45:44 INFO - 'tpaint', 18:45:44 INFO - 'sessionrestore', 18:45:44 INFO - 'sessionrestore_no_auto_restore', 18:45:44 INFO - 'tabpaint']}, 18:45:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['a11yr', 18:45:44 INFO - 'ts_paint', 18:45:44 INFO - 'tpaint', 18:45:44 INFO - 'sessionrestore', 18:45:44 INFO - 'sessionrestore_no_auto_restore', 18:45:44 INFO - 'tabpaint']}, 18:45:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['a11yr', 18:45:44 INFO - 'ts_paint', 18:45:44 INFO - 'tpaint', 18:45:44 INFO - 'sessionrestore', 18:45:44 INFO - 'sessionrestore_no_auto_restore', 18:45:44 INFO - 'tabpaint']}, 18:45:44 INFO - 'other_l64': {'tests': ['a11yr', 18:45:44 INFO - 'ts_paint', 18:45:44 INFO - 'tpaint', 18:45:44 INFO - 'sessionrestore', 18:45:44 INFO - 'sessionrestore_no_auto_restore', 18:45:44 INFO - 'tabpaint']}, 18:45:44 INFO - 'other_nol64': {'tests': ['a11yr', 18:45:44 INFO - 'ts_paint', 18:45:44 INFO - 'tpaint', 18:45:44 INFO - 'sessionrestore', 18:45:44 INFO - 'sessionrestore_no_auto_restore', 18:45:44 INFO - 'tabpaint']}, 18:45:44 INFO - 'svgr': {'tests': ['tsvgx', 18:45:44 INFO - 'tsvgr_opacity', 18:45:44 INFO - 'tart', 18:45:44 INFO - 'tscrollx', 18:45:44 INFO - 'cart']}, 18:45:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['tsvgx', 18:45:44 INFO - 'tsvgr_opacity', 18:45:44 INFO - 'tart', 18:45:44 INFO - 'tscrollx', 18:45:44 INFO - 'cart']}, 18:45:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'tests': ['tp5o']}, 18:45:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'talos_options': ['--e10s'], 18:45:44 INFO - 'tests': ['tp5o']}, 18:45:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'talos_options': ['--xperf_path', 18:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:44 INFO - 'tests': ['tp5n']}, 18:45:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:44 INFO - 'talos_options': ['--e10s', 18:45:44 INFO - '--xperf_path', 18:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:44 INFO - 'tests': ['tp5n']}}, 18:45:44 INFO - 'talos.zip': {'path': '', 18:45:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:45:44 INFO - Running post-action listener: _resource_record_post_action 18:45:44 INFO - ##### 18:45:44 INFO - ##### Running create-virtualenv step. 18:45:44 INFO - ##### 18:45:44 INFO - Running pre-action listener: _resource_record_pre_action 18:45:44 INFO - Running main action method: create_virtualenv 18:45:44 INFO - Creating virtualenv /builds/slave/test/build/venv 18:45:44 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 18:45:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:45:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:45:44 INFO - Using real prefix '/usr' 18:45:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:45:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:45:46 INFO - Installing pip.................done. 18:45:46 INFO - Return code: 0 18:45:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:45:46 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')]} 18:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:46 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')]} 18:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:46 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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:45:46 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 18:45:46 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 18:45:46 INFO - Using env: {'DISPLAY': ':0', 18:45:46 INFO - 'HOME': '/home/cltbld', 18:45:46 INFO - 'LANG': 'en_US.UTF-8', 18:45:46 INFO - 'LANGUAGE': 'en_US:en', 18:45:46 INFO - 'LOGNAME': 'cltbld', 18:45:46 INFO - 'MAIL': '/var/mail/cltbld', 18:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:46 INFO - 'MOZ_NO_REMOTE': '1', 18:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:46 INFO - 'NO_EM_RESTART': '1', 18:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:46 INFO - 'PWD': '/builds/slave/test', 18:45:46 INFO - 'SHELL': '/bin/bash', 18:45:46 INFO - 'SHLVL': '1', 18:45:46 INFO - 'TERM': 'linux', 18:45:46 INFO - 'TMOUT': '86400', 18:45:46 INFO - 'USER': 'cltbld', 18:45:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:46 INFO - '_': '/tools/buildbot/bin/python'} 18:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:47 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 18:45:47 INFO - Cleaning up... 18:45:47 INFO - Return code: 0 18:45:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:45:47 INFO - Using env: {'DISPLAY': ':0', 18:45:47 INFO - 'HOME': '/home/cltbld', 18:45:47 INFO - 'LANG': 'en_US.UTF-8', 18:45:47 INFO - 'LANGUAGE': 'en_US:en', 18:45:47 INFO - 'LOGNAME': 'cltbld', 18:45:47 INFO - 'MAIL': '/var/mail/cltbld', 18:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:47 INFO - 'MOZ_NO_REMOTE': '1', 18:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:47 INFO - 'NO_EM_RESTART': '1', 18:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:47 INFO - 'PWD': '/builds/slave/test', 18:45:47 INFO - 'SHELL': '/bin/bash', 18:45:47 INFO - 'SHLVL': '1', 18:45:47 INFO - 'TERM': 'linux', 18:45:47 INFO - 'TMOUT': '86400', 18:45:47 INFO - 'USER': 'cltbld', 18:45:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:47 INFO - '_': '/tools/buildbot/bin/python'} 18:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:47 INFO - Downloading/unpacking psutil>=0.7.1 18:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:49 INFO - Installing collected packages: psutil 18:45:49 INFO - Running setup.py install for psutil 18:45:49 INFO - building 'psutil._psutil_linux' extension 18:45:49 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 18:45:49 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 18:45:49 INFO - building 'psutil._psutil_posix' extension 18:45:49 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 18:45:49 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 18:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:49 INFO - Successfully installed psutil 18:45:49 INFO - Cleaning up... 18:45:49 INFO - Return code: 0 18:45:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:45:49 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')]} 18:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:49 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')]} 18:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:49 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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:45:49 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 18:45:49 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 18:45:49 INFO - Using env: {'DISPLAY': ':0', 18:45:49 INFO - 'HOME': '/home/cltbld', 18:45:49 INFO - 'LANG': 'en_US.UTF-8', 18:45:49 INFO - 'LANGUAGE': 'en_US:en', 18:45:49 INFO - 'LOGNAME': 'cltbld', 18:45:49 INFO - 'MAIL': '/var/mail/cltbld', 18:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:49 INFO - 'MOZ_NO_REMOTE': '1', 18:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:49 INFO - 'NO_EM_RESTART': '1', 18:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:49 INFO - 'PWD': '/builds/slave/test', 18:45:49 INFO - 'SHELL': '/bin/bash', 18:45:49 INFO - 'SHLVL': '1', 18:45:49 INFO - 'TERM': 'linux', 18:45:49 INFO - 'TMOUT': '86400', 18:45:49 INFO - 'USER': 'cltbld', 18:45:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:49 INFO - '_': '/tools/buildbot/bin/python'} 18:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:45:51 INFO - Installing collected packages: mozsystemmonitor 18:45:51 INFO - Running setup.py install for mozsystemmonitor 18:45:51 INFO - Successfully installed mozsystemmonitor 18:45:51 INFO - Cleaning up... 18:45:51 INFO - Return code: 0 18:45:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:45:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:45:51 INFO - Using env: {'DISPLAY': ':0', 18:45:51 INFO - 'HOME': '/home/cltbld', 18:45:51 INFO - 'LANG': 'en_US.UTF-8', 18:45:51 INFO - 'LANGUAGE': 'en_US:en', 18:45:51 INFO - 'LOGNAME': 'cltbld', 18:45:51 INFO - 'MAIL': '/var/mail/cltbld', 18:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:51 INFO - 'MOZ_NO_REMOTE': '1', 18:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:51 INFO - 'NO_EM_RESTART': '1', 18:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:51 INFO - 'PWD': '/builds/slave/test', 18:45:51 INFO - 'SHELL': '/bin/bash', 18:45:51 INFO - 'SHLVL': '1', 18:45:51 INFO - 'TERM': 'linux', 18:45:51 INFO - 'TMOUT': '86400', 18:45:51 INFO - 'USER': 'cltbld', 18:45:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:51 INFO - '_': '/tools/buildbot/bin/python'} 18:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:45:52 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 18:45:52 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 18:45:52 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 18:45:52 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 18:45:52 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 18:45:52 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 18:45:53 INFO - Downloading blobuploader-1.2.4.tar.gz 18:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:45:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:45:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:54 INFO - Downloading docopt-0.6.1.tar.gz 18:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:45:54 INFO - Installing collected packages: blobuploader, requests, docopt 18:45:54 INFO - Running setup.py install for blobuploader 18:45:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:45:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:45:54 INFO - Running setup.py install for requests 18:45:55 INFO - Running setup.py install for docopt 18:45:55 INFO - Successfully installed blobuploader requests docopt 18:45:55 INFO - Cleaning up... 18:45:55 INFO - Return code: 0 18:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:55 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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:45:55 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 18:45:55 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 18:45:55 INFO - Using env: {'DISPLAY': ':0', 18:45:55 INFO - 'HOME': '/home/cltbld', 18:45:55 INFO - 'LANG': 'en_US.UTF-8', 18:45:55 INFO - 'LANGUAGE': 'en_US:en', 18:45:55 INFO - 'LOGNAME': 'cltbld', 18:45:55 INFO - 'MAIL': '/var/mail/cltbld', 18:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:55 INFO - 'MOZ_NO_REMOTE': '1', 18:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:55 INFO - 'NO_EM_RESTART': '1', 18:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:55 INFO - 'PWD': '/builds/slave/test', 18:45:55 INFO - 'SHELL': '/bin/bash', 18:45:55 INFO - 'SHLVL': '1', 18:45:55 INFO - 'TERM': 'linux', 18:45:55 INFO - 'TMOUT': '86400', 18:45:55 INFO - 'USER': 'cltbld', 18:45:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:55 INFO - '_': '/tools/buildbot/bin/python'} 18:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:55 INFO - Running setup.py (path:/tmp/pip-n6tfMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:55 INFO - Running setup.py (path:/tmp/pip-zDMkhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:55 INFO - Running setup.py (path:/tmp/pip-Gg9qjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:55 INFO - Running setup.py (path:/tmp/pip-u7UhOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:55 INFO - Running setup.py (path:/tmp/pip-XBLWd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:56 INFO - Running setup.py (path:/tmp/pip-eK3sJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:56 INFO - Running setup.py (path:/tmp/pip-hHtLF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:56 INFO - Running setup.py (path:/tmp/pip-CG3rtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:56 INFO - Running setup.py (path:/tmp/pip-7Ml5u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:56 INFO - Running setup.py (path:/tmp/pip-xT4Vdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:56 INFO - Running setup.py (path:/tmp/pip-pXASAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:56 INFO - Running setup.py (path:/tmp/pip-MV2Z_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:56 INFO - Running setup.py (path:/tmp/pip-d0YDlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:56 INFO - Running setup.py (path:/tmp/pip-JHfVNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:56 INFO - Running setup.py (path:/tmp/pip-rQoTbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:56 INFO - Running setup.py (path:/tmp/pip-0QXJTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:56 INFO - Running setup.py (path:/tmp/pip-vuycLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:45:56 INFO - Running setup.py install for manifestparser 18:45:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Running setup.py install for mozcrash 18:45:57 INFO - Running setup.py install for mozdebug 18:45:57 INFO - Running setup.py install for mozdevice 18:45:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Running setup.py install for mozfile 18:45:57 INFO - Running setup.py install for mozhttpd 18:45:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Running setup.py install for mozinfo 18:45:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Running setup.py install for mozInstall 18:45:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Running setup.py install for mozleak 18:45:57 INFO - Running setup.py install for mozlog 18:45:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:45:57 INFO - Running setup.py install for moznetwork 18:45:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:45:58 INFO - Running setup.py install for mozprocess 18:45:58 INFO - Running setup.py install for mozprofile 18:45:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:45:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:45:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:45:58 INFO - Running setup.py install for mozrunner 18:45:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:45:58 INFO - Running setup.py install for mozscreenshot 18:45:58 INFO - Running setup.py install for moztest 18:45:58 INFO - Running setup.py install for mozversion 18:45:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:45:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:45:58 INFO - Cleaning up... 18:45:58 INFO - Return code: 0 18:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:58 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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:45:58 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 18:45:58 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 18:45:58 INFO - Using env: {'DISPLAY': ':0', 18:45:58 INFO - 'HOME': '/home/cltbld', 18:45:58 INFO - 'LANG': 'en_US.UTF-8', 18:45:58 INFO - 'LANGUAGE': 'en_US:en', 18:45:58 INFO - 'LOGNAME': 'cltbld', 18:45:58 INFO - 'MAIL': '/var/mail/cltbld', 18:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:58 INFO - 'MOZ_NO_REMOTE': '1', 18:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:58 INFO - 'NO_EM_RESTART': '1', 18:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:58 INFO - 'PWD': '/builds/slave/test', 18:45:58 INFO - 'SHELL': '/bin/bash', 18:45:58 INFO - 'SHLVL': '1', 18:45:58 INFO - 'TERM': 'linux', 18:45:58 INFO - 'TMOUT': '86400', 18:45:58 INFO - 'USER': 'cltbld', 18:45:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:58 INFO - '_': '/tools/buildbot/bin/python'} 18:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:58 INFO - Running setup.py (path:/tmp/pip-vYQJB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:58 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)) 18:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:58 INFO - Running setup.py (path:/tmp/pip-9WwEiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:59 INFO - Running setup.py (path:/tmp/pip-dwMfUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:59 INFO - Running setup.py (path:/tmp/pip-0ciZcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:59 INFO - Running setup.py (path:/tmp/pip-ZOE6Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:59 INFO - Running setup.py (path:/tmp/pip-O2zafd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:59 INFO - Running setup.py (path:/tmp/pip-hRzEsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:59 INFO - Running setup.py (path:/tmp/pip-VkIgzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:59 INFO - Running setup.py (path:/tmp/pip-jSPynr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:59 INFO - Running setup.py (path:/tmp/pip-GDJFnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:59 INFO - Running setup.py (path:/tmp/pip-b_T2rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:59 INFO - Running setup.py (path:/tmp/pip-FXO7wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:59 INFO - Running setup.py (path:/tmp/pip-1AhhDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:59 INFO - Running setup.py (path:/tmp/pip-c1WJk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:59 INFO - Running setup.py (path:/tmp/pip-hjxht4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:59 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)) 18:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:59 INFO - Running setup.py (path:/tmp/pip-tfYGNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:00 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)) 18:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:00 INFO - Running setup.py (path:/tmp/pip-MM405o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:00 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)) 18:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:46:00 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)) 18:46:00 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)) 18:46:00 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)) 18:46:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:01 INFO - Downloading blessings-1.6.tar.gz 18:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:46:02 INFO - Installing collected packages: blessings 18:46:02 INFO - Running setup.py install for blessings 18:46:02 INFO - Successfully installed blessings 18:46:02 INFO - Cleaning up... 18:46:02 INFO - Return code: 0 18:46:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:46:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:02 INFO - Reading from file tmpfile_stdout 18:46:02 INFO - Current package versions: 18:46:02 INFO - argparse == 1.2.1 18:46:02 INFO - blessings == 1.6 18:46:02 INFO - blobuploader == 1.2.4 18:46:02 INFO - docopt == 0.6.1 18:46:02 INFO - manifestparser == 1.1 18:46:02 INFO - mozInstall == 1.12 18:46:02 INFO - mozcrash == 0.17 18:46:02 INFO - mozdebug == 0.1 18:46:02 INFO - mozdevice == 0.48 18:46:02 INFO - mozfile == 1.2 18:46:02 INFO - mozhttpd == 0.7 18:46:02 INFO - mozinfo == 0.9 18:46:02 INFO - mozleak == 0.1 18:46:02 INFO - mozlog == 3.1 18:46:02 INFO - moznetwork == 0.27 18:46:02 INFO - mozprocess == 0.22 18:46:02 INFO - mozprofile == 0.28 18:46:02 INFO - mozrunner == 6.11 18:46:02 INFO - mozscreenshot == 0.1 18:46:02 INFO - mozsystemmonitor == 0.0 18:46:02 INFO - moztest == 0.7 18:46:02 INFO - mozversion == 1.4 18:46:02 INFO - psutil == 3.1.1 18:46:02 INFO - requests == 1.2.3 18:46:02 INFO - wsgiref == 0.1.2 18:46:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46: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')]} 18:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:02 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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:46:02 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 18:46:02 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 18:46:02 INFO - Using env: {'DISPLAY': ':0', 18:46:02 INFO - 'HOME': '/home/cltbld', 18:46:02 INFO - 'LANG': 'en_US.UTF-8', 18:46:02 INFO - 'LANGUAGE': 'en_US:en', 18:46:02 INFO - 'LOGNAME': 'cltbld', 18:46:02 INFO - 'MAIL': '/var/mail/cltbld', 18:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:02 INFO - 'MOZ_NO_REMOTE': '1', 18:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:02 INFO - 'NO_EM_RESTART': '1', 18:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:02 INFO - 'PWD': '/builds/slave/test', 18:46:02 INFO - 'SHELL': '/bin/bash', 18:46:02 INFO - 'SHLVL': '1', 18:46:02 INFO - 'TERM': 'linux', 18:46:02 INFO - 'TMOUT': '86400', 18:46:02 INFO - 'USER': 'cltbld', 18:46:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:02 INFO - '_': '/tools/buildbot/bin/python'} 18:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 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)) 18:46:02 INFO - Cleaning up... 18:46:02 INFO - Return code: 0 18:46:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:46: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')]} 18:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:02 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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:46:02 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 18:46:02 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 18:46:02 INFO - Using env: {'DISPLAY': ':0', 18:46:02 INFO - 'HOME': '/home/cltbld', 18:46:02 INFO - 'LANG': 'en_US.UTF-8', 18:46:02 INFO - 'LANGUAGE': 'en_US:en', 18:46:02 INFO - 'LOGNAME': 'cltbld', 18:46:02 INFO - 'MAIL': '/var/mail/cltbld', 18:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:02 INFO - 'MOZ_NO_REMOTE': '1', 18:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:02 INFO - 'NO_EM_RESTART': '1', 18:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:02 INFO - 'PWD': '/builds/slave/test', 18:46:02 INFO - 'SHELL': '/bin/bash', 18:46:02 INFO - 'SHLVL': '1', 18:46:02 INFO - 'TERM': 'linux', 18:46:02 INFO - 'TMOUT': '86400', 18:46:02 INFO - 'USER': 'cltbld', 18:46:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:02 INFO - '_': '/tools/buildbot/bin/python'} 18:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:02 INFO - Downloading/unpacking jsonschema 18:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:46:04 INFO - Downloading/unpacking functools32 (from jsonschema) 18:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:04 INFO - Downloading functools32-3.2.3-2.tar.gz 18:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:46:04 INFO - warning: no files found matching '*.txt' 18:46:04 INFO - no previously-included directories found matching 'build' 18:46:04 INFO - no previously-included directories found matching 'dist' 18:46:04 INFO - no previously-included directories found matching '.git*' 18:46:04 INFO - Installing collected packages: jsonschema, functools32 18:46:04 INFO - Running setup.py install for functools32 18:46:05 INFO - warning: no files found matching '*.txt' 18:46:05 INFO - no previously-included directories found matching 'build' 18:46:05 INFO - no previously-included directories found matching 'dist' 18:46:05 INFO - no previously-included directories found matching '.git*' 18:46:05 INFO - Successfully installed jsonschema functools32 18:46:05 INFO - Cleaning up... 18:46:05 INFO - Return code: 0 18:46:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:46:05 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')]} 18:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:05 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')]} 18:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:05 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 0x7f11f60fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1859410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', '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 18:46:05 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 18:46:05 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 18:46:05 INFO - Using env: {'DISPLAY': ':0', 18:46:05 INFO - 'HOME': '/home/cltbld', 18:46:05 INFO - 'LANG': 'en_US.UTF-8', 18:46:05 INFO - 'LANGUAGE': 'en_US:en', 18:46:05 INFO - 'LOGNAME': 'cltbld', 18:46:05 INFO - 'MAIL': '/var/mail/cltbld', 18:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:05 INFO - 'MOZ_NO_REMOTE': '1', 18:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:05 INFO - 'NO_EM_RESTART': '1', 18:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:05 INFO - 'PWD': '/builds/slave/test', 18:46:05 INFO - 'SHELL': '/bin/bash', 18:46:05 INFO - 'SHLVL': '1', 18:46:05 INFO - 'TERM': 'linux', 18:46:05 INFO - 'TMOUT': '86400', 18:46:05 INFO - 'USER': 'cltbld', 18:46:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:05 INFO - '_': '/tools/buildbot/bin/python'} 18:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:05 INFO - Downloading/unpacking flake8 18:46:05 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 18:46:05 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 18:46:05 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 18:46:05 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 18:46:05 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 18:46:05 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 18:46:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:46:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:46:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:46:07 INFO - no previously-included directories found matching 'docs/_build' 18:46:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:46:07 INFO - Running setup.py install for pep8 18:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:46:07 INFO - no previously-included directories found matching 'docs/_build' 18:46:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:46:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:46:08 INFO - Cleaning up... 18:46:08 INFO - Return code: 0 18:46:08 INFO - Running post-action listener: _resource_record_post_action 18:46:08 INFO - Running post-action listener: _start_resource_monitoring 18:46:08 INFO - Starting resource monitoring. 18:46:08 INFO - ##### 18:46:08 INFO - ##### Running install step. 18:46:08 INFO - ##### 18:46:08 INFO - Running pre-action listener: _resource_record_pre_action 18:46:08 INFO - Running main action method: install 18:46:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:08 INFO - Reading from file tmpfile_stdout 18:46:08 INFO - Detecting whether we're running mozinstall >=1.0... 18:46:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:46:08 INFO - Reading from file tmpfile_stdout 18:46:08 INFO - Output received: 18:46:08 INFO - Usage: mozinstall [options] installer 18:46:08 INFO - Options: 18:46:08 INFO - -h, --help show this help message and exit 18:46:08 INFO - -d DEST, --destination=DEST 18:46:08 INFO - Directory to install application into. [default: 18:46:08 INFO - "/builds/slave/test"] 18:46:08 INFO - --app=APP Application being installed. [default: firefox] 18:46:08 INFO - mkdir: /builds/slave/test/build/application 18:46:08 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'] 18:46:08 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 18:46:24 INFO - Reading from file tmpfile_stdout 18:46:24 INFO - Output received: 18:46:24 INFO - /builds/slave/test/build/application/firefox/firefox 18:46:24 INFO - Running post-action listener: _resource_record_post_action 18:46:24 INFO - ##### 18:46:24 INFO - ##### Running run-tests step. 18:46:24 INFO - ##### 18:46:24 INFO - Running pre-action listener: _resource_record_pre_action 18:46:24 INFO - Running main action method: run_tests 18:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:46:24 INFO - Python 2.7.3 18:46:24 INFO - Return code: 0 18:46:24 INFO - grabbing minidump binary from tooltool 18:46:24 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')]} 18:46:24 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 0x18e8160>, '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 0x18e9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e94f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:46:24 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 18:46:24 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 18:46:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:46:24 INFO - Return code: 0 18:46:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:46:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:46:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:46:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:46:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:46:25 INFO - Return code: 0 18:46:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 18:46:25 INFO - Using env: {'DISPLAY': ':0', 18:46:25 INFO - 'HOME': '/home/cltbld', 18:46:25 INFO - 'LANG': 'en_US.UTF-8', 18:46:25 INFO - 'LANGUAGE': 'en_US:en', 18:46:25 INFO - 'LOGNAME': 'cltbld', 18:46:25 INFO - 'MAIL': '/var/mail/cltbld', 18:46:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:46:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:25 INFO - 'MOZ_NO_REMOTE': '1', 18:46:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:25 INFO - 'NO_EM_RESTART': '1', 18:46:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:25 INFO - 'PWD': '/builds/slave/test', 18:46:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:46:25 INFO - 'SHELL': '/bin/bash', 18:46:25 INFO - 'SHLVL': '1', 18:46:25 INFO - 'TERM': 'linux', 18:46:25 INFO - 'TMOUT': '86400', 18:46:25 INFO - 'USER': 'cltbld', 18:46:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231', 18:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:25 INFO - '_': '/tools/buildbot/bin/python'} 18:46:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:46:25 INFO - mozversion application_buildid: 20160306175510 18:46:25 INFO - mozversion application_changeset: 6f37ab432cf08ea6d729161d205d686ffacbff0b 18:46:25 INFO - mozversion application_display_name: Nightly 18:46:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:46:25 INFO - mozversion application_name: Firefox 18:46:25 INFO - mozversion application_remotingname: firefox 18:46:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:46:25 INFO - mozversion application_vendor: Mozilla 18:46:25 INFO - mozversion application_version: 47.0a1 18:46:25 INFO - mozversion platform_buildid: 20160306175510 18:46:25 INFO - mozversion platform_changeset: 6f37ab432cf08ea6d729161d205d686ffacbff0b 18:46:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:46:25 INFO - mozversion platform_version: 47.0a1 18:46:25 INFO - using testdate: 1457318785 18:46:25 INFO - actual date: 1457318785 18:46:25 INFO - starting webserver on 'localhost:39235' 18:46:25 INFO - SUITE-START | Running 2 tests 18:46:25 INFO - TEST-START | dromaeo_css 18:46:25 INFO - operating with platform_type : linux_ 18:46:25 INFO - Initialising browser for dromaeo_css test... 18:46:25 INFO - TEST-INFO | started process 15762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYEij6H/profile http://localhost:39235/getInfo.html) 18:46:29 INFO - PROCESS | 15762 | 18:46:29 INFO - PROCESS | 15762 | (process:15844): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:46:30 INFO - PROCESS | 15762 | __metrics Screen width/height:1600/1200 18:46:30 INFO - PROCESS | 15762 | colorDepth:24 18:46:30 INFO - PROCESS | 15762 | Browser inner width/height: 1024/697 18:46:30 INFO - PROCESS | 15762 | __metrics 18:46:30 ERROR - PROCESS | 15762 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:46:31 INFO - TEST-INFO | 15762: exit 0 18:46:31 INFO - Browser initialized. 18:46:31 INFO - Running cycle 1/1 for dromaeo_css test... 18:46:31 INFO - TEST-INFO | started process 15896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYEij6H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:33 INFO - PROCESS | 15896 | 18:46:33 INFO - PROCESS | 15896 | (process:15958): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:46:43 INFO - PROCESS | 15896 | RSS: Main: 165212160 18:46:43 INFO - PROCESS | 15896 | 18:47:33 INFO - PROCESS | 15896 | 1457318853297 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] 18:49:45 INFO - PROCESS | 15896 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39235/tests/dromaeo/cssquery-ext.html) 18:49:46 INFO - PROCESS | 15896 | RSS: Main: 169660416 18:49:46 INFO - PROCESS | 15896 | 18:52:48 INFO - PROCESS | 15896 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-ext.html (next: http://localhost:39235/tests/dromaeo/cssquery-jquery.html) 18:52:48 INFO - PROCESS | 15896 | RSS: Main: 168333312 18:52:48 INFO - PROCESS | 15896 | 18:55:50 INFO - PROCESS | 15896 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39235/tests/dromaeo/cssquery-mootools.html) 18:55:51 INFO - PROCESS | 15896 | RSS: Main: 170389504 18:55:51 INFO - PROCESS | 15896 | 18:58:53 INFO - PROCESS | 15896 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39235/tests/dromaeo/cssquery-prototype.html) 18:58:53 INFO - PROCESS | 15896 | RSS: Main: 167653376 18:58:53 INFO - PROCESS | 15896 | 19:01:56 INFO - PROCESS | 15896 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39235/tests/dromaeo/cssquery-yui.html) 19:01:56 INFO - PROCESS | 15896 | RSS: Main: 168853504 19:01:56 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-yui.html (next: http://localhost:39235/tests/dromaeo/cssquery-dojo.html) 19:04:59 INFO - PROCESS | 15896 | RSS: Main: 171556864 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | __start_tp_report 19:04:59 INFO - PROCESS | 15896 | _x_x_mozilla_page_load 19:04:59 INFO - PROCESS | 15896 | _x_x_mozilla_page_load_details 19:04:59 INFO - PROCESS | 15896 | |i|pagename|runs| 19:04:59 INFO - PROCESS | 15896 | |0;dojo.html;2619.0571394298054;2657.98671006645;2686.8790904409298;2700.4734076855007;2702.3919618085934;4578.15304168729;4618.44578650562;4625;4631.884202894929;4657.813687452506;4492.460904691434;4532.229520981433;4569.954300456994;4571.6114130298965;4626.259798432252;4234.364845273203;4257.084726783741;4300.032492689135;4308.3968244445805;4359.564043595631;4233.640140588053;4233.66130709544;4285.335772955197;4310.935335969963;4351.760653164075;4241.554636763126;4285.078708077778;4314.590113939171;4316.3741257517795;4333.501647310537;4221.7255878367805;4231.026863821307;4239.427677263561;4253.8723838284905;4268.9146217075795;4128.422020917074;4201.621854033152;4209.284421648296;4232.555581663912;4252.872413827559;4514.503404625489;4550.658700597469;4553.5218802025975;4594.74728889911;4617.746023968681;4899.387576552931;4912.778924948386;4916.483769204217;4927.408710954673;4982.377202849644;4687.9531204687855;4730.195866702668;4910.975445122787;4952.62855285855;4961.5534601886;4563.840265590688;4589.862304130815;4593.081383723269;4601.838935637236;4603.240465323218;5007.399112106497;5024.6231532634465;5033.84898453047;5038.34501514808;5081.59347252219;4688.413948256468;4814.301926220748;4815.3017812417;4847.612191024709;4904.215325547895;4887.04702583;4903.387076615423;4918.975405122951;4949.505049495094;4971.055499455092;4877.926856091654;4880;4883.951160488421;4896.6572339935865;4939.382577177853;4692.41344831896;4777.1878780606685;4847;4860.076585448754;4863.221884498464;4070.4874737014734;4080.4083407905687;4109.815058322382;4110.794460276974;4115.835366585363;3566.983409728267;3601.819909004539;3617.909552261162;3646.3983442732183;3660.3228402745576;4074.694397920168;4142.647874930664;4206.432131662247;4221.746695198298;4303.63419109373;4937.703737775745;4955.851324460272;4976.328195693607;4986.950130498649;5044.1172794761505;4240.427542281753;4246.363045543193;4272.33778764292;4284.978575107105;4309.806058727365;4191.874243772691;4263.211305908417;4308.74147551148;4316.848910288125;4347.1740369330355;4609.124266389375;4661.557152070548;4663.533646635445;4672.205725026685;4739.407574053313;4853.514648535118;4919.63102767301;4927.679700819435;4931.408231012301;4943.901121977468;4606.332081848181;4650.48844627084;4651.069786042873;4663.370444989883;4703.3415321855655;4797.56821886032;4801.567858892717;4810.182269014346;4814.940713043125;4830.227163653799;4792.448868380181;4835.758212089452;4885.438174609823;4909.025759445685;4925.9014819704125;4659.627229821538;4732.432108147044;4780.689255198401;4821.493743156918;4832.734199619054;4781.665283430127;4782.641301902302;4783.497732738151;4783.569478746929;4824.95175048245;4631.305304204261;4656.138614356355;4667.813287468463;4677.970846413784;4715.292706094114;4771.7375544344;4790.7365094920115;4804.399450068741;4852.878678033077;4854.563089321978;4695.342652028787;4728.550787675165;4745.264484004984;4745.525447455227;4780.450248221499 19:04:59 INFO - PROCESS | 15896 | |1;ext.html;461.6952811144643;502.7034049910552;503.28784769551083;509.63306419378034;512.6770134815066;29153;29217.707822921766;29362.412751744952;29464.85267573659;29484.115476535713;31865;32162.839185804096;32252.19369515763;32538;32590;7407.222241664628;7642.312191902728;7643.46495745298;7652.081750189985;7654.846903061935;7317.1219453665635;7430.554166750012;7478.140013898417;7483.962580187092;7485.887711684302;7546.622668866562;7556.848863022737;7602.961985190066;7605;7634.236576342377;7547.73582924595;7618.923810761932;7619.695212191534;7630.504017238862;7658.3873290136935;7524.6237688115925;7634.885476717854;7649.464537482379;7651.081870175559;7673.923260767377;31780.841095794374;32130.839345803353;32250;32314.353712925844;32470;2167.328128280238;2611.5952027435587;2620.7903367730537;2629.684437867449;2650.77468415183;23743.525129497313;23960.760392396027;24191.637125443132;24273.878630606912;24423.145189918447;3074.646415662205;3078.0919628709585;3114.5483904833673;3156.936861262785;3157.1002264354547;139191;139487;139908.30045849807;140692;141366;40900.38649420261;41067.56263530822;41135;41214.1757164855;41333;50694.74652626787;51234.23148652773;51592.48407515877;51632.74183629133;51773.48226517762;12546.435410406553;12708.936455317664;12808.743825123633;12820.743585128244;12873.163244389085;9553.665621703207;9651.806963860823;9654.613815447445;9667.081627245401;9754.902450975542;14210.431582736781;14393.28033598316;14482.275886205858;14650.706985860435;14908.329125189393;5906.135524270725;6118.051701986199;6161.753529858755;6172.753089876444;6199.070139479114;738.78205929251;756.1719916691214;792.1484404265437;817.6320655704957;841.3143288220203;22512.986915588837;22700.65949010766;23025.19411820578;23132.190373336853;23395.883020584788;864.4121997042072;877.9956100219458;898.1691934960136;900.599233341157;917.312015988009;12245;12441.626751197478;12553.686157846127;12739;12818.80771788424;259730;261044;261616;263278;263732;36681.44977825335;37247.81376093102;37340.62659373426;37410.88480267169;37897.62102378996;1005.2862467647906;1035.30634474902;1036.3574583757968;1055.8099542082346;1072.0887245840972;22464.213752518583;22562.887185564625;23105.19131830378;23206.419839504146;23335.41661458477;33179.17052073718;33203.66796332102;33472.163195919326;33690.157746056546;33725.32549349048;245139;245369;247003;247473;247684;24700.50598988046;25001.249962501155;25002.624960625242;25065.87467062653;26900.730992689823;32774.50838237381;33031.17422064468;33220.33559328751;33378.33243335168;33391.165220869676;30056.849715751283;30214;30493.390132197677;30879.845600771852;31026.534601980537;28629.570556442086;29318.26704332409;29406.705932940396;29437;29654.703452965194;24621.87689061615;28443.857780710965;29044;29948.251293717833;30269.545956810223;23834.88082559576;24389.878050609634;24613.261602151964;24649.137280195107;24781;20572.897135514228;21247.575048499253;21282.829444380706;21304.893475532524;21460.14159433605 19:04:59 INFO - PROCESS | 15896 | |2;jquery.html;320.3285824477624;323.26099383044556;327.39758843727543;328.533482454914;332.09172912085427;14139.505117320896;14615.123092614424;14674.486392976249;14682.926585367071;15237;9792.657256996006;9869.457179855106;9913.306068575203;9977.650782222623;10283.897161028406;4356.194104090738;4581.106684196583;4587.403637527117;4588.2888152336445;4594.793234304464;4514.729116253019;4597.356370108188;4607.285870690049;4624.237000894848;4636.814527418916;4605.631549476034;4610.884727881813;4620.491745907947;4977.527134922195;4992.475790042048;4935.432425271086;4951.3810773653295;4990.750462476862;4999.500049994989;5026.145555255615;4499.52754960731;4503.392042074343;4526.841560545365;4532.184206842767;4536.931946020813;10316.071553560216;10324.948375258076;10376.481175941248;10396.11633011195;10443.94778026105;1667.0747735007067;1667.316400275893;1749.1079549429755;1926.2969016308946;2262.9321120366417;8321.83356332876;8407.369447291416;8571.828563428759;8617.48295102296;8625.784355391103;1544.637010302578;1688.991555042217;1739.4433781190023;1741.8171092035407;1806.5573934386027;49906.75046624744;53697.731511342194;54009.189862152096;54103;56043;9327.813443731224;9391.671291504765;9425.717228483156;9484.95257523708;9644.373115747454;11921.880781192078;11993.280403175837;12019.699507512381;12078.27530348182;12106.757864842653;5991;6045.425684559959;6060.515158787286;6085.726142323606;6117.938820611737;5422.078246697992;5430.212619170277;5471.781128754806;5690.857728556819;5716.857078572986;3933.6656384207663;3957.1689945111275;3990.3615421532995;4046.858359957387;4046.9797651012145;1606.2852030846161;1680.420255012019;1700.9149542522825;1704.343827626348;1725.3529926277645;716.6488420673833;721.6319676964786;723.3995783499682;763.2634507700096;777.4324742937687;13965.23191224472;14394.784078238834;14533.85466145325;14597.978141530204;14734.410623574937;761.3186198352444;768.1818862910982;772.0388116794514;773.8294085091261;814.5886327404622;8122.025356957203;8281.089080201173;8333.125021872738;8426.343997893822;8446.639493023104;361850;384357;390809;391380;392613;50547;61107;61561;62639;64529.67735161388;795.5028107432854;822.2476434062766;823.3824631526355;824.1675907333636;827.420805436197;13625;13691.863081369458;14065.156090634595;14121.505747299207;14365.066270692372;28777.856110719313;30971.380572387974;31156;31443;31638.367232655677;42378;42385.57614423816;42472;42666.360004600574;43010.56989430066;6875;6880.139982502187;6916.861662766817;6976.720931162697;7057.858842823012;10158.847617285599;11041.779164416826;11140;11143.442827858737;11296.587926509186;8333.95833020831;8604.268637165911;8892.555372231232;9349.065093490597;9389.85915211286;8723.258523025614;8731.388802783744;8847.911520884709;8922.55387230623;9195.678151264674;8701.17338852808;8865.955670221607;8892.466452012899;9061.13919177677;9159.221466175182;6594.439472644879;6684.598924064571;6969.0940177776565;7051.330123638246;7076.504644674823;6915.585064896122;8495.95752021236;8658.220760131619;8841.381103322705;9121.726348209564 19:04:59 INFO - PROCESS | 15896 | |3;mootools.html;1194.4266751959058;1203.7953547896857;1219.8353222314986;1395.3999780094568;1400.0829456705856;6211.409916057967;7111.644417779104;7124.430045596353;7244.203137654854;7347.816304592381;6974.616396098212;7067.646617669109;7079.85840283194;7094.716211351552;7098.645067746605;2010.979890201094;2029.7158397824242;2033.877967321958;2035.1248962945926;2039.6532589459828;2041.989790051055;2048.068129001308;2060.845436592254;2096.706461095448;2098.171222367164;2071.6271071207175;2097.286922446368;2129.818965387944;2132.029926383492;2134.6264403729283;2086.3428020173674;2089.707440958267;2090.216168936649;2091.7176181215495;2098.8950552472393;1964.7642282925997;1969.1434226111687;1975.7629084509952;1977.7231187633743;2054.065400242886;7235.348818606298;7277;7280.199178090405;7282.781516554512;7350.044494215771;4170.833166673329;4178.582141785828;4207.221663992172;4281.871543853689;4310.3534469829465;2744.3276397282793;2775.514285000117;2834.9149525514267;2870.3398218409884;2875.8993435229877;819.2790344496864;828.9212524810133;834.0700119366862;836.9121242269534;840.7687885831384;10253.948730256301;10262.384256944608;10271.589136434533;10278;10295.691129266059;3758.2859256741676;3826.712996525216;3865.7487263327794;3903.941440878389;3951.1110000250287;8609.91390086091;8631.956840215884;8655.56722163902;8692.478451292942;8711.607977640895;4287.3140297552245;4309.547497512779;4332.826686932551;4335.111302183045;4335.3713711511655;3360.915977100592;3702.444633305026;3759.793211373401;3923.9215215695526;3924.1955399143108;3239.303549736771;3274.459714147187;3333.1500467381147;3333.4999750037687;3347.246869454402;1051.2115913065202;1055.208593554834;1056.0759335581367;1070.983935240972;1079.222959469181;772.2046292318809;780.847734691741;783.9176886426957;788.5662885413;835.1189495082746;6276.843078922972;6283.8114856554375;6327.557071004985;6338.841528961812;6350.491960643138;382.72635065927994;388.6851650163377;388.7084686485136;389.17689087579566;393.0527428896346;5135.6148288878485;5150.922736158961;5157.510036546522;5200.557952573998;5213.504717051874;8786.736397908073;8923;9052.185303322733;9055.275577953747;9158.129977652112;8929;8966.372353935161;8986.236169925629;9069.59186836594;9090.045545217788;6886.48351373649;6905.240423553405;6973.58158510491;7017.754378596725;7038.683259253346;6618.404343609098;6641.568298060611;6659.034440006269;6680.799576012728;6683.966580167068;7855.921440785519;7989;8150.2664760171865;8179.550124743197;8180.263776260165;8120.878186827084;8137.75586732399;8334.458260213067;8417.83164336722;8499.192576705203;5245.737713114406;5907.91138132937;6316.210473690789;6321.33625969285;6350.301466838551;6617.66911654425;6624.337566243337;6639.170103737033;6649.567778094409;6658.3674550917585;5645.096784514458;5734.942650573441;5910.70446477683;6055.576109672281;6134.202553667995;5831.679257640871;5984.491318237999;5994.130851026664;6068.878622427438;6085.056816193497;6131.816045518642;6323.841903952438;6325.620462772248;6365.586236894587;6381.968090159519;5710.114932185518;5723.713814309352;5751.1373294006235;5758.62568933018;5777.537796976148;5278.2346559749385;5299.5230429261555;5316.734163291897;5320.228566857707;5352.705601191972 19:04:59 INFO - PROCESS | 15896 | |4;prototype.html;296.8026262535414;300.84055450611186;304.0877367896311;304.7912180156593;306.79138186033515;5534.861628459285;5569.248151499546;5574.331080270368;5578.69317187555;5582.134769110784;5493.313335833021;5508.9724551377285;5509.449055094488;5512.118061110224;5517.613767036309;4011.618896204856;4064.8170832312617;4165.83336666533;4185.539590645027;4201.075763332062;4165.895852603679;4169.791510424467;4169.812358443877;4170.520390155126;4182.393552934823;4159.2721273777115;4168.520620128694;4179.811908464127;4182.665386769051;4183.456150700405;4184.665226781881;4188.874333769992;4189.601987811153;4190.308599081148;4198.3702444633245;3644.5626524816926;3645.052286405527;3649.8905032849057;3651.2514934438377;3663.285659296438;5292.867678308035;5316.840494785162;5323.680579165262;5326.174442961308;5333.786648534054;4679.27471241958;4741.122892264942;4786.52134786522;4794.208955522335;4809.735464549449;5698.6580805151825;5737.3688894221605;5746.712664366807;5763.366029736726;5766.654000759968;3933.9213215735813;3937.5078115235597;3938.8336414971936;3942.329803933338;3970.06703424695;6088.299845517778;6090.147379366892;6098.60359076663;6154.599951003171;6171.691415429255;4039.8788036358956;4044.1507283470214;4052.169305292408;4055.9391609125887;4081.775502347399;4114.033202197481;4115.9176816463505;4121.52602450716;4121.670266378683;4157.064660451435;4545.2954792007295;4754.809807607726;4761.642876784255;4762.214234651313;4782.784774685148;5780.653160810365;5784.479396854304;5796.681182534917;5803.129530570363;5817.069268916953;1412.3009110490168;1423.985760142406;1424.33056463462;1425.4440768100449;1428.5071650280636;914.5290175559592;934.5327336331834;940.4498368454394;953.2802733935835;956.6460409648474;4972.080165169383;4981.825636102792;4998.450170481244;5007.073691367036;5014.52362025607;5969.3732158122775;5986.07215881539;5990.371011043778;5992.370801065913;6007.579469437097;4821.686590371614;4890.95109048912;4984.526469985346;4999.075171093359;5001.974990125026;3251.2684645954473;3269.7874638148446;3270.787398819117;3273.721733652666;3281.8194999274792;5725.713714314267;5732;5742.913856292159;5747.3103227612955;5753.877993791254;6242.094896240111;6284.528660350492;6293.590916590407;6307.05394190875;6311.368863113744;5769.365369809318;5774.913376299359;5785.392533783976;5791.102379131242;5791.594588378857;5799.594028417971;5833.591648584558;5865.120231965239;5976.581639285208;6021.638701677914;5940.138679891478;5940.970295148497;5942.078977758454;5946.43508866657;5949.851253718692;5670.262865827416;5719.283340413437;5719.885602287848;5720.313562372542;5723.5707321950185;3985.063510075072;3985.7807820570147;4001.9199616006936;4004.8798536043964;4019.9598004019585;5749.712514374348;5875.118732190205;5990.64056156632;6038.879222415615;6056.152138700673;5631.183478395692;5812.128180772918;5814.215080964016;5815.41845815415;5821.854453638693;5752.568557358131;5802.65184088956;5814.447627475383;5815.854603634773;5827.24245848037;5680.233168522362;5681.289838770153;5689.032864412977;5694.743736531949;5698.943010569841;5844.3571207168025;5845.064789633639;5846.298444186725;5856.824295271149;5861.208736820645;5164.173732202829;5495.5878309127775;5600.047991841316;5618.494335509824;5673.5461163107675 19:04:59 INFO - PROCESS | 15896 | |5;yui.html;473.97156170629756;516.4654582507106;542.2977244468414;542.5822116969933;549.0062985995352;9682.564284607191;9899.851502227473;9910.306278560503;9963.953784852594;10214.080732734052;9551.044895510446;9551.856722149174;9591.616335346578;9610.327277090606;9612.807743845118;417.69716955207537;561.2535328013753;574.7729646789516;758.3819187362282;761.550685095792;768.0361146760836;773.4817672159667;776.1191048160322;777.4014009212931;778.1790211327047;808.1110778144024;811.4482152136545;816.049302562514;818.7543736878943;819.8401311744212;810.4853418079502;812.6140083460339;812.9146439623872;814.6008455856647;815.5188438821094;598.8652553175544;599.6851652882228;600.2586805295457;600.8317671052068;603.7494439807475;10210.387376757419;10225.488725563766;10320.638777642747;10334.483275836179;10362.792744145076;9859.852102218472;10360;10485.213608979357;10608.045275925127;10748.408837513934;7795.727149549739;8389.454685445426;8407;8407.201315874981;8513.53175575343;3040.7415369693604;3049.603551538286;3057.6636569977286;3090.0111964171474;3096.6593674695764;41361.58638413608;41457.585424145975;41557.37663935013;41611;41862;7953.602319883983;8125;8302.128276530877;8325.583720813935;8329.250367466957;13990.650233744238;14044.929775351058;14172.433102675983;14192.290385480685;14207.928960355339;5548.472895074961;5654.038813401731;5845.503132233808;5902.822915312548;5963.403659634088;3071.769617278713;3087.7529797616135;3120.063980805749;3156.1162874395204;3232.4504834178247;2297.7931986120993;2322.6516022596747;2329.4409341758196;2329.883505824736;2331.9650205246935;409.985650502231;413.7145369694961;419.67055861149464;431.8531699222217;433.559936664286;433.09050992914626;477.25309890022004;507.4620901844057;524.6930545630772;527.2302438439845;7266.055412796409;7345.816354591178;7373.483856130019;7542.208068152875;7571.091469023752;438.7192196993926;477.22212793146946;502.21654219417826;540.1357827476007;545.3319683387897;3391.69419773389;3515.7011654009184;3551.4317709166407;3556.1820781220463;3675.9081022974638;50920;51114.48885511172;52460.21309680358;53126.734366327924;53567.19649205265;45540.772296138966;46001;46503.069938601715;46593.534064659594;46765.53234467612;41008.589914101074;41400.79299603483;41734;42375.36436953448;42401.78799106047;7531.774046778605;7623.390128789794;7685.4620176587105;7705.152433232228;7710.498817576839;30708.692913070583;31571.21071973219;31952.84023579867;32031.519527206645;32147.517787232744;36431.635683642824;39298;40018.39972400475;40200.798996004836;40229.39655905105;8636;8657.740267791976;8726.30189584819;8807.867881981903;8820.162084601952;9759.9024009759;9816.263780216656;9827.754306142404;9851.950740246253;9884.159846413135;9069.863952040592;9191.448513089235;9315.97524272343;9339.906600933904;9434.386764860263;8765.693200737944;8866.335024873031;8909.599068041824;9100.044495327895;9455.24358051368;8905.777355566162;9003.324750643596;9014.053524379846;9106.362554621113;9297.535123243675;7696.422768292288;8235.423520353517;8420.215673607121;8440.53577053268;8569.614367353359;7570.242975702386;7641.42689298316;7850.018747656543;8056.637451314587;8105.27052565272 19:04:59 INFO - PROCESS | 15896 | __end_tp_report 19:04:59 INFO - PROCESS | 15896 | __start_cc_report 19:04:59 INFO - PROCESS | 15896 | _x_x_mozilla_cycle_collect,365 19:04:59 INFO - PROCESS | 15896 | __end_cc_report 19:04:59 INFO - PROCESS | 15896 | __startTimestamp1457319899356__endTimestamp 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | ------- Summary: start ------- 19:04:59 INFO - PROCESS | 15896 | Number of tests: 6 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | [#0] dojo.html Cycles:165 Average:4537.32 Median:4661.56 stddev:460.52 (9.9%) stddev-sans-first:436.66 19:04:59 INFO - PROCESS | 15896 | Values: 2619.1 2658.0 2686.9 2700.5 2702.4 4578.2 4618.4 4625.0 4631.9 4657.8 4492.5 4532.2 4570.0 4571.6 4626.3 4234.4 4257.1 4300.0 4308.4 4359.6 4233.6 4233.7 4285.3 4310.9 4351.8 4241.6 4285.1 4314.6 4316.4 4333.5 4221.7 4231.0 4239.4 4253.9 4268.9 4128.4 4201.6 4209.3 4232.6 4252.9 4514.5 4550.7 4553.5 4594.7 4617.7 4899.4 4912.8 4916.5 4927.4 4982.4 4688.0 4730.2 4911.0 4952.6 4961.6 4563.8 4589.9 4593.1 4601.8 4603.2 5007.4 5024.6 5033.8 5038.3 5081.6 4688.4 4814.3 4815.3 4847.6 4904.2 4887.0 4903.4 4919.0 4949.5 4971.1 4877.9 4880.0 4884.0 4896.7 4939.4 4692.4 4777.2 4847.0 4860.1 4863.2 4070.5 4080.4 4109.8 4110.8 4115.8 3567.0 3601.8 3617.9 3646.4 3660.3 4074.7 4142.6 4206.4 4221.7 4303.6 4937.7 4955.9 4976.3 4987.0 5044.1 4240.4 4246.4 4272.3 4285.0 4309.8 4191.9 4263.2 4308.7 4316.8 4347.2 4609.1 4661.6 4663.5 4672.2 4739.4 4853.5 4919.6 4927.7 4931.4 4943.9 4606.3 4650.5 4651.1 4663.4 4703.3 4797.6 4801.6 4810.2 4814.9 4830.2 4792.4 4835.8 4885.4 4909.0 4925.9 4659.6 4732.4 4780.7 4821.5 4832.7 4781.7 4782.6 4783.5 4783.6 4825.0 4631.3 4656.1 4667.8 4678.0 4715.3 4771.7 4790.7 4804.4 4852.9 4854.6 4695.3 4728.6 4745.3 4745.5 4780.5 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | [#1] ext.html Cycles:180 Average:35288.94 Median:30953.19 stddev:58364.16 (188.6%) stddev-sans-first:58469.31 19:04:59 INFO - PROCESS | 15896 | Values: 461.7 502.7 503.3 509.6 512.7 29153.0 29217.7 29362.4 29464.9 29484.1 31865.0 32162.8 32252.2 32538.0 32590.0 7407.2 7642.3 7643.5 7652.1 7654.8 7317.1 7430.6 7478.1 7484.0 7485.9 7546.6 7556.8 7603.0 7605.0 7634.2 7547.7 7618.9 7619.7 7630.5 7658.4 7524.6 7634.9 7649.5 7651.1 7673.9 31780.8 32130.8 32250.0 32314.4 32470.0 2167.3 2611.6 2620.8 2629.7 2650.8 23743.5 23960.8 24191.6 24273.9 24423.1 3074.6 3078.1 3114.5 3156.9 3157.1 139191.0 139487.0 139908.3 140692.0 141366.0 40900.4 41067.6 41135.0 41214.2 41333.0 50694.7 51234.2 51592.5 51632.7 51773.5 12546.4 12708.9 12808.7 12820.7 12873.2 9553.7 9651.8 9654.6 9667.1 9754.9 14210.4 14393.3 14482.3 14650.7 14908.3 5906.1 6118.1 6161.8 6172.8 6199.1 738.8 756.2 792.1 817.6 841.3 22513.0 22700.7 23025.2 23132.2 23395.9 864.4 878.0 898.2 900.6 917.3 12245.0 12441.6 12553.7 12739.0 12818.8 259730.0 261044.0 261616.0 263278.0 263732.0 36681.4 37247.8 37340.6 37410.9 37897.6 1005.3 1035.3 1036.4 1055.8 1072.1 22464.2 22562.9 23105.2 23206.4 23335.4 33179.2 33203.7 33472.2 33690.2 33725.3 245139.0 245369.0 247003.0 247473.0 247684.0 24700.5 25001.2 25002.6 25065.9 26900.7 32774.5 33031.2 33220.3 33378.3 33391.2 30056.8 30214.0 30493.4 30879.8 31026.5 28629.6 29318.3 29406.7 29437.0 29654.7 24621.9 28443.9 29044.0 29948.3 30269.5 23834.9 24389.9 24613.3 24649.1 24781.0 20572.9 21247.6 21282.8 21304.9 21460.1 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | [#2] jquery.html Cycles:180 Average:21660.21 Median:4964.45 stddev:62991.97 (1268.9%) stddev-sans-first:63148.30 19:04:59 INFO - PROCESS | 15896 | Values: 320.3 323.3 327.4 328.5 332.1 14139.5 14615.1 14674.5 14682.9 15237.0 9792.7 9869.5 9913.3 9977.7 10283.9 4356.2 4581.1 4587.4 4588.3 4594.8 4514.7 4597.4 4607.3 4624.2 4636.8 4605.6 4610.9 4620.5 4977.5 4992.5 4935.4 4951.4 4990.8 4999.5 5026.1 4499.5 4503.4 4526.8 4532.2 4536.9 10316.1 10324.9 10376.5 10396.1 10443.9 1667.1 1667.3 1749.1 1926.3 2262.9 8321.8 8407.4 8571.8 8617.5 8625.8 1544.6 1689.0 1739.4 1741.8 1806.6 49906.8 53697.7 54009.2 54103.0 56043.0 9327.8 9391.7 9425.7 9485.0 9644.4 11921.9 11993.3 12019.7 12078.3 12106.8 5991.0 6045.4 6060.5 6085.7 6117.9 5422.1 5430.2 5471.8 5690.9 5716.9 3933.7 3957.2 3990.4 4046.9 4047.0 1606.3 1680.4 1700.9 1704.3 1725.4 716.6 721.6 723.4 763.3 777.4 13965.2 14394.8 14533.9 14598.0 14734.4 761.3 768.2 772.0 773.8 814.6 8122.0 8281.1 8333.1 8426.3 8446.6 361850.0 384357.0 390809.0 391380.0 392613.0 50547.0 61107.0 61561.0 62639.0 64529.7 795.5 822.2 823.4 824.2 827.4 13625.0 13691.9 14065.2 14121.5 14365.1 28777.9 30971.4 31156.0 31443.0 31638.4 42378.0 42385.6 42472.0 42666.4 43010.6 6875.0 6880.1 6916.9 6976.7 7057.9 10158.8 11041.8 11140.0 11143.4 11296.6 8334.0 8604.3 8892.6 9349.1 9389.9 8723.3 8731.4 8847.9 8922.6 9195.7 8701.2 8866.0 8892.5 9061.1 9159.2 6594.4 6684.6 6969.1 7051.3 7076.5 6915.6 8496.0 8658.2 8841.4 9121.7 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | [#3] mootools.html Cycles:180 Average:4961.46 Median:5754.88 stddev:2717.20 (47.2%) stddev-sans-first:2710.07 19:04:59 INFO - PROCESS | 15896 | Values: 1194.4 1203.8 1219.8 1395.4 1400.1 6211.4 7111.6 7124.4 7244.2 7347.8 6974.6 7067.6 7079.9 7094.7 7098.6 2011.0 2029.7 2033.9 2035.1 2039.7 2042.0 2048.1 2060.8 2096.7 2098.2 2071.6 2097.3 2129.8 2132.0 2134.6 2086.3 2089.7 2090.2 2091.7 2098.9 1964.8 1969.1 1975.8 1977.7 2054.1 7235.3 7277.0 7280.2 7282.8 7350.0 4170.8 4178.6 4207.2 4281.9 4310.4 2744.3 2775.5 2834.9 2870.3 2875.9 819.3 828.9 834.1 836.9 840.8 10253.9 10262.4 10271.6 10278.0 10295.7 3758.3 3826.7 3865.7 3903.9 3951.1 8609.9 8632.0 8655.6 8692.5 8711.6 4287.3 4309.5 4332.8 4335.1 4335.4 3360.9 3702.4 3759.8 3923.9 3924.2 3239.3 3274.5 3333.2 3333.5 3347.2 1051.2 1055.2 1056.1 1071.0 1079.2 772.2 780.8 783.9 788.6 835.1 6276.8 6283.8 6327.6 6338.8 6350.5 382.7 388.7 388.7 389.2 393.1 5135.6 5150.9 5157.5 5200.6 5213.5 8786.7 8923.0 9052.2 9055.3 9158.1 8929.0 8966.4 8986.2 9069.6 9090.0 6886.5 6905.2 6973.6 7017.8 7038.7 6618.4 6641.6 6659.0 6680.8 6684.0 7855.9 7989.0 8150.3 8179.6 8180.3 8120.9 8137.8 8334.5 8417.8 8499.2 5245.7 5907.9 6316.2 6321.3 6350.3 6617.7 6624.3 6639.2 6649.6 6658.4 5645.1 5734.9 5910.7 6055.6 6134.2 5831.7 5984.5 5994.1 6068.9 6085.1 6131.8 6323.8 6325.6 6365.6 6382.0 5710.1 5723.7 5751.1 5758.6 5777.5 5278.2 5299.5 5316.7 5320.2 5352.7 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | [#4] prototype.html Cycles:180 Average:4771.47 Median:5514.87 stddev:1435.64 (26.0%) stddev-sans-first:1399.83 19:04:59 INFO - PROCESS | 15896 | Values: 296.8 300.8 304.1 304.8 306.8 5534.9 5569.2 5574.3 5578.7 5582.1 5493.3 5509.0 5509.4 5512.1 5517.6 4011.6 4064.8 4165.8 4185.5 4201.1 4165.9 4169.8 4169.8 4170.5 4182.4 4159.3 4168.5 4179.8 4182.7 4183.5 4184.7 4188.9 4189.6 4190.3 4198.4 3644.6 3645.1 3649.9 3651.3 3663.3 5292.9 5316.8 5323.7 5326.2 5333.8 4679.3 4741.1 4786.5 4794.2 4809.7 5698.7 5737.4 5746.7 5763.4 5766.7 3933.9 3937.5 3938.8 3942.3 3970.1 6088.3 6090.1 6098.6 6154.6 6171.7 4039.9 4044.2 4052.2 4055.9 4081.8 4114.0 4115.9 4121.5 4121.7 4157.1 4545.3 4754.8 4761.6 4762.2 4782.8 5780.7 5784.5 5796.7 5803.1 5817.1 1412.3 1424.0 1424.3 1425.4 1428.5 914.5 934.5 940.4 953.3 956.6 4972.1 4981.8 4998.5 5007.1 5014.5 5969.4 5986.1 5990.4 5992.4 6007.6 4821.7 4891.0 4984.5 4999.1 5002.0 3251.3 3269.8 3270.8 3273.7 3281.8 5725.7 5732.0 5742.9 5747.3 5753.9 6242.1 6284.5 6293.6 6307.1 6311.4 5769.4 5774.9 5785.4 5791.1 5791.6 5799.6 5833.6 5865.1 5976.6 6021.6 5940.1 5941.0 5942.1 5946.4 5949.9 5670.3 5719.3 5719.9 5720.3 5723.6 3985.1 3985.8 4001.9 4004.9 4020.0 5749.7 5875.1 5990.6 6038.9 6056.2 5631.2 5812.1 5814.2 5815.4 5821.9 5752.6 5802.7 5814.4 5815.9 5827.2 5680.2 5681.3 5689.0 5694.7 5698.9 5844.4 5845.1 5846.3 5856.8 5861.2 5164.2 5495.6 5600.0 5618.5 5673.5 19:04:59 INFO - PROCESS | 15896 | 19:04:59 INFO - PROCESS | 15896 | [#5] yui.html Cycles:180 Average:11781.86 Median:5874.16 stddev:14353.63 (244.4%) stddev-sans-first:14368.77 19:04:59 INFO - PROCESS | 15896 | Values: 474.0 516.5 542.3 542.6 549.0 9682.6 9899.9 9910.3 9964.0 10214.1 9551.0 9551.9 9591.6 9610.3 9612.8 417.7 561.3 574.8 758.4 761.6 768.0 773.5 776.1 777.4 778.2 808.1 811.4 816.0 818.8 819.8 810.5 812.6 812.9 814.6 815.5 598.9 599.7 600.3 600.8 603.7 10210.4 10225.5 10320.6 10334.5 10362.8 9859.9 10360.0 10485.2 10608.0 10748.4 7795.7 8389.5 8407.0 8407.2 8513.5 3040.7 3049.6 3057.7 3090.0 3096.7 41361.6 41457.6 41557.4 41611.0 41862.0 7953.6 8125.0 8302.1 8325.6 8329.3 13990.7 14044.9 14172.4 14192.3 14207.9 5548.5 5654.0 5845.5 5902.8 5963.4 3071.8 3087.8 3120.1 3156.1 3232.5 2297.8 2322.7 2329.4 2329.9 2332.0 410.0 413.7 419.7 431.9 433.6 433.1 477.3 507.5 524.7 527.2 7266.1 7345.8 7373.5 7542.2 7571.1 438.7 477.2 502.2 540.1 545.3 3391.7 3515.7 3551.4 3556.2 3675.9 50920.0 51114.5 52460.2 53126.7 53567.2 45540.8 46001.0 46503.1 46593.5 46765.5 41008.6 41400.8 41734.0 42375.4 42401.8 7531.8 7623.4 7685.5 7705.2 7710.5 30708.7 31571.2 31952.8 32031.5 32147.5 36431.6 39298.0 40018.4 40200.8 40229.4 8636.0 8657.7 8726.3 8807.9 8820.2 9759.9 9816.3 9827.8 9852.0 9884.2 9069.9 9191.4 9316.0 9339.9 9434.4 8765.7 8866.3 8909.6 9100.0 9455.2 8905.8 9003.3 9014.1 9106.4 9297.5 7696.4 8235.4 8420.2 8440.5 8569.6 7570.2 7641.4 7850.0 8056.6 8105.3 19:04:59 INFO - PROCESS | 15896 | -------- Summary: end -------- 19:04:59 INFO - PROCESS | 15896 | 19:05:00 INFO - TEST-INFO | 15896: exit 0 19:05:00 INFO - TEST-OK | dromaeo_css | took 1114599ms 19:05:00 INFO - TEST-START | kraken 19:05:00 INFO - operating with platform_type : linux_ 19:05:00 INFO - Initialising browser for kraken test... 19:05:00 INFO - TEST-INFO | started process 16134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv88DdG/profile http://localhost:39235/getInfo.html) 19:05:03 INFO - PROCESS | 16134 | 19:05:03 INFO - PROCESS | 16134 | (process:16205): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:05:04 INFO - PROCESS | 16134 | __metrics Screen width/height:1600/1200 19:05:04 INFO - PROCESS | 16134 | colorDepth:24 19:05:04 INFO - PROCESS | 16134 | Browser inner width/height: 1024/697 19:05:04 INFO - PROCESS | 16134 | __metrics 19:05:05 ERROR - PROCESS | 16134 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:05:06 INFO - TEST-INFO | 16134: exit 0 19:05:06 INFO - Browser initialized. 19:05:06 INFO - Running cycle 1/1 for kraken test... 19:05:06 INFO - TEST-INFO | started process 16256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv88DdG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:08 INFO - PROCESS | 16256 | 19:05:08 INFO - PROCESS | 16256 | (process:16318): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:05:18 INFO - PROCESS | 16256 | RSS: Main: 164331520 19:05:18 INFO - PROCESS | 16256 | 19:05:20 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-beat-detection) 19:05:21 INFO - PROCESS | 16256 | RSS: Main: 169619456 19:05:21 INFO - PROCESS | 16256 | 19:05:24 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-dft) 19:05:24 INFO - PROCESS | 16256 | RSS: Main: 171827200 19:05:24 INFO - PROCESS | 16256 | 19:05:27 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-fft) 19:05:28 INFO - PROCESS | 16256 | RSS: Main: 167604224 19:05:28 INFO - PROCESS | 16256 | 19:05:30 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-oscillator) 19:05:31 INFO - PROCESS | 16256 | RSS: Main: 166486016 19:05:31 INFO - PROCESS | 16256 | 19:05:33 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:05:33 INFO - PROCESS | 16256 | RSS: Main: 169062400 19:05:33 INFO - PROCESS | 16256 | 19:05:37 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39235/tests/kraken/driver.html?testName=imaging-darkroom) 19:05:37 INFO - PROCESS | 16256 | RSS: Main: 168128512 19:05:37 INFO - PROCESS | 16256 | 19:05:41 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39235/tests/kraken/driver.html?testName=imaging-desaturate) 19:05:41 INFO - PROCESS | 16256 | RSS: Main: 167575552 19:05:41 INFO - PROCESS | 16256 | 19:05:44 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39235/tests/kraken/driver.html?testName=json-parse-financial) 19:05:45 INFO - PROCESS | 16256 | RSS: Main: 168390656 19:05:45 INFO - PROCESS | 16256 | 19:05:47 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:05:47 INFO - PROCESS | 16256 | RSS: Main: 167616512 19:05:47 INFO - PROCESS | 16256 | 19:05:49 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:05:50 INFO - PROCESS | 16256 | RSS: Main: 168710144 19:05:50 INFO - PROCESS | 16256 | 19:05:52 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:05:53 INFO - PROCESS | 16256 | RSS: Main: 170242048 19:05:53 INFO - PROCESS | 16256 | 19:05:55 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:05:56 INFO - PROCESS | 16256 | RSS: Main: 168984576 19:05:56 INFO - PROCESS | 16256 | 19:05:59 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:05:59 INFO - PROCESS | 16256 | RSS: Main: 170221568 19:05:59 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39235/tests/kraken/driver.html?testName=ai-astar) 19:06:01 INFO - PROCESS | 16256 | RSS: Main: 170414080 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | __start_tp_report 19:06:01 INFO - PROCESS | 16256 | _x_x_mozilla_page_load 19:06:01 INFO - PROCESS | 16256 | _x_x_mozilla_page_load_details 19:06:01 INFO - PROCESS | 16256 | |i|pagename|runs| 19:06:01 INFO - PROCESS | 16256 | |0;ai-astar;113;110;114;115;114;126;114;113;113;113 19:06:01 INFO - PROCESS | 16256 | |1;audio-beat-detection;161;134;155;178;136;160;161;135;176;139 19:06:01 INFO - PROCESS | 16256 | |2;audio-dft;163;163;162;162;163;164;168;161;163;165 19:06:01 INFO - PROCESS | 16256 | |3;audio-fft;73;74;73;73;75;74;74;76;140;74 19:06:01 INFO - PROCESS | 16256 | |4;audio-oscillator;96;93;142;95;95;94;140;94;95;134 19:06:01 INFO - PROCESS | 16256 | |5;imaging-gaussian-blur;117;117;120;117;117;118;118;117;118;118 19:06:01 INFO - PROCESS | 16256 | |6;imaging-darkroom;146;149;147;146;147;148;149;147;147;148 19:06:01 INFO - PROCESS | 16256 | |7;imaging-desaturate;98;96;96;96;96;97;96;97;96;97 19:06:01 INFO - PROCESS | 16256 | |8;json-parse-financial;71;69;70;71;70;71;70;71;68;68 19:06:01 INFO - PROCESS | 16256 | |9;json-stringify-tinderbox;71;71;70;71;70;75;70;71;70;71 19:06:01 INFO - PROCESS | 16256 | |10;stanford-crypto-aes;82;82;85;83;83;83;83;81;82;83 19:06:01 INFO - PROCESS | 16256 | |11;stanford-crypto-ccm;124;131;122;129;129;125;124;126;123;127 19:06:01 INFO - PROCESS | 16256 | |12;stanford-crypto-pbkdf2;139;163;156;158;147;151;150;152;151;164 19:06:01 INFO - PROCESS | 16256 | |13;stanford-crypto-sha256-iterative;73;71;72;71;73;74;72;72;74;71 19:06:01 INFO - PROCESS | 16256 | __end_tp_report 19:06:01 INFO - PROCESS | 16256 | __start_cc_report 19:06:01 INFO - PROCESS | 16256 | _x_x_mozilla_cycle_collect,900 19:06:01 INFO - PROCESS | 16256 | __end_cc_report 19:06:01 INFO - PROCESS | 16256 | __startTimestamp1457319961642__endTimestamp 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | ------- Summary: start ------- 19:06:01 INFO - PROCESS | 16256 | Number of tests: 14 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:4.25 (3.7%) stddev-sans-first:4.47 19:06:01 INFO - PROCESS | 16256 | Values: 113.0 110.0 114.0 115.0 114.0 126.0 114.0 113.0 113.0 113.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:160.50 stddev:16.67 (10.4%) stddev-sans-first:17.46 19:06:01 INFO - PROCESS | 16256 | Values: 161.0 134.0 155.0 178.0 136.0 160.0 161.0 135.0 176.0 139.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.96 (1.2%) stddev-sans-first:2.07 19:06:01 INFO - PROCESS | 16256 | Values: 163.0 163.0 162.0 162.0 163.0 164.0 168.0 161.0 163.0 165.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#3] audio-fft Cycles:10 Average:80.60 Median:74.00 stddev:20.89 (28.2%) stddev-sans-first:21.98 19:06:01 INFO - PROCESS | 16256 | Values: 73.0 74.0 73.0 73.0 75.0 74.0 74.0 76.0 140.0 74.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:94.50 stddev:21.41 (22.7%) stddev-sans-first:22.27 19:06:01 INFO - PROCESS | 16256 | Values: 96.0 93.0 142.0 95.0 95.0 94.0 140.0 94.0 95.0 134.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 19:06:01 INFO - PROCESS | 16256 | Values: 117.0 117.0 120.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 19:06:01 INFO - PROCESS | 16256 | Values: 146.0 149.0 147.0 146.0 147.0 148.0 149.0 147.0 147.0 148.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 19:06:01 INFO - PROCESS | 16256 | Values: 98.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#8] json-parse-financial Cycles:10 Average:69.90 Median:70.50 stddev:1.20 (1.7%) stddev-sans-first:1.20 19:06:01 INFO - PROCESS | 16256 | Values: 71.0 69.0 70.0 71.0 70.0 71.0 70.0 71.0 68.0 68.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:1.49 (2.1%) stddev-sans-first:1.58 19:06:01 INFO - PROCESS | 16256 | Values: 71.0 71.0 70.0 71.0 70.0 75.0 70.0 71.0 70.0 71.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 19:06:01 INFO - PROCESS | 16256 | Values: 82.0 82.0 85.0 83.0 83.0 83.0 83.0 81.0 82.0 83.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.50 stddev:2.94 (2.3%) stddev-sans-first:3.03 19:06:01 INFO - PROCESS | 16256 | Values: 124.0 131.0 122.0 129.0 129.0 125.0 124.0 126.0 123.0 127.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:7.49 (4.9%) stddev-sans-first:5.96 19:06:01 INFO - PROCESS | 16256 | Values: 139.0 163.0 156.0 158.0 147.0 151.0 150.0 152.0 151.0 164.0 19:06:01 INFO - PROCESS | 16256 | 19:06:01 INFO - PROCESS | 16256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.16 (1.6%) stddev-sans-first:1.20 19:06:01 INFO - PROCESS | 16256 | Values: 73.0 71.0 72.0 71.0 73.0 74.0 72.0 72.0 74.0 71.0 19:06:01 INFO - PROCESS | 16256 | -------- Summary: end -------- 19:06:01 INFO - PROCESS | 16256 | 19:06:02 INFO - TEST-INFO | 16256: exit 0 19:06:02 INFO - TEST-OK | kraken | took 62622ms 19:06:02 INFO - SUITE-END | took 1177s 19:06:02 INFO - Completed test suite (00:19:37) 19:06:02 INFO - javascript benchmark 19:06:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.0571394298054, 2657.98671006645, 2686.8790904409298, 2700.4734076855007, 2702.3919618085934, 4578.15304168729, 4618.44578650562, 4625.0, 4631.884202894929, 4657.813687452506, 4492.460904691434, 4532.229520981433, 4569.954300456994, 4571.6114130298965, 4626.259798432252, 4234.364845273203, 4257.084726783741, 4300.032492689135, 4308.3968244445805, 4359.564043595631, 4233.640140588053, 4233.66130709544, 4285.335772955197, 4310.935335969963, 4351.760653164075, 4241.554636763126, 4285.078708077778, 4314.590113939171, 4316.3741257517795, 4333.501647310537, 4221.7255878367805, 4231.026863821307, 4239.427677263561, 4253.8723838284905, 4268.9146217075795, 4128.422020917074, 4201.621854033152, 4209.284421648296, 4232.555581663912, 4252.872413827559, 4514.503404625489, 4550.658700597469, 4553.5218802025975, 4594.74728889911, 4617.746023968681, 4899.387576552931, 4912.778924948386, 4916.483769204217, 4927.408710954673, 4982.377202849644, 4687.9531204687855, 4730.195866702668, 4910.975445122787, 4952.62855285855, 4961.5534601886, 4563.840265590688, 4589.862304130815, 4593.081383723269, 4601.838935637236, 4603.240465323218, 5007.399112106497, 5024.6231532634465, 5033.84898453047, 5038.34501514808, 5081.59347252219, 4688.413948256468, 4814.301926220748, 4815.3017812417, 4847.612191024709, 4904.215325547895, 4887.04702583, 4903.387076615423, 4918.975405122951, 4949.505049495094, 4971.055499455092, 4877.926856091654, 4880.0, 4883.951160488421, 4896.6572339935865, 4939.382577177853, 4692.41344831896, 4777.1878780606685, 4847.0, 4860.076585448754, 4863.221884498464, 4070.4874737014734, 4080.4083407905687, 4109.815058322382, 4110.794460276974, 4115.835366585363, 3566.983409728267, 3601.819909004539, 3617.909552261162, 3646.3983442732183, 3660.3228402745576, 4074.694397920168, 4142.647874930664, 4206.432131662247, 4221.746695198298, 4303.63419109373, 4937.703737775745, 4955.851324460272, 4976.328195693607, 4986.950130498649, 5044.1172794761505, 4240.427542281753, 4246.363045543193, 4272.33778764292, 4284.978575107105, 4309.806058727365, 4191.874243772691, 4263.211305908417, 4308.74147551148, 4316.848910288125, 4347.1740369330355, 4609.124266389375, 4661.557152070548, 4663.533646635445, 4672.205725026685, 4739.407574053313, 4853.514648535118, 4919.63102767301, 4927.679700819435, 4931.408231012301, 4943.901121977468, 4606.332081848181, 4650.48844627084, 4651.069786042873, 4663.370444989883, 4703.3415321855655, 4797.56821886032, 4801.567858892717, 4810.182269014346, 4814.940713043125, 4830.227163653799, 4792.448868380181, 4835.758212089452, 4885.438174609823, 4909.025759445685, 4925.9014819704125, 4659.627229821538, 4732.432108147044, 4780.689255198401, 4821.493743156918, 4832.734199619054, 4781.665283430127, 4782.641301902302, 4783.497732738151, 4783.569478746929, 4824.95175048245, 4631.305304204261, 4656.138614356355, 4667.813287468463, 4677.970846413784, 4715.292706094114, 4771.7375544344, 4790.7365094920115, 4804.399450068741, 4852.878678033077, 4854.563089321978, 4695.342652028787, 4728.550787675165, 4745.264484004984, 4745.525447455227, 4780.450248221499], "unit": "score", "name": "dojo.html", "value": 4509.446269231949}, {"lowerIsBetter": false, "replicates": [461.6952811144643, 502.7034049910552, 503.28784769551083, 509.63306419378034, 512.6770134815066, 29153.0, 29217.707822921766, 29362.412751744952, 29464.85267573659, 29484.115476535713, 31865.0, 32162.839185804096, 32252.19369515763, 32538.0, 32590.0, 7407.222241664628, 7642.312191902728, 7643.46495745298, 7652.081750189985, 7654.846903061935, 7317.1219453665635, 7430.554166750012, 7478.140013898417, 7483.962580187092, 7485.887711684302, 7546.622668866562, 7556.848863022737, 7602.961985190066, 7605.0, 7634.236576342377, 7547.73582924595, 7618.923810761932, 7619.695212191534, 7630.504017238862, 7658.3873290136935, 7524.6237688115925, 7634.885476717854, 7649.464537482379, 7651.081870175559, 7673.923260767377, 31780.841095794374, 32130.839345803353, 32250.0, 32314.353712925844, 32470.0, 2167.328128280238, 2611.5952027435587, 2620.7903367730537, 2629.684437867449, 2650.77468415183, 23743.525129497313, 23960.760392396027, 24191.637125443132, 24273.878630606912, 24423.145189918447, 3074.646415662205, 3078.0919628709585, 3114.5483904833673, 3156.936861262785, 3157.1002264354547, 139191.0, 139487.0, 139908.30045849807, 140692.0, 141366.0, 40900.38649420261, 41067.56263530822, 41135.0, 41214.1757164855, 41333.0, 50694.74652626787, 51234.23148652773, 51592.48407515877, 51632.74183629133, 51773.48226517762, 12546.435410406553, 12708.936455317664, 12808.743825123633, 12820.743585128244, 12873.163244389085, 9553.665621703207, 9651.806963860823, 9654.613815447445, 9667.081627245401, 9754.902450975542, 14210.431582736781, 14393.28033598316, 14482.275886205858, 14650.706985860435, 14908.329125189393, 5906.135524270725, 6118.051701986199, 6161.753529858755, 6172.753089876444, 6199.070139479114, 738.78205929251, 756.1719916691214, 792.1484404265437, 817.6320655704957, 841.3143288220203, 22512.986915588837, 22700.65949010766, 23025.19411820578, 23132.190373336853, 23395.883020584788, 864.4121997042072, 877.9956100219458, 898.1691934960136, 900.599233341157, 917.312015988009, 12245.0, 12441.626751197478, 12553.686157846127, 12739.0, 12818.80771788424, 259730.0, 261044.0, 261616.0, 263278.0, 263732.0, 36681.44977825335, 37247.81376093102, 37340.62659373426, 37410.88480267169, 37897.62102378996, 1005.2862467647906, 1035.30634474902, 1036.3574583757968, 1055.8099542082346, 1072.0887245840972, 22464.213752518583, 22562.887185564625, 23105.19131830378, 23206.419839504146, 23335.41661458477, 33179.17052073718, 33203.66796332102, 33472.163195919326, 33690.157746056546, 33725.32549349048, 245139.0, 245369.0, 247003.0, 247473.0, 247684.0, 24700.50598988046, 25001.249962501155, 25002.624960625242, 25065.87467062653, 26900.730992689823, 32774.50838237381, 33031.17422064468, 33220.33559328751, 33378.33243335168, 33391.165220869676, 30056.849715751283, 30214.0, 30493.390132197677, 30879.845600771852, 31026.534601980537, 28629.570556442086, 29318.26704332409, 29406.705932940396, 29437.0, 29654.703452965194, 24621.87689061615, 28443.857780710965, 29044.0, 29948.251293717833, 30269.545956810223, 23834.88082559576, 24389.878050609634, 24613.261602151964, 24649.137280195107, 24781.0, 20572.897135514228, 21247.575048499253, 21282.829444380706, 21304.893475532524, 21460.14159433605], "unit": "score", "name": "ext.html", "value": 14683.96581716481}, {"lowerIsBetter": false, "replicates": [320.3285824477624, 323.26099383044556, 327.39758843727543, 328.533482454914, 332.09172912085427, 14139.505117320896, 14615.123092614424, 14674.486392976249, 14682.926585367071, 15237.0, 9792.657256996006, 9869.457179855106, 9913.306068575203, 9977.650782222623, 10283.897161028406, 4356.194104090738, 4581.106684196583, 4587.403637527117, 4588.2888152336445, 4594.793234304464, 4514.729116253019, 4597.356370108188, 4607.285870690049, 4624.237000894848, 4636.814527418916, 4605.631549476034, 4610.884727881813, 4620.491745907947, 4977.527134922195, 4992.475790042048, 4935.432425271086, 4951.3810773653295, 4990.750462476862, 4999.500049994989, 5026.145555255615, 4499.52754960731, 4503.392042074343, 4526.841560545365, 4532.184206842767, 4536.931946020813, 10316.071553560216, 10324.948375258076, 10376.481175941248, 10396.11633011195, 10443.94778026105, 1667.0747735007067, 1667.316400275893, 1749.1079549429755, 1926.2969016308946, 2262.9321120366417, 8321.83356332876, 8407.369447291416, 8571.828563428759, 8617.48295102296, 8625.784355391103, 1544.637010302578, 1688.991555042217, 1739.4433781190023, 1741.8171092035407, 1806.5573934386027, 49906.75046624744, 53697.731511342194, 54009.189862152096, 54103.0, 56043.0, 9327.813443731224, 9391.671291504765, 9425.717228483156, 9484.95257523708, 9644.373115747454, 11921.880781192078, 11993.280403175837, 12019.699507512381, 12078.27530348182, 12106.757864842653, 5991.0, 6045.425684559959, 6060.515158787286, 6085.726142323606, 6117.938820611737, 5422.078246697992, 5430.212619170277, 5471.781128754806, 5690.857728556819, 5716.857078572986, 3933.6656384207663, 3957.1689945111275, 3990.3615421532995, 4046.858359957387, 4046.9797651012145, 1606.2852030846161, 1680.420255012019, 1700.9149542522825, 1704.343827626348, 1725.3529926277645, 716.6488420673833, 721.6319676964786, 723.3995783499682, 763.2634507700096, 777.4324742937687, 13965.23191224472, 14394.784078238834, 14533.85466145325, 14597.978141530204, 14734.410623574937, 761.3186198352444, 768.1818862910982, 772.0388116794514, 773.8294085091261, 814.5886327404622, 8122.025356957203, 8281.089080201173, 8333.125021872738, 8426.343997893822, 8446.639493023104, 361850.0, 384357.0, 390809.0, 391380.0, 392613.0, 50547.0, 61107.0, 61561.0, 62639.0, 64529.67735161388, 795.5028107432854, 822.2476434062766, 823.3824631526355, 824.1675907333636, 827.420805436197, 13625.0, 13691.863081369458, 14065.156090634595, 14121.505747299207, 14365.066270692372, 28777.856110719313, 30971.380572387974, 31156.0, 31443.0, 31638.367232655677, 42378.0, 42385.57614423816, 42472.0, 42666.360004600574, 43010.56989430066, 6875.0, 6880.139982502187, 6916.861662766817, 6976.720931162697, 7057.858842823012, 10158.847617285599, 11041.779164416826, 11140.0, 11143.442827858737, 11296.587926509186, 8333.95833020831, 8604.268637165911, 8892.555372231232, 9349.065093490597, 9389.85915211286, 8723.258523025614, 8731.388802783744, 8847.911520884709, 8922.55387230623, 9195.678151264674, 8701.17338852808, 8865.955670221607, 8892.466452012899, 9061.13919177677, 9159.221466175182, 6594.439472644879, 6684.598924064571, 6969.0940177776565, 7051.330123638246, 7076.504644674823, 6915.585064896122, 8495.95752021236, 8658.220760131619, 8841.381103322705, 9121.726348209564], "unit": "score", "name": "jquery.html", "value": 7029.018367521619}, {"lowerIsBetter": false, "replicates": [1194.4266751959058, 1203.7953547896857, 1219.8353222314986, 1395.3999780094568, 1400.0829456705856, 6211.409916057967, 7111.644417779104, 7124.430045596353, 7244.203137654854, 7347.816304592381, 6974.616396098212, 7067.646617669109, 7079.85840283194, 7094.716211351552, 7098.645067746605, 2010.979890201094, 2029.7158397824242, 2033.877967321958, 2035.1248962945926, 2039.6532589459828, 2041.989790051055, 2048.068129001308, 2060.845436592254, 2096.706461095448, 2098.171222367164, 2071.6271071207175, 2097.286922446368, 2129.818965387944, 2132.029926383492, 2134.6264403729283, 2086.3428020173674, 2089.707440958267, 2090.216168936649, 2091.7176181215495, 2098.8950552472393, 1964.7642282925997, 1969.1434226111687, 1975.7629084509952, 1977.7231187633743, 2054.065400242886, 7235.348818606298, 7277.0, 7280.199178090405, 7282.781516554512, 7350.044494215771, 4170.833166673329, 4178.582141785828, 4207.221663992172, 4281.871543853689, 4310.3534469829465, 2744.3276397282793, 2775.514285000117, 2834.9149525514267, 2870.3398218409884, 2875.8993435229877, 819.2790344496864, 828.9212524810133, 834.0700119366862, 836.9121242269534, 840.7687885831384, 10253.948730256301, 10262.384256944608, 10271.589136434533, 10278.0, 10295.691129266059, 3758.2859256741676, 3826.712996525216, 3865.7487263327794, 3903.941440878389, 3951.1110000250287, 8609.91390086091, 8631.956840215884, 8655.56722163902, 8692.478451292942, 8711.607977640895, 4287.3140297552245, 4309.547497512779, 4332.826686932551, 4335.111302183045, 4335.3713711511655, 3360.915977100592, 3702.444633305026, 3759.793211373401, 3923.9215215695526, 3924.1955399143108, 3239.303549736771, 3274.459714147187, 3333.1500467381147, 3333.4999750037687, 3347.246869454402, 1051.2115913065202, 1055.208593554834, 1056.0759335581367, 1070.983935240972, 1079.222959469181, 772.2046292318809, 780.847734691741, 783.9176886426957, 788.5662885413, 835.1189495082746, 6276.843078922972, 6283.8114856554375, 6327.557071004985, 6338.841528961812, 6350.491960643138, 382.72635065927994, 388.6851650163377, 388.7084686485136, 389.17689087579566, 393.0527428896346, 5135.6148288878485, 5150.922736158961, 5157.510036546522, 5200.557952573998, 5213.504717051874, 8786.736397908073, 8923.0, 9052.185303322733, 9055.275577953747, 9158.129977652112, 8929.0, 8966.372353935161, 8986.236169925629, 9069.59186836594, 9090.045545217788, 6886.48351373649, 6905.240423553405, 6973.58158510491, 7017.754378596725, 7038.683259253346, 6618.404343609098, 6641.568298060611, 6659.034440006269, 6680.799576012728, 6683.966580167068, 7855.921440785519, 7989.0, 8150.2664760171865, 8179.550124743197, 8180.263776260165, 8120.878186827084, 8137.75586732399, 8334.458260213067, 8417.83164336722, 8499.192576705203, 5245.737713114406, 5907.91138132937, 6316.210473690789, 6321.33625969285, 6350.301466838551, 6617.66911654425, 6624.337566243337, 6639.170103737033, 6649.567778094409, 6658.3674550917585, 5645.096784514458, 5734.942650573441, 5910.70446477683, 6055.576109672281, 6134.202553667995, 5831.679257640871, 5984.491318237999, 5994.130851026664, 6068.878622427438, 6085.056816193497, 6131.816045518642, 6323.841903952438, 6325.620462772248, 6365.586236894587, 6381.968090159519, 5710.114932185518, 5723.713814309352, 5751.1373294006235, 5758.62568933018, 5777.537796976148, 5278.2346559749385, 5299.5230429261555, 5316.734163291897, 5320.228566857707, 5352.705601191972], "unit": "score", "name": "mootools.html", "value": 3919.9224118292977}, {"lowerIsBetter": false, "replicates": [296.8026262535414, 300.84055450611186, 304.0877367896311, 304.7912180156593, 306.79138186033515, 5534.861628459285, 5569.248151499546, 5574.331080270368, 5578.69317187555, 5582.134769110784, 5493.313335833021, 5508.9724551377285, 5509.449055094488, 5512.118061110224, 5517.613767036309, 4011.618896204856, 4064.8170832312617, 4165.83336666533, 4185.539590645027, 4201.075763332062, 4165.895852603679, 4169.791510424467, 4169.812358443877, 4170.520390155126, 4182.393552934823, 4159.2721273777115, 4168.520620128694, 4179.811908464127, 4182.665386769051, 4183.456150700405, 4184.665226781881, 4188.874333769992, 4189.601987811153, 4190.308599081148, 4198.3702444633245, 3644.5626524816926, 3645.052286405527, 3649.8905032849057, 3651.2514934438377, 3663.285659296438, 5292.867678308035, 5316.840494785162, 5323.680579165262, 5326.174442961308, 5333.786648534054, 4679.27471241958, 4741.122892264942, 4786.52134786522, 4794.208955522335, 4809.735464549449, 5698.6580805151825, 5737.3688894221605, 5746.712664366807, 5763.366029736726, 5766.654000759968, 3933.9213215735813, 3937.5078115235597, 3938.8336414971936, 3942.329803933338, 3970.06703424695, 6088.299845517778, 6090.147379366892, 6098.60359076663, 6154.599951003171, 6171.691415429255, 4039.8788036358956, 4044.1507283470214, 4052.169305292408, 4055.9391609125887, 4081.775502347399, 4114.033202197481, 4115.9176816463505, 4121.52602450716, 4121.670266378683, 4157.064660451435, 4545.2954792007295, 4754.809807607726, 4761.642876784255, 4762.214234651313, 4782.784774685148, 5780.653160810365, 5784.479396854304, 5796.681182534917, 5803.129530570363, 5817.069268916953, 1412.3009110490168, 1423.985760142406, 1424.33056463462, 1425.4440768100449, 1428.5071650280636, 914.5290175559592, 934.5327336331834, 940.4498368454394, 953.2802733935835, 956.6460409648474, 4972.080165169383, 4981.825636102792, 4998.450170481244, 5007.073691367036, 5014.52362025607, 5969.3732158122775, 5986.07215881539, 5990.371011043778, 5992.370801065913, 6007.579469437097, 4821.686590371614, 4890.95109048912, 4984.526469985346, 4999.075171093359, 5001.974990125026, 3251.2684645954473, 3269.7874638148446, 3270.787398819117, 3273.721733652666, 3281.8194999274792, 5725.713714314267, 5732.0, 5742.913856292159, 5747.3103227612955, 5753.877993791254, 6242.094896240111, 6284.528660350492, 6293.590916590407, 6307.05394190875, 6311.368863113744, 5769.365369809318, 5774.913376299359, 5785.392533783976, 5791.102379131242, 5791.594588378857, 5799.594028417971, 5833.591648584558, 5865.120231965239, 5976.581639285208, 6021.638701677914, 5940.138679891478, 5940.970295148497, 5942.078977758454, 5946.43508866657, 5949.851253718692, 5670.262865827416, 5719.283340413437, 5719.885602287848, 5720.313562372542, 5723.5707321950185, 3985.063510075072, 3985.7807820570147, 4001.9199616006936, 4004.8798536043964, 4019.9598004019585, 5749.712514374348, 5875.118732190205, 5990.64056156632, 6038.879222415615, 6056.152138700673, 5631.183478395692, 5812.128180772918, 5814.215080964016, 5815.41845815415, 5821.854453638693, 5752.568557358131, 5802.65184088956, 5814.447627475383, 5815.854603634773, 5827.24245848037, 5680.233168522362, 5681.289838770153, 5689.032864412977, 5694.743736531949, 5698.943010569841, 5844.3571207168025, 5845.064789633639, 5846.298444186725, 5856.824295271149, 5861.208736820645, 5164.173732202829, 5495.5878309127775, 5600.047991841316, 5618.494335509824, 5673.5461163107675], "unit": "score", "name": "prototype.html", "value": 4302.15164213505}, {"lowerIsBetter": false, "replicates": [473.97156170629756, 516.4654582507106, 542.2977244468414, 542.5822116969933, 549.0062985995352, 9682.564284607191, 9899.851502227473, 9910.306278560503, 9963.953784852594, 10214.080732734052, 9551.044895510446, 9551.856722149174, 9591.616335346578, 9610.327277090606, 9612.807743845118, 417.69716955207537, 561.2535328013753, 574.7729646789516, 758.3819187362282, 761.550685095792, 768.0361146760836, 773.4817672159667, 776.1191048160322, 777.4014009212931, 778.1790211327047, 808.1110778144024, 811.4482152136545, 816.049302562514, 818.7543736878943, 819.8401311744212, 810.4853418079502, 812.6140083460339, 812.9146439623872, 814.6008455856647, 815.5188438821094, 598.8652553175544, 599.6851652882228, 600.2586805295457, 600.8317671052068, 603.7494439807475, 10210.387376757419, 10225.488725563766, 10320.638777642747, 10334.483275836179, 10362.792744145076, 9859.852102218472, 10360.0, 10485.213608979357, 10608.045275925127, 10748.408837513934, 7795.727149549739, 8389.454685445426, 8407.0, 8407.201315874981, 8513.53175575343, 3040.7415369693604, 3049.603551538286, 3057.6636569977286, 3090.0111964171474, 3096.6593674695764, 41361.58638413608, 41457.585424145975, 41557.37663935013, 41611.0, 41862.0, 7953.602319883983, 8125.0, 8302.128276530877, 8325.583720813935, 8329.250367466957, 13990.650233744238, 14044.929775351058, 14172.433102675983, 14192.290385480685, 14207.928960355339, 5548.472895074961, 5654.038813401731, 5845.503132233808, 5902.822915312548, 5963.403659634088, 3071.769617278713, 3087.7529797616135, 3120.063980805749, 3156.1162874395204, 3232.4504834178247, 2297.7931986120993, 2322.6516022596747, 2329.4409341758196, 2329.883505824736, 2331.9650205246935, 409.985650502231, 413.7145369694961, 419.67055861149464, 431.8531699222217, 433.559936664286, 433.09050992914626, 477.25309890022004, 507.4620901844057, 524.6930545630772, 527.2302438439845, 7266.055412796409, 7345.816354591178, 7373.483856130019, 7542.208068152875, 7571.091469023752, 438.7192196993926, 477.22212793146946, 502.21654219417826, 540.1357827476007, 545.3319683387897, 3391.69419773389, 3515.7011654009184, 3551.4317709166407, 3556.1820781220463, 3675.9081022974638, 50920.0, 51114.48885511172, 52460.21309680358, 53126.734366327924, 53567.19649205265, 45540.772296138966, 46001.0, 46503.069938601715, 46593.534064659594, 46765.53234467612, 41008.589914101074, 41400.79299603483, 41734.0, 42375.36436953448, 42401.78799106047, 7531.774046778605, 7623.390128789794, 7685.4620176587105, 7705.152433232228, 7710.498817576839, 30708.692913070583, 31571.21071973219, 31952.84023579867, 32031.519527206645, 32147.517787232744, 36431.635683642824, 39298.0, 40018.39972400475, 40200.798996004836, 40229.39655905105, 8636.0, 8657.740267791976, 8726.30189584819, 8807.867881981903, 8820.162084601952, 9759.9024009759, 9816.263780216656, 9827.754306142404, 9851.950740246253, 9884.159846413135, 9069.863952040592, 9191.448513089235, 9315.97524272343, 9339.906600933904, 9434.386764860263, 8765.693200737944, 8866.335024873031, 8909.599068041824, 9100.044495327895, 9455.24358051368, 8905.777355566162, 9003.324750643596, 9014.053524379846, 9106.362554621113, 9297.535123243675, 7696.422768292288, 8235.423520353517, 8420.215673607121, 8440.53577053268, 8569.614367353359, 7570.242975702386, 7641.42689298316, 7850.018747656543, 8056.637451314587, 8105.27052565272], "unit": "score", "name": "yui.html", "value": 5197.935488611586}], "name": "dromaeo_css", "value": 5867.445020441256}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 114.0, 115.0, 114.0, 126.0, 114.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [161.0, 134.0, 155.0, 178.0, 136.0, 160.0, 161.0, 135.0, 176.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 153.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 164.0, 168.0, 161.0, 163.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 73.0, 75.0, 74.0, 74.0, 76.0, 140.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [96.0, 93.0, 142.0, 95.0, 95.0, 94.0, 140.0, 94.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 120.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [146.0, 149.0, 147.0, 146.0, 147.0, 148.0, 149.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 71.0, 70.0, 71.0, 70.0, 71.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 69.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 71.0, 70.0, 75.0, 70.0, 71.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 85.0, 83.0, 83.0, 83.0, 83.0, 81.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [124.0, 131.0, 122.0, 129.0, 129.0, 125.0, 124.0, 126.0, 123.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [139.0, 163.0, 156.0, 158.0, 147.0, 151.0, 150.0, 152.0, 151.0, 164.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 72.0, 71.0, 73.0, 74.0, 72.0, 72.0, 74.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1556.3999999999999}]} 19:06:02 INFO - Return code: 0 19:06:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:06:02 ERROR - # TBPL SUCCESS # 19:06:02 INFO - Running post-action listener: _resource_record_post_action 19:06:02 INFO - Running post-run listener: _resource_record_post_run 19:06:04 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 538849280; Read time: 0; Write time: 604968 19:06:04 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248045568; Read time: 0; Write time: 411632 19:06:04 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 290803712; Read time: 0; Write time: 193336 19:06:04 INFO - Running post-run listener: _upload_blobber_files 19:06:04 INFO - Blob upload gear active. 19:06:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:06:04 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 19:06:04 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:06:04 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:06:04 INFO - (blobuploader) - INFO - Open directory for files ... 19:06:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:06:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:05 INFO - (blobuploader) - INFO - Done attempting. 19:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:06 INFO - (blobuploader) - INFO - Done attempting. 19:06:06 INFO - (blobuploader) - INFO - Iteration through files over. 19:06:06 INFO - Return code: 0 19:06:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:06:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:06:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85e9956e7971764aef609717febc7c7108136ca09a0f08f9786586dfa29940a692f68de3f17c1e5bc997034773ab9f5accef739407eef1d3f5e92fd455fc9fd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf44beff16f3a744e4dc44983abc4dca630b5e812c02b4a703b07a92fadac9d99b72cd878699095baf70c616f9c84ae0375b5bcaabca105e7b739d7a7caac2ca"} 19:06:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:06:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:06:06 INFO - Contents: 19:06:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85e9956e7971764aef609717febc7c7108136ca09a0f08f9786586dfa29940a692f68de3f17c1e5bc997034773ab9f5accef739407eef1d3f5e92fd455fc9fd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf44beff16f3a744e4dc44983abc4dca630b5e812c02b4a703b07a92fadac9d99b72cd878699095baf70c616f9c84ae0375b5bcaabca105e7b739d7a7caac2ca"} 19:06:06 INFO - Running post-run listener: copy_logs_to_upload_dir 19:06:06 INFO - Copying logs to upload dir... 19:06:06 INFO - mkdir: /builds/slave/test/build/upload/logs 19:06:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.208594 ========= master_lag: 74.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-03-06 19:07:20.468170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 19:07:20.472126) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 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/Fx-Team-Non-PGO/sha512/85e9956e7971764aef609717febc7c7108136ca09a0f08f9786586dfa29940a692f68de3f17c1e5bc997034773ab9f5accef739407eef1d3f5e92fd455fc9fd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf44beff16f3a744e4dc44983abc4dca630b5e812c02b4a703b07a92fadac9d99b72cd878699095baf70c616f9c84ae0375b5bcaabca105e7b739d7a7caac2ca"} build_url:https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/GpAoLKIsQzi2LKi8ZNnMpA/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/Fx-Team-Non-PGO/sha512/85e9956e7971764aef609717febc7c7108136ca09a0f08f9786586dfa29940a692f68de3f17c1e5bc997034773ab9f5accef739407eef1d3f5e92fd455fc9fd8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf44beff16f3a744e4dc44983abc4dca630b5e812c02b4a703b07a92fadac9d99b72cd878699095baf70c616f9c84ae0375b5bcaabca105e7b739d7a7caac2ca"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 19:07:20.545191) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-03-06 19:07:20.545515) ========= 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=03627c79f6bb3d1578c4a402000001ba-1457301297.308130-2075962231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 3.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-03-06 19:07:23.762481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 19:07:23.762840) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 19:07:23.892235) ========= ========= Total master_lag: 77.77 =========