builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1456946056.83 results: failure (2) buildid: 20160302104121 builduid: a74d521d092c417884fa7e2f64e62aa1 revision: 63132b94b6a39f017e9952486e01b1041b5a2d9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.829164) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.829650) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.829936) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.856065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.856370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.869444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.869745) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.919466) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.919775) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.920144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:16.920412) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 11:14:16-- 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% 82.7M=0s 2016-03-02 11:14:17 (82.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:17.092445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:17.092787) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:17.143890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 11:14:17.144517) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63132b94b6a39f017e9952486e01b1041b5a2d9f --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 63132b94b6a39f017e9952486e01b1041b5a2d9f --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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 11:14:17,253 truncating revision to first 12 chars 2016-03-02 11:14:17,253 Setting DEBUG logging. 2016-03-02 11:14:17,253 attempt 1/10 2016-03-02 11:14:17,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63132b94b6a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 11:14:18,223 unpacking tar archive at: fx-team-63132b94b6a3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.240967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 11:14:18.399803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:18.400553) ========= echo 63132b94b6a39f017e9952486e01b1041b5a2d9f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'63132b94b6a39f017e9952486e01b1041b5a2d9f'] 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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 63132b94b6a39f017e9952486e01b1041b5a2d9f program finished with exit code 0 elapsedTime=0.004172 script_repo_revision: '63132b94b6a39f017e9952486e01b1041b5a2d9f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:18.454912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:18.455575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 11:14:18.465535) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' failed (results: 2, elapsed: 22 mins, 35 secs) (at 2016-03-02 11:14:18.465815) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:18 INFO - MultiFileLogger online at 20160302 11:14:18 in /builds/slave/test 11:14:18 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 11:14:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:18 INFO - {'append_to_log': False, 11:14:18 INFO - 'base_work_dir': '/builds/slave/test', 11:14:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:14:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:18 INFO - 'branch': 'Fx-Team-Non-PGO', 11:14:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:18 INFO - 'config_files': ('talos/linux_config.py',), 11:14:18 INFO - 'default_actions': ('clobber', 11:14:18 INFO - 'read-buildbot-config', 11:14:18 INFO - 'download-and-extract', 11:14:18 INFO - 'populate-webroot', 11:14:18 INFO - 'create-virtualenv', 11:14:18 INFO - 'install', 11:14:18 INFO - 'run-tests'), 11:14:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:18 INFO - 'download_minidump_stackwalk': True, 11:14:18 INFO - 'download_symbols': 'ondemand', 11:14:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:18 INFO - 'installer_path': 'installer.exe', 11:14:18 INFO - 'log_level': 'info', 11:14:18 INFO - 'log_name': 'talos', 11:14:18 INFO - 'log_to_console': True, 11:14:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:18 INFO - 'opt_config_files': (), 11:14:18 INFO - 'pip_index': False, 11:14:18 INFO - 'sps_profile': False, 11:14:18 INFO - 'sps_profile_interval': 0, 11:14:18 INFO - 'suite': 'dromaeojs-e10s', 11:14:18 INFO - 'system_bits': '32', 11:14:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:18 INFO - 'title': 'talos-linux64-ix-033', 11:14:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:18 INFO - 'use_talos_json': True, 11:14:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:18 INFO - 'work_dir': 'build'} 11:14:18 INFO - ##### 11:14:18 INFO - ##### Running clobber step. 11:14:18 INFO - ##### 11:14:18 INFO - Running pre-action listener: _resource_record_pre_action 11:14:18 INFO - Running main action method: clobber 11:14:18 INFO - rmtree: /builds/slave/test/build 11:14:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:19 INFO - Running post-action listener: _resource_record_post_action 11:14:19 INFO - ##### 11:14:19 INFO - ##### Running read-buildbot-config step. 11:14:19 INFO - ##### 11:14:19 INFO - Running pre-action listener: _resource_record_pre_action 11:14:19 INFO - Running main action method: read_buildbot_config 11:14:19 INFO - Using buildbot properties: 11:14:19 INFO - { 11:14:19 INFO - "project": "", 11:14:19 INFO - "product": "firefox", 11:14:19 INFO - "script_repo_revision": "production", 11:14:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:14:19 INFO - "repository": "", 11:14:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:14:19 INFO - "buildid": "20160302104121", 11:14:19 INFO - "pgo_build": "False", 11:14:19 INFO - "basedir": "/builds/slave/test", 11:14:19 INFO - "buildnumber": 1186, 11:14:19 INFO - "slavename": "talos-linux64-ix-033", 11:14:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:14:19 INFO - "platform": "ubuntu64_hw", 11:14:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:14:19 INFO - "branch": "fx-team", 11:14:19 INFO - "repo_path": "integration/fx-team", 11:14:19 INFO - "revision": "63132b94b6a39f017e9952486e01b1041b5a2d9f", 11:14:19 INFO - "stage_platform": "linux64", 11:14:19 INFO - "builduid": "a74d521d092c417884fa7e2f64e62aa1", 11:14:19 INFO - "slavebuilddir": "test" 11:14:19 INFO - } 11:14:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 11:14:19 INFO - Running post-action listener: _resource_record_post_action 11:14:19 INFO - ##### 11:14:19 INFO - ##### Running download-and-extract step. 11:14:19 INFO - ##### 11:14:19 INFO - Running pre-action listener: _resource_record_pre_action 11:14:19 INFO - Running main action method: download_and_extract 11:14:19 INFO - mkdir: /builds/slave/test/build/tests 11:14:19 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')]} 11:14:19 INFO - https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 11:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 11:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 11:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:14:19 INFO - Downloaded 1448 bytes. 11:14:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 11:14:19 INFO - Using the following test package requirements: 11:14:19 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:14:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'jsshell-linux-x86_64.zip'], 11:14:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:14:19 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:14:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14:19 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')]} 11:14:19 INFO - https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:20 INFO - Downloaded 22080961 bytes. 11:14:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:14:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:14:22 INFO - Return code: 0 11:14:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:14: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')]} 11:14:22 INFO - https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:14:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:14:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:23 INFO - Downloaded 22080961 bytes. 11:14:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:14:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:14:25 INFO - Return code: 0 11:14:25 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')]} 11:14:25 INFO - https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:14:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:14:26 INFO - Downloaded 10808263 bytes. 11:14:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:14:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:14:26 INFO - Return code: 0 11:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:26 INFO - https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:14:28 INFO - Downloaded 54392655 bytes. 11:14:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:14:28 INFO - mkdir: /builds/slave/test/properties 11:14:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:28 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:28 INFO - Contents: 11:14:28 INFO - build_url:https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:14:28 INFO - Running post-action listener: _resource_record_post_action 11:14:28 INFO - Running post-action listener: set_extra_try_arguments 11:14:28 INFO - ##### 11:14:28 INFO - ##### Running populate-webroot step. 11:14:28 INFO - ##### 11:14:28 INFO - Running pre-action listener: _resource_record_pre_action 11:14:28 INFO - Running main action method: populate_webroot 11:14:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:28 INFO - '--tppagecycles', 11:14:28 INFO - '7'], 11:14:28 INFO - 'tests': ['tsvgm']}}, 11:14:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:14:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:14:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:14:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'tests': ['damp', 'tps']}, 11:14:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['damp', 'tps']}, 11:14:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:14:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:28 INFO - 'other': {'tests': ['a11yr', 11:14:28 INFO - 'ts_paint', 11:14:28 INFO - 'tpaint', 11:14:28 INFO - 'sessionrestore', 11:14:28 INFO - 'sessionrestore_no_auto_restore']}, 11:14:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['a11yr', 11:14:28 INFO - 'ts_paint', 11:14:28 INFO - 'tpaint', 11:14:28 INFO - 'sessionrestore', 11:14:28 INFO - 'sessionrestore_no_auto_restore']}, 11:14:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['a11yr', 11:14:28 INFO - 'ts_paint', 11:14:28 INFO - 'tpaint', 11:14:28 INFO - 'sessionrestore', 11:14:28 INFO - 'sessionrestore_no_auto_restore']}, 11:14:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['a11yr', 11:14:28 INFO - 'ts_paint', 11:14:28 INFO - 'tpaint', 11:14:28 INFO - 'sessionrestore', 11:14:28 INFO - 'sessionrestore_no_auto_restore']}, 11:14:28 INFO - 'other_l64': {'tests': ['a11yr', 11:14:28 INFO - 'ts_paint', 11:14:28 INFO - 'tpaint', 11:14:28 INFO - 'sessionrestore', 11:14:28 INFO - 'sessionrestore_no_auto_restore']}, 11:14:28 INFO - 'other_nol64': {'tests': ['a11yr', 11:14:28 INFO - 'ts_paint', 11:14:28 INFO - 'tpaint', 11:14:28 INFO - 'sessionrestore', 11:14:28 INFO - 'sessionrestore_no_auto_restore']}, 11:14:28 INFO - 'svgr': {'tests': ['tsvgx', 11:14:28 INFO - 'tsvgr_opacity', 11:14:28 INFO - 'tart', 11:14:28 INFO - 'tscrollx', 11:14:28 INFO - 'cart']}, 11:14:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['tsvgx', 11:14:28 INFO - 'tsvgr_opacity', 11:14:28 INFO - 'tart', 11:14:28 INFO - 'tscrollx', 11:14:28 INFO - 'cart']}, 11:14:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'tests': ['tp5o']}, 11:14:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'talos_options': ['--e10s'], 11:14:28 INFO - 'tests': ['tp5o']}, 11:14:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'talos_options': ['--xperf_path', 11:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:28 INFO - 'tests': ['tp5n']}, 11:14:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:28 INFO - 'talos_options': ['--e10s', 11:14:28 INFO - '--xperf_path', 11:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:28 INFO - 'tests': ['tp5n']}}, 11:14:28 INFO - 'talos.zip': {'path': '', 11:14:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:28 INFO - Running post-action listener: _resource_record_post_action 11:14:28 INFO - ##### 11:14:28 INFO - ##### Running create-virtualenv step. 11:14:28 INFO - ##### 11:14:28 INFO - Running pre-action listener: _resource_record_pre_action 11:14:28 INFO - Running main action method: create_virtualenv 11:14:28 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:28 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 11:14:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:14:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:29 INFO - Using real prefix '/usr' 11:14:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:29 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:31 INFO - Installing pip.................done. 11:14:31 INFO - Return code: 0 11:14:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14:31 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')]} 11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 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')]} 11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14:31 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 11:14:31 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 11:14:31 INFO - Using env: {'DISPLAY': ':0', 11:14:31 INFO - 'HOME': '/home/cltbld', 11:14:31 INFO - 'LANG': 'en_US.UTF-8', 11:14:31 INFO - 'LANGUAGE': 'en_US:en', 11:14:31 INFO - 'LOGNAME': 'cltbld', 11:14:31 INFO - 'MAIL': '/var/mail/cltbld', 11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:31 INFO - 'MOZ_NO_REMOTE': '1', 11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:31 INFO - 'NO_EM_RESTART': '1', 11:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:31 INFO - 'PWD': '/builds/slave/test', 11:14:31 INFO - 'SHELL': '/bin/bash', 11:14:31 INFO - 'SHLVL': '1', 11:14:31 INFO - 'TERM': 'linux', 11:14:31 INFO - 'TMOUT': '86400', 11:14:31 INFO - 'USER': 'cltbld', 11:14:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:32 INFO - '_': '/tools/buildbot/bin/python'} 11:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:32 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 11:14:32 INFO - Cleaning up... 11:14:32 INFO - Return code: 0 11:14:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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', '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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11:14: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 psutil>=0.7.1 11:14:32 INFO - Using env: {'DISPLAY': ':0', 11:14:32 INFO - 'HOME': '/home/cltbld', 11:14:32 INFO - 'LANG': 'en_US.UTF-8', 11:14:32 INFO - 'LANGUAGE': 'en_US:en', 11:14:32 INFO - 'LOGNAME': 'cltbld', 11:14:32 INFO - 'MAIL': '/var/mail/cltbld', 11:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:32 INFO - 'MOZ_NO_REMOTE': '1', 11:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:32 INFO - 'NO_EM_RESTART': '1', 11:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:32 INFO - 'PWD': '/builds/slave/test', 11:14:32 INFO - 'SHELL': '/bin/bash', 11:14:32 INFO - 'SHLVL': '1', 11:14:32 INFO - 'TERM': 'linux', 11:14:32 INFO - 'TMOUT': '86400', 11:14:32 INFO - 'USER': 'cltbld', 11:14:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:32 INFO - '_': '/tools/buildbot/bin/python'} 11:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:32 INFO - Downloading/unpacking psutil>=0.7.1 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:34 INFO - Installing collected packages: psutil 11:14:34 INFO - Running setup.py install for psutil 11:14:34 INFO - building 'psutil._psutil_linux' extension 11:14:34 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 11:14:34 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 11:14:34 INFO - building 'psutil._psutil_posix' extension 11:14:34 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 11:14:34 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 11:14:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:34 INFO - Successfully installed psutil 11:14:34 INFO - Cleaning up... 11:14:34 INFO - Return code: 0 11:14:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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', '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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:14: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 mozsystemmonitor==0.0.0 11:14:34 INFO - Using env: {'DISPLAY': ':0', 11:14:34 INFO - 'HOME': '/home/cltbld', 11:14:34 INFO - 'LANG': 'en_US.UTF-8', 11:14:34 INFO - 'LANGUAGE': 'en_US:en', 11:14:34 INFO - 'LOGNAME': 'cltbld', 11:14:34 INFO - 'MAIL': '/var/mail/cltbld', 11:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:34 INFO - 'MOZ_NO_REMOTE': '1', 11:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:34 INFO - 'NO_EM_RESTART': '1', 11:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:34 INFO - 'PWD': '/builds/slave/test', 11:14:34 INFO - 'SHELL': '/bin/bash', 11:14:34 INFO - 'SHLVL': '1', 11:14:34 INFO - 'TERM': 'linux', 11:14:34 INFO - 'TMOUT': '86400', 11:14:34 INFO - 'USER': 'cltbld', 11:14:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:34 INFO - '_': '/tools/buildbot/bin/python'} 11:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:14:35 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 11:14:35 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 11:14:35 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 11:14:35 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 11:14:35 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 11:14:35 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 11:14:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:14:36 INFO - Installing collected packages: mozsystemmonitor 11:14:36 INFO - Running setup.py install for mozsystemmonitor 11:14:37 INFO - Successfully installed mozsystemmonitor 11:14:37 INFO - Cleaning up... 11:14:37 INFO - Return code: 0 11:14:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:37 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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14:37 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 11:14:37 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 11:14:37 INFO - Using env: {'DISPLAY': ':0', 11:14:37 INFO - 'HOME': '/home/cltbld', 11:14:37 INFO - 'LANG': 'en_US.UTF-8', 11:14:37 INFO - 'LANGUAGE': 'en_US:en', 11:14:37 INFO - 'LOGNAME': 'cltbld', 11:14:37 INFO - 'MAIL': '/var/mail/cltbld', 11:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:37 INFO - 'MOZ_NO_REMOTE': '1', 11:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:37 INFO - 'NO_EM_RESTART': '1', 11:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:37 INFO - 'PWD': '/builds/slave/test', 11:14:37 INFO - 'SHELL': '/bin/bash', 11:14:37 INFO - 'SHLVL': '1', 11:14:37 INFO - 'TERM': 'linux', 11:14:37 INFO - 'TMOUT': '86400', 11:14:37 INFO - 'USER': 'cltbld', 11:14:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:37 INFO - '_': '/tools/buildbot/bin/python'} 11:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:37 INFO - Downloading/unpacking blobuploader==1.2.4 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 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 11:14:39 INFO - Downloading docopt-0.6.1.tar.gz 11:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:39 INFO - Running setup.py install for blobuploader 11:14:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:39 INFO - Running setup.py install for requests 11:14:40 INFO - Running setup.py install for docopt 11:14:40 INFO - Successfully installed blobuploader requests docopt 11:14:40 INFO - Cleaning up... 11:14:40 INFO - Return code: 0 11:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:40 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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14:40 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 11:14:40 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 11:14:40 INFO - Using env: {'DISPLAY': ':0', 11:14:40 INFO - 'HOME': '/home/cltbld', 11:14:40 INFO - 'LANG': 'en_US.UTF-8', 11:14:40 INFO - 'LANGUAGE': 'en_US:en', 11:14:40 INFO - 'LOGNAME': 'cltbld', 11:14:40 INFO - 'MAIL': '/var/mail/cltbld', 11:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:40 INFO - 'MOZ_NO_REMOTE': '1', 11:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:40 INFO - 'NO_EM_RESTART': '1', 11:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:40 INFO - 'PWD': '/builds/slave/test', 11:14:40 INFO - 'SHELL': '/bin/bash', 11:14:40 INFO - 'SHLVL': '1', 11:14:40 INFO - 'TERM': 'linux', 11:14:40 INFO - 'TMOUT': '86400', 11:14:40 INFO - 'USER': 'cltbld', 11:14:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:40 INFO - '_': '/tools/buildbot/bin/python'} 11:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:40 INFO - Running setup.py (path:/tmp/pip-rxVa17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:40 INFO - Running setup.py (path:/tmp/pip-fgOJNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:40 INFO - Running setup.py (path:/tmp/pip-V0yvo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:40 INFO - Running setup.py (path:/tmp/pip-X2yWsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:41 INFO - Running setup.py (path:/tmp/pip-Qf1G4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:41 INFO - Running setup.py (path:/tmp/pip-NSjysa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:41 INFO - Running setup.py (path:/tmp/pip-hhLe2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:41 INFO - Running setup.py (path:/tmp/pip-uk8Len-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:41 INFO - Running setup.py (path:/tmp/pip-co1Ufs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:41 INFO - Running setup.py (path:/tmp/pip-PEL6Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:41 INFO - Running setup.py (path:/tmp/pip-gZrIAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:41 INFO - Running setup.py (path:/tmp/pip-2vm6bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:41 INFO - Running setup.py (path:/tmp/pip-Y6kPXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:41 INFO - Running setup.py (path:/tmp/pip-UQFr8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:41 INFO - Running setup.py (path:/tmp/pip-trBpnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:41 INFO - Running setup.py (path:/tmp/pip-25Fc_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:41 INFO - Running setup.py (path:/tmp/pip-z4D465-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:41 INFO - Running setup.py install for manifestparser 11:14:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozcrash 11:14:42 INFO - Running setup.py install for mozdebug 11:14:42 INFO - Running setup.py install for mozdevice 11:14:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozfile 11:14:42 INFO - Running setup.py install for mozhttpd 11:14:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozinfo 11:14:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozInstall 11:14:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozleak 11:14:42 INFO - Running setup.py install for mozlog 11:14:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for moznetwork 11:14:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Running setup.py install for mozprocess 11:14:43 INFO - Running setup.py install for mozprofile 11:14:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Running setup.py install for mozrunner 11:14:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Running setup.py install for mozscreenshot 11:14:43 INFO - Running setup.py install for moztest 11:14:43 INFO - Running setup.py install for mozversion 11:14:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:43 INFO - Cleaning up... 11:14:43 INFO - Return code: 0 11:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:43 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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14:43 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 11:14:43 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 11:14:43 INFO - Using env: {'DISPLAY': ':0', 11:14:43 INFO - 'HOME': '/home/cltbld', 11:14:43 INFO - 'LANG': 'en_US.UTF-8', 11:14:43 INFO - 'LANGUAGE': 'en_US:en', 11:14:43 INFO - 'LOGNAME': 'cltbld', 11:14:43 INFO - 'MAIL': '/var/mail/cltbld', 11:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:43 INFO - 'MOZ_NO_REMOTE': '1', 11:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:43 INFO - 'NO_EM_RESTART': '1', 11:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:43 INFO - 'PWD': '/builds/slave/test', 11:14:43 INFO - 'SHELL': '/bin/bash', 11:14:43 INFO - 'SHLVL': '1', 11:14:43 INFO - 'TERM': 'linux', 11:14:43 INFO - 'TMOUT': '86400', 11:14:43 INFO - 'USER': 'cltbld', 11:14:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:43 INFO - '_': '/tools/buildbot/bin/python'} 11:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:43 INFO - Running setup.py (path:/tmp/pip-mDPmyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:44 INFO - Running setup.py (path:/tmp/pip-5WSTRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:44 INFO - Running setup.py (path:/tmp/pip-chnG1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:44 INFO - Running setup.py (path:/tmp/pip-rBfJGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:44 INFO - Running setup.py (path:/tmp/pip-kfjEhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:44 INFO - Running setup.py (path:/tmp/pip-nSus7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:44 INFO - Running setup.py (path:/tmp/pip-G3e4Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:44 INFO - Running setup.py (path:/tmp/pip-tgAkHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:44 INFO - Running setup.py (path:/tmp/pip-c5Yibl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:44 INFO - Running setup.py (path:/tmp/pip-oAiMvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:44 INFO - Running setup.py (path:/tmp/pip-6sDu0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:44 INFO - Running setup.py (path:/tmp/pip-oGqjYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:44 INFO - Running setup.py (path:/tmp/pip-BeP8tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:44 INFO - Running setup.py (path:/tmp/pip-SM5Ily-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:44 INFO - Running setup.py (path:/tmp/pip-j0ggZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:45 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)) 11:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:45 INFO - Running setup.py (path:/tmp/pip-ZusCEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:45 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)) 11:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:45 INFO - Running setup.py (path:/tmp/pip-od_Why-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:45 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)) 11:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:45 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)) 11:14:45 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)) 11:14:45 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)) 11:14:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:47 INFO - Downloading blessings-1.6.tar.gz 11:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:47 INFO - Installing collected packages: blessings 11:14:47 INFO - Running setup.py install for blessings 11:14:47 INFO - Successfully installed blessings 11:14:47 INFO - Cleaning up... 11:14:47 INFO - Return code: 0 11:14:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:47 INFO - Reading from file tmpfile_stdout 11:14:47 INFO - Current package versions: 11:14:47 INFO - argparse == 1.2.1 11:14:47 INFO - blessings == 1.6 11:14:47 INFO - blobuploader == 1.2.4 11:14:47 INFO - docopt == 0.6.1 11:14:47 INFO - manifestparser == 1.1 11:14:47 INFO - mozInstall == 1.12 11:14:47 INFO - mozcrash == 0.16 11:14:47 INFO - mozdebug == 0.1 11:14:47 INFO - mozdevice == 0.48 11:14:47 INFO - mozfile == 1.2 11:14:47 INFO - mozhttpd == 0.7 11:14:47 INFO - mozinfo == 0.9 11:14:47 INFO - mozleak == 0.1 11:14:47 INFO - mozlog == 3.1 11:14:47 INFO - moznetwork == 0.27 11:14:47 INFO - mozprocess == 0.22 11:14:47 INFO - mozprofile == 0.28 11:14:47 INFO - mozrunner == 6.11 11:14:47 INFO - mozscreenshot == 0.1 11:14:47 INFO - mozsystemmonitor == 0.0 11:14:47 INFO - moztest == 0.7 11:14:47 INFO - mozversion == 1.4 11:14:47 INFO - psutil == 3.1.1 11:14:47 INFO - requests == 1.2.3 11:14:47 INFO - wsgiref == 0.1.2 11:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14:47 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 11:14:47 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 11:14:47 INFO - Using env: {'DISPLAY': ':0', 11:14:47 INFO - 'HOME': '/home/cltbld', 11:14:47 INFO - 'LANG': 'en_US.UTF-8', 11:14:47 INFO - 'LANGUAGE': 'en_US:en', 11:14:47 INFO - 'LOGNAME': 'cltbld', 11:14:47 INFO - 'MAIL': '/var/mail/cltbld', 11:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:47 INFO - 'MOZ_NO_REMOTE': '1', 11:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:47 INFO - 'NO_EM_RESTART': '1', 11:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:47 INFO - 'PWD': '/builds/slave/test', 11:14:47 INFO - 'SHELL': '/bin/bash', 11:14:47 INFO - 'SHLVL': '1', 11:14:47 INFO - 'TERM': 'linux', 11:14:47 INFO - 'TMOUT': '86400', 11:14:47 INFO - 'USER': 'cltbld', 11:14:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:47 INFO - '_': '/tools/buildbot/bin/python'} 11:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 INFO - Cleaning up... 11:14:47 INFO - Return code: 0 11:14:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14: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', 'jsonschema'] in /builds/slave/test/build 11:14: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 jsonschema 11:14:47 INFO - Using env: {'DISPLAY': ':0', 11:14:47 INFO - 'HOME': '/home/cltbld', 11:14:47 INFO - 'LANG': 'en_US.UTF-8', 11:14:47 INFO - 'LANGUAGE': 'en_US:en', 11:14:47 INFO - 'LOGNAME': 'cltbld', 11:14:47 INFO - 'MAIL': '/var/mail/cltbld', 11:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:47 INFO - 'MOZ_NO_REMOTE': '1', 11:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:47 INFO - 'NO_EM_RESTART': '1', 11:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:47 INFO - 'PWD': '/builds/slave/test', 11:14:47 INFO - 'SHELL': '/bin/bash', 11:14:47 INFO - 'SHLVL': '1', 11:14:47 INFO - 'TERM': 'linux', 11:14:47 INFO - 'TMOUT': '86400', 11:14:47 INFO - 'USER': 'cltbld', 11:14:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:47 INFO - '_': '/tools/buildbot/bin/python'} 11:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:47 INFO - Downloading/unpacking jsonschema 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:51 INFO - Downloading/unpacking functools32 (from jsonschema) 11:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:52 INFO - warning: no files found matching '*.txt' 11:14:52 INFO - no previously-included directories found matching 'build' 11:14:52 INFO - no previously-included directories found matching 'dist' 11:14:52 INFO - no previously-included directories found matching '.git*' 11:14:52 INFO - Installing collected packages: jsonschema, functools32 11:14:52 INFO - Running setup.py install for functools32 11:14:52 INFO - warning: no files found matching '*.txt' 11:14:52 INFO - no previously-included directories found matching 'build' 11:14:52 INFO - no previously-included directories found matching 'dist' 11:14:52 INFO - no previously-included directories found matching '.git*' 11:14:52 INFO - Successfully installed jsonschema functools32 11:14:52 INFO - Cleaning up... 11:14:52 INFO - Return code: 0 11:14:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:52 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 0x7f25b2c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd13b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', '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 11:14:52 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 11:14:52 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 11:14:52 INFO - Using env: {'DISPLAY': ':0', 11:14:52 INFO - 'HOME': '/home/cltbld', 11:14:52 INFO - 'LANG': 'en_US.UTF-8', 11:14:52 INFO - 'LANGUAGE': 'en_US:en', 11:14:52 INFO - 'LOGNAME': 'cltbld', 11:14:52 INFO - 'MAIL': '/var/mail/cltbld', 11:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:52 INFO - 'MOZ_NO_REMOTE': '1', 11:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:52 INFO - 'NO_EM_RESTART': '1', 11:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:52 INFO - 'PWD': '/builds/slave/test', 11:14:52 INFO - 'SHELL': '/bin/bash', 11:14:52 INFO - 'SHLVL': '1', 11:14:52 INFO - 'TERM': 'linux', 11:14:52 INFO - 'TMOUT': '86400', 11:14:52 INFO - 'USER': 'cltbld', 11:14:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:52 INFO - '_': '/tools/buildbot/bin/python'} 11:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:52 INFO - Downloading/unpacking flake8 11:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:14:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:14:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:15:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:15:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:15:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:15:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:15:01 INFO - no previously-included directories found matching 'docs/_build' 11:15:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:15:17 INFO - Running setup.py install for pep8 11:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:15:19 INFO - no previously-included directories found matching 'docs/_build' 11:15:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:15:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:15:33 INFO - Cleaning up... 11:15:41 INFO - Return code: 0 11:15:41 INFO - Running post-action listener: _resource_record_post_action 11:15:41 INFO - Running post-action listener: _start_resource_monitoring 11:15:41 INFO - Starting resource monitoring. 11:15:41 INFO - ##### 11:15:41 INFO - ##### Running install step. 11:15:41 INFO - ##### 11:15:41 INFO - Running pre-action listener: _resource_record_pre_action 11:15:41 INFO - Running main action method: install 11:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:41 INFO - Reading from file tmpfile_stdout 11:15:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:41 INFO - Reading from file tmpfile_stdout 11:15:41 INFO - Output received: 11:15:41 INFO - Usage: mozinstall [options] installer 11:15:41 INFO - Options: 11:15:41 INFO - -h, --help show this help message and exit 11:15:41 INFO - -d DEST, --destination=DEST 11:15:41 INFO - Directory to install application into. [default: 11:15:41 INFO - "/builds/slave/test"] 11:15:41 INFO - --app=APP Application being installed. [default: firefox] 11:15:41 INFO - mkdir: /builds/slave/test/build/application 11:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:15:57 INFO - Reading from file tmpfile_stdout 11:15:57 INFO - Output received: 11:15:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:57 INFO - Running post-action listener: _resource_record_post_action 11:15:57 INFO - ##### 11:15:57 INFO - ##### Running run-tests step. 11:15:57 INFO - ##### 11:15:57 INFO - Running pre-action listener: _resource_record_pre_action 11:15:57 INFO - Running main action method: run_tests 11:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:57 INFO - Python 2.7.3 11:15:57 INFO - Return code: 0 11:15:57 INFO - grabbing minidump binary from tooltool 11:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:57 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 0x2060100>, '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 0x2061000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2061490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:57 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 11:15:57 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 11:15:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:57 INFO - Return code: 0 11:15:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:15:58 INFO - Return code: 0 11:15:58 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/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 11:15:58 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/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 11:15:58 INFO - Using env: {'DISPLAY': ':0', 11:15:58 INFO - 'HOME': '/home/cltbld', 11:15:58 INFO - 'LANG': 'en_US.UTF-8', 11:15:58 INFO - 'LANGUAGE': 'en_US:en', 11:15:58 INFO - 'LOGNAME': 'cltbld', 11:15:58 INFO - 'MAIL': '/var/mail/cltbld', 11:15:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:58 INFO - 'MOZ_NO_REMOTE': '1', 11:15:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:58 INFO - 'NO_EM_RESTART': '1', 11:15:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:58 INFO - 'PWD': '/builds/slave/test', 11:15:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:58 INFO - 'SHELL': '/bin/bash', 11:15:58 INFO - 'SHLVL': '1', 11:15:58 INFO - 'TERM': 'linux', 11:15:58 INFO - 'TMOUT': '86400', 11:15:58 INFO - 'USER': 'cltbld', 11:15:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137', 11:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:58 INFO - '_': '/tools/buildbot/bin/python'} 11:15:58 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/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 11:15:58 INFO - mozversion application_buildid: 20160302104121 11:15:58 INFO - mozversion application_changeset: 63132b94b6a39f017e9952486e01b1041b5a2d9f 11:15:58 INFO - mozversion application_display_name: Nightly 11:15:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:58 INFO - mozversion application_name: Firefox 11:15:58 INFO - mozversion application_remotingname: firefox 11:15:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:15:58 INFO - mozversion application_vendor: Mozilla 11:15:58 INFO - mozversion application_version: 47.0a1 11:15:58 INFO - mozversion platform_buildid: 20160302104121 11:15:58 INFO - mozversion platform_changeset: 63132b94b6a39f017e9952486e01b1041b5a2d9f 11:15:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:15:58 INFO - mozversion platform_version: 47.0a1 11:15:58 INFO - using testdate: 1456946158 11:15:58 INFO - actual date: 1456946158 11:15:58 INFO - starting webserver on 'localhost:41188' 11:15:58 INFO - SUITE-START | Running 2 tests 11:15:58 INFO - TEST-START | dromaeo_css 11:15:58 INFO - operating with platform_type : linux_ 11:15:58 INFO - Initialising browser for dromaeo_css test... 11:15:58 INFO - TEST-INFO | started process 31937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVMmCQ0/profile http://localhost:41188/getInfo.html) 11:16:12 INFO - PROCESS | 31937 | 11:16:12 INFO - PROCESS | 31937 | (process:32016): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:16:15 INFO - PROCESS | 31937 | __metrics Screen width/height:1600/1200 11:16:15 INFO - PROCESS | 31937 | colorDepth:24 11:16:15 INFO - PROCESS | 31937 | Browser inner width/height: 1024/697 11:16:15 INFO - PROCESS | 31937 | __metrics 11:16:20 ERROR - PROCESS | 31937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:16:22 INFO - TEST-INFO | 31937: exit 0 11:16:22 INFO - Browser initialized. 11:16:22 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:22 INFO - TEST-INFO | started process 32071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVMmCQ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:26 INFO - PROCESS | 32071 | 11:16:26 INFO - PROCESS | 32071 | (process:32131): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:16:36 INFO - PROCESS | 32071 | RSS: Main: 163098624 11:16:36 INFO - PROCESS | 32071 | 11:17:26 INFO - PROCESS | 32071 | 1456946246581 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] 11:19:38 INFO - PROCESS | 32071 | Cycle 1(1): loaded http://localhost:41188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41188/tests/dromaeo/cssquery-ext.html) 11:19:39 INFO - PROCESS | 32071 | RSS: Main: 169791488 11:19:39 INFO - PROCESS | 32071 | 11:22:41 INFO - PROCESS | 32071 | Cycle 1(1): loaded http://localhost:41188/tests/dromaeo/cssquery-ext.html (next: http://localhost:41188/tests/dromaeo/cssquery-jquery.html) 11:22:41 INFO - PROCESS | 32071 | RSS: Main: 165937152 11:22:41 INFO - PROCESS | 32071 | 11:25:43 INFO - PROCESS | 32071 | Cycle 1(1): loaded http://localhost:41188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41188/tests/dromaeo/cssquery-mootools.html) 11:25:44 INFO - PROCESS | 32071 | RSS: Main: 165908480 11:25:44 INFO - PROCESS | 32071 | 11:28:45 INFO - PROCESS | 32071 | Cycle 1(1): loaded http://localhost:41188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41188/tests/dromaeo/cssquery-prototype.html) 11:28:46 INFO - PROCESS | 32071 | RSS: Main: 164233216 11:28:46 INFO - PROCESS | 32071 | 11:31:49 INFO - PROCESS | 32071 | Cycle 1(1): loaded http://localhost:41188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41188/tests/dromaeo/cssquery-yui.html) 11:31:49 INFO - PROCESS | 32071 | RSS: Main: 163897344 11:31:49 INFO - PROCESS | 32071 | 11:34:51 INFO - PROCESS | 32071 | Cycle 1(1): loaded http://localhost:41188/tests/dromaeo/cssquery-yui.html (next: http://localhost:41188/tests/dromaeo/cssquery-dojo.html) 11:34:52 INFO - PROCESS | 32071 | RSS: Main: 168476672 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | __start_tp_report 11:34:52 INFO - PROCESS | 32071 | _x_x_mozilla_page_load 11:34:52 INFO - PROCESS | 32071 | _x_x_mozilla_page_load_details 11:34:52 INFO - PROCESS | 32071 | |i|pagename|runs| 11:34:52 INFO - PROCESS | 32071 | |0;dojo.html;2642.2469596165092;2658.9867050664743;2704.905328313508;2711.3357227479264;2717.2663380887147;4491.955080449195;4618.607418369443;4630.07398520296;4645.6748027638;4674;4540.18276710192;4625.814967401308;4633.629309655228;4669.859904202871;4716.268978308359;4264.317709166527;4282.31482962726;4327.805248763813;4329.242382583036;4443.755593442359;4348.543402942693;4379.802908869108;4402.361657559652;4444.9555504445025;4459.576340247671;4248.129133527619;4287.742735435884;4288.120935208275;4330.39374487572;4336.132773445308;4186.455760751083;4231.576842315774;4232.746035237865;4242;4269.5516970718245;4114.177164567099;4203.831846726127;4212.347086201644;4236.639885609727;4238.788060596958;4460.085682435093;4534.9773251133865;4539.114872599845;4542.136993971168;4567.223571992769;4891.779869905828;4912;4917.262410638397;4919.852404427837;4922.064807686564;4766.046790641885;4920.6801557898625;4931.334269873557;4944.728039957801;4977.004599080162;4623.237165867594;4625.976870115628;4638.304254361805;4641.559051890065;4663.044075964385;5097.974510127426;5113.309703190096;5115.897682046339;5117.360329958755;5143.27994080829;4695.272232803921;4751.382320298339;4815.566599006106;4862.635302352267;4888.144574699413;4764.523547645277;4917.803287868445;4951.529604687549;4954.727489988013;4966.701997880139;4830.227163653799;4848.17581011229;4850.708957462493;4856.854294371175;4884.291777692286;4707.411573553306;4817.8313759018965;4823;4838.758062096881;4906.55840974314;4046.4132700758223;4063.329550624173;4080.530738965057;4096.40602112698;4109.486314210723;3587.7488575799966;3598.244368682606;3598.3702852000797;3619.040954147153;3623.474596183539;4226.154769046203;4324.718893271927;4329.285667864767;4388.956110438855;4415.205263052617;4964.553190212898;4996.400431948189;5012.223105418593;5025.974870125699;5059.544640982329;4341.544137865541;4373.671974601918;4391.451068616423;4398.428204333416;4419.911601767946;4280.743155410685;4323.718958267703;4368.4102646143;4379.912401752011;4436.201483732894;4709.081729062868;4713.245880659147;4727.976360118178;4737.786799594095;4768.642351823558;4726.456457507431;4935.703857768402;4937.382827146606;4945.653804233669;4970.179920313252;4735.905281894412;4737.052589482187;4778.235482322812;4796.472388037383;4835.637327200404;4823.614110871052;4838.080764654846;4856.587190088882;4871.634627402888;4895.265710143507;4726.669133160645;4933.654644174873;4947.183714687037;4968.8757781055765;4999.325091112799;4626.306054091913;4728.810847566197;4796.5203479651755;4836.588889944394;4851.054044461296;4778.426588809226;4787.664863459524;4794.5924596409695;4796.616270698266;4844.4186697595105;4576.222042252758;4670.719756814602;4683.648726345469;4711.081339138972;4757.833475828329;4791.544803243686;4806.831760888352;4812.25410061441;4814.229723244264;4862.124817532878;4676.532346765296;4708.788104535236;4711.269753188261;4731.479537250831;4740 11:34:52 INFO - PROCESS | 32071 | |1;ext.html;490.0835437731443;492.4017318957466;506.2431664661332;529.6345521590101;561.1414535760288;32623.67376326236;32951.34097318055;33081.338373232524;33170.17074573134;33205;35873.64126358736;36319.455208171836;36344;36352.09119772007;36386.45420318697;7677.577733224656;7846.764597062097;7849.5682737449415;7856.2536559027085;7856.921430785705;7560.130584982715;7647.885281720779;7660.540367577935;7835.294823465887;7866.370690344758;7778;7959.044914610255;7985.560794156319;8037.397195210353;8044.115147333789;7901;7923.247291507298;7966.402519810979;7989.241022102891;8011.359091272684;7732.6906923723545;7886.605669716549;7907.051153861516;7929.920700793034;7961.164077771867;36376.45435318472;36899;36942.26115477675;36942.815285923665;37012.62987370119;2363.2673871100014;2868.7991840571167;3057.281538838371;3232.5797646305828;3391.6269210386836;24471.38821529476;24673.753262467326;24826.875865620557;25152.496950060897;25191;3361.5461912641726;3364.882229121969;3404.3191361727754;3504.8422820972864;3508.386032444312;148882;148993;149255;149597.25201373923;149986;48894.266586001235;49735;49779.75110124426;50203;50216;53407;53706.19440708392;57941.4205857936;58668;58738.41261587415;10500.264981451224;10504.947475262576;10507.054365107177;10590.311629744043;10701.78596428067;8470.745877623682;8471.279941205066;8476.152384761475;8477.576121193915;8534;18136.637267254846;18321.450356489328;18323.541911452056;18361.632767344847;18465.261389544536;7470.775876723707;7676.274922402578;7713.884291735629;7828.060632723996;7950.8778240755455;838.6896848166217;866.9783255418539;906.4334790755778;916.9679061232824;967.7612655800586;25693.48613027729;25698.35754106162;25983;26006.73993260081;26058.95835607191;936.6113063078747;958.1424624960621;965.2712202287228;1017.5827910556636;1091.983620245697;13593.59219223425;13904.58286251414;14001.5099471518;14108;14184.85815141856;251017;252884;253690;254560;255219;45439.091218176116;45866.541334586895;45983.54016459793;46146;46300.3054954176;1175.9529618815322;1178.988210117905;1207.8912897839061;1212.5755985405215;1227.2943057741834;27236.863815681587;27241.86379068092;27445.394112060618;27910.581341280304;28155.155345339674;35892.461613075306;36466;36834;36850.8157459211;36962.63037369699;198960;200295;202778;202793;204110;28367.57448638231;29102.27244318909;29170.854145729136;29181.270468238465;29357.85321073381;37978.62021379861;38009.4298585527;38764.41853372145;39149.80425097857;39434;32399.676003239667;32493.675063249066;33011.834940825145;33347.166320842174;33687.494687579216;32346.514802278456;32591.511127332633;32772.83613581917;33093;33340.333193335515;26365.34086647849;31453;32558.51162232521;33182.336353273284;33488.83255583706;27582.44835103327;27638.723612763613;27755.722442775314;27995.720042799312;28385.85807071034;22286.21998230119;22731.204407845646;22803;22832.602576729205;22840 11:34:52 INFO - PROCESS | 32071 | |2;jquery.html;302.7986389051281;322.56775920266836;326.9836508174591;339.18933748341453;341.346321793765;14890.77663835042;15081.698366032673;15146.652268898311;15451.150186739726;15521.456749013787;13347.599572012856;13547.661308467294;13574.660633484167;13703.314834258272;14012.64968375791;4834.589059929901;5071.366079240095;5076.974615126919;5088.033273678007;5118.488151184889;4760.547747963955;4901.901961960759;4924.876878078041;5050.873728156789;5065.670731402465;4930;4932.432770231416;4946.72792996385;4957.380327459067;4982.202847544394;4902.289168070628;4927.433345165316;5185.922211166836;5200.427952925175;5203.427622961472;4970.080535101018;4993.575546078588;4999.400071991385;5012.473690262506;5013.799448022075;11100.61147859821;11188.272762270426;11311.490982905789;11327.660170194908;11427.714307142305;1853.898035608041;1856.5729882127052;1877.7277294792316;1879.6992481203079;1964.057252518799;8102.837943241102;8301.875471867927;8533.402661813676;8564.82870342596;8750.256228220609;1717.9570510737205;1721.079222615907;1812.3747307179003;1833;1839.6336643016564;39762.20475590472;49822.750886245696;50748.492515074744;56224;57700;8863.202311791842;8917.331200160013;9144.222741067084;9196.862047069299;9381.859272110923;12141.664416914133;12157.148999570121;12223.327716975651;12224.26654400721;12248.387580620933;6330.272018717815;6418.390252925965;6451.677416129175;6506.284308726036;6530.640814755234;5930.940690593039;6022.939770602238;6086.756529738761;6092.75628974836;6127.540434467343;3923.2349691810396;3938.8030598469963;3988.2422339755353;4035.8183881725395;4101.7744024078365;1652.8264532224184;1663.3097264635041;1682.200954546605;1691.205133587212;1693.9491815245563;858.3433673239977;874.309295656437;891.6255172827427;941.5527624378502;946.5693109635099;14994.775078373834;15181.392744290326;15368.308426120851;15674.9216253918;15769.29038193284;803.5901690137955;833.1210572845706;835.9038710548243;837.409626213518;870.7692461497708;8736.213740763362;8831.161039701217;8963.865542016874;9032.23226025782;9169.083091690778;349099;355689;356357;358983;364995;51744;62597.37402625915;63978.6801066001;64710.676446617465;64893.351066489675;864.0063926484468;868.7133246028922;882.6601758323092;885.7608445719619;892.5849479991834;13611.591652250449;13628.318584070956;13843.861561384258;13917.652058698613;14108.082974606617;20507.82511890458;24869.378265543506;28250.858745706963;28422;32054.358912821146;44142.558574413844;44155.337669934335;44512.10975780531;44535.55464445314;45039.774801125786;7046.929530704628;7078.433725302067;7146;7153.964230178815;7239.239879812544;9617.422954622745;10844.186685998424;11013.779724405627;11036.448177590928;11352.432378380883;9276.907230927603;9402.059794020543;9675.177609903238;9774.462404567817;10010.099091081838;9718.854217186607;9890.406575605486;9977;10016.098551130433;10122.139618132542;9718.659846905324;9813.264005199495;9890.159336456481;9910.851337229804;10026.298159129083;7080.929190708027;7177;7206.063211782434;7214.89177662346;7376.446766492427;7304.196538380667;8202.302804261466;9497.287703422133;9558.56986435626;9826.55780489894 11:34:52 INFO - PROCESS | 32071 | |3;mootools.html;1356.3692882809494;1371.49254775733;1490.6795039066599;1707.8292170782915;1726.5683579105223;6065.150878876961;6999.755008574701;7115.359617634412;7392.778216653503;7400.148982866972;7175.533590316639;7182.245864184264;7199.964000180005;7276.490645654793;7285.7814265572115;1994.0727561683814;2010.4370776182618;2018.3440381875948;2019.7778244393105;2020.9393718188478;1989.214260367154;1991.4722598511405;2002.1490866381803;2006.237629700719;2018.6770116781317;2006.7491563554556;2031.8069783370556;2045.7442819647545;2049.313479984207;2052.363767232155;2028.5739994601224;2036.1651722793583;2036.307655397172;2039.2454791727007;2047.0890453748088;1982.3953694123286;1996.111730280026;2009.2666176845346;2016.7680716717618;2021.050106449966;7303.196648368676;7315.926840731578;7360.742374016883;7365.668544915492;7418;3952.26883026641;4013.3578627419765;4033.233685599727;4045.878623641266;4057.8579749708915;2575.703794063669;2664.6669166354204;2722.6460560127257;2728.645276114112;2733.685626152978;820.3519219816338;840.5419046619546;857.7040920882285;862.4049405909965;1718.8195239499798;9589.856152157723;9647.179989700884;9651.324407291493;9682.273829462818;9694.418334899858;3537.34559106561;3549.5208146900354;3632.4369722693023;3705.81470926458;3719.423489359154;7505.66224519887;7534.321911028033;7569.280918312751;7571.091469023752;7622.923770762332;3884.4950156479476;3921.568627450978;3953.644172024474;3988.2422339755353;4003.339448990942;3162.446571849917;3628.6552777486095;3683.336999340091;3711.294853977736;3713.294474049976;2995.3559984603417;3030.9545356819667;3032.605761251023;3050.4966680497914;3090.242890491844;861.9569021548898;875.8073223890734;877.3989816975393;880.2825697056878;882.139913584263;835.6364981233183;902.5577467041103;1158.9304641721524;1174.4656181437426;1182.9826349339562;7097.609631470319;7138.643067846587;7154.785356439315;7178.066851309296;7203.243659415686;1037.6731329631143;1043.8225501664735;1073.130764081097;1079.8002369561657;1086.5273605981424;5047.369078865142;5076.771545280471;5092.567131793765;5111.897762044812;5134.845954621367;8469.576521173916;8929.10708929102;8945.373823832399;8956.910430895608;8997.910020899839;8822.867656985021;8841.071687472722;8903.777405564782;8909.064548222474;8955.149260820212;6839.316068393121;6908.3091690830515;6946.583205007716;6949.3745562899585;7002.299770022957;6713.462922966249;6714.294999025032;6724;6743.662816859235;6753.1220941277315;7838.686452541834;8035.67857285702;8051.355891528547;8106.432549721463;8230.506169629842;8184.918150818416;8260;8308.833823323379;8347.83304333922;8382.748517544484;5916.378780228014;5967.194428752063;5994.190784244071;6084.787032453843;6151.354107818794;6681.064650948968;6696.397324240842;6759.932400675931;6813.454923606;6825.8634827302185;5995.730192141451;6002.0996850472775;6051.183090282755;6181.96909015452;6311.558190926591;5876.294844618673;5926.851828704317;5938.673372964528;5957.493613042767;6165.907511387243;6543.901841472287;6579.671016449254;6626.337366263335;6633.469322454095;6658.7336506539195;6164.599301045418;6204.627722336674;6205.844853878689;6211.068339749074;6227.128202051807;6161.784337548164;6232.345603711727;6237.656928868956;6241.78153764616;6246.937530624636 11:34:52 INFO - PROCESS | 32071 | |4;prototype.html;292.4969053228448;294.4581969176715;301.3385618567246;302.330338300664;305.65308374994373;5527.115661494162;5555.777768889245;5588.608797384185;5622.269105016342;5684.090545512719;5501.339839219289;5587.161925711145;5612.07400778871;5612.382637909837;5613.578981576388;4070.3080476319096;4167.6249137577615;4216.367544868263;4223.704340696145;4226.492820861486;4186.079062606237;4186.099988502471;4186.665066794649;4196.727212731163;4197.349410841324;4123.8969025774295;4143.1713657268665;4143.97928010361;4151.543330233671;4161.83352665893;4159.792010399498;4161.542230354644;4163.3130533461945;4164.354525048607;4169.020280234143;3582.910427239314;3583.62371950944;3583.6595523425235;3586.8385922633283;3586.8385922633543;5284.5243928046275;5299.205119232108;5306.8407947761625;5309.4425085365865;5312.707801070939;4585.518520555327;4701.576858082754;4705.247160454345;4710.505396933307;4712.175369310357;5661.264035675377;5720.8855822883725;5733.569982251348;5738.110592858114;5779.913301300484;3826.617338266179;3829.4447305140875;3833.1758671885677;3836.712246581518;3838.366669499529;6017.879642407172;6110.358412366682;6113.633182009049;6117.418845209698;6130.938690613081;3961.801909904493;3961.8217180226957;3964.226975739703;3965.385365268388;3974.364101743707;4026.094128820992;4030.153667729751;4030.556638769733;4031.4355990161403;4032.697547683935;4576.336431217454;4684.859454216379;4703.741294228782;4711.7879695413785;4719.693219940693;5795.536357091507;5796.507296879812;5804.4775970162045;5805.129230615357;5809.8547536311935;1403.277312184226;1424.3661570600982;1424.64383904024;1426.1514398932618;1428.3857941085432;928.178561972659;930.251147825993;943.5470973932413;949.1694767078806;957.5690939077443;5116.258142569381;5120.257562653469;5132.461091585405;5138.922916156186;5142.460041695568;5988.9401105989255;6004.249468816398;6017.849553761103;6027.126066720301;6036.547258955596;5070.340855688737;5092.159793634083;5099.923501147486;5119.462456442095;5119.769610367543;3187.171335452753;3254.332861763333;3274.476083826624;3302.2734998300334;3304.1739565108724;5801.9419805802245;5811.506021988093;5819.505342045889;5820;5829.94170058294;6255.906161407583;6279.183706118175;6282.371762823681;6285.371462853678;6298.464630506367;5775.509081728016;5796.275465566889;5798.362180160179;5798.826035218865;5807;5899.67551784656;6069.5751297410525;6075.058365953284;6084.69576521181;6122.173506576555;5816.94183058164;5965.492933100735;5966.075258334965;5966.403359663999;5966.880662386641;5759.71201439918;5781.075027995501;5783.7397317119985;5796.333421656564;5807.506361959281;3956.169204466979;3990.3415936371334;3991;3991.900202494961;4000.559938406831;6030.909536357046;6077.24034495688;6122.448979591858;6138.0179171332375;6142.262928448615;5672.517835983987;5845.357010728731;5858.297004359334;5860.472557469848;5862.794802181903;5814.186013957965;5822.359540450462;5840.094785308284;5859.94140058594;5868.618539794899;5747.885042299047;5787.797427090031;5804.21643078179;5804.535637148933;5818.214541037075;5876.08920617305;5881;5891.646501209942;5909.674967876808;5925.40745925404;5546.611737178358;5724.341700704473;5739.368669446274;5751.166080918327;5760.423957604206 11:34:52 INFO - PROCESS | 32071 | |5;yui.html;670.7707901679912;671.8992151177323;709.4359983812865;725.7677543186181;777.8327659553197;10707.678769636914;11018.944905275483;11070.667879963614;11094.778104437906;11098.223124381286;10888.346699198033;11324.490397932092;11427;11482.598109066184;11497.770044599103;597.4145337569184;754.4718696912156;761.4213197969527;775.5075527040342;779.2635959018729;763.9885401718979;766.4290103872622;769.1231995525078;769.6075001749092;772.3010675338827;805.8468890910738;806.2662976691212;806.544302469106;812.6383759227147;813.4224700462679;796.8924195233657;802.8875957365973;804.505229283989;805.1988271669668;806.6813608624619;585.3853453873415;587.4654064801053;588.1383772772908;588.2705445247905;590.2326974932613;11685.883141168564;11742.706432339175;11761.117916156323;11800.114991375682;11801.586944456903;11600.4199790011;11694.356810375426;11920.523179072827;11956.461959211856;12046.337451440168;8766.780830479225;8975.147361000694;9094.136057074567;9095.090490950919;9146.77133071672;3213.9839300803346;3230.5315729219133;3237.87048518059;3305.2067503798917;3341.799492030486;41343.586564134275;41718;41766.58233417657;41959.1608167838;42433.57566424296;9092.499912504743;9125.726228213165;9237.630494780133;9335.859962100574;9507.952460237655;15596;15737.527874163794;15750.9212453937;15789.368425262861;15911.840881591035;6370.872582548323;6502.187226596676;6628.635425051669;6663.333666633298;6860.211075726255;3555.5555555555557;3618.2944325856206;3679.5584529856055;3684.7236457265813;3719.683826874746;2631.052820984444;2631.2369412870053;2634.697009843854;2649.324422272347;2651.681798184192;447.085709723616;448.3946671992784;452.3328091065652;461.71373748276284;461.9376384188092;478.45695136020174;492.88663607370506;577.9192909259712;582.7698059266651;606.1937622961451;7811.296983271419;7909.485883417559;7956.9602151988865;8106.837863242702;8147.75556733299;554.7559074007423;595.1311085814759;595.1340799137331;601.2904772368647;620.0513214781391;3390.7626466147135;3394.287199688044;3468.4623883298127;3505.1237190702323;3614.367485689994;49889.25166122511;50431.243531347056;50823.745881270355;50844.74577627088;50925;43857.56142438599;44189.337159942625;44279.11441771211;44428.777856110515;45049;39241.41137882934;39833.601663983565;40072.79963600163;40477.595224047975;40890.386644200364;6929.203141638574;6955.826104347432;7103.147622285359;7113.75101871432;7179.605121718356;30964.69035309708;31266.53100203544;31374;31950.68049319477;32175;37213;37648.81175594214;40884.18231635291;41120.38319425151;41365.58634413738;8657.52383618907;8803.515806630698;8879.689210877588;8937.910620893708;9027.729168124966;9169.680492854273;9232.723018309462;9263.429393383105;9406.153446189875;9453.149216570542;8972.506512141634;9026.232770214605;9102.499362535124;9108.863367049633;9326.347155699035;9389.24886009104;10011.499425028866;10087.848682269625;10193.592256309961;10687.839682404614;9436.480993545421;9827.55775990068;10218.335808172445;10218.744531386776;10304;8563.272121869462;8701.216890479887;8723.52020638871;8847.24798392144;9050.683226087056;8371.706990255556;8406.83186336282;8512;8516.361272904682;8623.482591044558 11:34:52 INFO - PROCESS | 32071 | __end_tp_report 11:34:52 INFO - PROCESS | 32071 | __start_cc_report 11:34:52 INFO - PROCESS | 32071 | _x_x_mozilla_cycle_collect,367 11:34:52 INFO - PROCESS | 32071 | __end_cc_report 11:34:52 INFO - PROCESS | 32071 | __startTimestamp1456947292237__endTimestamp 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | ------- Summary: start ------- 11:34:52 INFO - PROCESS | 32071 | Number of tests: 6 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | [#0] dojo.html Cycles:165 Average:4564.68 Median:4709.08 stddev:460.61 (9.8%) stddev-sans-first:436.64 11:34:52 INFO - PROCESS | 32071 | Values: 2642.2 2659.0 2704.9 2711.3 2717.3 4492.0 4618.6 4630.1 4645.7 4674.0 4540.2 4625.8 4633.6 4669.9 4716.3 4264.3 4282.3 4327.8 4329.2 4443.8 4348.5 4379.8 4402.4 4445.0 4459.6 4248.1 4287.7 4288.1 4330.4 4336.1 4186.5 4231.6 4232.7 4242.0 4269.6 4114.2 4203.8 4212.3 4236.6 4238.8 4460.1 4535.0 4539.1 4542.1 4567.2 4891.8 4912.0 4917.3 4919.9 4922.1 4766.0 4920.7 4931.3 4944.7 4977.0 4623.2 4626.0 4638.3 4641.6 4663.0 5098.0 5113.3 5115.9 5117.4 5143.3 4695.3 4751.4 4815.6 4862.6 4888.1 4764.5 4917.8 4951.5 4954.7 4966.7 4830.2 4848.2 4850.7 4856.9 4884.3 4707.4 4817.8 4823.0 4838.8 4906.6 4046.4 4063.3 4080.5 4096.4 4109.5 3587.7 3598.2 3598.4 3619.0 3623.5 4226.2 4324.7 4329.3 4389.0 4415.2 4964.6 4996.4 5012.2 5026.0 5059.5 4341.5 4373.7 4391.5 4398.4 4419.9 4280.7 4323.7 4368.4 4379.9 4436.2 4709.1 4713.2 4728.0 4737.8 4768.6 4726.5 4935.7 4937.4 4945.7 4970.2 4735.9 4737.1 4778.2 4796.5 4835.6 4823.6 4838.1 4856.6 4871.6 4895.3 4726.7 4933.7 4947.2 4968.9 4999.3 4626.3 4728.8 4796.5 4836.6 4851.1 4778.4 4787.7 4794.6 4796.6 4844.4 4576.2 4670.7 4683.6 4711.1 4757.8 4791.5 4806.8 4812.3 4814.2 4862.1 4676.5 4708.8 4711.3 4731.5 4740.0 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | [#1] ext.html Cycles:180 Average:36160.15 Median:3363.21 stddev:53648.60 (1595.2%) stddev-sans-first:53732.24 11:34:52 INFO - PROCESS | 32071 | Values: 490.1 492.4 506.2 529.6 561.1 32623.7 32951.3 33081.3 33170.2 33205.0 35873.6 36319.5 36344.0 36352.1 36386.5 7677.6 7846.8 7849.6 7856.3 7856.9 7560.1 7647.9 7660.5 7835.3 7866.4 7778.0 7959.0 7985.6 8037.4 8044.1 7901.0 7923.2 7966.4 7989.2 8011.4 7732.7 7886.6 7907.1 7929.9 7961.2 36376.5 36899.0 36942.3 36942.8 37012.6 2363.3 2868.8 3057.3 3232.6 3391.6 24471.4 24673.8 24826.9 25152.5 25191.0 3361.5 3364.9 3404.3 3504.8 3508.4 148882.0 148993.0 149255.0 149597.3 149986.0 48894.3 49735.0 49779.8 50203.0 50216.0 53407.0 53706.2 57941.4 58668.0 58738.4 10500.3 10504.9 10507.1 10590.3 10701.8 8470.7 8471.3 8476.2 8477.6 8534.0 18136.6 18321.5 18323.5 18361.6 18465.3 7470.8 7676.3 7713.9 7828.1 7950.9 838.7 867.0 906.4 917.0 967.8 25693.5 25698.4 25983.0 26006.7 26059.0 936.6 958.1 965.3 1017.6 1092.0 13593.6 13904.6 14001.5 14108.0 14184.9 251017.0 252884.0 253690.0 254560.0 255219.0 45439.1 45866.5 45983.5 46146.0 46300.3 1176.0 1179.0 1207.9 1212.6 1227.3 27236.9 27241.9 27445.4 27910.6 28155.2 35892.5 36466.0 36834.0 36850.8 36962.6 198960.0 200295.0 202778.0 202793.0 204110.0 28367.6 29102.3 29170.9 29181.3 29357.9 37978.6 38009.4 38764.4 39149.8 39434.0 32399.7 32493.7 33011.8 33347.2 33687.5 32346.5 32591.5 32772.8 33093.0 33340.3 26365.3 31453.0 32558.5 33182.3 33488.8 27582.4 27638.7 27755.7 27995.7 28385.9 22286.2 22731.2 22803.0 22832.6 22840.0 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | [#2] jquery.html Cycles:180 Average:21167.79 Median:27402.48 stddev:58542.40 (213.6%) stddev-sans-first:58685.67 11:34:52 INFO - PROCESS | 32071 | Values: 302.8 322.6 327.0 339.2 341.3 14890.8 15081.7 15146.7 15451.2 15521.5 13347.6 13547.7 13574.7 13703.3 14012.6 4834.6 5071.4 5077.0 5088.0 5118.5 4760.5 4901.9 4924.9 5050.9 5065.7 4930.0 4932.4 4946.7 4957.4 4982.2 4902.3 4927.4 5185.9 5200.4 5203.4 4970.1 4993.6 4999.4 5012.5 5013.8 11100.6 11188.3 11311.5 11327.7 11427.7 1853.9 1856.6 1877.7 1879.7 1964.1 8102.8 8301.9 8533.4 8564.8 8750.3 1718.0 1721.1 1812.4 1833.0 1839.6 39762.2 49822.8 50748.5 56224.0 57700.0 8863.2 8917.3 9144.2 9196.9 9381.9 12141.7 12157.1 12223.3 12224.3 12248.4 6330.3 6418.4 6451.7 6506.3 6530.6 5930.9 6022.9 6086.8 6092.8 6127.5 3923.2 3938.8 3988.2 4035.8 4101.8 1652.8 1663.3 1682.2 1691.2 1693.9 858.3 874.3 891.6 941.6 946.6 14994.8 15181.4 15368.3 15674.9 15769.3 803.6 833.1 835.9 837.4 870.8 8736.2 8831.2 8963.9 9032.2 9169.1 349099.0 355689.0 356357.0 358983.0 364995.0 51744.0 62597.4 63978.7 64710.7 64893.4 864.0 868.7 882.7 885.8 892.6 13611.6 13628.3 13843.9 13917.7 14108.1 20507.8 24869.4 28250.9 28422.0 32054.4 44142.6 44155.3 44512.1 44535.6 45039.8 7046.9 7078.4 7146.0 7154.0 7239.2 9617.4 10844.2 11013.8 11036.4 11352.4 9276.9 9402.1 9675.2 9774.5 10010.1 9718.9 9890.4 9977.0 10016.1 10122.1 9718.7 9813.3 9890.2 9910.9 10026.3 7080.9 7177.0 7206.1 7214.9 7376.4 7304.2 8202.3 9497.3 9558.6 9826.6 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | [#3] mootools.html Cycles:180 Average:4978.37 Median:6193.30 stddev:2654.15 (42.9%) stddev-sans-first:2647.63 11:34:52 INFO - PROCESS | 32071 | Values: 1356.4 1371.5 1490.7 1707.8 1726.6 6065.2 6999.8 7115.4 7392.8 7400.1 7175.5 7182.2 7200.0 7276.5 7285.8 1994.1 2010.4 2018.3 2019.8 2020.9 1989.2 1991.5 2002.1 2006.2 2018.7 2006.7 2031.8 2045.7 2049.3 2052.4 2028.6 2036.2 2036.3 2039.2 2047.1 1982.4 1996.1 2009.3 2016.8 2021.1 7303.2 7315.9 7360.7 7365.7 7418.0 3952.3 4013.4 4033.2 4045.9 4057.9 2575.7 2664.7 2722.6 2728.6 2733.7 820.4 840.5 857.7 862.4 1718.8 9589.9 9647.2 9651.3 9682.3 9694.4 3537.3 3549.5 3632.4 3705.8 3719.4 7505.7 7534.3 7569.3 7571.1 7622.9 3884.5 3921.6 3953.6 3988.2 4003.3 3162.4 3628.7 3683.3 3711.3 3713.3 2995.4 3031.0 3032.6 3050.5 3090.2 862.0 875.8 877.4 880.3 882.1 835.6 902.6 1158.9 1174.5 1183.0 7097.6 7138.6 7154.8 7178.1 7203.2 1037.7 1043.8 1073.1 1079.8 1086.5 5047.4 5076.8 5092.6 5111.9 5134.8 8469.6 8929.1 8945.4 8956.9 8997.9 8822.9 8841.1 8903.8 8909.1 8955.1 6839.3 6908.3 6946.6 6949.4 7002.3 6713.5 6714.3 6724.0 6743.7 6753.1 7838.7 8035.7 8051.4 8106.4 8230.5 8184.9 8260.0 8308.8 8347.8 8382.7 5916.4 5967.2 5994.2 6084.8 6151.4 6681.1 6696.4 6759.9 6813.5 6825.9 5995.7 6002.1 6051.2 6182.0 6311.6 5876.3 5926.9 5938.7 5957.5 6165.9 6543.9 6579.7 6626.3 6633.5 6658.7 6164.6 6204.6 6205.8 6211.1 6227.1 6161.8 6232.3 6237.7 6241.8 6246.9 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | [#4] prototype.html Cycles:180 Average:4792.93 Median:5600.34 stddev:1462.11 (26.1%) stddev-sans-first:1426.66 11:34:52 INFO - PROCESS | 32071 | Values: 292.5 294.5 301.3 302.3 305.7 5527.1 5555.8 5588.6 5622.3 5684.1 5501.3 5587.2 5612.1 5612.4 5613.6 4070.3 4167.6 4216.4 4223.7 4226.5 4186.1 4186.1 4186.7 4196.7 4197.3 4123.9 4143.2 4144.0 4151.5 4161.8 4159.8 4161.5 4163.3 4164.4 4169.0 3582.9 3583.6 3583.7 3586.8 3586.8 5284.5 5299.2 5306.8 5309.4 5312.7 4585.5 4701.6 4705.2 4710.5 4712.2 5661.3 5720.9 5733.6 5738.1 5779.9 3826.6 3829.4 3833.2 3836.7 3838.4 6017.9 6110.4 6113.6 6117.4 6130.9 3961.8 3961.8 3964.2 3965.4 3974.4 4026.1 4030.2 4030.6 4031.4 4032.7 4576.3 4684.9 4703.7 4711.8 4719.7 5795.5 5796.5 5804.5 5805.1 5809.9 1403.3 1424.4 1424.6 1426.2 1428.4 928.2 930.3 943.5 949.2 957.6 5116.3 5120.3 5132.5 5138.9 5142.5 5988.9 6004.2 6017.8 6027.1 6036.5 5070.3 5092.2 5099.9 5119.5 5119.8 3187.2 3254.3 3274.5 3302.3 3304.2 5801.9 5811.5 5819.5 5820.0 5829.9 6255.9 6279.2 6282.4 6285.4 6298.5 5775.5 5796.3 5798.4 5798.8 5807.0 5899.7 6069.6 6075.1 6084.7 6122.2 5816.9 5965.5 5966.1 5966.4 5966.9 5759.7 5781.1 5783.7 5796.3 5807.5 3956.2 3990.3 3991.0 3991.9 4000.6 6030.9 6077.2 6122.4 6138.0 6142.3 5672.5 5845.4 5858.3 5860.5 5862.8 5814.2 5822.4 5840.1 5859.9 5868.6 5747.9 5787.8 5804.2 5804.5 5818.2 5876.1 5881.0 5891.6 5909.7 5925.4 5546.6 5724.3 5739.4 5751.2 5760.4 11:34:52 INFO - PROCESS | 32071 | 11:34:52 INFO - PROCESS | 32071 | [#5] yui.html Cycles:180 Average:12037.22 Median:580.34 stddev:13970.59 (2407.3%) stddev-sans-first:13983.71 11:34:52 INFO - PROCESS | 32071 | Values: 670.8 671.9 709.4 725.8 777.8 10707.7 11018.9 11070.7 11094.8 11098.2 10888.3 11324.5 11427.0 11482.6 11497.8 597.4 754.5 761.4 775.5 779.3 764.0 766.4 769.1 769.6 772.3 805.8 806.3 806.5 812.6 813.4 796.9 802.9 804.5 805.2 806.7 585.4 587.5 588.1 588.3 590.2 11685.9 11742.7 11761.1 11800.1 11801.6 11600.4 11694.4 11920.5 11956.5 12046.3 8766.8 8975.1 9094.1 9095.1 9146.8 3214.0 3230.5 3237.9 3305.2 3341.8 41343.6 41718.0 41766.6 41959.2 42433.6 9092.5 9125.7 9237.6 9335.9 9508.0 15596.0 15737.5 15750.9 15789.4 15911.8 6370.9 6502.2 6628.6 6663.3 6860.2 3555.6 3618.3 3679.6 3684.7 3719.7 2631.1 2631.2 2634.7 2649.3 2651.7 447.1 448.4 452.3 461.7 461.9 478.5 492.9 577.9 582.8 606.2 7811.3 7909.5 7957.0 8106.8 8147.8 554.8 595.1 595.1 601.3 620.1 3390.8 3394.3 3468.5 3505.1 3614.4 49889.3 50431.2 50823.7 50844.7 50925.0 43857.6 44189.3 44279.1 44428.8 45049.0 39241.4 39833.6 40072.8 40477.6 40890.4 6929.2 6955.8 7103.1 7113.8 7179.6 30964.7 31266.5 31374.0 31950.7 32175.0 37213.0 37648.8 40884.2 41120.4 41365.6 8657.5 8803.5 8879.7 8937.9 9027.7 9169.7 9232.7 9263.4 9406.2 9453.1 8972.5 9026.2 9102.5 9108.9 9326.3 9389.2 10011.5 10087.8 10193.6 10687.8 9436.5 9827.6 10218.3 10218.7 10304.0 8563.3 8701.2 8723.5 8847.2 9050.7 8371.7 8406.8 8512.0 8516.4 8623.5 11:34:52 INFO - PROCESS | 32071 | -------- Summary: end -------- 11:34:52 INFO - PROCESS | 32071 | 11:34:53 INFO - TEST-INFO | 32071: exit 0 11:34:53 INFO - TEST-OK | dromaeo_css | took 1134930ms 11:34:53 INFO - TEST-START | kraken 11:34:53 INFO - operating with platform_type : linux_ 11:34:53 INFO - Initialising browser for kraken test... 11:34:53 INFO - TEST-INFO | started process 32309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_KLkWa/profile http://localhost:41188/getInfo.html) 11:35:02 INFO - PROCESS | 32309 | 11:35:02 INFO - PROCESS | 32309 | (process:32382): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:35:05 INFO - PROCESS | 32309 | __metrics Screen width/height:1600/1200 11:35:05 INFO - PROCESS | 32309 | colorDepth:24 11:35:05 INFO - PROCESS | 32309 | Browser inner width/height: 1024/697 11:35:05 INFO - PROCESS | 32309 | __metrics 11:35:08 ERROR - PROCESS | 32309 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:35:10 INFO - TEST-INFO | 32309: exit 0 11:35:10 INFO - Browser initialized. 11:35:10 INFO - Running cycle 1/1 for kraken test... 11:35:10 INFO - TEST-INFO | started process 32437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_KLkWa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:11 INFO - PROCESS | 32437 | 11:35:11 INFO - PROCESS | 32437 | (process:32495): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:35:22 INFO - PROCESS | 32437 | RSS: Main: 161193984 11:35:22 INFO - PROCESS | 32437 | 11:35:24 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41188/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:25 INFO - PROCESS | 32437 | RSS: Main: 167383040 11:35:25 INFO - PROCESS | 32437 | 11:35:28 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41188/tests/kraken/driver.html?testName=audio-dft) 11:35:28 INFO - PROCESS | 32437 | RSS: Main: 169689088 11:35:28 INFO - PROCESS | 32437 | 11:35:31 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41188/tests/kraken/driver.html?testName=audio-fft) 11:35:32 INFO - PROCESS | 32437 | RSS: Main: 164929536 11:35:32 INFO - PROCESS | 32437 | 11:35:34 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41188/tests/kraken/driver.html?testName=audio-oscillator) 11:35:35 INFO - PROCESS | 32437 | RSS: Main: 165425152 11:35:35 INFO - PROCESS | 32437 | 11:35:37 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:37 INFO - PROCESS | 32437 | RSS: Main: 165900288 11:35:37 INFO - PROCESS | 32437 | 11:35:41 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41188/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:41 INFO - PROCESS | 32437 | RSS: Main: 165289984 11:35:41 INFO - PROCESS | 32437 | 11:35:45 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41188/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:45 INFO - PROCESS | 32437 | RSS: Main: 163471360 11:35:45 INFO - PROCESS | 32437 | 11:35:48 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41188/tests/kraken/driver.html?testName=json-parse-financial) 11:35:49 INFO - PROCESS | 32437 | RSS: Main: 164667392 11:35:49 INFO - PROCESS | 32437 | 11:35:51 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:51 INFO - PROCESS | 32437 | RSS: Main: 164683776 11:35:51 INFO - PROCESS | 32437 | 11:35:53 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:54 INFO - PROCESS | 32437 | RSS: Main: 163733504 11:35:54 INFO - PROCESS | 32437 | 11:35:56 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:35:57 INFO - PROCESS | 32437 | RSS: Main: 163827712 11:35:57 INFO - PROCESS | 32437 | 11:35:59 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:00 INFO - PROCESS | 32437 | RSS: Main: 165060608 11:36:00 INFO - PROCESS | 32437 | 11:36:02 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:03 INFO - PROCESS | 32437 | RSS: Main: 163696640 11:36:03 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | Cycle 1(1): loaded http://localhost:41188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41188/tests/kraken/driver.html?testName=ai-astar) 11:36:05 INFO - PROCESS | 32437 | RSS: Main: 166252544 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | __start_tp_report 11:36:05 INFO - PROCESS | 32437 | _x_x_mozilla_page_load 11:36:05 INFO - PROCESS | 32437 | _x_x_mozilla_page_load_details 11:36:05 INFO - PROCESS | 32437 | |i|pagename|runs| 11:36:05 INFO - PROCESS | 32437 | |0;ai-astar;115;111;114;114;114;126;113;114;114;116 11:36:05 INFO - PROCESS | 32437 | |1;audio-beat-detection;159;134;154;171;142;166;164;141;180;137 11:36:05 INFO - PROCESS | 32437 | |2;audio-dft;164;166;165;164;166;175;163;164;167;164 11:36:05 INFO - PROCESS | 32437 | |3;audio-fft;74;77;74;150;74;75;84;75;158;74 11:36:05 INFO - PROCESS | 32437 | |4;audio-oscillator;98;95;145;95;94;96;145;97;95;143 11:36:05 INFO - PROCESS | 32437 | |5;imaging-gaussian-blur;118;117;118;118;118;118;119;117;118;118 11:36:05 INFO - PROCESS | 32437 | |6;imaging-darkroom;148;148;147;147;148;147;148;147;148;148 11:36:05 INFO - PROCESS | 32437 | |7;imaging-desaturate;97;97;96;97;96;96;96;96;96;96 11:36:05 INFO - PROCESS | 32437 | |8;json-parse-financial;66;68;67;66;69;67;67;74;65;65 11:36:05 INFO - PROCESS | 32437 | |9;json-stringify-tinderbox;71;71;71;71;72;73;70;71;71;71 11:36:05 INFO - PROCESS | 32437 | |10;stanford-crypto-aes;86;86;87;86;85;86;92;85;86;87 11:36:05 INFO - PROCESS | 32437 | |11;stanford-crypto-ccm;121;128;124;126;126;128;130;129;127;130 11:36:05 INFO - PROCESS | 32437 | |12;stanford-crypto-pbkdf2;148;155;156;156;157;142;154;161;161;141 11:36:05 INFO - PROCESS | 32437 | |13;stanford-crypto-sha256-iterative;71;71;73;72;74;73;71;73;72;70 11:36:05 INFO - PROCESS | 32437 | __end_tp_report 11:36:05 INFO - PROCESS | 32437 | __start_cc_report 11:36:05 INFO - PROCESS | 32437 | _x_x_mozilla_cycle_collect,866 11:36:05 INFO - PROCESS | 32437 | __end_cc_report 11:36:05 INFO - PROCESS | 32437 | __startTimestamp1456947365530__endTimestamp 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | ------- Summary: start ------- 11:36:05 INFO - PROCESS | 32437 | Number of tests: 14 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#0] ai-astar Cycles:10 Average:115.10 Median:114.00 stddev:4.04 (3.5%) stddev-sans-first:4.28 11:36:05 INFO - PROCESS | 32437 | Values: 115.0 111.0 114.0 114.0 114.0 126.0 113.0 114.0 114.0 116.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:161.50 stddev:15.74 (9.7%) stddev-sans-first:16.62 11:36:05 INFO - PROCESS | 32437 | Values: 159.0 134.0 154.0 171.0 142.0 166.0 164.0 141.0 180.0 137.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.46 (2.1%) stddev-sans-first:3.61 11:36:05 INFO - PROCESS | 32437 | Values: 164.0 166.0 165.0 164.0 166.0 175.0 163.0 164.0 167.0 164.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#3] audio-fft Cycles:10 Average:91.50 Median:74.50 stddev:33.13 (44.5%) stddev-sans-first:34.53 11:36:05 INFO - PROCESS | 32437 | Values: 74.0 77.0 74.0 150.0 74.0 75.0 84.0 75.0 158.0 74.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:95.00 stddev:23.52 (24.8%) stddev-sans-first:24.52 11:36:05 INFO - PROCESS | 32437 | Values: 98.0 95.0 145.0 95.0 94.0 96.0 145.0 97.0 95.0 143.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:36:05 INFO - PROCESS | 32437 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 119.0 117.0 118.0 118.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 11:36:05 INFO - PROCESS | 32437 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 148.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:36:05 INFO - PROCESS | 32437 | Values: 97.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:67.00 stddev:2.63 (3.9%) stddev-sans-first:2.74 11:36:05 INFO - PROCESS | 32437 | Values: 66.0 68.0 67.0 66.0 69.0 67.0 67.0 74.0 65.0 65.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 11:36:05 INFO - PROCESS | 32437 | Values: 71.0 71.0 71.0 71.0 72.0 73.0 70.0 71.0 71.0 71.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.00 stddev:2.01 (2.3%) stddev-sans-first:2.12 11:36:05 INFO - PROCESS | 32437 | Values: 86.0 86.0 87.0 86.0 85.0 86.0 92.0 85.0 86.0 87.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.00 stddev:2.81 (2.2%) stddev-sans-first:2.01 11:36:05 INFO - PROCESS | 32437 | Values: 121.0 128.0 124.0 126.0 126.0 128.0 130.0 129.0 127.0 130.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:156.00 stddev:7.13 (4.6%) stddev-sans-first:7.31 11:36:05 INFO - PROCESS | 32437 | Values: 148.0 155.0 156.0 156.0 157.0 142.0 154.0 161.0 161.0 141.0 11:36:05 INFO - PROCESS | 32437 | 11:36:05 INFO - PROCESS | 32437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.50 stddev:1.25 (1.7%) stddev-sans-first:1.27 11:36:05 INFO - PROCESS | 32437 | Values: 71.0 71.0 73.0 72.0 74.0 73.0 71.0 73.0 72.0 70.0 11:36:05 INFO - PROCESS | 32437 | -------- Summary: end -------- 11:36:05 INFO - PROCESS | 32437 | 11:36:13 INFO - Browser shutdown timed out after 5 seconds, terminating process. 11:36:13 INFO - Terminating psutil.Process(pid=32437, name='firefox') 11:36:23 INFO - PROCESS | 32437 | [Child 32495] ###!!! ABORT: Aborting on channel error.: file /builds/slave/fx-team-l64-000000000000000000/build/src/ipc/glue/MessageChannel.cpp, line 1824 11:36:44 INFO - PROCESS | 32437 | [Child 32495] ###!!! ABORT: Aborting on channel error.: file /builds/slave/fx-team-l64-000000000000000000/build/src/ipc/glue/MessageChannel.cpp, line 1824 11:36:50 INFO - TEST-UNEXPECTED-ERROR | kraken | psutil.TimeoutExpired timeout after 3 seconds (pid=32437, name='firefox') 11:36:50 ERROR - Traceback (most recent call last): 11:36:50 INFO - File "/builds/slave/test/build/tests/talos/talos/run_tests.py", line 196, in run_tests 11:36:50 INFO - talos_results.add(mytest.runTest(browser_config, test)) 11:36:50 INFO - File "/builds/slave/test/build/tests/talos/talos/ttest.py", line 64, in runTest 11:36:50 INFO - return self._runTest(browser_config, test_config, setup) 11:36:50 INFO - File "/builds/slave/test/build/tests/talos/talos/ttest.py", line 167, in _runTest 11:36:50 INFO - if counter_management else None), 11:36:50 INFO - File "/builds/slave/test/build/tests/talos/talos/talos_process.py", line 132, in run_browser 11:36:50 INFO - return_code = context.kill_process() 11:36:50 INFO - File "/builds/slave/test/build/tests/talos/talos/talos_process.py", line 43, in kill_process 11:36:50 INFO - return self.process.wait(3) 11:36:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/psutil/__init__.py", line 1102, in wait 11:36:50 INFO - return self._proc.wait(timeout) 11:36:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/psutil/_pslinux.py", line 709, in wrapper 11:36:50 INFO - return fun(self, *args, **kwargs) 11:36:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/psutil/_pslinux.py", line 851, in wait 11:36:50 INFO - raise TimeoutExpired(timeout, self.pid, self._name) 11:36:50 INFO - TimeoutExpired: psutil.TimeoutExpired timeout after 3 seconds (pid=32437, name='firefox') 11:36:50 INFO - TEST-INFO took 117600ms 11:36:50 INFO - SUITE-END | took 1252s 11:36:51 ERROR - Return code: 2 11:36:51 WARNING - setting return code to 2 11:36:51 ERROR - # TBPL FAILURE # 11:36:51 INFO - Running post-action listener: _resource_record_post_action 11:36:51 INFO - Running post-run listener: _resource_record_post_run 11:36:52 INFO - Total resource usage - Wall time: 1270s; CPU: 14.0%; Read bytes: 8192; Write bytes: 446361600; Read time: 1316; Write time: 6959592 11:36:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 819200; Read time: 0; Write time: 368 11:36:52 INFO - run-tests - Wall time: 1254s; CPU: 14.0%; Read bytes: 8192; Write bytes: 445337600; Read time: 1316; Write time: 6951044 11:36:52 INFO - Running post-run listener: _upload_blobber_files 11:36:52 INFO - Blob upload gear active. 11:36:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:52 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 11:36:52 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'] 11:36:52 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 11:36:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:53 INFO - (blobuploader) - INFO - Done attempting. 11:36:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:36:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:54 INFO - (blobuploader) - INFO - Done attempting. 11:36:54 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:54 INFO - Return code: 0 11:36:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ff58db2e201fc6722ada2f712231d55bbfdce3e0483ace440191795384a3e9c0db491093860bc3e37bde3d9682089e76cf99c7e1de77f3097215c7e8fad772b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/490f225c44f9df41461708b0e086c6825a1d4e81eeb92fbb3919d4871186544b2a3d54a81f01ca76b35ee273c28205a5cd72205168113b64cd49ce5540e7447c"} 11:36:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:54 INFO - Contents: 11:36:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ff58db2e201fc6722ada2f712231d55bbfdce3e0483ace440191795384a3e9c0db491093860bc3e37bde3d9682089e76cf99c7e1de77f3097215c7e8fad772b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/490f225c44f9df41461708b0e086c6825a1d4e81eeb92fbb3919d4871186544b2a3d54a81f01ca76b35ee273c28205a5cd72205168113b64cd49ce5540e7447c"} 11:36:54 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:54 INFO - Copying logs to upload dir... 11:36:54 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:54 INFO - Copying logs to upload dir... 11:36:54 WARNING - returning nonzero exit status 2 program finished with exit code 2 elapsedTime=1355.915139 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' failed (results: 2, elapsed: 22 mins, 35 secs) (at 2016-03-02 11:36:54.406995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 11:36:54.410201) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 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/1ff58db2e201fc6722ada2f712231d55bbfdce3e0483ace440191795384a3e9c0db491093860bc3e37bde3d9682089e76cf99c7e1de77f3097215c7e8fad772b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/490f225c44f9df41461708b0e086c6825a1d4e81eeb92fbb3919d4871186544b2a3d54a81f01ca76b35ee273c28205a5cd72205168113b64cd49ce5540e7447c"} build_url:https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/GusjT2EYRmCstSj1aHRrpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ff58db2e201fc6722ada2f712231d55bbfdce3e0483ace440191795384a3e9c0db491093860bc3e37bde3d9682089e76cf99c7e1de77f3097215c7e8fad772b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/490f225c44f9df41461708b0e086c6825a1d4e81eeb92fbb3919d4871186544b2a3d54a81f01ca76b35ee273c28205a5cd72205168113b64cd49ce5540e7447c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 11:36:54.435036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:36:54.435360) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456946055.856899-375513137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 11:36:54.520806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 11:36:54.521117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 11:36:54.521414) ========= ========= Total master_lag: 0.29 =========