builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1460057711.17 results: success (0) buildid: 20160407115853 builduid: 61865a9ba917442790027f8857189b7d revision: 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.170671) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.171258) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.171849) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006417 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.202987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.203529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.235483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.235864) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004734 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.300534) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.301049) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.301680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.302197) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 12:35:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.4M=0s 2016-04-07 12:35:12 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.413936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.414270) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022252 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.478387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:11.478782) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 --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 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 --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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 12:35:12,143 truncating revision to first 12 chars 2016-04-07 12:35:12,143 Setting DEBUG logging. 2016-04-07 12:35:12,143 attempt 1/10 2016-04-07 12:35:12,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0559e1ea4660?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 12:35:12,423 unpacking tar archive at: fx-team-0559e1ea4660/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:12.050755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:12.051125) ========= echo 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0559e1ea4660abf46d6ad114bb6518e9d26c5b33'] 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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 program finished with exit code 0 elapsedTime=0.003714 script_repo_revision: '0559e1ea4660abf46d6ad114bb6518e9d26c5b33' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:12.100511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:12.100884) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 12:35:12.112065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-07 12:35:12.112451) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:35:12 INFO - MultiFileLogger online at 20160407 12:35:12 in /builds/slave/test 12:35:12 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 12:35:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:35:12 INFO - {'append_to_log': False, 12:35:12 INFO - 'base_work_dir': '/builds/slave/test', 12:35:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:35:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:35:12 INFO - 'branch': 'Fx-Team-Non-PGO', 12:35:12 INFO - 'buildbot_json_path': 'buildprops.json', 12:35:12 INFO - 'config_files': ('talos/linux_config.py',), 12:35:12 INFO - 'default_actions': ('clobber', 12:35:12 INFO - 'read-buildbot-config', 12:35:12 INFO - 'download-and-extract', 12:35:12 INFO - 'populate-webroot', 12:35:12 INFO - 'create-virtualenv', 12:35:12 INFO - 'install', 12:35:12 INFO - 'run-tests'), 12:35:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:35:12 INFO - 'download_minidump_stackwalk': True, 12:35:12 INFO - 'download_symbols': 'ondemand', 12:35:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:35:12 INFO - 'tooltool.py': '/tools/tooltool.py', 12:35:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:35:12 INFO - '/tools/misc-python/virtualenv.py')}, 12:35:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:35:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:35:12 INFO - 'installer_path': 'installer.exe', 12:35:12 INFO - 'log_level': 'info', 12:35:12 INFO - 'log_name': 'talos', 12:35:12 INFO - 'log_to_console': True, 12:35:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:35:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:35:12 INFO - 'opt_config_files': (), 12:35:12 INFO - 'pip_index': False, 12:35:12 INFO - 'sps_profile': False, 12:35:12 INFO - 'sps_profile_interval': 0, 12:35:12 INFO - 'suite': 'dromaeojs-e10s', 12:35:12 INFO - 'system_bits': '32', 12:35:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:35:12 INFO - 'title': 'talos-linux64-ix-042', 12:35:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:35:12 INFO - 'use_talos_json': True, 12:35:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:35:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:35:12 INFO - 'work_dir': 'build'} 12:35:12 INFO - ##### 12:35:12 INFO - ##### Running clobber step. 12:35:12 INFO - ##### 12:35:12 INFO - Running pre-action listener: _resource_record_pre_action 12:35:12 INFO - Running main action method: clobber 12:35:12 INFO - rmtree: /builds/slave/test/build 12:35:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:35:13 INFO - Running post-action listener: _resource_record_post_action 12:35:13 INFO - ##### 12:35:13 INFO - ##### Running read-buildbot-config step. 12:35:13 INFO - ##### 12:35:13 INFO - Running pre-action listener: _resource_record_pre_action 12:35:13 INFO - Running main action method: read_buildbot_config 12:35:13 INFO - Using buildbot properties: 12:35:13 INFO - { 12:35:13 INFO - "project": "", 12:35:13 INFO - "product": "firefox", 12:35:13 INFO - "script_repo_revision": "production", 12:35:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:35:13 INFO - "repository": "", 12:35:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:35:13 INFO - "buildid": "20160407115853", 12:35:13 INFO - "pgo_build": "False", 12:35:13 INFO - "basedir": "/builds/slave/test", 12:35:13 INFO - "buildnumber": 1372, 12:35:13 INFO - "slavename": "talos-linux64-ix-042", 12:35:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:35:13 INFO - "platform": "ubuntu64_hw", 12:35:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:35:13 INFO - "branch": "fx-team", 12:35:13 INFO - "repo_path": "integration/fx-team", 12:35:13 INFO - "revision": "0559e1ea4660abf46d6ad114bb6518e9d26c5b33", 12:35:13 INFO - "stage_platform": "linux64", 12:35:13 INFO - "builduid": "61865a9ba917442790027f8857189b7d", 12:35:13 INFO - "slavebuilddir": "test" 12:35:13 INFO - } 12:35:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:35:13 INFO - Running post-action listener: _resource_record_post_action 12:35:13 INFO - ##### 12:35:13 INFO - ##### Running download-and-extract step. 12:35:13 INFO - ##### 12:35:13 INFO - Running pre-action listener: _resource_record_pre_action 12:35:13 INFO - Running main action method: download_and_extract 12:35:13 INFO - mkdir: /builds/slave/test/build/tests 12:35:13 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')]} 12:35:13 INFO - https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:35:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:35:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:35:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:35:14 INFO - Downloaded 1361 bytes. 12:35:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:35:14 INFO - Using the following test package requirements: 12:35:14 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:35:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:35:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:35:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'jsshell-linux-x86_64.zip'], 12:35:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:35:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:35:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:35:14 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:35:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:35:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:35:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:14 INFO - https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:35:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:35:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:35:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:35:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:35:15 INFO - Downloaded 22143484 bytes. 12:35:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:35:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:35:17 INFO - Return code: 0 12:35:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:17 INFO - https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:35:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:35:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:35:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:35:20 INFO - Downloaded 22143484 bytes. 12:35:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:35:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:35:22 INFO - Return code: 0 12:35:22 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')]} 12:35:22 INFO - https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:35:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:35:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:35:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:35:23 INFO - Downloaded 10847693 bytes. 12:35:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:35:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:35:23 INFO - Return code: 0 12:35:23 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')]} 12:35:23 INFO - https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:35:25 INFO - Downloaded 54198843 bytes. 12:35:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:35:25 INFO - mkdir: /builds/slave/test/properties 12:35:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:35:25 INFO - Writing to file /builds/slave/test/properties/build_url 12:35:25 INFO - Contents: 12:35:25 INFO - build_url:https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:35:26 INFO - Running post-action listener: _resource_record_post_action 12:35:26 INFO - Running post-action listener: set_extra_try_arguments 12:35:26 INFO - ##### 12:35:26 INFO - ##### Running populate-webroot step. 12:35:26 INFO - ##### 12:35:26 INFO - Running pre-action listener: _resource_record_pre_action 12:35:26 INFO - Running main action method: populate_webroot 12:35:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:35:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:35:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:35:26 INFO - '--tppagecycles', 12:35:26 INFO - '7'], 12:35:26 INFO - 'tests': ['tsvgm']}}, 12:35:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:35:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:35:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:35:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:35:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['damp', 'tps']}, 12:35:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'tests': ['damp', 'tps']}, 12:35:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['dromaeo_dom']}, 12:35:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:35:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['a11yr', 12:35:26 INFO - 'ts_paint', 12:35:26 INFO - 'tpaint', 12:35:26 INFO - 'sessionrestore', 12:35:26 INFO - 'sessionrestore_no_auto_restore', 12:35:26 INFO - 'tabpaint']}, 12:35:26 INFO - 'other-e10s': {'tests': ['a11yr', 12:35:26 INFO - 'ts_paint', 12:35:26 INFO - 'tpaint', 12:35:26 INFO - 'sessionrestore', 12:35:26 INFO - 'sessionrestore_no_auto_restore', 12:35:26 INFO - 'tabpaint']}, 12:35:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:35:26 INFO - 'ts_paint', 12:35:26 INFO - 'tpaint', 12:35:26 INFO - 'sessionrestore', 12:35:26 INFO - 'sessionrestore_no_auto_restore', 12:35:26 INFO - 'tabpaint']}, 12:35:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:35:26 INFO - 'ts_paint', 12:35:26 INFO - 'tpaint', 12:35:26 INFO - 'sessionrestore', 12:35:26 INFO - 'sessionrestore_no_auto_restore', 12:35:26 INFO - 'tabpaint']}, 12:35:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['a11yr', 12:35:26 INFO - 'ts_paint', 12:35:26 INFO - 'tpaint', 12:35:26 INFO - 'sessionrestore', 12:35:26 INFO - 'sessionrestore_no_auto_restore', 12:35:26 INFO - 'tabpaint']}, 12:35:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['a11yr', 12:35:26 INFO - 'ts_paint', 12:35:26 INFO - 'tpaint', 12:35:26 INFO - 'sessionrestore', 12:35:26 INFO - 'sessionrestore_no_auto_restore', 12:35:26 INFO - 'tabpaint']}, 12:35:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['tsvgx', 12:35:26 INFO - 'tsvgr_opacity', 12:35:26 INFO - 'tart', 12:35:26 INFO - 'tscrollx', 12:35:26 INFO - 'cart']}, 12:35:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:35:26 INFO - 'tsvgr_opacity', 12:35:26 INFO - 'tart', 12:35:26 INFO - 'tscrollx', 12:35:26 INFO - 'cart']}, 12:35:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'talos_options': ['--disable-e10s'], 12:35:26 INFO - 'tests': ['tp5o']}, 12:35:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'tests': ['tp5o']}, 12:35:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'talos_options': ['--disable-e10s', 12:35:26 INFO - '--xperf_path', 12:35:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:26 INFO - 'tests': ['tp5n']}, 12:35:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:26 INFO - 'talos_options': ['--xperf_path', 12:35:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:26 INFO - 'tests': ['tp5n']}}, 12:35:26 INFO - 'talos.zip': {'path': '', 12:35:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:35:26 INFO - Running post-action listener: _resource_record_post_action 12:35:26 INFO - ##### 12:35:26 INFO - ##### Running create-virtualenv step. 12:35:26 INFO - ##### 12:35:26 INFO - Running pre-action listener: _resource_record_pre_action 12:35:26 INFO - Running main action method: create_virtualenv 12:35:26 INFO - Creating virtualenv /builds/slave/test/build/venv 12:35:26 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 12:35:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:35:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:35:26 INFO - Using real prefix '/usr' 12:35:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:35:27 INFO - Installing distribute.............................................................................................................................................................................................done. 12:35:29 INFO - Installing pip.................done. 12:35:29 INFO - Return code: 0 12:35:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:29 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 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:29 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 12:35:29 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 12:35:29 INFO - Using env: {'DISPLAY': ':0', 12:35:29 INFO - 'HOME': '/home/cltbld', 12:35:29 INFO - 'LANG': 'en_US.UTF-8', 12:35:29 INFO - 'LANGUAGE': 'en_US:en', 12:35:29 INFO - 'LOGNAME': 'cltbld', 12:35:29 INFO - 'MAIL': '/var/mail/cltbld', 12:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:29 INFO - 'MOZ_NO_REMOTE': '1', 12:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:29 INFO - 'NO_EM_RESTART': '1', 12:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:29 INFO - 'PWD': '/builds/slave/test', 12:35:29 INFO - 'SHELL': '/bin/bash', 12:35:29 INFO - 'SHLVL': '1', 12:35:29 INFO - 'TERM': 'linux', 12:35:29 INFO - 'TMOUT': '86400', 12:35:29 INFO - 'USER': 'cltbld', 12:35:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:29 INFO - '_': '/tools/buildbot/bin/python'} 12:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:29 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 12:35:29 INFO - Cleaning up... 12:35:29 INFO - Return code: 0 12:35:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:29 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 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:29 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 12:35:29 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 12:35:29 INFO - Using env: {'DISPLAY': ':0', 12:35:29 INFO - 'HOME': '/home/cltbld', 12:35:29 INFO - 'LANG': 'en_US.UTF-8', 12:35:29 INFO - 'LANGUAGE': 'en_US:en', 12:35:29 INFO - 'LOGNAME': 'cltbld', 12:35:29 INFO - 'MAIL': '/var/mail/cltbld', 12:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:29 INFO - 'MOZ_NO_REMOTE': '1', 12:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:29 INFO - 'NO_EM_RESTART': '1', 12:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:29 INFO - 'PWD': '/builds/slave/test', 12:35:29 INFO - 'SHELL': '/bin/bash', 12:35:29 INFO - 'SHLVL': '1', 12:35:29 INFO - 'TERM': 'linux', 12:35:29 INFO - 'TMOUT': '86400', 12:35:29 INFO - 'USER': 'cltbld', 12:35:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:29 INFO - '_': '/tools/buildbot/bin/python'} 12:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:29 INFO - Downloading/unpacking psutil>=0.7.1 12:35:29 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 12:35:29 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 12:35:29 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 12:35:29 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 12:35:29 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 12:35:29 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 12:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:35:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:31 INFO - Installing collected packages: psutil 12:35:31 INFO - Running setup.py install for psutil 12:35:31 INFO - building 'psutil._psutil_linux' extension 12:35:31 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 12:35:31 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 12:35:32 INFO - building 'psutil._psutil_posix' extension 12:35:32 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 12:35:32 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 12:35:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:32 INFO - Successfully installed psutil 12:35:32 INFO - Cleaning up... 12:35:32 INFO - Return code: 0 12:35:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:35:32 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')]} 12:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:32 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')]} 12:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:32 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 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:32 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 12:35:32 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 12:35:32 INFO - Using env: {'DISPLAY': ':0', 12:35:32 INFO - 'HOME': '/home/cltbld', 12:35:32 INFO - 'LANG': 'en_US.UTF-8', 12:35:32 INFO - 'LANGUAGE': 'en_US:en', 12:35:32 INFO - 'LOGNAME': 'cltbld', 12:35:32 INFO - 'MAIL': '/var/mail/cltbld', 12:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:32 INFO - 'MOZ_NO_REMOTE': '1', 12:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:32 INFO - 'NO_EM_RESTART': '1', 12:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:32 INFO - 'PWD': '/builds/slave/test', 12:35:32 INFO - 'SHELL': '/bin/bash', 12:35:32 INFO - 'SHLVL': '1', 12:35:32 INFO - 'TERM': 'linux', 12:35:32 INFO - 'TMOUT': '86400', 12:35:32 INFO - 'USER': 'cltbld', 12:35:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:32 INFO - '_': '/tools/buildbot/bin/python'} 12:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:35:32 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 12:35:32 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 12:35:32 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 12:35:32 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 12:35:32 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 12:35:32 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 12:35:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:35:34 INFO - Installing collected packages: mozsystemmonitor 12:35:34 INFO - Running setup.py install for mozsystemmonitor 12:35:34 INFO - Successfully installed mozsystemmonitor 12:35:34 INFO - Cleaning up... 12:35:34 INFO - Return code: 0 12:35:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:35: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')]} 12:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35: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')]} 12:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:34 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 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:34 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 12:35:34 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 12:35:34 INFO - Using env: {'DISPLAY': ':0', 12:35:34 INFO - 'HOME': '/home/cltbld', 12:35:34 INFO - 'LANG': 'en_US.UTF-8', 12:35:34 INFO - 'LANGUAGE': 'en_US:en', 12:35:34 INFO - 'LOGNAME': 'cltbld', 12:35:34 INFO - 'MAIL': '/var/mail/cltbld', 12:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:34 INFO - 'MOZ_NO_REMOTE': '1', 12:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:34 INFO - 'NO_EM_RESTART': '1', 12:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:34 INFO - 'PWD': '/builds/slave/test', 12:35:34 INFO - 'SHELL': '/bin/bash', 12:35:34 INFO - 'SHLVL': '1', 12:35:34 INFO - 'TERM': 'linux', 12:35:34 INFO - 'TMOUT': '86400', 12:35:34 INFO - 'USER': 'cltbld', 12:35:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:34 INFO - '_': '/tools/buildbot/bin/python'} 12:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:34 INFO - Downloading/unpacking blobuploader==1.2.4 12:35:34 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 12:35:34 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 12:35:34 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 12:35:34 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 12:35:34 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 12:35:34 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 12:35:36 INFO - Downloading blobuploader-1.2.4.tar.gz 12:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:35:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:35:36 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 12:35:36 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 12:35:36 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 12:35:36 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 12:35:36 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 12:35:36 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 12:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:35:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:37 INFO - Downloading docopt-0.6.1.tar.gz 12:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:35:37 INFO - Installing collected packages: blobuploader, requests, docopt 12:35:37 INFO - Running setup.py install for blobuploader 12:35:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:35:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:35:37 INFO - Running setup.py install for requests 12:35:37 INFO - Running setup.py install for docopt 12:35:37 INFO - Successfully installed blobuploader requests docopt 12:35:37 INFO - Cleaning up... 12:35:38 INFO - Return code: 0 12:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:38 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')]} 12:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:38 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')]} 12:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:38 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 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:38 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 12:35:38 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 12:35:38 INFO - Using env: {'DISPLAY': ':0', 12:35:38 INFO - 'HOME': '/home/cltbld', 12:35:38 INFO - 'LANG': 'en_US.UTF-8', 12:35:38 INFO - 'LANGUAGE': 'en_US:en', 12:35:38 INFO - 'LOGNAME': 'cltbld', 12:35:38 INFO - 'MAIL': '/var/mail/cltbld', 12:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:38 INFO - 'MOZ_NO_REMOTE': '1', 12:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:38 INFO - 'NO_EM_RESTART': '1', 12:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:38 INFO - 'PWD': '/builds/slave/test', 12:35:38 INFO - 'SHELL': '/bin/bash', 12:35:38 INFO - 'SHLVL': '1', 12:35:38 INFO - 'TERM': 'linux', 12:35:38 INFO - 'TMOUT': '86400', 12:35:38 INFO - 'USER': 'cltbld', 12:35:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:38 INFO - '_': '/tools/buildbot/bin/python'} 12:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:38 INFO - Running setup.py (path:/tmp/pip-shi1Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:38 INFO - Running setup.py (path:/tmp/pip-cpaQab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:38 INFO - Running setup.py (path:/tmp/pip-BCPRyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:38 INFO - Running setup.py (path:/tmp/pip-ypPwuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:38 INFO - Running setup.py (path:/tmp/pip-lsbEB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:38 INFO - Running setup.py (path:/tmp/pip-w6i3WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:38 INFO - Running setup.py (path:/tmp/pip-XfceTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:38 INFO - Running setup.py (path:/tmp/pip-BO1rh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:38 INFO - Running setup.py (path:/tmp/pip-weDUaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:38 INFO - Running setup.py (path:/tmp/pip-WqGuZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:38 INFO - Running setup.py (path:/tmp/pip-VZA7B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:39 INFO - Running setup.py (path:/tmp/pip-WSsqWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:39 INFO - Running setup.py (path:/tmp/pip-Px4nCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:39 INFO - Running setup.py (path:/tmp/pip-EWRpul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:39 INFO - Running setup.py (path:/tmp/pip-DF7XqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:39 INFO - Running setup.py (path:/tmp/pip-ZQMWpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:39 INFO - Running setup.py (path:/tmp/pip-dGXbnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:35:39 INFO - Running setup.py install for manifestparser 12:35:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:35:39 INFO - Running setup.py install for mozcrash 12:35:39 INFO - Running setup.py install for mozdebug 12:35:39 INFO - Running setup.py install for mozdevice 12:35:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:35:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:35:39 INFO - Running setup.py install for mozfile 12:35:40 INFO - Running setup.py install for mozhttpd 12:35:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Running setup.py install for mozinfo 12:35:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Running setup.py install for mozInstall 12:35:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Running setup.py install for mozleak 12:35:40 INFO - Running setup.py install for mozlog 12:35:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Running setup.py install for moznetwork 12:35:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Running setup.py install for mozprocess 12:35:40 INFO - Running setup.py install for mozprofile 12:35:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Running setup.py install for mozrunner 12:35:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:35:40 INFO - Running setup.py install for mozscreenshot 12:35:41 INFO - Running setup.py install for moztest 12:35:41 INFO - Running setup.py install for mozversion 12:35:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:35:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:35:41 INFO - Cleaning up... 12:35:41 INFO - Return code: 0 12:35:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35: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')]} 12:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35: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')]} 12:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:41 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 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:41 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 12:35:41 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 12:35:41 INFO - Using env: {'DISPLAY': ':0', 12:35:41 INFO - 'HOME': '/home/cltbld', 12:35:41 INFO - 'LANG': 'en_US.UTF-8', 12:35:41 INFO - 'LANGUAGE': 'en_US:en', 12:35:41 INFO - 'LOGNAME': 'cltbld', 12:35:41 INFO - 'MAIL': '/var/mail/cltbld', 12:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:41 INFO - 'MOZ_NO_REMOTE': '1', 12:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:41 INFO - 'NO_EM_RESTART': '1', 12:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:41 INFO - 'PWD': '/builds/slave/test', 12:35:41 INFO - 'SHELL': '/bin/bash', 12:35:41 INFO - 'SHLVL': '1', 12:35:41 INFO - 'TERM': 'linux', 12:35:41 INFO - 'TMOUT': '86400', 12:35:41 INFO - 'USER': 'cltbld', 12:35:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:41 INFO - '_': '/tools/buildbot/bin/python'} 12:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:41 INFO - Running setup.py (path:/tmp/pip-17ME1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:41 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)) 12:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:41 INFO - Running setup.py (path:/tmp/pip-iZfvlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:41 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)) 12:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:41 INFO - Running setup.py (path:/tmp/pip-S_dvJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:41 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)) 12:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:41 INFO - Running setup.py (path:/tmp/pip-rwM54_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:41 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)) 12:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:41 INFO - Running setup.py (path:/tmp/pip-Jw9_so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:41 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)) 12:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:41 INFO - Running setup.py (path:/tmp/pip-eEkfcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:41 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)) 12:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:41 INFO - Running setup.py (path:/tmp/pip-UEDPgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:42 INFO - Running setup.py (path:/tmp/pip-3OJj6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:42 INFO - Running setup.py (path:/tmp/pip-vRHJIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:42 INFO - Running setup.py (path:/tmp/pip-pn0TAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:42 INFO - Running setup.py (path:/tmp/pip-zoua2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:42 INFO - Running setup.py (path:/tmp/pip-4A3FTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:42 INFO - Running setup.py (path:/tmp/pip-zj9hpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:42 INFO - Running setup.py (path:/tmp/pip-ssmIg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:42 INFO - Running setup.py (path:/tmp/pip-YJclFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:42 INFO - Running setup.py (path:/tmp/pip-Q3qUMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:42 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)) 12:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:42 INFO - Running setup.py (path:/tmp/pip-mgjhOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:42 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)) 12:35:42 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)) 12:35:42 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)) 12:35:42 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)) 12:35:42 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)) 12:35:42 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)) 12:35:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:44 INFO - Downloading blessings-1.6.tar.gz 12:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:44 INFO - Installing collected packages: blessings 12:35:44 INFO - Running setup.py install for blessings 12:35:44 INFO - Successfully installed blessings 12:35:44 INFO - Cleaning up... 12:35:44 INFO - Return code: 0 12:35:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:45 INFO - Reading from file tmpfile_stdout 12:35:45 INFO - Current package versions: 12:35:45 INFO - argparse == 1.2.1 12:35:45 INFO - blessings == 1.6 12:35:45 INFO - blobuploader == 1.2.4 12:35:45 INFO - docopt == 0.6.1 12:35:45 INFO - manifestparser == 1.1 12:35:45 INFO - mozInstall == 1.12 12:35:45 INFO - mozcrash == 0.17 12:35:45 INFO - mozdebug == 0.1 12:35:45 INFO - mozdevice == 0.48 12:35:45 INFO - mozfile == 1.2 12:35:45 INFO - mozhttpd == 0.7 12:35:45 INFO - mozinfo == 0.9 12:35:45 INFO - mozleak == 0.1 12:35:45 INFO - mozlog == 3.1 12:35:45 INFO - moznetwork == 0.27 12:35:45 INFO - mozprocess == 0.22 12:35:45 INFO - mozprofile == 0.28 12:35:45 INFO - mozrunner == 6.11 12:35:45 INFO - mozscreenshot == 0.1 12:35:45 INFO - mozsystemmonitor == 0.0 12:35:45 INFO - moztest == 0.7 12:35:45 INFO - mozversion == 1.4 12:35:45 INFO - psutil == 3.1.1 12:35:45 INFO - requests == 1.2.3 12:35:45 INFO - wsgiref == 0.1.2 12:35:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:45 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 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:45 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 12:35:45 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 12:35:45 INFO - Using env: {'DISPLAY': ':0', 12:35:45 INFO - 'HOME': '/home/cltbld', 12:35:45 INFO - 'LANG': 'en_US.UTF-8', 12:35:45 INFO - 'LANGUAGE': 'en_US:en', 12:35:45 INFO - 'LOGNAME': 'cltbld', 12:35:45 INFO - 'MAIL': '/var/mail/cltbld', 12:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:45 INFO - 'MOZ_NO_REMOTE': '1', 12:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:45 INFO - 'NO_EM_RESTART': '1', 12:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:45 INFO - 'PWD': '/builds/slave/test', 12:35:45 INFO - 'SHELL': '/bin/bash', 12:35:45 INFO - 'SHLVL': '1', 12:35:45 INFO - 'TERM': 'linux', 12:35:45 INFO - 'TMOUT': '86400', 12:35:45 INFO - 'USER': 'cltbld', 12:35:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:45 INFO - '_': '/tools/buildbot/bin/python'} 12:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 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)) 12:35:45 INFO - Cleaning up... 12:35:45 INFO - Return code: 0 12:35:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:35:45 INFO - Using env: {'DISPLAY': ':0', 12:35:45 INFO - 'HOME': '/home/cltbld', 12:35:45 INFO - 'LANG': 'en_US.UTF-8', 12:35:45 INFO - 'LANGUAGE': 'en_US:en', 12:35:45 INFO - 'LOGNAME': 'cltbld', 12:35:45 INFO - 'MAIL': '/var/mail/cltbld', 12:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:45 INFO - 'MOZ_NO_REMOTE': '1', 12:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:45 INFO - 'NO_EM_RESTART': '1', 12:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:45 INFO - 'PWD': '/builds/slave/test', 12:35:45 INFO - 'SHELL': '/bin/bash', 12:35:45 INFO - 'SHLVL': '1', 12:35:45 INFO - 'TERM': 'linux', 12:35:45 INFO - 'TMOUT': '86400', 12:35:45 INFO - 'USER': 'cltbld', 12:35:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:45 INFO - '_': '/tools/buildbot/bin/python'} 12:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:45 INFO - Downloading/unpacking jsonschema 12:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:35:47 INFO - Downloading/unpacking functools32 (from jsonschema) 12:35: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 12:35: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 12:35: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 12:35: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 12:35: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 12:35: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 12:35:47 INFO - Downloading functools32-3.2.3-2.tar.gz 12:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:35:47 INFO - warning: no files found matching '*.txt' 12:35:47 INFO - no previously-included directories found matching 'build' 12:35:47 INFO - no previously-included directories found matching 'dist' 12:35:47 INFO - no previously-included directories found matching '.git*' 12:35:47 INFO - Installing collected packages: jsonschema, functools32 12:35:47 INFO - Running setup.py install for functools32 12:35:47 INFO - warning: no files found matching '*.txt' 12:35:47 INFO - no previously-included directories found matching 'build' 12:35:47 INFO - no previously-included directories found matching 'dist' 12:35:47 INFO - no previously-included directories found matching '.git*' 12:35:47 INFO - Successfully installed jsonschema functools32 12:35:47 INFO - Cleaning up... 12:35:47 INFO - Return code: 0 12:35:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:35: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')]} 12:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35: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')]} 12:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ccc23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', '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 12:35: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', 'flake8'] in /builds/slave/test/build 12:35: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 flake8 12:35:47 INFO - Using env: {'DISPLAY': ':0', 12:35:47 INFO - 'HOME': '/home/cltbld', 12:35:47 INFO - 'LANG': 'en_US.UTF-8', 12:35:47 INFO - 'LANGUAGE': 'en_US:en', 12:35:47 INFO - 'LOGNAME': 'cltbld', 12:35:47 INFO - 'MAIL': '/var/mail/cltbld', 12:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:47 INFO - 'MOZ_NO_REMOTE': '1', 12:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:47 INFO - 'NO_EM_RESTART': '1', 12:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:47 INFO - 'PWD': '/builds/slave/test', 12:35:47 INFO - 'SHELL': '/bin/bash', 12:35:47 INFO - 'SHLVL': '1', 12:35:47 INFO - 'TERM': 'linux', 12:35:47 INFO - 'TMOUT': '86400', 12:35:47 INFO - 'USER': 'cltbld', 12:35:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:47 INFO - '_': '/tools/buildbot/bin/python'} 12:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:48 INFO - Downloading/unpacking flake8 12:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:35:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:35: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 12:35: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 12:35: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 12:35: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 12:35: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 12:35: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 12:35:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:35:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:35:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:35:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:35:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:35:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:35:50 INFO - no previously-included directories found matching 'docs/_build' 12:35:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:35:50 INFO - Running setup.py install for pep8 12:35:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:35:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:35:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:35:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:35:50 INFO - no previously-included directories found matching 'docs/_build' 12:35:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:35:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:35:50 INFO - Cleaning up... 12:35:50 INFO - Return code: 0 12:35:50 INFO - Running post-action listener: _resource_record_post_action 12:35:50 INFO - Running post-action listener: _start_resource_monitoring 12:35:50 INFO - Starting resource monitoring. 12:35:50 INFO - ##### 12:35:50 INFO - ##### Running install step. 12:35:50 INFO - ##### 12:35:50 INFO - Running pre-action listener: _resource_record_pre_action 12:35:50 INFO - Running main action method: install 12:35:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:51 INFO - Reading from file tmpfile_stdout 12:35:51 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:51 INFO - Reading from file tmpfile_stdout 12:35:51 INFO - Output received: 12:35:51 INFO - Usage: mozinstall [options] installer 12:35:51 INFO - Options: 12:35:51 INFO - -h, --help show this help message and exit 12:35:51 INFO - -d DEST, --destination=DEST 12:35:51 INFO - Directory to install application into. [default: 12:35:51 INFO - "/builds/slave/test"] 12:35:51 INFO - --app=APP Application being installed. [default: firefox] 12:35:51 INFO - mkdir: /builds/slave/test/build/application 12:35:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:36:06 INFO - Reading from file tmpfile_stdout 12:36:06 INFO - Output received: 12:36:06 INFO - /builds/slave/test/build/application/firefox/firefox 12:36:06 INFO - Running post-action listener: _resource_record_post_action 12:36:06 INFO - ##### 12:36:06 INFO - ##### Running run-tests step. 12:36:06 INFO - ##### 12:36:06 INFO - Running pre-action listener: _resource_record_pre_action 12:36:06 INFO - Running main action method: run_tests 12:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:36:06 INFO - Python 2.7.3 12:36:06 INFO - Return code: 0 12:36:06 INFO - grabbing minidump binary from tooltool 12:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:06 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 0x1ea2410>, '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 0x1ea3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:36:06 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 12:36:06 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 12:36:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:36:06 INFO - Return code: 0 12:36:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:36:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:36:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:36:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:36:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:36:07 INFO - Return code: 0 12:36:07 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/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 12:36:07 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/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 12:36:07 INFO - Using env: {'DISPLAY': ':0', 12:36:07 INFO - 'HOME': '/home/cltbld', 12:36:07 INFO - 'LANG': 'en_US.UTF-8', 12:36:07 INFO - 'LANGUAGE': 'en_US:en', 12:36:07 INFO - 'LOGNAME': 'cltbld', 12:36:07 INFO - 'MAIL': '/var/mail/cltbld', 12:36:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:36:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:07 INFO - 'MOZ_NO_REMOTE': '1', 12:36:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:07 INFO - 'NO_EM_RESTART': '1', 12:36:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:07 INFO - 'PWD': '/builds/slave/test', 12:36:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:36:07 INFO - 'SHELL': '/bin/bash', 12:36:07 INFO - 'SHLVL': '1', 12:36:07 INFO - 'TERM': 'linux', 12:36:07 INFO - 'TMOUT': '86400', 12:36:07 INFO - 'USER': 'cltbld', 12:36:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386', 12:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:07 INFO - '_': '/tools/buildbot/bin/python'} 12:36:07 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/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 12:36:08 INFO - mozversion application_buildid: 20160407115853 12:36:08 INFO - mozversion application_changeset: 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 12:36:08 INFO - mozversion application_display_name: Nightly 12:36:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:36:08 INFO - mozversion application_name: Firefox 12:36:08 INFO - mozversion application_remotingname: firefox 12:36:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:36:08 INFO - mozversion application_vendor: Mozilla 12:36:08 INFO - mozversion application_version: 48.0a1 12:36:08 INFO - mozversion platform_buildid: 20160407115853 12:36:08 INFO - mozversion platform_changeset: 0559e1ea4660abf46d6ad114bb6518e9d26c5b33 12:36:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:36:08 INFO - mozversion platform_version: 48.0a1 12:36:08 INFO - using testdate: 1460057768 12:36:08 INFO - actual date: 1460057768 12:36:08 INFO - starting webserver on 'localhost:53982' 12:36:08 INFO - SUITE-START | Running 2 tests 12:36:08 INFO - TEST-START | dromaeo_css 12:36:08 INFO - operating with platform_type : linux_ 12:36:08 INFO - Initialising browser for dromaeo_css test... 12:36:08 INFO - TEST-INFO | started process 2556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpae0Ujs/profile http://localhost:53982/getInfo.html) 12:36:12 INFO - PROCESS | 2556 | 12:36:12 INFO - PROCESS | 2556 | (process:2626): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:36:12 INFO - PROCESS | 2556 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:36:12 INFO - PROCESS | 2556 | __metrics Screen width/height:1600/1200 12:36:12 INFO - PROCESS | 2556 | colorDepth:24 12:36:12 INFO - PROCESS | 2556 | Browser inner width/height: 1024/697 12:36:12 INFO - PROCESS | 2556 | __metrics 12:36:13 ERROR - PROCESS | 2556 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 12:36:14 INFO - TEST-INFO | 2556: exit 0 12:36:14 INFO - Browser initialized. 12:36:14 INFO - Running cycle 1/1 for dromaeo_css test... 12:36:14 INFO - TEST-INFO | started process 2700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpae0Ujs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:16 INFO - PROCESS | 2700 | 12:36:16 INFO - PROCESS | 2700 | (process:2813): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:36:26 INFO - PROCESS | 2700 | RSS: Main: 164249600 12:36:26 INFO - PROCESS | 2700 | 12:37:16 INFO - PROCESS | 2700 | 1460057836053 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] 12:39:27 INFO - PROCESS | 2700 | Cycle 1(1): loaded http://localhost:53982/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53982/tests/dromaeo/cssquery-ext.html) 12:39:28 INFO - PROCESS | 2700 | RSS: Main: 168521728 12:39:28 INFO - PROCESS | 2700 | 12:42:30 INFO - PROCESS | 2700 | Cycle 1(1): loaded http://localhost:53982/tests/dromaeo/cssquery-ext.html (next: http://localhost:53982/tests/dromaeo/cssquery-jquery.html) 12:42:30 INFO - PROCESS | 2700 | RSS: Main: 165298176 12:42:30 INFO - PROCESS | 2700 | 12:45:32 INFO - PROCESS | 2700 | Cycle 1(1): loaded http://localhost:53982/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53982/tests/dromaeo/cssquery-mootools.html) 12:45:33 INFO - PROCESS | 2700 | RSS: Main: 166420480 12:45:33 INFO - PROCESS | 2700 | 12:48:34 INFO - PROCESS | 2700 | Cycle 1(1): loaded http://localhost:53982/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53982/tests/dromaeo/cssquery-prototype.html) 12:48:35 INFO - PROCESS | 2700 | RSS: Main: 164012032 12:48:35 INFO - PROCESS | 2700 | 12:51:38 INFO - PROCESS | 2700 | Cycle 1(1): loaded http://localhost:53982/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53982/tests/dromaeo/cssquery-yui.html) 12:51:38 INFO - PROCESS | 2700 | RSS: Main: 165011456 12:51:38 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | Cycle 1(1): loaded http://localhost:53982/tests/dromaeo/cssquery-yui.html (next: http://localhost:53982/tests/dromaeo/cssquery-dojo.html) 12:54:41 INFO - PROCESS | 2700 | RSS: Main: 167415808 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | __start_tp_report 12:54:41 INFO - PROCESS | 2700 | _x_x_mozilla_page_load 12:54:41 INFO - PROCESS | 2700 | _x_x_mozilla_page_load_details 12:54:41 INFO - PROCESS | 2700 | |i|pagename|runs| 12:54:41 INFO - PROCESS | 2700 | |0;dojo.html;2603.5704108822047;2660.906868259611;2662.0416650006;2679.8660066996645;2682.9731702682966;4668.346431499593;4687.484376718567;4689.507601701824;4691.225947718626;4742.6205903527725;4599.586037256646;4688.132695451344;4738.6919850209715;4773.212419950704;4777.5222477752295;4244.830206791732;4332.913341733163;4335.848245311415;4390.4511936008;4499.1901457737595;4322.373255877896;4328.7402755834755;4354.042110735649;4366.345048242757;4421.557844215585;4318.762468064271;4367.388565600819;4368.410264614268;4380.540043295472;4431.512533621299;4332.415123958257;4333.934990975106;4338.609525142752;4342.066455712037;4377.802998865059;4199.118185181115;4288.592583704543;4302.225599392108;4305.9354109688065;4343.957450211958;4592.058627981256;4597.080583883237;4603.608693261077;4630.490646028934;4645.488996210414;5041.722705251246;5065.493450654942;5066.569341605968;5067.290579318898;5088.23676448532;4907.975460122712;4963.900721985576;5015.523525265094;5097.566706829887;5140.126178549655;4718.528147185254;4735.100330937111;4735.810567577328;4773.0453909218295;4793.304970779218;5179.81870634526;5187.377514698261;5192.4547922468355;5193.844184674465;5195.740212989335;4822.95177048225;4871.098846713369;4949.356583644175;4967.453580106186;5022.648414610942;4859.781309841065;5017.874553136201;5033.647644664911;5081.898362032739;5128.794848206105;4994.051130285234;5050.545450909436;5052.8484145475695;5068.138416469209;5093.617978651542;4921.926171107436;4965.652404331662;4989.925151122736;5018.172001619765;5031.22016087507;4337.240982828055;4365.126974605092;4369.847055353048;4384.079343337871;4418.07220483702;3814.599467055975;3819.866304679323;3820.331441997639;3827.942580861289;3849.4418309344987;4293.50624678166;4371.431713877176;4407.801648925806;4412.448443944507;4450.688451808407;5089.4147173074825;5120.078385890501;5120.4111527174855;5129.743512824344;5131.56381707559;4311.07311927937;4403.229434848889;4427.380166776589;4439.023414848728;4473.977630111829;4622.260438329851;4647.442306923191;4675.532446755297;4702.85891423251;4710.034442939189;4727.220008698526;4742.980259244279;4750.809967601257;4784.497627749036;4812.109759694467;4957.975210123926;5019.799208031638;5020.648554601289;5045.798168073383;5067;4787.329773831597;4805.831795887128;4826.0830442215865;4830.541098595628;4860.489648586848;4990.6007519397635;4993.101241776515;4995.300657907968;4995.750212489288;5012.799488020439;4931.9753401232765;5012.548870601663;5031.572316353151;5047.318611987334;5129.9743501282255;4811.759412029454;4871.878203044952;4962.057209130254;4962.528559786814;5010.674306170087;4882.658213924991;4941.579965702956;4943.3573635427165;4956.10790057793;4992.350994370709;4704.741239231875;4773.260144677581;4817.27740838877;4859.902801944012;4873.220284754422;4832.613390928787;4881.609471242221;4885.1450996076255;4917.409910810726;4936.136176169228;4807.278908163804;4841.1285968526;4868.95131048685;4869.366982292279;4917.631177661761 12:54:41 INFO - PROCESS | 2700 | |1;ext.html;539.0405078959451;544.0479161467432;560.949514543691;570.1704020649955;629.2071989293489;34636.30727385451;35387.82306088469;35431.2913741725;35563.644363556356;35564.644353556454;38285.23429531415;38976.297251761105;39000.609993900056;39069.60930390695;39198.41202381966;7527.811804704871;7692.692292308301;7748.573828439434;7756.379489640815;7760.573168475732;7566.583837888914;7725.111612164616;7739.2260773922435;7750;7753.418493613001;7694.653740581659;7769.9899013128215;7771.844563108734;7772.183920688331;7773.961130194341;7669.233076692342;7689.038870141232;7713.305802477804;7723.691052357899;7751.573663448508;7622.123455802598;7753.534787912743;7755.457118001742;7768.922310776877;7773;35634.10914727153;36079;36107.277854443026;36228.63771362279;36316.81841590801;2923.8099523530905;3067.309855282566;3204.247001954539;3204.7275981541598;3254.4467440534927;29057.70942290571;29623.555646665318;29736.40527189466;29962;30399;3488.389531831919;3522.2603253316834;3548.1307079765365;3575.3385623659706;3702.333579955607;241338;241813;242087;243356;243478;56802;57814.421855781744;57864;57868.42131578714;57912.42087579155;64287;64800;64979.67510162419;65055.349446505876;65180.67409662921;14633.926830365994;14725.779113313309;14852.2573871306;14869.330880110421;14941;11240.213185076966;11257.21199516026;11267.54929802815;11296.71758206035;11305.830412543819;19393.709094363596;19502.31741889027;19631.803681963283;19667.409977700692;20724;7281.5631062136445;7435.367993720594;7444.42168066646;7543.245675432413;7551.036730450122;807.4347956430522;851.8126012277289;895.9776005599912;945.2485274207022;1030.7732298894232;27740;27859.72140278612;28043.71956280411;28053.579196312072;28221.43557128846;858.4205661178679;867.1891781184613;974.2088915257735;994.2096033653263;1011.1910471622673;13688.931555342358;13922.234277114856;13977.79033314501;13983.930080349533;14130.293485325692;348715;350281;352210;352245;354083;50325;50838.74580627073;50889;50984.74507627438;51083;1197.9580714674944;1218.9756204875853;1227.3679055286534;1227.9508819647292;1253.4359538207843;25096.49807003813;26109.608355874298;26710.332241693337;26984.73015269901;27064;38951.41572876466;39623.40564891587;39777.40333895052;39862;39950.200995979336;283761;284472;285503;285550;285891;31604.841975789976;32529.512057319633;32735;32984.505232422016;33124.503132453516;40140.79929600333;40972.79513602413;40986;41390.37914431225;41604.79197603992;34869.476957845145;35649.46525802063;35673.643263567035;35919.28161436704;36121.27757444889;34753.65246347504;34763.478547821294;35259;35777.82111089428;36010.4598431029;35275.64724352724;37264.25471490501;37420.43869341908;37824.43263351107;38229;26938.36432821101;31174.786237835135;31673.366532668755;31792.36415271728;31868.68131318657;24864.627030594194;24891.25326240216;24946.251612451655;24980.625290620294;25091.87454062718 12:54:41 INFO - PROCESS | 2700 | |2;jquery.html;344.8362028036683;346.95297743314444;349.40252168791363;350.964903509649;356.7930600251854;14864.999999999987;15055.247237638116;15762.84237157628;15766.132862692548;15793.36826526939;15299.694006119871;15805.446809361645;15970.441034563764;15988;16083.517494475154;4415.889602759925;4583.243764778807;4598.310253461974;4626.65300102492;4639.930401043987;4841.61267098633;5001.949980500185;5030.572401345872;5032.094223039851;5042.924356134661;4955.554000140005;4970.155073637472;4986.401631804189;4991.226359914201;4995.0509403213455;4589.334546490773;4600.102979918917;4633.679401370593;4659.207934651101;5049.84850454487;4510.774461276923;4533.433320834895;4533.77331133442;4550.795214215335;4562.270036794131;11279.718007049807;11730.53077876884;11750.294982301004;11959.521619135225;12059.638210853689;1833.7157740550235;1881.285111657575;1882.717592361143;1893.715942608606;2015.858889877709;8156.959215203945;8383.916160838375;8850.911490885137;8914.153155450287;8974.730758077269;1727.0501224326695;1748.947531574055;1793.175139435861;1796.892186468803;1841.3371186372894;49025;54526.454735452535;55777.72111139459;61698.69150654263;63545.68227158881;9248.861267081;9393.483358415217;9583;9658.3722058066;9662.13040826329;12984.610461686165;13027.934860325639;13048.869511304956;13053.28206948627;13074.607761767162;6877.1747390313485;6969.965150174318;7019.192792828788;7049.89425158623;7103.502754807218;6589.143411356589;6722.899156512656;6733.797986060426;6747.392734653905;6855.794326170223;3983.362661974128;4102.569230230843;4120.484939382577;4149.2738770715005;4227.725197862129;1667.5580971042684;1676.9161541922856;1746.0745804723517;1758.1824451630052;1773.8226177382417;857.9618661419752;871.146276648875;953.7901661634429;977.5210147027905;993.8161440133598;15470.767938480933;16299.511014669579;16328.918355408146;16651.66696666084;16712.582185445463;831.3645742994721;883.1321754489209;885.6634478898106;901.2924853989587;912.4798864647088;8680.652773888974;8725.781855453664;8749.47503149813;9075.2286055686;9119.361644684808;313153;319377;431980;432902;436181;62106.37893621006;62894.68552657299;64189.35810641927;65119.34880651227;66125;951.1867353412871;975.6243846119153;982.5627595719836;994.0457161125256;1002.8295189817749;14207;14473.782893256399;14521.128732275674;14638.853611464176;15316;31859.36281274408;32619.673803261663;33225.667743323225;33987.3202535943;34390.82804585961;43138.56861431345;43567.56432435635;44907.55092449165;44987.775061124485;46302;10328.948355258175;10815.67552973412;10988.230823842254;11001.724956876142;11270.49282782293;11752.76494470123;12459.190152640049;12479.688007799878;12529.122961392615;12613.49546018149;6342.23893132827;9383.718488445358;10443.738906527398;10694.572217111228;11136.220464567727;10720.463976801284;10773.838392423962;10795.352278863293;10847.294925829796;11308.208425410472;10935.671929842118;11016.17378696585;11080.722981925517;11111.555537778399;11218.270812397168;10864.293820901616;11029.889701102886;11088.889111108785;11091.112710982941;11146.05258553032;10729.248952573556;10828;10843.240973131806;10944.23390362667;11238.719032024264 12:54:41 INFO - PROCESS | 2700 | |3;mootools.html;1385.1342910680823;1395.469721505828;1510.1845003697997;1715.322447633184;1722.8104908460075;6653.2681405045405;7380.483366164371;7436.739714110007;7645.044369453818;7683.193264707209;7242.674079666414;7280.199178090419;7325.560466372021;7340.743073992411;7353.7793866183965;2202.9779702203014;2221.1004543160047;2221.533477969628;2221.600111979843;2223.566404551113;2187.3219302016346;2187.6062308784494;2240.5070884405404;2248.5053288276554;2253.0649780341137;2190.759016508183;2204.801567858892;2226.3209721035078;2252.031626400647;2253.763354847742;2202.0861342542826;2208.194009186643;2213.6458166693333;2217.2350539064078;2222.9333120006427;2019.8283145932614;2032.6036422897541;2043.2542122125467;2043.6627956387179;2046.0383619698719;7303.050603421574;7341.559506429578;7429.108506979143;7450.925490745078;7456.962715186443;4604.8618541443475;4757.405324334458;4761.2382018876815;4763.952360476385;4786.617070634341;2941.661708903482;2954.4386566552284;3077.615298087739;3100.1784527100335;3113.9688603113905;924.5007695844236;925.3245131054301;936.059260443257;943.528235882059;968.5060619084318;10702.464876756208;10758.731031724192;10786.191035672278;10798.298110622783;10815.83776243357;4215.915681686411;4260.978695106566;4273.722208056466;4304.16068866568;4323.308270676676;9227.400218985878;9251.90748092524;9253.72238832836;9262.95368523153;9307.348485606079;4676.579107880307;4689.460712018094;4710.882227944328;4711.717296962193;4715.575598196178;3596.928061438809;4061.5735347788645;4116.094459218967;4229.921370050617;4246.320588705792;3598.208394153334;3656.0494271489606;3665;3675.301692678436;3683.355412802749;1195.1693572966878;1213.3690480949856;1220.4568966809684;1221.6151912147645;1236.2891337480985;1006.808706345792;1015.4770293298957;1188.0554958807595;1217.3243849663522;1233.7655845389347;6983.685734141975;7016.894746578805;7029.05107810439;7059.329363710542;7074.504784665024;469.5492327365767;477.38417441500076;477.5916591314376;486.55237181792126;488.50660832559373;5558.555315574744;5580.99542082421;5603.15952607104;5608.439156084359;5627.071533196977;9026.684066057656;9242.21441177494;9289.071092890657;9306;9507.144357007903;9140.085991400807;9141.77145571366;9149.542522873962;9162.541872906328;9199.770005749777;7131.8573628528175;7151.106111736033;7260.41916646667;7310.488265821342;7364.742234021891;7051.189113252041;7220.783376498714;7240;7243.637818109179;7259.6007219603425;8171.468854524437;8374.665013399395;8397.832043359222;8405.07544170153;8463.53450560225;8492.830143397221;8699.652013919373;8703.738887833375;8706.738797836075;8728.127187281221;6522.706478208397;6680.198376194888;6682.19813622349;6690.83272918181;6894.896576551256;7224.963875180591;7227.2772722729405;7252.456065795192;7253.854922901618;7288.744893928687;6355.269144048493;6542.313057128933;6570.77002304917;6581.14445122131;6625.304343043911;6395.296517382991;6409.807705768834;6414.5189110815945;6456.838579035561;6534.542582019403;6910.447164226749;6944.687489063105;6975.511714180162;6991.091158149408;7019.438444924496;6316.747330106744;6491.545591808717;6526.4452521536205;6535.57518761279;6546.018097285255;6345;6353.332900045613;6377.107204991397;6395.008773640093;6395.264544577433 12:54:41 INFO - PROCESS | 2700 | |4;prototype.html;316.8463295301779;322.1623778176741;326.7467712522793;328.5137995766266;329.6357524934947;5549.251985624525;5730.083186690131;5741.368449470555;5742.368339482654;5779.364269930315;5625.5218306444;5662.094064949609;5670.291213598301;5674.404187560309;5676.602637815345;4153.792310384484;4265.488141423034;4396;4402.317640765678;4402.3836662867225;4386.934195987063;4388.100439409929;4390.1878152541885;4397.670174736892;4418.779061046951;4327.567243275679;4327.610515053644;4331.7184383015165;4338.262495375794;4359.455068116486;4341.044970106587;4363.650907927358;4366.170427618742;4373.912521749563;4374.825006999717;3819.083419979213;3838.4626152338697;3841.4045822897497;3842.3660096084113;3847.6921846252512;5361.919571206435;5408.729563521808;5414.972925135349;5418.729063546807;5424.213489044067;4751.572358487718;4906.484819094015;4911.950880491185;5059.494050594948;5069.163588007974;5924.1113832924975;5932.525397968152;5966.791162309299;5972;5990.161377407167;4038.757674539537;4053.43251944728;4062.9796851015853;4071.2468193384025;4076.5719599441927;6228.688565571749;6253.499720022387;6264.373562643745;6292.842678933018;6293.496520278367;4180.372944058355;4184.686148538872;4186.832526698898;4187.24629566681;4189.120284740238;4243.533211346749;4245.0448649053715;4247.51153617338;4253.914921701548;4263.680223983214;4785.880352991203;4909.754512274372;4911.656184067152;4919.729414882216;4921.704697718148;5890.440408161217;5896.1450589664255;5899.292084949748;5921.526277897758;5926.318473375617;1479.2899408284084;1499.22789763272;1502.4065494129757;1503.804505414311;1504.646408094097;951.9571619277149;970.9902900971041;971.771633666088;979.5836769372988;980.0493521284485;5119.3088932994315;5139.743012849342;5148.588112950955;5148.716820574829;5152;6095.817125486243;6107.450329470369;6113.938860611426;6123.173371594867;6126.6017708848785;5011.974940125276;5114.43741188469;5121.615878809104;5124.89814689836;5130.666506677054;3357.815320157366;3384.1201287665385;3388.8983330500123;3393.52490651309;3395.168183794986;5864.179014937912;5865.618734782225;5879.176915231871;5881.411858814085;5890.3815099414805;6372.36276372359;6388.169537960129;6400.135981642512;6417.197850268716;6429.58207716497;5844.620099693507;5853.180554722342;5872.618279811884;5887.705614719247;5906.637345062009;6078.99696550082;6256.7810126645345;6277.71750271248;6283.842903927439;6288.905666415099;6081.483073938764;6090.208272924491;6110.175126357884;6112.205413296243;6144.6620435874665;5856.092305692625;5870.26621672291;5871.941280587311;5903.350631430625;5910.881782364415;4215.3044747616295;4215.957840421556;4227.32362821947;4232.809523571508;4238.936415953702;6182.227221597301;6236.282827474898;6239.469645080219;6240.781572645117;6248.156498872594;5771.595988280948;5945.989181839184;5995.730192141277;5995.790147344822;6004.129401236709;5945.137954996588;5976.581639285208;5982.312034115958;5998.130271110752;6021.819345419644;5860.238169037998;5878.794242201502;5886.05823068307;5889.087191485327;5897.9115313271195;6019.608725432833;6022.969885150546;6088.4215999479975;6090.269167699905;6120.326764056039;5703.401142879938;5859.150423188699;5868.647881127146;5877.970610146922;5905.4685078343155 12:54:41 INFO - PROCESS | 2700 | |5;yui.html;685.643465397993;693.6011793218901;704.3484776581661;746.1493896957472;746.2537462537463;12788.168769030019;13006.41471133799;13031.152975056615;13052.412641431134;13075.60773176804;12234.694132646666;12323.383830808469;12339.691507712312;13969.790453143185;14217;647.1296106736455;797.6490344248526;807.7455601485514;811.6104269950428;811.9594020298962;799.3764863406552;812.8943237379133;813.7274013205583;815.8001289684006;821.5235163605095;849.3417601358965;854.1842540373959;854.2653318146389;856.0882659967115;858.2061593026457;848.1560846957286;849.8300339931976;850.1413572291999;851.3104385447776;853.2193043365313;623.2116372788427;631.1384959530208;633.2369494758805;633.7211626884202;633.9049142628596;13536.120152190077;13611.251381174032;13618.046736728433;13620.59138225845;13632.045756797028;12588.622341329774;12898.613041608767;12916.397595747907;12975.351232438436;13060.477580896753;9806.852897206547;9968.451735154564;9972.90027099727;10066.69799906004;10589.9470502647;3678.5401824771902;3718.572364178127;3723.6834869036165;3725.254949010182;3741.1395379062697;44080.559194407964;45104.774476127735;45658.08683826305;45973.77013114913;46128.308075378896;9839.508024598885;9956.850647240297;10026.348287361445;10073.294869359075;10105;17317.56706082358;17922.641547169245;18066.27734890616;18090.45728628143;18198.45404637863;6438.742450301936;6461.353864613501;6499.610023398611;6574.342565743483;6634.469242460592;3530.0821786335737;3544.7131887537084;3625.492431059654;3641.6358364163902;3642.672159505604;2725.414035982273;2726.945461090807;2742.7394397532203;2754.490419272401;2756.490049340878;497.7237633113584;509.6126943522875;515.6442054982125;521.1713375732528;527.1512864288493;508.7710530261397;581.2443823030044;598.5780025082394;598.6228675934134;613.2747182955319;7507.436942229355;7596.924030759732;7614.619269036526;7702.653380597886;7887;606.7391021860554;617.2592888533777;617.6510271696567;623.7193263031654;643.9195100612424;3633.7456378053284;3750.3999360102252;3762.2099359134886;3776.6412190841825;3819.1788765415567;54725.45274547283;54863.45136548663;55188.17217741737;55239.72380138074;55324.44675553193;47005.5299447008;47710.28434573484;48038.27942580864;48305.27542086872;48718;41704.374434383506;43386.349204761325;43944.121117577466;44271.77864110659;44305;8453.788655283666;8480.575971201539;8544.102869198645;8596.312295016509;8604.48373097616;31361;32407.675923240466;32787.83606081954;33085.66914330826;33246.335073298884;38228.6177138225;39476.80261598674;40646.39030414605;41122.794386027876;41506;10118;10411.375317480975;10540.262181647211;10558.947205263925;10802.405867677038;11663.358515281741;11749.941250294036;11871.287722736663;11873.346965916957;12085;10972.725681858017;11055.336679799238;11333.886661133613;11544.884551154717;12077.154599177973;10747.731306717395;10985.450727463754;11055.778884422105;11081.889181108085;11339.376334301693;11121.16591255643;11288.379139147426;11365;11401.315921044432;11563.285751054347;9449.574769135543;9549.809003820024;9570.712878613653;9592;10101;8649.308055355683;8747.518886461306;9139.725808225763;9381.577828997575;9867.654632087842 12:54:41 INFO - PROCESS | 2700 | __end_tp_report 12:54:41 INFO - PROCESS | 2700 | __start_cc_report 12:54:41 INFO - PROCESS | 2700 | _x_x_mozilla_cycle_collect,370 12:54:41 INFO - PROCESS | 2700 | __end_cc_report 12:54:41 INFO - PROCESS | 2700 | __startTimestamp1460058881355__endTimestamp 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | ------- Summary: start ------- 12:54:41 INFO - PROCESS | 2700 | Number of tests: 6 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | [#0] dojo.html Cycles:165 Average:4675.09 Median:4805.83 stddev:476.11 (9.9%) stddev-sans-first:448.98 12:54:41 INFO - PROCESS | 2700 | Values: 2603.6 2660.9 2662.0 2679.9 2683.0 4668.3 4687.5 4689.5 4691.2 4742.6 4599.6 4688.1 4738.7 4773.2 4777.5 4244.8 4332.9 4335.8 4390.5 4499.2 4322.4 4328.7 4354.0 4366.3 4421.6 4318.8 4367.4 4368.4 4380.5 4431.5 4332.4 4333.9 4338.6 4342.1 4377.8 4199.1 4288.6 4302.2 4305.9 4344.0 4592.1 4597.1 4603.6 4630.5 4645.5 5041.7 5065.5 5066.6 5067.3 5088.2 4908.0 4963.9 5015.5 5097.6 5140.1 4718.5 4735.1 4735.8 4773.0 4793.3 5179.8 5187.4 5192.5 5193.8 5195.7 4823.0 4871.1 4949.4 4967.5 5022.6 4859.8 5017.9 5033.6 5081.9 5128.8 4994.1 5050.5 5052.8 5068.1 5093.6 4921.9 4965.7 4989.9 5018.2 5031.2 4337.2 4365.1 4369.8 4384.1 4418.1 3814.6 3819.9 3820.3 3827.9 3849.4 4293.5 4371.4 4407.8 4412.4 4450.7 5089.4 5120.1 5120.4 5129.7 5131.6 4311.1 4403.2 4427.4 4439.0 4474.0 4622.3 4647.4 4675.5 4702.9 4710.0 4727.2 4743.0 4750.8 4784.5 4812.1 4958.0 5019.8 5020.6 5045.8 5067.0 4787.3 4805.8 4826.1 4830.5 4860.5 4990.6 4993.1 4995.3 4995.8 5012.8 4932.0 5012.5 5031.6 5047.3 5130.0 4811.8 4871.9 4962.1 4962.5 5010.7 4882.7 4941.6 4943.4 4956.1 4992.4 4704.7 4773.3 4817.3 4859.9 4873.2 4832.6 4881.6 4885.1 4917.4 4936.1 4807.3 4841.1 4869.0 4869.4 4917.6 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | [#1] ext.html Cycles:180 Average:45554.82 Median:35641.79 stddev:77766.53 (218.2%) stddev-sans-first:77911.24 12:54:41 INFO - PROCESS | 2700 | Values: 539.0 544.0 560.9 570.2 629.2 34636.3 35387.8 35431.3 35563.6 35564.6 38285.2 38976.3 39000.6 39069.6 39198.4 7527.8 7692.7 7748.6 7756.4 7760.6 7566.6 7725.1 7739.2 7750.0 7753.4 7694.7 7770.0 7771.8 7772.2 7774.0 7669.2 7689.0 7713.3 7723.7 7751.6 7622.1 7753.5 7755.5 7768.9 7773.0 35634.1 36079.0 36107.3 36228.6 36316.8 2923.8 3067.3 3204.2 3204.7 3254.4 29057.7 29623.6 29736.4 29962.0 30399.0 3488.4 3522.3 3548.1 3575.3 3702.3 241338.0 241813.0 242087.0 243356.0 243478.0 56802.0 57814.4 57864.0 57868.4 57912.4 64287.0 64800.0 64979.7 65055.3 65180.7 14633.9 14725.8 14852.3 14869.3 14941.0 11240.2 11257.2 11267.5 11296.7 11305.8 19393.7 19502.3 19631.8 19667.4 20724.0 7281.6 7435.4 7444.4 7543.2 7551.0 807.4 851.8 896.0 945.2 1030.8 27740.0 27859.7 28043.7 28053.6 28221.4 858.4 867.2 974.2 994.2 1011.2 13688.9 13922.2 13977.8 13983.9 14130.3 348715.0 350281.0 352210.0 352245.0 354083.0 50325.0 50838.7 50889.0 50984.7 51083.0 1198.0 1219.0 1227.4 1228.0 1253.4 25096.5 26109.6 26710.3 26984.7 27064.0 38951.4 39623.4 39777.4 39862.0 39950.2 283761.0 284472.0 285503.0 285550.0 285891.0 31604.8 32529.5 32735.0 32984.5 33124.5 40140.8 40972.8 40986.0 41390.4 41604.8 34869.5 35649.5 35673.6 35919.3 36121.3 34753.7 34763.5 35259.0 35777.8 36010.5 35275.6 37264.3 37420.4 37824.4 38229.0 26938.4 31174.8 31673.4 31792.4 31868.7 24864.6 24891.3 24946.3 24980.6 25091.9 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | [#2] jquery.html Cycles:180 Average:22958.57 Median:2170.08 stddev:64072.13 (2952.5%) stddev-sans-first:64229.37 12:54:41 INFO - PROCESS | 2700 | Values: 344.8 347.0 349.4 351.0 356.8 14865.0 15055.2 15762.8 15766.1 15793.4 15299.7 15805.4 15970.4 15988.0 16083.5 4415.9 4583.2 4598.3 4626.7 4639.9 4841.6 5001.9 5030.6 5032.1 5042.9 4955.6 4970.2 4986.4 4991.2 4995.1 4589.3 4600.1 4633.7 4659.2 5049.8 4510.8 4533.4 4533.8 4550.8 4562.3 11279.7 11730.5 11750.3 11959.5 12059.6 1833.7 1881.3 1882.7 1893.7 2015.9 8157.0 8383.9 8850.9 8914.2 8974.7 1727.1 1748.9 1793.2 1796.9 1841.3 49025.0 54526.5 55777.7 61698.7 63545.7 9248.9 9393.5 9583.0 9658.4 9662.1 12984.6 13027.9 13048.9 13053.3 13074.6 6877.2 6970.0 7019.2 7049.9 7103.5 6589.1 6722.9 6733.8 6747.4 6855.8 3983.4 4102.6 4120.5 4149.3 4227.7 1667.6 1676.9 1746.1 1758.2 1773.8 858.0 871.1 953.8 977.5 993.8 15470.8 16299.5 16328.9 16651.7 16712.6 831.4 883.1 885.7 901.3 912.5 8680.7 8725.8 8749.5 9075.2 9119.4 313153.0 319377.0 431980.0 432902.0 436181.0 62106.4 62894.7 64189.4 65119.3 66125.0 951.2 975.6 982.6 994.0 1002.8 14207.0 14473.8 14521.1 14638.9 15316.0 31859.4 32619.7 33225.7 33987.3 34390.8 43138.6 43567.6 44907.6 44987.8 46302.0 10328.9 10815.7 10988.2 11001.7 11270.5 11752.8 12459.2 12479.7 12529.1 12613.5 6342.2 9383.7 10443.7 10694.6 11136.2 10720.5 10773.8 10795.4 10847.3 11308.2 10935.7 11016.2 11080.7 11111.6 11218.3 10864.3 11029.9 11088.9 11091.1 11146.1 10729.2 10828.0 10843.2 10944.2 11238.7 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | [#3] mootools.html Cycles:180 Average:5335.18 Median:6395.14 stddev:2818.92 (44.1%) stddev-sans-first:2811.19 12:54:41 INFO - PROCESS | 2700 | Values: 1385.1 1395.5 1510.2 1715.3 1722.8 6653.3 7380.5 7436.7 7645.0 7683.2 7242.7 7280.2 7325.6 7340.7 7353.8 2203.0 2221.1 2221.5 2221.6 2223.6 2187.3 2187.6 2240.5 2248.5 2253.1 2190.8 2204.8 2226.3 2252.0 2253.8 2202.1 2208.2 2213.6 2217.2 2222.9 2019.8 2032.6 2043.3 2043.7 2046.0 7303.1 7341.6 7429.1 7450.9 7457.0 4604.9 4757.4 4761.2 4764.0 4786.6 2941.7 2954.4 3077.6 3100.2 3114.0 924.5 925.3 936.1 943.5 968.5 10702.5 10758.7 10786.2 10798.3 10815.8 4215.9 4261.0 4273.7 4304.2 4323.3 9227.4 9251.9 9253.7 9263.0 9307.3 4676.6 4689.5 4710.9 4711.7 4715.6 3596.9 4061.6 4116.1 4229.9 4246.3 3598.2 3656.0 3665.0 3675.3 3683.4 1195.2 1213.4 1220.5 1221.6 1236.3 1006.8 1015.5 1188.1 1217.3 1233.8 6983.7 7016.9 7029.1 7059.3 7074.5 469.5 477.4 477.6 486.6 488.5 5558.6 5581.0 5603.2 5608.4 5627.1 9026.7 9242.2 9289.1 9306.0 9507.1 9140.1 9141.8 9149.5 9162.5 9199.8 7131.9 7151.1 7260.4 7310.5 7364.7 7051.2 7220.8 7240.0 7243.6 7259.6 8171.5 8374.7 8397.8 8405.1 8463.5 8492.8 8699.7 8703.7 8706.7 8728.1 6522.7 6680.2 6682.2 6690.8 6894.9 7225.0 7227.3 7252.5 7253.9 7288.7 6355.3 6542.3 6570.8 6581.1 6625.3 6395.3 6409.8 6414.5 6456.8 6534.5 6910.4 6944.7 6975.5 6991.1 7019.4 6316.7 6491.5 6526.4 6535.6 6546.0 6345.0 6353.3 6377.1 6395.0 6395.3 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | [#4] prototype.html Cycles:180 Average:4932.77 Median:5690.00 stddev:1469.94 (25.8%) stddev-sans-first:1432.66 12:54:41 INFO - PROCESS | 2700 | Values: 316.8 322.2 326.7 328.5 329.6 5549.3 5730.1 5741.4 5742.4 5779.4 5625.5 5662.1 5670.3 5674.4 5676.6 4153.8 4265.5 4396.0 4402.3 4402.4 4386.9 4388.1 4390.2 4397.7 4418.8 4327.6 4327.6 4331.7 4338.3 4359.5 4341.0 4363.7 4366.2 4373.9 4374.8 3819.1 3838.5 3841.4 3842.4 3847.7 5361.9 5408.7 5415.0 5418.7 5424.2 4751.6 4906.5 4912.0 5059.5 5069.2 5924.1 5932.5 5966.8 5972.0 5990.2 4038.8 4053.4 4063.0 4071.2 4076.6 6228.7 6253.5 6264.4 6292.8 6293.5 4180.4 4184.7 4186.8 4187.2 4189.1 4243.5 4245.0 4247.5 4253.9 4263.7 4785.9 4909.8 4911.7 4919.7 4921.7 5890.4 5896.1 5899.3 5921.5 5926.3 1479.3 1499.2 1502.4 1503.8 1504.6 952.0 971.0 971.8 979.6 980.0 5119.3 5139.7 5148.6 5148.7 5152.0 6095.8 6107.5 6113.9 6123.2 6126.6 5012.0 5114.4 5121.6 5124.9 5130.7 3357.8 3384.1 3388.9 3393.5 3395.2 5864.2 5865.6 5879.2 5881.4 5890.4 6372.4 6388.2 6400.1 6417.2 6429.6 5844.6 5853.2 5872.6 5887.7 5906.6 6079.0 6256.8 6277.7 6283.8 6288.9 6081.5 6090.2 6110.2 6112.2 6144.7 5856.1 5870.3 5871.9 5903.4 5910.9 4215.3 4216.0 4227.3 4232.8 4238.9 6182.2 6236.3 6239.5 6240.8 6248.2 5771.6 5946.0 5995.7 5995.8 6004.1 5945.1 5976.6 5982.3 5998.1 6021.8 5860.2 5878.8 5886.1 5889.1 5897.9 6019.6 6023.0 6088.4 6090.3 6120.3 5703.4 5859.2 5868.6 5878.0 5905.5 12:54:41 INFO - PROCESS | 2700 | 12:54:41 INFO - PROCESS | 2700 | [#5] yui.html Cycles:180 Average:13139.39 Median:44288.39 stddev:14949.51 (33.8%) stddev-sans-first:14962.19 12:54:41 INFO - PROCESS | 2700 | Values: 685.6 693.6 704.3 746.1 746.3 12788.2 13006.4 13031.2 13052.4 13075.6 12234.7 12323.4 12339.7 13969.8 14217.0 647.1 797.6 807.7 811.6 812.0 799.4 812.9 813.7 815.8 821.5 849.3 854.2 854.3 856.1 858.2 848.2 849.8 850.1 851.3 853.2 623.2 631.1 633.2 633.7 633.9 13536.1 13611.3 13618.0 13620.6 13632.0 12588.6 12898.6 12916.4 12975.4 13060.5 9806.9 9968.5 9972.9 10066.7 10589.9 3678.5 3718.6 3723.7 3725.3 3741.1 44080.6 45104.8 45658.1 45973.8 46128.3 9839.5 9956.9 10026.3 10073.3 10105.0 17317.6 17922.6 18066.3 18090.5 18198.5 6438.7 6461.4 6499.6 6574.3 6634.5 3530.1 3544.7 3625.5 3641.6 3642.7 2725.4 2726.9 2742.7 2754.5 2756.5 497.7 509.6 515.6 521.2 527.2 508.8 581.2 598.6 598.6 613.3 7507.4 7596.9 7614.6 7702.7 7887.0 606.7 617.3 617.7 623.7 643.9 3633.7 3750.4 3762.2 3776.6 3819.2 54725.5 54863.5 55188.2 55239.7 55324.4 47005.5 47710.3 48038.3 48305.3 48718.0 41704.4 43386.3 43944.1 44271.8 44305.0 8453.8 8480.6 8544.1 8596.3 8604.5 31361.0 32407.7 32787.8 33085.7 33246.3 38228.6 39476.8 40646.4 41122.8 41506.0 10118.0 10411.4 10540.3 10558.9 10802.4 11663.4 11749.9 11871.3 11873.3 12085.0 10972.7 11055.3 11333.9 11544.9 12077.2 10747.7 10985.5 11055.8 11081.9 11339.4 11121.2 11288.4 11365.0 11401.3 11563.3 9449.6 9549.8 9570.7 9592.0 10101.0 8649.3 8747.5 9139.7 9381.6 9867.7 12:54:41 INFO - PROCESS | 2700 | -------- Summary: end -------- 12:54:41 INFO - PROCESS | 2700 | 12:54:42 INFO - TEST-INFO | 2700: exit 0 12:54:42 INFO - TEST-OK | dromaeo_css | took 1113941ms 12:54:42 INFO - TEST-START | kraken 12:54:42 INFO - operating with platform_type : linux_ 12:54:42 INFO - Initialising browser for kraken test... 12:54:42 INFO - TEST-INFO | started process 3018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphY9DMu/profile http://localhost:53982/getInfo.html) 12:54:46 INFO - PROCESS | 3018 | 12:54:46 INFO - PROCESS | 3018 | (process:3086): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:54:46 INFO - PROCESS | 3018 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:54:47 INFO - PROCESS | 3018 | __metrics Screen width/height:1600/1200 12:54:47 INFO - PROCESS | 3018 | colorDepth:24 12:54:47 INFO - PROCESS | 3018 | Browser inner width/height: 1024/697 12:54:47 INFO - PROCESS | 3018 | __metrics 12:54:47 ERROR - PROCESS | 3018 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 12:54:48 INFO - TEST-INFO | 3018: exit 0 12:54:48 INFO - Browser initialized. 12:54:48 INFO - Running cycle 1/1 for kraken test... 12:54:48 INFO - TEST-INFO | started process 3137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphY9DMu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:50 INFO - PROCESS | 3137 | 12:54:50 INFO - PROCESS | 3137 | (process:3197): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:55:00 INFO - PROCESS | 3137 | RSS: Main: 163581952 12:55:00 INFO - PROCESS | 3137 | 12:55:03 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53982/tests/kraken/driver.html?testName=audio-beat-detection) 12:55:03 INFO - PROCESS | 3137 | RSS: Main: 166506496 12:55:03 INFO - PROCESS | 3137 | 12:55:06 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53982/tests/kraken/driver.html?testName=audio-dft) 12:55:07 INFO - PROCESS | 3137 | RSS: Main: 169910272 12:55:07 INFO - PROCESS | 3137 | 12:55:10 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53982/tests/kraken/driver.html?testName=audio-fft) 12:55:10 INFO - PROCESS | 3137 | RSS: Main: 161325056 12:55:10 INFO - PROCESS | 3137 | 12:55:13 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53982/tests/kraken/driver.html?testName=audio-oscillator) 12:55:13 INFO - PROCESS | 3137 | RSS: Main: 162496512 12:55:13 INFO - PROCESS | 3137 | 12:55:16 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53982/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:55:16 INFO - PROCESS | 3137 | RSS: Main: 163299328 12:55:16 INFO - PROCESS | 3137 | 12:55:19 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53982/tests/kraken/driver.html?testName=imaging-darkroom) 12:55:20 INFO - PROCESS | 3137 | RSS: Main: 163602432 12:55:20 INFO - PROCESS | 3137 | 12:55:24 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53982/tests/kraken/driver.html?testName=imaging-desaturate) 12:55:24 INFO - PROCESS | 3137 | RSS: Main: 163635200 12:55:24 INFO - PROCESS | 3137 | 12:55:27 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53982/tests/kraken/driver.html?testName=json-parse-financial) 12:55:28 INFO - PROCESS | 3137 | RSS: Main: 163975168 12:55:28 INFO - PROCESS | 3137 | 12:55:29 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53982/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:55:30 INFO - PROCESS | 3137 | RSS: Main: 164921344 12:55:30 INFO - PROCESS | 3137 | 12:55:32 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:55:33 INFO - PROCESS | 3137 | RSS: Main: 165396480 12:55:33 INFO - PROCESS | 3137 | 12:55:35 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:55:35 INFO - PROCESS | 3137 | RSS: Main: 164864000 12:55:35 INFO - PROCESS | 3137 | 12:55:38 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:55:38 INFO - PROCESS | 3137 | RSS: Main: 165216256 12:55:38 INFO - PROCESS | 3137 | 12:55:41 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:55:42 INFO - PROCESS | 3137 | RSS: Main: 164892672 12:55:42 INFO - PROCESS | 3137 | 12:55:43 INFO - PROCESS | 3137 | Cycle 1(1): loaded http://localhost:53982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53982/tests/kraken/driver.html?testName=ai-astar) 12:55:44 INFO - PROCESS | 3137 | RSS: Main: 166653952 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | __start_tp_report 12:55:44 INFO - PROCESS | 3137 | _x_x_mozilla_page_load 12:55:44 INFO - PROCESS | 3137 | _x_x_mozilla_page_load_details 12:55:44 INFO - PROCESS | 3137 | |i|pagename|runs| 12:55:44 INFO - PROCESS | 3137 | |0;ai-astar;115;107;113;113;113;126;112;117;117;113 12:55:44 INFO - PROCESS | 3137 | |1;audio-beat-detection;167;134;163;173;133;164;158;136;176;141 12:55:44 INFO - PROCESS | 3137 | |2;audio-dft;163;164;161;166;165;168;164;163;166;163 12:55:44 INFO - PROCESS | 3137 | |3;audio-fft;76;73;75;75;77;78;74;136;78;73 12:55:44 INFO - PROCESS | 3137 | |4;audio-oscillator;94;94;136;95;94;94;148;95;94;138 12:55:44 INFO - PROCESS | 3137 | |5;imaging-gaussian-blur;117;118;118;117;118;117;119;117;118;118 12:55:44 INFO - PROCESS | 3137 | |6;imaging-darkroom;147;148;146;147;148;146;150;151;146;147 12:55:44 INFO - PROCESS | 3137 | |7;imaging-desaturate;96;97;96;96;97;96;95;96;96;96 12:55:44 INFO - PROCESS | 3137 | |8;json-parse-financial;66;65;67;66;64;66;65;67;64;65 12:55:44 INFO - PROCESS | 3137 | |9;json-stringify-tinderbox;63;66;65;64;64;65;64;64;65;64 12:55:44 INFO - PROCESS | 3137 | |10;stanford-crypto-aes;82;84;86;85;82;85;85;83;83;87 12:55:44 INFO - PROCESS | 3137 | |11;stanford-crypto-ccm;127;116;124;117;119;120;143;121;125;121 12:55:44 INFO - PROCESS | 3137 | |12;stanford-crypto-pbkdf2;134;155;140;136;157;136;149;143;144;134 12:55:44 INFO - PROCESS | 3137 | |13;stanford-crypto-sha256-iterative;69;70;69;69;70;71;70;69;68;68 12:55:44 INFO - PROCESS | 3137 | __end_tp_report 12:55:44 INFO - PROCESS | 3137 | __start_cc_report 12:55:44 INFO - PROCESS | 3137 | _x_x_mozilla_cycle_collect,947 12:55:44 INFO - PROCESS | 3137 | __end_cc_report 12:55:44 INFO - PROCESS | 3137 | __startTimestamp1460058944197__endTimestamp 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | ------- Summary: start ------- 12:55:44 INFO - PROCESS | 3137 | Number of tests: 14 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:4.90 (4.3%) stddev-sans-first:5.20 12:55:44 INFO - PROCESS | 3137 | Values: 115.0 107.0 113.0 113.0 113.0 126.0 112.0 117.0 117.0 113.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:163.50 stddev:16.81 (10.3%) stddev-sans-first:17.21 12:55:44 INFO - PROCESS | 3137 | Values: 167.0 134.0 163.0 173.0 133.0 164.0 158.0 136.0 176.0 141.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.00 (1.2%) stddev-sans-first:2.07 12:55:44 INFO - PROCESS | 3137 | Values: 163.0 164.0 161.0 166.0 165.0 168.0 164.0 163.0 166.0 163.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:19.24 (25.5%) stddev-sans-first:20.30 12:55:44 INFO - PROCESS | 3137 | Values: 76.0 73.0 75.0 75.0 77.0 78.0 74.0 136.0 78.0 73.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:22.61 (24.1%) stddev-sans-first:23.39 12:55:44 INFO - PROCESS | 3137 | Values: 94.0 94.0 136.0 95.0 94.0 94.0 148.0 95.0 94.0 138.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:55:44 INFO - PROCESS | 3137 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 119.0 117.0 118.0 118.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.71 (1.2%) stddev-sans-first:1.80 12:55:44 INFO - PROCESS | 3137 | Values: 147.0 148.0 146.0 147.0 148.0 146.0 150.0 151.0 146.0 147.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:55:44 INFO - PROCESS | 3137 | Values: 96.0 97.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 96.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 12:55:44 INFO - PROCESS | 3137 | Values: 66.0 65.0 67.0 66.0 64.0 66.0 65.0 67.0 64.0 65.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 12:55:44 INFO - PROCESS | 3137 | Values: 63.0 66.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:85.00 stddev:1.69 (2.0%) stddev-sans-first:1.59 12:55:44 INFO - PROCESS | 3137 | Values: 82.0 84.0 86.0 85.0 82.0 85.0 85.0 83.0 83.0 87.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:122.50 stddev:7.73 (6.3%) stddev-sans-first:8.08 12:55:44 INFO - PROCESS | 3137 | Values: 127.0 116.0 124.0 117.0 119.0 120.0 143.0 121.0 125.0 121.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:143.50 stddev:8.47 (5.9%) stddev-sans-first:8.36 12:55:44 INFO - PROCESS | 3137 | Values: 134.0 155.0 140.0 136.0 157.0 136.0 149.0 143.0 144.0 134.0 12:55:44 INFO - PROCESS | 3137 | 12:55:44 INFO - PROCESS | 3137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 12:55:44 INFO - PROCESS | 3137 | Values: 69.0 70.0 69.0 69.0 70.0 71.0 70.0 69.0 68.0 68.0 12:55:44 INFO - PROCESS | 3137 | -------- Summary: end -------- 12:55:44 INFO - PROCESS | 3137 | 12:55:45 INFO - TEST-INFO | 3137: exit 0 12:55:45 INFO - TEST-OK | kraken | took 63104ms 12:55:45 INFO - SUITE-END | took 1177s 12:55:45 INFO - Completed test suite (00:19:37) 12:55:45 INFO - javascript benchmark 12:55:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.5704108822047, 2660.906868259611, 2662.0416650006, 2679.8660066996645, 2682.9731702682966, 4668.346431499593, 4687.484376718567, 4689.507601701824, 4691.225947718626, 4742.6205903527725, 4599.586037256646, 4688.132695451344, 4738.6919850209715, 4773.212419950704, 4777.5222477752295, 4244.830206791732, 4332.913341733163, 4335.848245311415, 4390.4511936008, 4499.1901457737595, 4322.373255877896, 4328.7402755834755, 4354.042110735649, 4366.345048242757, 4421.557844215585, 4318.762468064271, 4367.388565600819, 4368.410264614268, 4380.540043295472, 4431.512533621299, 4332.415123958257, 4333.934990975106, 4338.609525142752, 4342.066455712037, 4377.802998865059, 4199.118185181115, 4288.592583704543, 4302.225599392108, 4305.9354109688065, 4343.957450211958, 4592.058627981256, 4597.080583883237, 4603.608693261077, 4630.490646028934, 4645.488996210414, 5041.722705251246, 5065.493450654942, 5066.569341605968, 5067.290579318898, 5088.23676448532, 4907.975460122712, 4963.900721985576, 5015.523525265094, 5097.566706829887, 5140.126178549655, 4718.528147185254, 4735.100330937111, 4735.810567577328, 4773.0453909218295, 4793.304970779218, 5179.81870634526, 5187.377514698261, 5192.4547922468355, 5193.844184674465, 5195.740212989335, 4822.95177048225, 4871.098846713369, 4949.356583644175, 4967.453580106186, 5022.648414610942, 4859.781309841065, 5017.874553136201, 5033.647644664911, 5081.898362032739, 5128.794848206105, 4994.051130285234, 5050.545450909436, 5052.8484145475695, 5068.138416469209, 5093.617978651542, 4921.926171107436, 4965.652404331662, 4989.925151122736, 5018.172001619765, 5031.22016087507, 4337.240982828055, 4365.126974605092, 4369.847055353048, 4384.079343337871, 4418.07220483702, 3814.599467055975, 3819.866304679323, 3820.331441997639, 3827.942580861289, 3849.4418309344987, 4293.50624678166, 4371.431713877176, 4407.801648925806, 4412.448443944507, 4450.688451808407, 5089.4147173074825, 5120.078385890501, 5120.4111527174855, 5129.743512824344, 5131.56381707559, 4311.07311927937, 4403.229434848889, 4427.380166776589, 4439.023414848728, 4473.977630111829, 4622.260438329851, 4647.442306923191, 4675.532446755297, 4702.85891423251, 4710.034442939189, 4727.220008698526, 4742.980259244279, 4750.809967601257, 4784.497627749036, 4812.109759694467, 4957.975210123926, 5019.799208031638, 5020.648554601289, 5045.798168073383, 5067.0, 4787.329773831597, 4805.831795887128, 4826.0830442215865, 4830.541098595628, 4860.489648586848, 4990.6007519397635, 4993.101241776515, 4995.300657907968, 4995.750212489288, 5012.799488020439, 4931.9753401232765, 5012.548870601663, 5031.572316353151, 5047.318611987334, 5129.9743501282255, 4811.759412029454, 4871.878203044952, 4962.057209130254, 4962.528559786814, 5010.674306170087, 4882.658213924991, 4941.579965702956, 4943.3573635427165, 4956.10790057793, 4992.350994370709, 4704.741239231875, 4773.260144677581, 4817.27740838877, 4859.902801944012, 4873.220284754422, 4832.613390928787, 4881.609471242221, 4885.1450996076255, 4917.409910810726, 4936.136176169228, 4807.278908163804, 4841.1285968526, 4868.95131048685, 4869.366982292279, 4917.631177661761], "value": 4645.466933225909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.0405078959451, 544.0479161467432, 560.949514543691, 570.1704020649955, 629.2071989293489, 34636.30727385451, 35387.82306088469, 35431.2913741725, 35563.644363556356, 35564.644353556454, 38285.23429531415, 38976.297251761105, 39000.609993900056, 39069.60930390695, 39198.41202381966, 7527.811804704871, 7692.692292308301, 7748.573828439434, 7756.379489640815, 7760.573168475732, 7566.583837888914, 7725.111612164616, 7739.2260773922435, 7750.0, 7753.418493613001, 7694.653740581659, 7769.9899013128215, 7771.844563108734, 7772.183920688331, 7773.961130194341, 7669.233076692342, 7689.038870141232, 7713.305802477804, 7723.691052357899, 7751.573663448508, 7622.123455802598, 7753.534787912743, 7755.457118001742, 7768.922310776877, 7773.0, 35634.10914727153, 36079.0, 36107.277854443026, 36228.63771362279, 36316.81841590801, 2923.8099523530905, 3067.309855282566, 3204.247001954539, 3204.7275981541598, 3254.4467440534927, 29057.70942290571, 29623.555646665318, 29736.40527189466, 29962.0, 30399.0, 3488.389531831919, 3522.2603253316834, 3548.1307079765365, 3575.3385623659706, 3702.333579955607, 241338.0, 241813.0, 242087.0, 243356.0, 243478.0, 56802.0, 57814.421855781744, 57864.0, 57868.42131578714, 57912.42087579155, 64287.0, 64800.0, 64979.67510162419, 65055.349446505876, 65180.67409662921, 14633.926830365994, 14725.779113313309, 14852.2573871306, 14869.330880110421, 14941.0, 11240.213185076966, 11257.21199516026, 11267.54929802815, 11296.71758206035, 11305.830412543819, 19393.709094363596, 19502.31741889027, 19631.803681963283, 19667.409977700692, 20724.0, 7281.5631062136445, 7435.367993720594, 7444.42168066646, 7543.245675432413, 7551.036730450122, 807.4347956430522, 851.8126012277289, 895.9776005599912, 945.2485274207022, 1030.7732298894232, 27740.0, 27859.72140278612, 28043.71956280411, 28053.579196312072, 28221.43557128846, 858.4205661178679, 867.1891781184613, 974.2088915257735, 994.2096033653263, 1011.1910471622673, 13688.931555342358, 13922.234277114856, 13977.79033314501, 13983.930080349533, 14130.293485325692, 348715.0, 350281.0, 352210.0, 352245.0, 354083.0, 50325.0, 50838.74580627073, 50889.0, 50984.74507627438, 51083.0, 1197.9580714674944, 1218.9756204875853, 1227.3679055286534, 1227.9508819647292, 1253.4359538207843, 25096.49807003813, 26109.608355874298, 26710.332241693337, 26984.73015269901, 27064.0, 38951.41572876466, 39623.40564891587, 39777.40333895052, 39862.0, 39950.200995979336, 283761.0, 284472.0, 285503.0, 285550.0, 285891.0, 31604.841975789976, 32529.512057319633, 32735.0, 32984.505232422016, 33124.503132453516, 40140.79929600333, 40972.79513602413, 40986.0, 41390.37914431225, 41604.79197603992, 34869.476957845145, 35649.46525802063, 35673.643263567035, 35919.28161436704, 36121.27757444889, 34753.65246347504, 34763.478547821294, 35259.0, 35777.82111089428, 36010.4598431029, 35275.64724352724, 37264.25471490501, 37420.43869341908, 37824.43263351107, 38229.0, 26938.36432821101, 31174.786237835135, 31673.366532668755, 31792.36415271728, 31868.68131318657, 24864.627030594194, 24891.25326240216, 24946.251612451655, 24980.625290620294, 25091.87454062718], "value": 17531.963465711473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.8362028036683, 346.95297743314444, 349.40252168791363, 350.964903509649, 356.7930600251854, 14864.999999999987, 15055.247237638116, 15762.84237157628, 15766.132862692548, 15793.36826526939, 15299.694006119871, 15805.446809361645, 15970.441034563764, 15988.0, 16083.517494475154, 4415.889602759925, 4583.243764778807, 4598.310253461974, 4626.65300102492, 4639.930401043987, 4841.61267098633, 5001.949980500185, 5030.572401345872, 5032.094223039851, 5042.924356134661, 4955.554000140005, 4970.155073637472, 4986.401631804189, 4991.226359914201, 4995.0509403213455, 4589.334546490773, 4600.102979918917, 4633.679401370593, 4659.207934651101, 5049.84850454487, 4510.774461276923, 4533.433320834895, 4533.77331133442, 4550.795214215335, 4562.270036794131, 11279.718007049807, 11730.53077876884, 11750.294982301004, 11959.521619135225, 12059.638210853689, 1833.7157740550235, 1881.285111657575, 1882.717592361143, 1893.715942608606, 2015.858889877709, 8156.959215203945, 8383.916160838375, 8850.911490885137, 8914.153155450287, 8974.730758077269, 1727.0501224326695, 1748.947531574055, 1793.175139435861, 1796.892186468803, 1841.3371186372894, 49025.0, 54526.454735452535, 55777.72111139459, 61698.69150654263, 63545.68227158881, 9248.861267081, 9393.483358415217, 9583.0, 9658.3722058066, 9662.13040826329, 12984.610461686165, 13027.934860325639, 13048.869511304956, 13053.28206948627, 13074.607761767162, 6877.1747390313485, 6969.965150174318, 7019.192792828788, 7049.89425158623, 7103.502754807218, 6589.143411356589, 6722.899156512656, 6733.797986060426, 6747.392734653905, 6855.794326170223, 3983.362661974128, 4102.569230230843, 4120.484939382577, 4149.2738770715005, 4227.725197862129, 1667.5580971042684, 1676.9161541922856, 1746.0745804723517, 1758.1824451630052, 1773.8226177382417, 857.9618661419752, 871.146276648875, 953.7901661634429, 977.5210147027905, 993.8161440133598, 15470.767938480933, 16299.511014669579, 16328.918355408146, 16651.66696666084, 16712.582185445463, 831.3645742994721, 883.1321754489209, 885.6634478898106, 901.2924853989587, 912.4798864647088, 8680.652773888974, 8725.781855453664, 8749.47503149813, 9075.2286055686, 9119.361644684808, 313153.0, 319377.0, 431980.0, 432902.0, 436181.0, 62106.37893621006, 62894.68552657299, 64189.35810641927, 65119.34880651227, 66125.0, 951.1867353412871, 975.6243846119153, 982.5627595719836, 994.0457161125256, 1002.8295189817749, 14207.0, 14473.782893256399, 14521.128732275674, 14638.853611464176, 15316.0, 31859.36281274408, 32619.673803261663, 33225.667743323225, 33987.3202535943, 34390.82804585961, 43138.56861431345, 43567.56432435635, 44907.55092449165, 44987.775061124485, 46302.0, 10328.948355258175, 10815.67552973412, 10988.230823842254, 11001.724956876142, 11270.49282782293, 11752.76494470123, 12459.190152640049, 12479.688007799878, 12529.122961392615, 12613.49546018149, 6342.23893132827, 9383.718488445358, 10443.738906527398, 10694.572217111228, 11136.220464567727, 10720.463976801284, 10773.838392423962, 10795.352278863293, 10847.294925829796, 11308.208425410472, 10935.671929842118, 11016.17378696585, 11080.722981925517, 11111.555537778399, 11218.270812397168, 10864.293820901616, 11029.889701102886, 11088.889111108785, 11091.112710982941, 11146.05258553032, 10729.248952573556, 10828.0, 10843.240973131806, 10944.23390362667, 11238.719032024264], "value": 7892.914470999915, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.1342910680823, 1395.469721505828, 1510.1845003697997, 1715.322447633184, 1722.8104908460075, 6653.2681405045405, 7380.483366164371, 7436.739714110007, 7645.044369453818, 7683.193264707209, 7242.674079666414, 7280.199178090419, 7325.560466372021, 7340.743073992411, 7353.7793866183965, 2202.9779702203014, 2221.1004543160047, 2221.533477969628, 2221.600111979843, 2223.566404551113, 2187.3219302016346, 2187.6062308784494, 2240.5070884405404, 2248.5053288276554, 2253.0649780341137, 2190.759016508183, 2204.801567858892, 2226.3209721035078, 2252.031626400647, 2253.763354847742, 2202.0861342542826, 2208.194009186643, 2213.6458166693333, 2217.2350539064078, 2222.9333120006427, 2019.8283145932614, 2032.6036422897541, 2043.2542122125467, 2043.6627956387179, 2046.0383619698719, 7303.050603421574, 7341.559506429578, 7429.108506979143, 7450.925490745078, 7456.962715186443, 4604.8618541443475, 4757.405324334458, 4761.2382018876815, 4763.952360476385, 4786.617070634341, 2941.661708903482, 2954.4386566552284, 3077.615298087739, 3100.1784527100335, 3113.9688603113905, 924.5007695844236, 925.3245131054301, 936.059260443257, 943.528235882059, 968.5060619084318, 10702.464876756208, 10758.731031724192, 10786.191035672278, 10798.298110622783, 10815.83776243357, 4215.915681686411, 4260.978695106566, 4273.722208056466, 4304.16068866568, 4323.308270676676, 9227.400218985878, 9251.90748092524, 9253.72238832836, 9262.95368523153, 9307.348485606079, 4676.579107880307, 4689.460712018094, 4710.882227944328, 4711.717296962193, 4715.575598196178, 3596.928061438809, 4061.5735347788645, 4116.094459218967, 4229.921370050617, 4246.320588705792, 3598.208394153334, 3656.0494271489606, 3665.0, 3675.301692678436, 3683.355412802749, 1195.1693572966878, 1213.3690480949856, 1220.4568966809684, 1221.6151912147645, 1236.2891337480985, 1006.808706345792, 1015.4770293298957, 1188.0554958807595, 1217.3243849663522, 1233.7655845389347, 6983.685734141975, 7016.894746578805, 7029.05107810439, 7059.329363710542, 7074.504784665024, 469.5492327365767, 477.38417441500076, 477.5916591314376, 486.55237181792126, 488.50660832559373, 5558.555315574744, 5580.99542082421, 5603.15952607104, 5608.439156084359, 5627.071533196977, 9026.684066057656, 9242.21441177494, 9289.071092890657, 9306.0, 9507.144357007903, 9140.085991400807, 9141.77145571366, 9149.542522873962, 9162.541872906328, 9199.770005749777, 7131.8573628528175, 7151.106111736033, 7260.41916646667, 7310.488265821342, 7364.742234021891, 7051.189113252041, 7220.783376498714, 7240.0, 7243.637818109179, 7259.6007219603425, 8171.468854524437, 8374.665013399395, 8397.832043359222, 8405.07544170153, 8463.53450560225, 8492.830143397221, 8699.652013919373, 8703.738887833375, 8706.738797836075, 8728.127187281221, 6522.706478208397, 6680.198376194888, 6682.19813622349, 6690.83272918181, 6894.896576551256, 7224.963875180591, 7227.2772722729405, 7252.456065795192, 7253.854922901618, 7288.744893928687, 6355.269144048493, 6542.313057128933, 6570.77002304917, 6581.14445122131, 6625.304343043911, 6395.296517382991, 6409.807705768834, 6414.5189110815945, 6456.838579035561, 6534.542582019403, 6910.447164226749, 6944.687489063105, 6975.511714180162, 6991.091158149408, 7019.438444924496, 6316.747330106744, 6491.545591808717, 6526.4452521536205, 6535.57518761279, 6546.018097285255, 6345.0, 6353.332900045613, 6377.107204991397, 6395.008773640093, 6395.264544577433], "value": 4293.161019945796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.8463295301779, 322.1623778176741, 326.7467712522793, 328.5137995766266, 329.6357524934947, 5549.251985624525, 5730.083186690131, 5741.368449470555, 5742.368339482654, 5779.364269930315, 5625.5218306444, 5662.094064949609, 5670.291213598301, 5674.404187560309, 5676.602637815345, 4153.792310384484, 4265.488141423034, 4396.0, 4402.317640765678, 4402.3836662867225, 4386.934195987063, 4388.100439409929, 4390.1878152541885, 4397.670174736892, 4418.779061046951, 4327.567243275679, 4327.610515053644, 4331.7184383015165, 4338.262495375794, 4359.455068116486, 4341.044970106587, 4363.650907927358, 4366.170427618742, 4373.912521749563, 4374.825006999717, 3819.083419979213, 3838.4626152338697, 3841.4045822897497, 3842.3660096084113, 3847.6921846252512, 5361.919571206435, 5408.729563521808, 5414.972925135349, 5418.729063546807, 5424.213489044067, 4751.572358487718, 4906.484819094015, 4911.950880491185, 5059.494050594948, 5069.163588007974, 5924.1113832924975, 5932.525397968152, 5966.791162309299, 5972.0, 5990.161377407167, 4038.757674539537, 4053.43251944728, 4062.9796851015853, 4071.2468193384025, 4076.5719599441927, 6228.688565571749, 6253.499720022387, 6264.373562643745, 6292.842678933018, 6293.496520278367, 4180.372944058355, 4184.686148538872, 4186.832526698898, 4187.24629566681, 4189.120284740238, 4243.533211346749, 4245.0448649053715, 4247.51153617338, 4253.914921701548, 4263.680223983214, 4785.880352991203, 4909.754512274372, 4911.656184067152, 4919.729414882216, 4921.704697718148, 5890.440408161217, 5896.1450589664255, 5899.292084949748, 5921.526277897758, 5926.318473375617, 1479.2899408284084, 1499.22789763272, 1502.4065494129757, 1503.804505414311, 1504.646408094097, 951.9571619277149, 970.9902900971041, 971.771633666088, 979.5836769372988, 980.0493521284485, 5119.3088932994315, 5139.743012849342, 5148.588112950955, 5148.716820574829, 5152.0, 6095.817125486243, 6107.450329470369, 6113.938860611426, 6123.173371594867, 6126.6017708848785, 5011.974940125276, 5114.43741188469, 5121.615878809104, 5124.89814689836, 5130.666506677054, 3357.815320157366, 3384.1201287665385, 3388.8983330500123, 3393.52490651309, 3395.168183794986, 5864.179014937912, 5865.618734782225, 5879.176915231871, 5881.411858814085, 5890.3815099414805, 6372.36276372359, 6388.169537960129, 6400.135981642512, 6417.197850268716, 6429.58207716497, 5844.620099693507, 5853.180554722342, 5872.618279811884, 5887.705614719247, 5906.637345062009, 6078.99696550082, 6256.7810126645345, 6277.71750271248, 6283.842903927439, 6288.905666415099, 6081.483073938764, 6090.208272924491, 6110.175126357884, 6112.205413296243, 6144.6620435874665, 5856.092305692625, 5870.26621672291, 5871.941280587311, 5903.350631430625, 5910.881782364415, 4215.3044747616295, 4215.957840421556, 4227.32362821947, 4232.809523571508, 4238.936415953702, 6182.227221597301, 6236.282827474898, 6239.469645080219, 6240.781572645117, 6248.156498872594, 5771.595988280948, 5945.989181839184, 5995.730192141277, 5995.790147344822, 6004.129401236709, 5945.137954996588, 5976.581639285208, 5982.312034115958, 5998.130271110752, 6021.819345419644, 5860.238169037998, 5878.794242201502, 5886.05823068307, 5889.087191485327, 5897.9115313271195, 6019.608725432833, 6022.969885150546, 6088.4215999479975, 6090.269167699905, 6120.326764056039, 5703.401142879938, 5859.150423188699, 5868.647881127146, 5877.970610146922, 5905.4685078343155], "value": 4456.281508509928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.643465397993, 693.6011793218901, 704.3484776581661, 746.1493896957472, 746.2537462537463, 12788.168769030019, 13006.41471133799, 13031.152975056615, 13052.412641431134, 13075.60773176804, 12234.694132646666, 12323.383830808469, 12339.691507712312, 13969.790453143185, 14217.0, 647.1296106736455, 797.6490344248526, 807.7455601485514, 811.6104269950428, 811.9594020298962, 799.3764863406552, 812.8943237379133, 813.7274013205583, 815.8001289684006, 821.5235163605095, 849.3417601358965, 854.1842540373959, 854.2653318146389, 856.0882659967115, 858.2061593026457, 848.1560846957286, 849.8300339931976, 850.1413572291999, 851.3104385447776, 853.2193043365313, 623.2116372788427, 631.1384959530208, 633.2369494758805, 633.7211626884202, 633.9049142628596, 13536.120152190077, 13611.251381174032, 13618.046736728433, 13620.59138225845, 13632.045756797028, 12588.622341329774, 12898.613041608767, 12916.397595747907, 12975.351232438436, 13060.477580896753, 9806.852897206547, 9968.451735154564, 9972.90027099727, 10066.69799906004, 10589.9470502647, 3678.5401824771902, 3718.572364178127, 3723.6834869036165, 3725.254949010182, 3741.1395379062697, 44080.559194407964, 45104.774476127735, 45658.08683826305, 45973.77013114913, 46128.308075378896, 9839.508024598885, 9956.850647240297, 10026.348287361445, 10073.294869359075, 10105.0, 17317.56706082358, 17922.641547169245, 18066.27734890616, 18090.45728628143, 18198.45404637863, 6438.742450301936, 6461.353864613501, 6499.610023398611, 6574.342565743483, 6634.469242460592, 3530.0821786335737, 3544.7131887537084, 3625.492431059654, 3641.6358364163902, 3642.672159505604, 2725.414035982273, 2726.945461090807, 2742.7394397532203, 2754.490419272401, 2756.490049340878, 497.7237633113584, 509.6126943522875, 515.6442054982125, 521.1713375732528, 527.1512864288493, 508.7710530261397, 581.2443823030044, 598.5780025082394, 598.6228675934134, 613.2747182955319, 7507.436942229355, 7596.924030759732, 7614.619269036526, 7702.653380597886, 7887.0, 606.7391021860554, 617.2592888533777, 617.6510271696567, 623.7193263031654, 643.9195100612424, 3633.7456378053284, 3750.3999360102252, 3762.2099359134886, 3776.6412190841825, 3819.1788765415567, 54725.45274547283, 54863.45136548663, 55188.17217741737, 55239.72380138074, 55324.44675553193, 47005.5299447008, 47710.28434573484, 48038.27942580864, 48305.27542086872, 48718.0, 41704.374434383506, 43386.349204761325, 43944.121117577466, 44271.77864110659, 44305.0, 8453.788655283666, 8480.575971201539, 8544.102869198645, 8596.312295016509, 8604.48373097616, 31361.0, 32407.675923240466, 32787.83606081954, 33085.66914330826, 33246.335073298884, 38228.6177138225, 39476.80261598674, 40646.39030414605, 41122.794386027876, 41506.0, 10118.0, 10411.375317480975, 10540.262181647211, 10558.947205263925, 10802.405867677038, 11663.358515281741, 11749.941250294036, 11871.287722736663, 11873.346965916957, 12085.0, 10972.725681858017, 11055.336679799238, 11333.886661133613, 11544.884551154717, 12077.154599177973, 10747.731306717395, 10985.450727463754, 11055.778884422105, 11081.889181108085, 11339.376334301693, 11121.16591255643, 11288.379139147426, 11365.0, 11401.315921044432, 11563.285751054347, 9449.574769135543, 9549.809003820024, 9570.712878613653, 9592.0, 10101.0, 8649.308055355683, 8747.518886461306, 9139.725808225763, 9381.577828997575, 9867.654632087842], "value": 6038.942223810569, "unit": "score"}], "name": "dromaeo_css", "value": 6483.482085311911, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 113.0, 113.0, 113.0, 126.0, 112.0, 117.0, 117.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 134.0, 163.0, 173.0, 133.0, 164.0, 158.0, 136.0, 176.0, 141.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 166.0, 165.0, 168.0, 164.0, 163.0, 166.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 75.0, 75.0, 77.0, 78.0, 74.0, 136.0, 78.0, 73.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 136.0, 95.0, 94.0, 94.0, 148.0, 95.0, 94.0, 138.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 148.0, 146.0, 150.0, 151.0, 146.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 64.0, 66.0, 65.0, 67.0, 64.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 86.0, 85.0, 82.0, 85.0, 85.0, 83.0, 83.0, 87.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 124.0, 117.0, 119.0, 120.0, 143.0, 121.0, 125.0, 121.0], "value": 123.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 155.0, 140.0, 136.0, 157.0, 136.0, 149.0, 143.0, 144.0, 134.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 71.0, 70.0, 69.0, 68.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1534.0000000000002, "alertThreshold": 2.0}]} 12:55:45 INFO - Return code: 0 12:55:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:55:45 ERROR - # TBPL SUCCESS # 12:55:45 INFO - Running post-action listener: _resource_record_post_action 12:55:45 INFO - Running post-run listener: _resource_record_post_run 12:55:46 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 527114240; Read time: 0; Write time: 781200 12:55:46 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 224776192; Read time: 0; Write time: 561764 12:55:46 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 281858048; Read time: 0; Write time: 216420 12:55:46 INFO - Running post-run listener: _upload_blobber_files 12:55:46 INFO - Blob upload gear active. 12:55:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:55:46 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 12:55:46 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'] 12:55:46 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 12:55:46 INFO - (blobuploader) - INFO - Open directory for files ... 12:55:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:55:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:47 INFO - (blobuploader) - INFO - Done attempting. 12:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:48 INFO - (blobuploader) - INFO - Done attempting. 12:55:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:48 INFO - Return code: 0 12:55:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8e066c72f58916d8baf16699ad3db56e69db0d2b519ba0574dca58de663fa931a2071fc3ebaea42212abfdefeaa82f9061a42eefc334e6684500e00b539254b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/528ea5112c00bb252c5b0026e81e422987f4c7b498b791bcfe979c30523b858579c51d16d23ee29cbc1e4c6f12f7f944c3838af673a4b8cb42a3e52b5a7a9f7c"} 12:55:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:48 INFO - Contents: 12:55:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8e066c72f58916d8baf16699ad3db56e69db0d2b519ba0574dca58de663fa931a2071fc3ebaea42212abfdefeaa82f9061a42eefc334e6684500e00b539254b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/528ea5112c00bb252c5b0026e81e422987f4c7b498b791bcfe979c30523b858579c51d16d23ee29cbc1e4c6f12f7f944c3838af673a4b8cb42a3e52b5a7a9f7c"} 12:55:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:48 INFO - Copying logs to upload dir... 12:55:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.933658 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-07 12:55:48.056501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 12:55:48.060069) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 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/e8e066c72f58916d8baf16699ad3db56e69db0d2b519ba0574dca58de663fa931a2071fc3ebaea42212abfdefeaa82f9061a42eefc334e6684500e00b539254b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/528ea5112c00bb252c5b0026e81e422987f4c7b498b791bcfe979c30523b858579c51d16d23ee29cbc1e4c6f12f7f944c3838af673a4b8cb42a3e52b5a7a9f7c"} build_url:https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/QvoJQW68RTKX5wrZOLtNCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8e066c72f58916d8baf16699ad3db56e69db0d2b519ba0574dca58de663fa931a2071fc3ebaea42212abfdefeaa82f9061a42eefc334e6684500e00b539254b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/528ea5112c00bb252c5b0026e81e422987f4c7b498b791bcfe979c30523b858579c51d16d23ee29cbc1e4c6f12f7f944c3838af673a4b8cb42a3e52b5a7a9f7c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 12:55:48.085143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:55:48.085461) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1460056526.634811-280554386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:55:48.169545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 12:55:48.169880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 12:55:48.170184) ========= ========= Total master_lag: 0.31 =========