builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1458039611.18 results: success (0) buildid: 20160315025645 builduid: 1692256d2eaa4a7f9aa4651338c11c00 revision: d5c32bb6c8f41e013ef2e9f0f74094146d8113f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.182330) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.182776) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.183101) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006375 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.208476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.208758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.224739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.225240) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.275028) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.275333) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.275677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.275972) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 04:00:12-- 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% 16.8M=0.001s 2016-03-15 04:00:13 (16.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166888 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.455016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.455316) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019942 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.504580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:11.504911) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d5c32bb6c8f41e013ef2e9f0f74094146d8113f9 --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 d5c32bb6c8f41e013ef2e9f0f74094146d8113f9 --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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 04:00:13,266 truncating revision to first 12 chars 2016-03-15 04:00:13,266 Setting DEBUG logging. 2016-03-15 04:00:13,266 attempt 1/10 2016-03-15 04:00:13,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d5c32bb6c8f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 04:00:13,500 unpacking tar archive at: fx-team-d5c32bb6c8f4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.500972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:12.019497) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:12.019844) ========= echo d5c32bb6c8f41e013ef2e9f0f74094146d8113f9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd5c32bb6c8f41e013ef2e9f0f74094146d8113f9'] 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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d5c32bb6c8f41e013ef2e9f0f74094146d8113f9 program finished with exit code 0 elapsedTime=0.003558 script_repo_revision: 'd5c32bb6c8f41e013ef2e9f0f74094146d8113f9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:12.071698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:12.072020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 04:00:12.088457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-15 04:00:12.088722) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:00:13 INFO - MultiFileLogger online at 20160315 04:00:13 in /builds/slave/test 04:00:13 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 04:00:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:13 INFO - {'append_to_log': False, 04:00:13 INFO - 'base_work_dir': '/builds/slave/test', 04:00:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:00:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:13 INFO - 'branch': 'Fx-Team-Non-PGO', 04:00:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:13 INFO - 'config_files': ('talos/linux_config.py',), 04:00:13 INFO - 'default_actions': ('clobber', 04:00:13 INFO - 'read-buildbot-config', 04:00:13 INFO - 'download-and-extract', 04:00:13 INFO - 'populate-webroot', 04:00:13 INFO - 'create-virtualenv', 04:00:13 INFO - 'install', 04:00:13 INFO - 'run-tests'), 04:00:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:13 INFO - 'download_minidump_stackwalk': True, 04:00:13 INFO - 'download_symbols': 'ondemand', 04:00:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:13 INFO - 'installer_path': 'installer.exe', 04:00:13 INFO - 'log_level': 'info', 04:00:13 INFO - 'log_name': 'talos', 04:00:13 INFO - 'log_to_console': True, 04:00:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:00:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:00:13 INFO - 'opt_config_files': (), 04:00:13 INFO - 'pip_index': False, 04:00:13 INFO - 'sps_profile': False, 04:00:13 INFO - 'sps_profile_interval': 0, 04:00:13 INFO - 'suite': 'dromaeojs-e10s', 04:00:13 INFO - 'system_bits': '32', 04:00:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:13 INFO - 'title': 'talos-linux64-ix-067', 04:00:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:13 INFO - 'use_talos_json': True, 04:00:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:13 INFO - 'work_dir': 'build'} 04:00:13 INFO - ##### 04:00:13 INFO - ##### Running clobber step. 04:00:13 INFO - ##### 04:00:13 INFO - Running pre-action listener: _resource_record_pre_action 04:00:13 INFO - Running main action method: clobber 04:00:13 INFO - rmtree: /builds/slave/test/build 04:00:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:14 INFO - Running post-action listener: _resource_record_post_action 04:00:14 INFO - ##### 04:00:14 INFO - ##### Running read-buildbot-config step. 04:00:14 INFO - ##### 04:00:14 INFO - Running pre-action listener: _resource_record_pre_action 04:00:14 INFO - Running main action method: read_buildbot_config 04:00:14 INFO - Using buildbot properties: 04:00:14 INFO - { 04:00:14 INFO - "project": "", 04:00:14 INFO - "product": "firefox", 04:00:14 INFO - "script_repo_revision": "production", 04:00:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:00:14 INFO - "repository": "", 04:00:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:00:14 INFO - "buildid": "20160315025645", 04:00:14 INFO - "pgo_build": "False", 04:00:14 INFO - "basedir": "/builds/slave/test", 04:00:14 INFO - "buildnumber": 1048, 04:00:14 INFO - "slavename": "talos-linux64-ix-067", 04:00:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:00:14 INFO - "platform": "ubuntu64_hw", 04:00:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:00:14 INFO - "branch": "fx-team", 04:00:14 INFO - "repo_path": "integration/fx-team", 04:00:14 INFO - "revision": "d5c32bb6c8f41e013ef2e9f0f74094146d8113f9", 04:00:14 INFO - "stage_platform": "linux64", 04:00:14 INFO - "builduid": "1692256d2eaa4a7f9aa4651338c11c00", 04:00:14 INFO - "slavebuilddir": "test" 04:00:14 INFO - } 04:00:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:00:14 INFO - Running post-action listener: _resource_record_post_action 04:00:14 INFO - ##### 04:00:14 INFO - ##### Running download-and-extract step. 04:00:14 INFO - ##### 04:00:14 INFO - Running pre-action listener: _resource_record_pre_action 04:00:14 INFO - Running main action method: download_and_extract 04:00:14 INFO - mkdir: /builds/slave/test/build/tests 04:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:14 INFO - https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:00:21 INFO - Downloaded 1361 bytes. 04:00:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:00:21 INFO - Using the following test package requirements: 04:00:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:00:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:00:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'jsshell-linux-x86_64.zip'], 04:00:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:00:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:00:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:00:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:00:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:00:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:21 INFO - https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:24 INFO - Downloaded 21991811 bytes. 04:00:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:00:25 INFO - Return code: 0 04:00:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:00: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')]} 04:00:25 INFO - https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:27 INFO - Downloaded 21991811 bytes. 04:00:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:00:28 INFO - Return code: 0 04:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:28 INFO - https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:00:29 INFO - Downloaded 10845263 bytes. 04:00:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:00:29 INFO - Return code: 0 04:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:29 INFO - https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:00:31 INFO - Downloaded 54120713 bytes. 04:00:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:31 INFO - mkdir: /builds/slave/test/properties 04:00:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:31 INFO - Contents: 04:00:31 INFO - build_url:https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:00:31 INFO - Running post-action listener: _resource_record_post_action 04:00:31 INFO - Running post-action listener: set_extra_try_arguments 04:00:31 INFO - ##### 04:00:31 INFO - ##### Running populate-webroot step. 04:00:31 INFO - ##### 04:00:31 INFO - Running pre-action listener: _resource_record_pre_action 04:00:31 INFO - Running main action method: populate_webroot 04:00:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:31 INFO - '--tppagecycles', 04:00:31 INFO - '7'], 04:00:31 INFO - 'tests': ['tsvgm']}}, 04:00:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:00:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:00:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:00:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'tests': ['damp', 'tps']}, 04:00:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['damp', 'tps']}, 04:00:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:00:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:31 INFO - 'other': {'tests': ['a11yr', 04:00:31 INFO - 'ts_paint', 04:00:31 INFO - 'tpaint', 04:00:31 INFO - 'sessionrestore', 04:00:31 INFO - 'sessionrestore_no_auto_restore', 04:00:31 INFO - 'tabpaint']}, 04:00:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['a11yr', 04:00:31 INFO - 'ts_paint', 04:00:31 INFO - 'tpaint', 04:00:31 INFO - 'sessionrestore', 04:00:31 INFO - 'sessionrestore_no_auto_restore', 04:00:31 INFO - 'tabpaint']}, 04:00:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['a11yr', 04:00:31 INFO - 'ts_paint', 04:00:31 INFO - 'tpaint', 04:00:31 INFO - 'sessionrestore', 04:00:31 INFO - 'sessionrestore_no_auto_restore', 04:00:31 INFO - 'tabpaint']}, 04:00:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['a11yr', 04:00:31 INFO - 'ts_paint', 04:00:31 INFO - 'tpaint', 04:00:31 INFO - 'sessionrestore', 04:00:31 INFO - 'sessionrestore_no_auto_restore', 04:00:31 INFO - 'tabpaint']}, 04:00:31 INFO - 'other_l64': {'tests': ['a11yr', 04:00:31 INFO - 'ts_paint', 04:00:31 INFO - 'tpaint', 04:00:31 INFO - 'sessionrestore', 04:00:31 INFO - 'sessionrestore_no_auto_restore', 04:00:31 INFO - 'tabpaint']}, 04:00:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:00:31 INFO - 'ts_paint', 04:00:31 INFO - 'tpaint', 04:00:31 INFO - 'sessionrestore', 04:00:31 INFO - 'sessionrestore_no_auto_restore', 04:00:31 INFO - 'tabpaint']}, 04:00:31 INFO - 'svgr': {'tests': ['tsvgx', 04:00:31 INFO - 'tsvgr_opacity', 04:00:31 INFO - 'tart', 04:00:31 INFO - 'tscrollx', 04:00:31 INFO - 'cart']}, 04:00:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['tsvgx', 04:00:31 INFO - 'tsvgr_opacity', 04:00:31 INFO - 'tart', 04:00:31 INFO - 'tscrollx', 04:00:31 INFO - 'cart']}, 04:00:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'tests': ['tp5o']}, 04:00:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'talos_options': ['--e10s'], 04:00:31 INFO - 'tests': ['tp5o']}, 04:00:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'talos_options': ['--xperf_path', 04:00:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:31 INFO - 'tests': ['tp5n']}, 04:00:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:31 INFO - 'talos_options': ['--e10s', 04:00:31 INFO - '--xperf_path', 04:00:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:31 INFO - 'tests': ['tp5n']}}, 04:00:31 INFO - 'talos.zip': {'path': '', 04:00:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:31 INFO - Running post-action listener: _resource_record_post_action 04:00:31 INFO - ##### 04:00:31 INFO - ##### Running create-virtualenv step. 04:00:31 INFO - ##### 04:00:31 INFO - Running pre-action listener: _resource_record_pre_action 04:00:31 INFO - Running main action method: create_virtualenv 04:00:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:31 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 04:00:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:31 INFO - Using real prefix '/usr' 04:00:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:34 INFO - Installing pip.................done. 04:00:34 INFO - Return code: 0 04:00:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00: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', 'pip>=1.5'] in /builds/slave/test/build 04:00: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 pip>=1.5 04:00:34 INFO - Using env: {'DISPLAY': ':0', 04:00:34 INFO - 'HOME': '/home/cltbld', 04:00:34 INFO - 'LANG': 'en_US.UTF-8', 04:00:34 INFO - 'LANGUAGE': 'en_US:en', 04:00:34 INFO - 'LOGNAME': 'cltbld', 04:00:34 INFO - 'MAIL': '/var/mail/cltbld', 04:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:34 INFO - 'MOZ_NO_REMOTE': '1', 04:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:34 INFO - 'NO_EM_RESTART': '1', 04:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:34 INFO - 'PWD': '/builds/slave/test', 04:00:34 INFO - 'SHELL': '/bin/bash', 04:00:34 INFO - 'SHLVL': '1', 04:00:34 INFO - 'TERM': 'linux', 04:00:34 INFO - 'TMOUT': '86400', 04:00:34 INFO - 'USER': 'cltbld', 04:00:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:34 INFO - '_': '/tools/buildbot/bin/python'} 04:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:34 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 04:00:34 INFO - Cleaning up... 04:00:34 INFO - Return code: 0 04:00:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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', '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 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:00: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 psutil>=0.7.1 04:00:34 INFO - Using env: {'DISPLAY': ':0', 04:00:34 INFO - 'HOME': '/home/cltbld', 04:00:34 INFO - 'LANG': 'en_US.UTF-8', 04:00:34 INFO - 'LANGUAGE': 'en_US:en', 04:00:34 INFO - 'LOGNAME': 'cltbld', 04:00:34 INFO - 'MAIL': '/var/mail/cltbld', 04:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:34 INFO - 'MOZ_NO_REMOTE': '1', 04:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:34 INFO - 'NO_EM_RESTART': '1', 04:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:34 INFO - 'PWD': '/builds/slave/test', 04:00:34 INFO - 'SHELL': '/bin/bash', 04:00:34 INFO - 'SHLVL': '1', 04:00:34 INFO - 'TERM': 'linux', 04:00:34 INFO - 'TMOUT': '86400', 04:00:34 INFO - 'USER': 'cltbld', 04:00:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:34 INFO - '_': '/tools/buildbot/bin/python'} 04:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:34 INFO - Downloading/unpacking psutil>=0.7.1 04:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:36 INFO - Installing collected packages: psutil 04:00:36 INFO - Running setup.py install for psutil 04:00:36 INFO - building 'psutil._psutil_linux' extension 04:00:36 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 04:00:37 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 04:00:37 INFO - building 'psutil._psutil_posix' extension 04:00:37 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 04:00:37 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 04:00:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:37 INFO - Successfully installed psutil 04:00:37 INFO - Cleaning up... 04:00:37 INFO - Return code: 0 04:00:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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', '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 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:00: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 mozsystemmonitor==0.0.0 04:00:37 INFO - Using env: {'DISPLAY': ':0', 04:00:37 INFO - 'HOME': '/home/cltbld', 04:00:37 INFO - 'LANG': 'en_US.UTF-8', 04:00:37 INFO - 'LANGUAGE': 'en_US:en', 04:00:37 INFO - 'LOGNAME': 'cltbld', 04:00:37 INFO - 'MAIL': '/var/mail/cltbld', 04:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:37 INFO - 'MOZ_NO_REMOTE': '1', 04:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:37 INFO - 'NO_EM_RESTART': '1', 04:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:37 INFO - 'PWD': '/builds/slave/test', 04:00:37 INFO - 'SHELL': '/bin/bash', 04:00:37 INFO - 'SHLVL': '1', 04:00:37 INFO - 'TERM': 'linux', 04:00:37 INFO - 'TMOUT': '86400', 04:00:37 INFO - 'USER': 'cltbld', 04:00:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:37 INFO - '_': '/tools/buildbot/bin/python'} 04:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:00:39 INFO - Installing collected packages: mozsystemmonitor 04:00:39 INFO - Running setup.py install for mozsystemmonitor 04:00:39 INFO - Successfully installed mozsystemmonitor 04:00:39 INFO - Cleaning up... 04:00:39 INFO - Return code: 0 04:00:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00:39 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')]} 04:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:39 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')]} 04:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:39 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 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00:39 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 04:00:39 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 04:00:39 INFO - Using env: {'DISPLAY': ':0', 04:00:39 INFO - 'HOME': '/home/cltbld', 04:00:39 INFO - 'LANG': 'en_US.UTF-8', 04:00:39 INFO - 'LANGUAGE': 'en_US:en', 04:00:39 INFO - 'LOGNAME': 'cltbld', 04:00:39 INFO - 'MAIL': '/var/mail/cltbld', 04:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:39 INFO - 'MOZ_NO_REMOTE': '1', 04:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:39 INFO - 'NO_EM_RESTART': '1', 04:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:39 INFO - 'PWD': '/builds/slave/test', 04:00:39 INFO - 'SHELL': '/bin/bash', 04:00:39 INFO - 'SHLVL': '1', 04:00:39 INFO - 'TERM': 'linux', 04:00:39 INFO - 'TMOUT': '86400', 04:00:39 INFO - 'USER': 'cltbld', 04:00:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:39 INFO - '_': '/tools/buildbot/bin/python'} 04:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:41 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 04:00:41 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 04:00:41 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 04:00:41 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 04:00:41 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 04:00:41 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 04:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:42 INFO - Downloading docopt-0.6.1.tar.gz 04:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:42 INFO - Running setup.py install for blobuploader 04:00:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:42 INFO - Running setup.py install for requests 04:00:42 INFO - Running setup.py install for docopt 04:00:42 INFO - Successfully installed blobuploader requests docopt 04:00:42 INFO - Cleaning up... 04:00:42 INFO - Return code: 0 04:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:42 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 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00:42 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 04:00:42 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 04:00:42 INFO - Using env: {'DISPLAY': ':0', 04:00:42 INFO - 'HOME': '/home/cltbld', 04:00:42 INFO - 'LANG': 'en_US.UTF-8', 04:00:42 INFO - 'LANGUAGE': 'en_US:en', 04:00:42 INFO - 'LOGNAME': 'cltbld', 04:00:42 INFO - 'MAIL': '/var/mail/cltbld', 04:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:42 INFO - 'MOZ_NO_REMOTE': '1', 04:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:42 INFO - 'NO_EM_RESTART': '1', 04:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:42 INFO - 'PWD': '/builds/slave/test', 04:00:42 INFO - 'SHELL': '/bin/bash', 04:00:42 INFO - 'SHLVL': '1', 04:00:42 INFO - 'TERM': 'linux', 04:00:42 INFO - 'TMOUT': '86400', 04:00:42 INFO - 'USER': 'cltbld', 04:00:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:42 INFO - '_': '/tools/buildbot/bin/python'} 04:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:43 INFO - Running setup.py (path:/tmp/pip-ll3ITC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:43 INFO - Running setup.py (path:/tmp/pip-YzW6If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:43 INFO - Running setup.py (path:/tmp/pip-LdFN8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:43 INFO - Running setup.py (path:/tmp/pip-RhbIjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:43 INFO - Running setup.py (path:/tmp/pip-Ji7oPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:43 INFO - Running setup.py (path:/tmp/pip-4Bl5Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:43 INFO - Running setup.py (path:/tmp/pip-ajXnrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:43 INFO - Running setup.py (path:/tmp/pip-p9fILG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:43 INFO - Running setup.py (path:/tmp/pip-IZPTfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:43 INFO - Running setup.py (path:/tmp/pip-DuIqIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:43 INFO - Running setup.py (path:/tmp/pip-o4Cr0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:43 INFO - Running setup.py (path:/tmp/pip-vM1jgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:44 INFO - Running setup.py (path:/tmp/pip-dAFgbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:44 INFO - Running setup.py (path:/tmp/pip-98Idp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:44 INFO - Running setup.py (path:/tmp/pip-jJgptG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:44 INFO - Running setup.py (path:/tmp/pip-pXMxsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:44 INFO - Running setup.py (path:/tmp/pip-_A6Lk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:44 INFO - Running setup.py install for manifestparser 04:00:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:44 INFO - Running setup.py install for mozcrash 04:00:44 INFO - Running setup.py install for mozdebug 04:00:44 INFO - Running setup.py install for mozdevice 04:00:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:00:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:44 INFO - Running setup.py install for mozfile 04:00:44 INFO - Running setup.py install for mozhttpd 04:00:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Running setup.py install for mozinfo 04:00:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Running setup.py install for mozInstall 04:00:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Running setup.py install for mozleak 04:00:45 INFO - Running setup.py install for mozlog 04:00:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Running setup.py install for moznetwork 04:00:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Running setup.py install for mozprocess 04:00:45 INFO - Running setup.py install for mozprofile 04:00:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Running setup.py install for mozrunner 04:00:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:45 INFO - Running setup.py install for mozscreenshot 04:00:45 INFO - Running setup.py install for moztest 04:00:46 INFO - Running setup.py install for mozversion 04:00:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:46 INFO - Cleaning up... 04:00:46 INFO - Return code: 0 04:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:46 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 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00:46 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 04:00:46 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 04:00:46 INFO - Using env: {'DISPLAY': ':0', 04:00:46 INFO - 'HOME': '/home/cltbld', 04:00:46 INFO - 'LANG': 'en_US.UTF-8', 04:00:46 INFO - 'LANGUAGE': 'en_US:en', 04:00:46 INFO - 'LOGNAME': 'cltbld', 04:00:46 INFO - 'MAIL': '/var/mail/cltbld', 04:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:46 INFO - 'MOZ_NO_REMOTE': '1', 04:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:46 INFO - 'NO_EM_RESTART': '1', 04:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:46 INFO - 'PWD': '/builds/slave/test', 04:00:46 INFO - 'SHELL': '/bin/bash', 04:00:46 INFO - 'SHLVL': '1', 04:00:46 INFO - 'TERM': 'linux', 04:00:46 INFO - 'TMOUT': '86400', 04:00:46 INFO - 'USER': 'cltbld', 04:00:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:46 INFO - '_': '/tools/buildbot/bin/python'} 04:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:46 INFO - Running setup.py (path:/tmp/pip-qc1M8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:46 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)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:46 INFO - Running setup.py (path:/tmp/pip-n1gYZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:46 INFO - Running setup.py (path:/tmp/pip-UNiajb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:46 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)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:46 INFO - Running setup.py (path:/tmp/pip-qG3sGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:46 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)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:46 INFO - Running setup.py (path:/tmp/pip-nJv35J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:46 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)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:46 INFO - Running setup.py (path:/tmp/pip-xNOH8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:46 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)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:46 INFO - Running setup.py (path:/tmp/pip-Qgi6mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:46 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)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:46 INFO - Running setup.py (path:/tmp/pip-DPsTbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:46 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)) 04:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:46 INFO - Running setup.py (path:/tmp/pip-JeiMGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:47 INFO - Running setup.py (path:/tmp/pip-yPaloj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:47 INFO - Running setup.py (path:/tmp/pip-XwkJK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:47 INFO - Running setup.py (path:/tmp/pip-3wYK_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:47 INFO - Running setup.py (path:/tmp/pip-AfQQi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:47 INFO - Running setup.py (path:/tmp/pip-yBIVpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:47 INFO - Running setup.py (path:/tmp/pip-iskNEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:47 INFO - Running setup.py (path:/tmp/pip-z3sKC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:47 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)) 04:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:47 INFO - Running setup.py (path:/tmp/pip-BSzvEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:47 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)) 04:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:47 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)) 04:00:47 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)) 04:00:47 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)) 04:00:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:49 INFO - Downloading blessings-1.6.tar.gz 04:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:49 INFO - Installing collected packages: blessings 04:00:49 INFO - Running setup.py install for blessings 04:00:49 INFO - Successfully installed blessings 04:00:49 INFO - Cleaning up... 04:00:49 INFO - Return code: 0 04:00:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:49 INFO - Reading from file tmpfile_stdout 04:00:49 INFO - Current package versions: 04:00:49 INFO - argparse == 1.2.1 04:00:49 INFO - blessings == 1.6 04:00:49 INFO - blobuploader == 1.2.4 04:00:49 INFO - docopt == 0.6.1 04:00:49 INFO - manifestparser == 1.1 04:00:49 INFO - mozInstall == 1.12 04:00:49 INFO - mozcrash == 0.17 04:00:49 INFO - mozdebug == 0.1 04:00:49 INFO - mozdevice == 0.48 04:00:49 INFO - mozfile == 1.2 04:00:49 INFO - mozhttpd == 0.7 04:00:49 INFO - mozinfo == 0.9 04:00:49 INFO - mozleak == 0.1 04:00:49 INFO - mozlog == 3.1 04:00:49 INFO - moznetwork == 0.27 04:00:49 INFO - mozprocess == 0.22 04:00:49 INFO - mozprofile == 0.28 04:00:49 INFO - mozrunner == 6.11 04:00:49 INFO - mozscreenshot == 0.1 04:00:49 INFO - mozsystemmonitor == 0.0 04:00:49 INFO - moztest == 0.7 04:00:49 INFO - mozversion == 1.4 04:00:49 INFO - psutil == 3.1.1 04:00:49 INFO - requests == 1.2.3 04:00:49 INFO - wsgiref == 0.1.2 04:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:49 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 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00:49 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 04:00:49 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 04:00:49 INFO - Using env: {'DISPLAY': ':0', 04:00:49 INFO - 'HOME': '/home/cltbld', 04:00:49 INFO - 'LANG': 'en_US.UTF-8', 04:00:49 INFO - 'LANGUAGE': 'en_US:en', 04:00:49 INFO - 'LOGNAME': 'cltbld', 04:00:49 INFO - 'MAIL': '/var/mail/cltbld', 04:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:49 INFO - 'MOZ_NO_REMOTE': '1', 04:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:49 INFO - 'NO_EM_RESTART': '1', 04:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:49 INFO - 'PWD': '/builds/slave/test', 04:00:49 INFO - 'SHELL': '/bin/bash', 04:00:49 INFO - 'SHLVL': '1', 04:00:49 INFO - 'TERM': 'linux', 04:00:49 INFO - 'TMOUT': '86400', 04:00:49 INFO - 'USER': 'cltbld', 04:00:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:49 INFO - '_': '/tools/buildbot/bin/python'} 04:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 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)) 04:00:50 INFO - Cleaning up... 04:00:50 INFO - Return code: 0 04:00:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:00:50 INFO - Using env: {'DISPLAY': ':0', 04:00:50 INFO - 'HOME': '/home/cltbld', 04:00:50 INFO - 'LANG': 'en_US.UTF-8', 04:00:50 INFO - 'LANGUAGE': 'en_US:en', 04:00:50 INFO - 'LOGNAME': 'cltbld', 04:00:50 INFO - 'MAIL': '/var/mail/cltbld', 04:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:50 INFO - 'MOZ_NO_REMOTE': '1', 04:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:50 INFO - 'NO_EM_RESTART': '1', 04:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:50 INFO - 'PWD': '/builds/slave/test', 04:00:50 INFO - 'SHELL': '/bin/bash', 04:00:50 INFO - 'SHLVL': '1', 04:00:50 INFO - 'TERM': 'linux', 04:00:50 INFO - 'TMOUT': '86400', 04:00:50 INFO - 'USER': 'cltbld', 04:00:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:50 INFO - '_': '/tools/buildbot/bin/python'} 04:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:50 INFO - Downloading/unpacking jsonschema 04:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:52 INFO - Downloading/unpacking functools32 (from jsonschema) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:52 INFO - warning: no files found matching '*.txt' 04:00:52 INFO - no previously-included directories found matching 'build' 04:00:52 INFO - no previously-included directories found matching 'dist' 04:00:52 INFO - no previously-included directories found matching '.git*' 04:00:52 INFO - Installing collected packages: jsonschema, functools32 04:00:52 INFO - Running setup.py install for functools32 04:00:52 INFO - warning: no files found matching '*.txt' 04:00:52 INFO - no previously-included directories found matching 'build' 04:00:52 INFO - no previously-included directories found matching 'dist' 04:00:52 INFO - no previously-included directories found matching '.git*' 04:00:52 INFO - Successfully installed jsonschema functools32 04:00:52 INFO - Cleaning up... 04:00:52 INFO - Return code: 0 04:00:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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 0x7fe8491ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', '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 04:00: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 04:00: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 04:00:52 INFO - Using env: {'DISPLAY': ':0', 04:00:52 INFO - 'HOME': '/home/cltbld', 04:00:52 INFO - 'LANG': 'en_US.UTF-8', 04:00:52 INFO - 'LANGUAGE': 'en_US:en', 04:00:52 INFO - 'LOGNAME': 'cltbld', 04:00:52 INFO - 'MAIL': '/var/mail/cltbld', 04:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:52 INFO - 'MOZ_NO_REMOTE': '1', 04:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:52 INFO - 'NO_EM_RESTART': '1', 04:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:52 INFO - 'PWD': '/builds/slave/test', 04:00:52 INFO - 'SHELL': '/bin/bash', 04:00:52 INFO - 'SHLVL': '1', 04:00:52 INFO - 'TERM': 'linux', 04:00:52 INFO - 'TMOUT': '86400', 04:00:52 INFO - 'USER': 'cltbld', 04:00:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:52 INFO - '_': '/tools/buildbot/bin/python'} 04:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:52 INFO - Downloading/unpacking flake8 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:00:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:00:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:00:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:55 INFO - no previously-included directories found matching 'docs/_build' 04:00:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:00:55 INFO - Running setup.py install for pep8 04:00:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:55 INFO - no previously-included directories found matching 'docs/_build' 04:00:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:00:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:00:55 INFO - Cleaning up... 04:00:55 INFO - Return code: 0 04:00:55 INFO - Running post-action listener: _resource_record_post_action 04:00:55 INFO - Running post-action listener: _start_resource_monitoring 04:00:55 INFO - Starting resource monitoring. 04:00:55 INFO - ##### 04:00:55 INFO - ##### Running install step. 04:00:55 INFO - ##### 04:00:55 INFO - Running pre-action listener: _resource_record_pre_action 04:00:55 INFO - Running main action method: install 04:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:55 INFO - Reading from file tmpfile_stdout 04:00:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:55 INFO - Reading from file tmpfile_stdout 04:00:55 INFO - Output received: 04:00:55 INFO - Usage: mozinstall [options] installer 04:00:55 INFO - Options: 04:00:55 INFO - -h, --help show this help message and exit 04:00:55 INFO - -d DEST, --destination=DEST 04:00:55 INFO - Directory to install application into. [default: 04:00:55 INFO - "/builds/slave/test"] 04:00:55 INFO - --app=APP Application being installed. [default: firefox] 04:00:55 INFO - mkdir: /builds/slave/test/build/application 04:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:01:11 INFO - Reading from file tmpfile_stdout 04:01:11 INFO - Output received: 04:01:11 INFO - /builds/slave/test/build/application/firefox/firefox 04:01:11 INFO - Running post-action listener: _resource_record_post_action 04:01:11 INFO - ##### 04:01:11 INFO - ##### Running run-tests step. 04:01:11 INFO - ##### 04:01:11 INFO - Running pre-action listener: _resource_record_pre_action 04:01:11 INFO - Running main action method: run_tests 04:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:11 INFO - Python 2.7.3 04:01:11 INFO - Return code: 0 04:01:11 INFO - grabbing minidump binary from tooltool 04:01:11 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')]} 04:01:11 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 0x1b3b160>, '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 0x1b3c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:11 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 04:01:11 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 04:01:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:11 INFO - Return code: 0 04:01:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:01:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:01:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:01:12 INFO - Return code: 0 04:01:12 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/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:01:12 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/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 04:01:12 INFO - Using env: {'DISPLAY': ':0', 04:01:12 INFO - 'HOME': '/home/cltbld', 04:01:12 INFO - 'LANG': 'en_US.UTF-8', 04:01:12 INFO - 'LANGUAGE': 'en_US:en', 04:01:12 INFO - 'LOGNAME': 'cltbld', 04:01:12 INFO - 'MAIL': '/var/mail/cltbld', 04:01:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:12 INFO - 'MOZ_NO_REMOTE': '1', 04:01:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:12 INFO - 'NO_EM_RESTART': '1', 04:01:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:12 INFO - 'PWD': '/builds/slave/test', 04:01:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:12 INFO - 'SHELL': '/bin/bash', 04:01:12 INFO - 'SHLVL': '1', 04:01:12 INFO - 'TERM': 'linux', 04:01:12 INFO - 'TMOUT': '86400', 04:01:12 INFO - 'USER': 'cltbld', 04:01:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624', 04:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:12 INFO - '_': '/tools/buildbot/bin/python'} 04:01:12 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/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:01:12 INFO - mozversion application_buildid: 20160315025645 04:01:12 INFO - mozversion application_changeset: d5c32bb6c8f41e013ef2e9f0f74094146d8113f9 04:01:12 INFO - mozversion application_display_name: Nightly 04:01:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:12 INFO - mozversion application_name: Firefox 04:01:12 INFO - mozversion application_remotingname: firefox 04:01:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:01:12 INFO - mozversion application_vendor: Mozilla 04:01:12 INFO - mozversion application_version: 48.0a1 04:01:12 INFO - mozversion platform_buildid: 20160315025645 04:01:12 INFO - mozversion platform_changeset: d5c32bb6c8f41e013ef2e9f0f74094146d8113f9 04:01:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:01:12 INFO - mozversion platform_version: 48.0a1 04:01:12 INFO - using testdate: 1458039672 04:01:12 INFO - actual date: 1458039672 04:01:12 INFO - starting webserver on 'localhost:43867' 04:01:12 INFO - SUITE-START | Running 2 tests 04:01:12 INFO - TEST-START | dromaeo_css 04:01:12 INFO - operating with platform_type : linux_ 04:01:12 INFO - Initialising browser for dromaeo_css test... 04:01:12 INFO - TEST-INFO | started process 2241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQNCtO/profile http://localhost:43867/getInfo.html) 04:01:16 INFO - PROCESS | 2241 | 04:01:16 INFO - PROCESS | 2241 | (process:2322): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:01:16 INFO - PROCESS | 2241 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:01:17 INFO - PROCESS | 2241 | __metrics Screen width/height:1600/1200 04:01:17 INFO - PROCESS | 2241 | colorDepth:24 04:01:17 INFO - PROCESS | 2241 | Browser inner width/height: 1024/697 04:01:17 INFO - PROCESS | 2241 | __metrics 04:01:17 ERROR - PROCESS | 2241 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 04:01:18 INFO - TEST-INFO | 2241: exit 0 04:01:18 INFO - Browser initialized. 04:01:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:18 INFO - TEST-INFO | started process 2447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQNCtO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:20 INFO - PROCESS | 2447 | 04:01:20 INFO - PROCESS | 2447 | (process:2526): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:01:30 INFO - PROCESS | 2447 | RSS: Main: 165400576 04:01:30 INFO - PROCESS | 2447 | 04:02:20 INFO - PROCESS | 2447 | 1458039740168 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] 04:04:31 INFO - PROCESS | 2447 | Cycle 1(1): loaded http://localhost:43867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43867/tests/dromaeo/cssquery-ext.html) 04:04:32 INFO - PROCESS | 2447 | RSS: Main: 169017344 04:04:32 INFO - PROCESS | 2447 | 04:07:34 INFO - PROCESS | 2447 | Cycle 1(1): loaded http://localhost:43867/tests/dromaeo/cssquery-ext.html (next: http://localhost:43867/tests/dromaeo/cssquery-jquery.html) 04:07:35 INFO - PROCESS | 2447 | RSS: Main: 168464384 04:07:35 INFO - PROCESS | 2447 | 04:10:37 INFO - PROCESS | 2447 | Cycle 1(1): loaded http://localhost:43867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43867/tests/dromaeo/cssquery-mootools.html) 04:10:37 INFO - PROCESS | 2447 | RSS: Main: 168300544 04:10:37 INFO - PROCESS | 2447 | 04:13:39 INFO - PROCESS | 2447 | Cycle 1(1): loaded http://localhost:43867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43867/tests/dromaeo/cssquery-prototype.html) 04:13:40 INFO - PROCESS | 2447 | RSS: Main: 166748160 04:13:40 INFO - PROCESS | 2447 | 04:16:42 INFO - PROCESS | 2447 | Cycle 1(1): loaded http://localhost:43867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43867/tests/dromaeo/cssquery-yui.html) 04:16:43 INFO - PROCESS | 2447 | RSS: Main: 168640512 04:16:43 INFO - PROCESS | 2447 | 04:19:45 INFO - PROCESS | 2447 | Cycle 1(1): loaded http://localhost:43867/tests/dromaeo/cssquery-yui.html (next: http://localhost:43867/tests/dromaeo/cssquery-dojo.html) 04:19:46 INFO - PROCESS | 2447 | RSS: Main: 170172416 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | __start_tp_report 04:19:46 INFO - PROCESS | 2447 | _x_x_mozilla_page_load 04:19:46 INFO - PROCESS | 2447 | _x_x_mozilla_page_load_details 04:19:46 INFO - PROCESS | 2447 | |i|pagename|runs| 04:19:46 INFO - PROCESS | 2447 | |0;dojo.html;2638.643783089283;2663.2676014096123;2690.4484580660965;2695.272276485348;2703.2025552462032;4697.365855609496;4733.8343157989475;4737.9763101184535;4767.237242041269;4781.689190202635;4751.501092385293;4806.6875653082525;4818.542238487347;4832.951670483294;4879.609631229502;4422.97788511057;4438.667099967499;4482.641388688913;4560.885977850564;4568.5431456854385;4434.623057040139;4447.621952134073;4480.6639502037315;4499.7750112494405;4509.0530988492455;4354.194474022316;4361.367601697768;4373.497047839507;4395.7142785718825;4403.229434848889;4426.114777044604;4427.712198707074;4439.64482841372;4440.222960981815;4495.910081798378;4306.203352379788;4346.587074227943;4369.868903932887;4401.867943961686;4457.1977044132045;4688.2733176357715;4709.976450117728;4728.432588089451;4733.502982186856;4777.402824646919;5097.108006098955;5134.05020071288;5137.7944882204665;5138.229265610151;5159.638825282232;5085.313482679865;5147.176451767699;5192.143296356135;5209.947900521022;5250.05499010178;4736.8342108026745;4755.714657120584;4767.356406885061;4808.8797780055775;4817.0365926814775;5202.817901373433;5205;5207.192885102815;5210.348706411699;5232.136697444879;4997.800087996439;5024.171011783015;5064.974675126601;5103;5111.182210846247;4909.361782968192;5017.54842064216;5088.77100530477;5110.744462776846;5123.180291153398;5018.146915024455;5020.623453241022;5034.848954531297;5035.269885866602;5080.110980578458;4959.727215003138;5010.924836127461;5021.648484606042;5024.572911302507;5069.493050694901;4301.483821941324;4310.482742070972;4312.353147027909;4320.049589090395;4343.891402714958;3726.5341832270965;3771.340015497332;3773.5660399053913;3799.9740070180897;3801.9049523761573;4308.009157893702;4343.04453020335;4387.846425375096;4407.515173330995;4423.314386270134;5148.562372198405;5162.586993040548;5162.870928226825;5174.53429191367;5177.378714554277;4372.3878656988045;4427.358033085249;4429.68992170545;4439.267520859022;4485.820567177341;4561.429821272341;4577.382053422812;4581.816727330869;4610.354550362952;4635.980084381498;4765.0946320199055;4774.832880849153;4775.2598347256235;4794.376731024944;4812.446568644651;5053.646244762978;5149.6910185389;5162.967406518636;5172.508611681884;5200.947990520046;4764.380630518011;4773.928391074206;4781.402324709411;4788.16207163738;4819.518048195152;5037.168867136881;5038.294638750504;5041.798328066836;5042.697438153723;5103.7448127592725;4953.034158339089;5086.033653605803;5098.923516147187;5126.410462796826;5152.5877929766275;4861.076395484846;4876.878078048077;4898.608111351012;4938.802447902188;4956.851294461172;4835.492273311252;4868.440129385166;4874.5369189928315;4876.341693871282;4888.777805548613;4781.760911954458;4824.49342818999;4832.806687732451;4862.149123903232;4886.193778026586;5003.674761140514;5034.892323688782;5055.292259083658;5058.924116138334;5114.053900028507;4865.367502224688;4937.679050861682;4952.678075925053;4958.0083983202785;4982.825601103944 04:19:46 INFO - PROCESS | 2447 | |1;ext.html;494.0489557601616;495.2323897958164;513.2967834067327;522.4696932613398;544.0805039483274;34284;34923.30153396931;34947.4757878632;35021.64978350216;35066.474002889976;38278.23443531128;38624;38835;38839.22321553567;39128;7727.497712648674;7818.14000459949;7866.52800831949;7868.881966770503;7916.722914697987;7618.504797188193;7709.575973321465;7738.767836964872;7739;7742.961285193566;7807.921920780776;7942.364610831149;7943.960280198591;7951.602419878983;7985.880211796828;7821.100573434042;7921.445498815086;7935.484193527431;7981.760547183594;7989.920100799034;7743.574103424309;7795.883061754078;7848.9607551962445;7955.164707705665;7989.96005019977;38004;38277.80861095704;38407;38454;38504;2602.921912342633;3068.1102480280915;3140.560321554984;3146.2606287522412;3167.572377729;25296.98812047516;25537.74462255391;25717.35706607331;25894.611580826302;25943;3523.5771707395274;3537.7169826413824;3540.168060505779;3594.4608308753636;3639.090227443139;267739;272571;272828;273100;273311;54971;55934.44065559374;56161.43838561562;56194.438055619736;56318.15522767162;63479.365206348266;64309.356906431276;64523;64532.677336613015;64898;13592.320383980761;13719.657008574866;13731.519396821062;13782.104163229558;13847;11021.118310535137;11022.393768342657;11063.336199828036;11089.778204435866;11099;19421.382391852538;19488.96446487881;20565.280215192397;20585.176592936114;20724.274650387164;8059.3552515799765;8141.22658347456;8213.178682131738;8214.917850821415;8313.501189928624;885.4996926736374;892.5269607108243;939.7791518993031;960.7934294126796;1098.5180463708052;26490;27115.593266101023;27226.72773272242;27782.861085694847;27821.16536503908;962.6390103711109;1012.1750773119884;1058.312097136852;1090.3566895531674;1155.4280631087497;13618.910487161202;14156.150630961969;14437.711245775236;14450.205238711762;14458.638534036732;290956;428082;428523;435503;436934;50542.494575054516;50885.23672144921;50974;51187.74406127945;51369.486305137216;1254.2223821230714;1262.696952731338;1266.8289780879463;1267.0940277701488;1276.4511260158222;28051.438971220054;28358.432831342845;28490.57264140998;29080.7091929078;29374.412511750073;41416;41563.58436415597;41921.37117943172;42174.78912605417;42183.78908105563;271466;272904.63547682134;273427;275008;275745;31139.68860311368;31407.685923140478;31770.52344214885;31797.682023179474;31835.522467162547;40143.799281004576;40628.39057414082;40928.18143637051;41002.38496422496;41040.1791964165;34642;34819.30361392707;34822.47766283558;34870.825645871606;34954.12614684653;34100.65899341074;34389.65610343964;34644.133896652784;34927.65072349244;34946.65053349434;31784.364312713155;34203.82898085494;34641.48037779385;34679.47980780341;34731.13172170716;27078;27087.322816929733;29430.558541622322;29439;29762.553561697026;23341.76658233396;23524.52950941006;23784.881075595204;23875.40311492157;23976.88011559931 04:19:46 INFO - PROCESS | 2447 | |2;jquery.html;350.843969121744;352.6138877928668;357.67272945255087;361.92399596084823;364.792068520943;15690.607734806636;16016.839831601681;16055.919720401396;16189.35242590298;16848.578785530368;10580.100691441237;10871.782564348709;10891.237613367068;10896.40069796161;15657.295421706021;4552.066826300609;4737.715737055788;4782.617390608743;4785.1147537705465;4786.425628924534;4628.514006029369;5060.190369540875;5233.816816411427;5244.554212891909;5253.6322457428;4981.1283025470575;5148.819791307305;5205.063088644042;5207.895842083156;5227;5197.48025197481;5201.739913004372;5225.2162175673575;5226.973865130688;5236.738163091868;4944.9258261126115;4994.800207991676;5279.788808447657;5312.521873031407;5325.387580428262;11792.705182370424;11877.82183267243;11949.283043017447;11992.460339284753;14179.291035448186;1892.2714754819356;1923.6248931458372;1936.9128389222378;1949.3664559018234;1950.473372189515;8354.916450835535;9491.905080949171;9616.23070154386;11132.554697812078;12672.556460523838;1760.5070580237425;1812.4019073705645;1821.9180136893872;1854.3231720422084;1870.4388683394927;58429.70785146047;59311.517212069615;59776.70111649501;59975;60968.39031609672;10178.949105254575;10240.64157754475;10312.742181445374;10381.273310868166;10545.630902918361;13407;13412.329383530785;13441.596752097257;13493.730125397436;13536.59390218295;6321.336259692758;7108.609026503488;7271.636418179176;7305.305995930378;7355.271511194972;7079.504434689626;7105.502614817016;7198.856022879513;7221.89167162493;7235.602041887747;4288.764117973541;4376.190404775127;4409.206342858252;4420.403245561873;4433.00257442073;1836.2838492987746;1836.9908150459162;1838.4852241372437;1847.7967423583395;1909.207678813277;829.2950991657164;889.3774357949331;900.243795212025;922.6632279218171;1024.702836177515;15467.303971321318;15919.442819501262;15929.601759955862;15996.680066398607;16357.263923123488;859.6604341285157;881.9559022049;901.324006994754;916.7616419730919;933.9392939458913;9026.097390260922;9066.09339066088;9086.136817002374;9213.216876565568;9369.297302702325;425282;428803;435160;444380;446220;69555;71072.28927710657;71228.2877171232;71784.64107679532;72230;958.7890664053897;962.1821451766083;970.2722957781664;978.9427418388124;985.9852102218473;13989.370478328703;14248;14280;14465.927670361581;14599.197044162673;32232.033039008867;32434.189145271557;33144.50283245801;33268.50097248495;33942;42856;43935.340969886114;44045.77977110094;44467;44475.77762111169;7487.625618718933;7532.623368831427;7554.395648348229;7727.574983375968;7756.92243077562;9980.500974951368;11233.831492527455;11434.199606027498;11873.525058997544;12239.87760122423;10107.69676909694;10275.845862311922;10298.279120461795;10430.37417754937;10593.09958653523;10071.295009349275;10221.284510084222;10264.538095785856;10397.948010259901;10496.422696751752;10399.94800025995;10666.36001839892;10667.946660266649;10738.73153171177;10884.564617415532;7584.886226706493;7686.577238251726;7692.346150577264;7757.642412577889;7851.528908265523;10003.549840257352;10180.643677471253;10241.74395640115;10271.281010329205;10466.162706983576 04:19:46 INFO - PROCESS | 2447 | |3;mootools.html;1417.7944198091277;1427.343422025868;1574.519771469702;1751.929922803088;1774.503139121045;6498.577592456487;7162.212156662776;7303.926960730391;7477.588732619697;7512.286332798389;7168.928310716891;7214.819629509265;7244.710211591543;7250.637468126599;7263.709451621929;2258.4128126687096;2278.2026290798253;2280.327303445479;2280.6579013147993;2286.9085236590518;2175.1082056356895;2206.6138425775425;2226.1540614566525;2226.2875879718495;2227.387468446182;2246.9662955055687;2262.2082271205027;2263.7170353705787;2274.5223503064376;2297.9195728149516;2249.7975182233513;2254.3462395905085;2277.749447560767;2279.9202027929027;2280.133549251274;2266.6826644269813;2271.193726227182;2273.147569661377;2276.4195130241847;2283.3264187064688;7320.560766353982;7386.889196662054;7422.480426370156;7423.74016909411;7431.628418579104;4685.109829132488;4784.067106914154;4817.975910120462;4823.662343635947;4829.058333624945;3108.2074071111947;3117.0960421477744;3276.852541635632;3284.0640417480904;3297.4559197732347;1043.7338478687886;1045.0698877998586;1049.6168898352046;1067.460932229227;1792.5429015601069;9891.505424728806;9892.802143957153;9897.554610042493;9934.45360505172;9972;4130.421740956269;4225.830966761295;4296.398504209413;4304.332828411601;4316.589923957219;7990.9200907991335;8056.637451314587;8057.83884322322;8067.596620168968;8082.434229603871;4669.95330046702;4677.32178834074;4705.247160454311;4719;4721.315409265637;3801.676857467091;4222.936655950163;4307.353896915488;4370.2352088384405;4388.692791504564;3441.208522039945;3468.9826550867083;3509;3531.646835316499;3540.185757275841;1072.3726619927274;1075.3010543147018;1078.1428764132534;1078.5038882114316;1084.5065495199665;994.6319861651091;1002.3634991780272;1018.5212949913529;1115.59838458155;1254.8933340665963;6896.27589103147;6902.413294869892;6905.343992320822;6917.342852429011;6979.336962988508;468.9155951928686;479.4103252998831;479.8560431870425;479.9424069111729;480.4738811001947;5329.840104796862;5422.674639521641;5434.83695489136;5457.181422786613;5574.414686457944;9081.909180908106;9248.445093294424;9301.674441394518;9314.161725444743;9367.62529498826;8576.1423857615;9103.726888193365;9162.17540421352;9182.95408522953;9211.677591284273;6950.756723514653;7043.330883566053;7060.258672839381;7073.92926070743;7125.073740413816;6977.581345119309;6990;7076.7523136692025;7078.893816592652;7095.716171353088;7852.646630901738;8066.354691624773;8077.15189905075;8154.83690326202;8192.590370481572;8026.7591972240925;8052.436329456882;8081.272685458337;8104.756857294291;8123.984501937258;6256.31180570146;6647.501437392311;6656.800295991128;6739.42714869222;6849.315068493111;6703.765368212089;6753.763618273337;6766;6792.422644075309;6803.353681400259;6215.098810672517;6242.625442473466;6334.8733025338315;6348.650824204713;6361.650109244036;6014.458698717136;6094.969525152524;6147.692615369303;6221.720022598904;6240.7503699851495;6639.03733958583;6667.066610674607;6679.165104361955;6709.630970296681;6725.159355080615;6066.059760737093;6088.786892458743;6165.876682466415;6173.197484327009;6192.566520343533;6118.541109416722;6142.877142457037;6168;6175;6191.876162476635 04:19:46 INFO - PROCESS | 2447 | |4;prototype.html;309.7661265744364;326.4515613768868;333.1537893749875;334.5233042913849;335.06683885379215;5710.685912274828;5720.3993580674005;5732.5987180897355;5756.481916627513;5758.531574448515;5678.063119585274;5678.971605141968;5692.288463942007;5703.201551782754;5714.828555143353;4169.124483858378;4304.698671093025;4428.446444194484;4440.178566965105;4454.576815202567;4422.314541246096;4430.113977204572;4437.911241775162;4440.866773996785;4448.644108471331;4398.3842262083335;4403.603675669189;4408.801603927831;4410;4411.82352705893;4399.38408622793;4407.07451435199;4414.97792511037;4416.028473735773;4426.070525189714;3896.4350169225586;3901.375779875235;3905.3946638271113;3907.648311651965;3913.1391093959282;5513.338399392099;5523.751431185607;5524.33707955048;5539.584531160179;5544.500994910478;4789.257665061921;4980.05378977993;4999.450060493379;5002.574781143607;5102.872428189288;5934.198883150762;5996.940030599681;6004.909926351108;6021.066734656135;6028.668423236721;4072.124493233969;4093.6111069448652;4100.302948498763;4110.527289361732;4113.424120623115;6272.65500397478;6304.842378940517;6350.9682451587905;6354.586951848161;6367.713452894631;4227.112306415625;4232.4286221360335;4241.533431322552;4242.44848169736;4251.404803327537;4152.5432202457705;4308.310670292738;4316.784160791948;4319.07139964909;4321.632661223831;4941.579965702956;4944.728039957837;4965.478624744422;4976.104301225814;5025.296458495814;6033.849153771103;6035.969820150871;6052.243469566304;6053.636781793107;6059.091136329585;1452.1867754057762;1511.7656763201721;1513.4702854001232;1514.545636309103;1515.0303805564447;982.8967958364411;986.6990567876867;1001.9448930308903;1014.6753039027441;1037.9117774989058;5175.689458632494;5189.610779191576;5203.739813009334;5222.112240919053;5229.947700522946;6235.064740288993;6265.749370025239;6269.059641053787;6269.0909818076125;6282.874342513215;5000.1749711297225;5088.92366614501;5188.870278242998;5196.636235463481;5213.322268105122;3323.916902077419;3377.037544299912;3398.966010339865;3404.4552871540436;3406.2506248625264;5841.620294680917;5843.561732870052;5844.152597873284;5850.678212698257;5856.385079566669;6460.515461340418;6466.805995820133;6481.0602462642655;6487.18910136233;6501.349865013555;5759.136129580513;5810.767569297265;5836.766529338779;5853.239078919713;5856.385079566584;6150.600210986271;6301.243850737941;6349.301576826638;6349.936500635119;6351.460125889351;6183.227096612924;6200.503959683305;6202.131701561695;6214.5028397728975;6221.160143380585;5832.562557808096;5849.034909239927;5852.151438041375;5854.092615644582;5866.442687944638;4236.957630423656;4248.766317852548;4284.871453856389;4293;4309.332053531708;6148;6273.090401891609;6285.685715714288;6288.779892703917;6308.779192728232;6055.848603784764;6071.605345652519;6091.451769340781;6100.664463454553;6115.694215289307;6013.488853447331;6051.12258722474;6060.575759696955;6061.848453788691;6072.514198864169;5884.176215329943;5939.049752039653;5946.108083787466;5950.672713000827;5968.701564921824;6061.36355682647;6098.359672234529;6100.603460775035;6104.11490333908;6105.694715264308;5741.167530708108;5952.255968003999;5970.402959704169;5976.043832986701;5977.880442391215 04:19:46 INFO - PROCESS | 2447 | |5;yui.html;679.463224052998;707.8513512162446;734.3684431389008;756.984860302794;768.4421130167326;12186.51253949842;12329.075319351063;12362.134650574464;12404.193727407723;12409.069319801029;12644.747105057893;12657.050721195901;12671.746565068694;12688.682782930431;12721.42753576089;632.2981490545491;800.235774835034;804.7022601637373;810.7973006748313;826.0747962282252;813.369638530141;814.1776805426503;817.3787921179917;818.3984771193168;818.5416166946529;860.389123722158;863.5336918064238;864.235151890575;868.4789126524098;868.9782755431102;851.2083762101244;856.04550925718;857.6740838481369;859.0679113162226;859.8237361340911;633.8795628830508;634.8539835837737;635.7679447001857;636.6434796513921;637.9649119298437;11930.642080737593;11980.041596672245;11980.281183128953;11989.400529973467;11992.220505667105;12664.17682850621;12984.805227921588;13040.282784446852;13077.888379487755;13106.082574219809;10124.94937525315;10160.847587286196;10173.186145108373;10191;10388.324758890723;3356.077078803324;3399.1162297802503;3413.7269018478464;3439.9852043647184;3442.3631628148623;43251.78374108141;43314.783426082984;43345.13309733788;43399;43475.34786978198;9668.854967175497;9849.916509183984;9979.950100249453;10264.538095785707;10318.43248621318;18121.54696132581;18275;18289.359872404402;18396.26414943414;18473.815261847478;6745.325467453215;7023.086998690138;7048.612326321999;7118.537295075804;7218.962591381661;3609.296187243462;3840.231953609289;3923.2349691809823;3931.6068393160454;3971.5035620547433;2827.491051610689;2832.589274555178;2854.072426461408;2863.3843723599525;2864.756495697847;512.6437126197258;535.1143856916809;538.569144684251;538.9006426889102;539.6438350688527;456.19253920560425;522.0655027500732;531.9122344813062;542.4954792043359;545.4627192215664;7398.223186565333;7409.62951852416;7464.664090115958;7707;7767.883481747778;439.0779363337028;480.82209582454715;518.1761000010002;523.8428471458548;543.6737957225633;3496.8426420811124;3554.982225088858;3636.61815509373;3684.5578530576504;3706.258748250361;47216.29175562369;53476.73261633667;53939.460605394226;53964;54031;44167.116657666666;44397.55602443934;45080;45465.77267113643;45543.54456455459;42169.36745948813;42997.570024299355;43209.13581728411;43572.346414803804;43931.34102988522;8481.15188481147;8553.61508732121;8663.306935445275;8663.870041949502;8663.91336086631;32116.518252226702;32179.35641287208;32560.34879302448;33019.33961320712;33392.49911251382;38226.426603601525;38621.6137838618;40951.97620059522;41041.58958410497;42622.36066459068;10280.228982826467;10771.46142692878;10970.670879873616;11041.72395690082;11324;11787.233829801036;12064.517419303129;12242.449089791158;12271.877281227431;12309.076819238413;11401.20191586581;12042.578509752117;12105.75788484243;12112.515499379926;12134.089943254115;11172.49723762449;11322.60370887015;11630.360330181922;12172.087093467848;12237.510499579917;10496.632617858339;10529.842052369373;10561.049505544537;10656.520456579628;10696.465176741287;9997.200223982209;10124.797504050026;10158.441285729356;10189.235807314333;10522.736931576466;9600.950806737499;10201.74495637615;10228.795424091626;10230.130438912776;10270.435126068138 04:19:46 INFO - PROCESS | 2447 | __end_tp_report 04:19:46 INFO - PROCESS | 2447 | __start_cc_report 04:19:46 INFO - PROCESS | 2447 | _x_x_mozilla_cycle_collect,354 04:19:46 INFO - PROCESS | 2447 | __end_cc_report 04:19:46 INFO - PROCESS | 2447 | __startTimestamp1458040786097__endTimestamp 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | ------- Summary: start ------- 04:19:46 INFO - PROCESS | 2447 | Number of tests: 6 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | [#0] dojo.html Cycles:165 Average:4718.65 Median:4818.54 stddev:488.36 (10.1%) stddev-sans-first:461.79 04:19:46 INFO - PROCESS | 2447 | Values: 2638.6 2663.3 2690.4 2695.3 2703.2 4697.4 4733.8 4738.0 4767.2 4781.7 4751.5 4806.7 4818.5 4833.0 4879.6 4423.0 4438.7 4482.6 4560.9 4568.5 4434.6 4447.6 4480.7 4499.8 4509.1 4354.2 4361.4 4373.5 4395.7 4403.2 4426.1 4427.7 4439.6 4440.2 4495.9 4306.2 4346.6 4369.9 4401.9 4457.2 4688.3 4710.0 4728.4 4733.5 4777.4 5097.1 5134.1 5137.8 5138.2 5159.6 5085.3 5147.2 5192.1 5209.9 5250.1 4736.8 4755.7 4767.4 4808.9 4817.0 5202.8 5205.0 5207.2 5210.3 5232.1 4997.8 5024.2 5065.0 5103.0 5111.2 4909.4 5017.5 5088.8 5110.7 5123.2 5018.1 5020.6 5034.8 5035.3 5080.1 4959.7 5010.9 5021.6 5024.6 5069.5 4301.5 4310.5 4312.4 4320.0 4343.9 3726.5 3771.3 3773.6 3800.0 3801.9 4308.0 4343.0 4387.8 4407.5 4423.3 5148.6 5162.6 5162.9 5174.5 5177.4 4372.4 4427.4 4429.7 4439.3 4485.8 4561.4 4577.4 4581.8 4610.4 4636.0 4765.1 4774.8 4775.3 4794.4 4812.4 5053.6 5149.7 5163.0 5172.5 5200.9 4764.4 4773.9 4781.4 4788.2 4819.5 5037.2 5038.3 5041.8 5042.7 5103.7 4953.0 5086.0 5098.9 5126.4 5152.6 4861.1 4876.9 4898.6 4938.8 4956.9 4835.5 4868.4 4874.5 4876.3 4888.8 4781.8 4824.5 4832.8 4862.1 4886.2 5003.7 5034.9 5055.3 5058.9 5114.1 4865.4 4937.7 4952.7 4958.0 4982.8 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | [#1] ext.html Cycles:180 Average:47259.21 Median:34937.15 stddev:85521.07 (244.8%) stddev-sans-first:85688.90 04:19:46 INFO - PROCESS | 2447 | Values: 494.0 495.2 513.3 522.5 544.1 34284.0 34923.3 34947.5 35021.6 35066.5 38278.2 38624.0 38835.0 38839.2 39128.0 7727.5 7818.1 7866.5 7868.9 7916.7 7618.5 7709.6 7738.8 7739.0 7743.0 7807.9 7942.4 7944.0 7951.6 7985.9 7821.1 7921.4 7935.5 7981.8 7989.9 7743.6 7795.9 7849.0 7955.2 7990.0 38004.0 38277.8 38407.0 38454.0 38504.0 2602.9 3068.1 3140.6 3146.3 3167.6 25297.0 25537.7 25717.4 25894.6 25943.0 3523.6 3537.7 3540.2 3594.5 3639.1 267739.0 272571.0 272828.0 273100.0 273311.0 54971.0 55934.4 56161.4 56194.4 56318.2 63479.4 64309.4 64523.0 64532.7 64898.0 13592.3 13719.7 13731.5 13782.1 13847.0 11021.1 11022.4 11063.3 11089.8 11099.0 19421.4 19489.0 20565.3 20585.2 20724.3 8059.4 8141.2 8213.2 8214.9 8313.5 885.5 892.5 939.8 960.8 1098.5 26490.0 27115.6 27226.7 27782.9 27821.2 962.6 1012.2 1058.3 1090.4 1155.4 13618.9 14156.2 14437.7 14450.2 14458.6 290956.0 428082.0 428523.0 435503.0 436934.0 50542.5 50885.2 50974.0 51187.7 51369.5 1254.2 1262.7 1266.8 1267.1 1276.5 28051.4 28358.4 28490.6 29080.7 29374.4 41416.0 41563.6 41921.4 42174.8 42183.8 271466.0 272904.6 273427.0 275008.0 275745.0 31139.7 31407.7 31770.5 31797.7 31835.5 40143.8 40628.4 40928.2 41002.4 41040.2 34642.0 34819.3 34822.5 34870.8 34954.1 34100.7 34389.7 34644.1 34927.7 34946.7 31784.4 34203.8 34641.5 34679.5 34731.1 27078.0 27087.3 29430.6 29439.0 29762.6 23341.8 23524.5 23784.9 23875.4 23976.9 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | [#2] jquery.html Cycles:180 Average:24402.38 Median:431981.50 stddev:71455.25 (16.5%) stddev-sans-first:71632.88 04:19:46 INFO - PROCESS | 2447 | Values: 350.8 352.6 357.7 361.9 364.8 15690.6 16016.8 16055.9 16189.4 16848.6 10580.1 10871.8 10891.2 10896.4 15657.3 4552.1 4737.7 4782.6 4785.1 4786.4 4628.5 5060.2 5233.8 5244.6 5253.6 4981.1 5148.8 5205.1 5207.9 5227.0 5197.5 5201.7 5225.2 5227.0 5236.7 4944.9 4994.8 5279.8 5312.5 5325.4 11792.7 11877.8 11949.3 11992.5 14179.3 1892.3 1923.6 1936.9 1949.4 1950.5 8354.9 9491.9 9616.2 11132.6 12672.6 1760.5 1812.4 1821.9 1854.3 1870.4 58429.7 59311.5 59776.7 59975.0 60968.4 10178.9 10240.6 10312.7 10381.3 10545.6 13407.0 13412.3 13441.6 13493.7 13536.6 6321.3 7108.6 7271.6 7305.3 7355.3 7079.5 7105.5 7198.9 7221.9 7235.6 4288.8 4376.2 4409.2 4420.4 4433.0 1836.3 1837.0 1838.5 1847.8 1909.2 829.3 889.4 900.2 922.7 1024.7 15467.3 15919.4 15929.6 15996.7 16357.3 859.7 882.0 901.3 916.8 933.9 9026.1 9066.1 9086.1 9213.2 9369.3 425282.0 428803.0 435160.0 444380.0 446220.0 69555.0 71072.3 71228.3 71784.6 72230.0 958.8 962.2 970.3 978.9 986.0 13989.4 14248.0 14280.0 14465.9 14599.2 32232.0 32434.2 33144.5 33268.5 33942.0 42856.0 43935.3 44045.8 44467.0 44475.8 7487.6 7532.6 7554.4 7727.6 7756.9 9980.5 11233.8 11434.2 11873.5 12239.9 10107.7 10275.8 10298.3 10430.4 10593.1 10071.3 10221.3 10264.5 10397.9 10496.4 10399.9 10666.4 10667.9 10738.7 10884.6 7584.9 7686.6 7692.3 7757.6 7851.5 10003.5 10180.6 10241.7 10271.3 10466.2 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | [#3] mootools.html Cycles:180 Average:5192.11 Median:6156.78 stddev:2640.87 (42.9%) stddev-sans-first:2633.04 04:19:46 INFO - PROCESS | 2447 | Values: 1417.8 1427.3 1574.5 1751.9 1774.5 6498.6 7162.2 7303.9 7477.6 7512.3 7168.9 7214.8 7244.7 7250.6 7263.7 2258.4 2278.2 2280.3 2280.7 2286.9 2175.1 2206.6 2226.2 2226.3 2227.4 2247.0 2262.2 2263.7 2274.5 2297.9 2249.8 2254.3 2277.7 2279.9 2280.1 2266.7 2271.2 2273.1 2276.4 2283.3 7320.6 7386.9 7422.5 7423.7 7431.6 4685.1 4784.1 4818.0 4823.7 4829.1 3108.2 3117.1 3276.9 3284.1 3297.5 1043.7 1045.1 1049.6 1067.5 1792.5 9891.5 9892.8 9897.6 9934.5 9972.0 4130.4 4225.8 4296.4 4304.3 4316.6 7990.9 8056.6 8057.8 8067.6 8082.4 4670.0 4677.3 4705.2 4719.0 4721.3 3801.7 4222.9 4307.4 4370.2 4388.7 3441.2 3469.0 3509.0 3531.6 3540.2 1072.4 1075.3 1078.1 1078.5 1084.5 994.6 1002.4 1018.5 1115.6 1254.9 6896.3 6902.4 6905.3 6917.3 6979.3 468.9 479.4 479.9 479.9 480.5 5329.8 5422.7 5434.8 5457.2 5574.4 9081.9 9248.4 9301.7 9314.2 9367.6 8576.1 9103.7 9162.2 9183.0 9211.7 6950.8 7043.3 7060.3 7073.9 7125.1 6977.6 6990.0 7076.8 7078.9 7095.7 7852.6 8066.4 8077.2 8154.8 8192.6 8026.8 8052.4 8081.3 8104.8 8124.0 6256.3 6647.5 6656.8 6739.4 6849.3 6703.8 6753.8 6766.0 6792.4 6803.4 6215.1 6242.6 6334.9 6348.7 6361.7 6014.5 6095.0 6147.7 6221.7 6240.8 6639.0 6667.1 6679.2 6709.6 6725.2 6066.1 6088.8 6165.9 6173.2 6192.6 6118.5 6142.9 6168.0 6175.0 6191.9 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | [#4] prototype.html Cycles:180 Average:4982.66 Median:5697.75 stddev:1483.97 (26.0%) stddev-sans-first:1446.09 04:19:46 INFO - PROCESS | 2447 | Values: 309.8 326.5 333.2 334.5 335.1 5710.7 5720.4 5732.6 5756.5 5758.5 5678.1 5679.0 5692.3 5703.2 5714.8 4169.1 4304.7 4428.4 4440.2 4454.6 4422.3 4430.1 4437.9 4440.9 4448.6 4398.4 4403.6 4408.8 4410.0 4411.8 4399.4 4407.1 4415.0 4416.0 4426.1 3896.4 3901.4 3905.4 3907.6 3913.1 5513.3 5523.8 5524.3 5539.6 5544.5 4789.3 4980.1 4999.5 5002.6 5102.9 5934.2 5996.9 6004.9 6021.1 6028.7 4072.1 4093.6 4100.3 4110.5 4113.4 6272.7 6304.8 6351.0 6354.6 6367.7 4227.1 4232.4 4241.5 4242.4 4251.4 4152.5 4308.3 4316.8 4319.1 4321.6 4941.6 4944.7 4965.5 4976.1 5025.3 6033.8 6036.0 6052.2 6053.6 6059.1 1452.2 1511.8 1513.5 1514.5 1515.0 982.9 986.7 1001.9 1014.7 1037.9 5175.7 5189.6 5203.7 5222.1 5229.9 6235.1 6265.7 6269.1 6269.1 6282.9 5000.2 5088.9 5188.9 5196.6 5213.3 3323.9 3377.0 3399.0 3404.5 3406.3 5841.6 5843.6 5844.2 5850.7 5856.4 6460.5 6466.8 6481.1 6487.2 6501.3 5759.1 5810.8 5836.8 5853.2 5856.4 6150.6 6301.2 6349.3 6349.9 6351.5 6183.2 6200.5 6202.1 6214.5 6221.2 5832.6 5849.0 5852.2 5854.1 5866.4 4237.0 4248.8 4284.9 4293.0 4309.3 6148.0 6273.1 6285.7 6288.8 6308.8 6055.8 6071.6 6091.5 6100.7 6115.7 6013.5 6051.1 6060.6 6061.8 6072.5 5884.2 5939.0 5946.1 5950.7 5968.7 6061.4 6098.4 6100.6 6104.1 6105.7 5741.2 5952.3 5970.4 5976.0 5977.9 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - PROCESS | 2447 | [#5] yui.html Cycles:180 Average:12948.73 Median:3951.56 stddev:14423.61 (365.0%) stddev-sans-first:14434.64 04:19:46 INFO - PROCESS | 2447 | Values: 679.5 707.9 734.4 757.0 768.4 12186.5 12329.1 12362.1 12404.2 12409.1 12644.7 12657.1 12671.7 12688.7 12721.4 632.3 800.2 804.7 810.8 826.1 813.4 814.2 817.4 818.4 818.5 860.4 863.5 864.2 868.5 869.0 851.2 856.0 857.7 859.1 859.8 633.9 634.9 635.8 636.6 638.0 11930.6 11980.0 11980.3 11989.4 11992.2 12664.2 12984.8 13040.3 13077.9 13106.1 10124.9 10160.8 10173.2 10191.0 10388.3 3356.1 3399.1 3413.7 3440.0 3442.4 43251.8 43314.8 43345.1 43399.0 43475.3 9668.9 9849.9 9980.0 10264.5 10318.4 18121.5 18275.0 18289.4 18396.3 18473.8 6745.3 7023.1 7048.6 7118.5 7219.0 3609.3 3840.2 3923.2 3931.6 3971.5 2827.5 2832.6 2854.1 2863.4 2864.8 512.6 535.1 538.6 538.9 539.6 456.2 522.1 531.9 542.5 545.5 7398.2 7409.6 7464.7 7707.0 7767.9 439.1 480.8 518.2 523.8 543.7 3496.8 3555.0 3636.6 3684.6 3706.3 47216.3 53476.7 53939.5 53964.0 54031.0 44167.1 44397.6 45080.0 45465.8 45543.5 42169.4 42997.6 43209.1 43572.3 43931.3 8481.2 8553.6 8663.3 8663.9 8663.9 32116.5 32179.4 32560.3 33019.3 33392.5 38226.4 38621.6 40952.0 41041.6 42622.4 10280.2 10771.5 10970.7 11041.7 11324.0 11787.2 12064.5 12242.4 12271.9 12309.1 11401.2 12042.6 12105.8 12112.5 12134.1 11172.5 11322.6 11630.4 12172.1 12237.5 10496.6 10529.8 10561.0 10656.5 10696.5 9997.2 10124.8 10158.4 10189.2 10522.7 9601.0 10201.7 10228.8 10230.1 10270.4 04:19:46 INFO - PROCESS | 2447 | -------- Summary: end -------- 04:19:46 INFO - PROCESS | 2447 | 04:19:46 INFO - TEST-INFO | 2447: exit 0 04:19:46 INFO - TEST-OK | dromaeo_css | took 1114003ms 04:19:46 INFO - TEST-START | kraken 04:19:46 INFO - operating with platform_type : linux_ 04:19:46 INFO - Initialising browser for kraken test... 04:19:46 INFO - TEST-INFO | started process 2759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptTqXNE/profile http://localhost:43867/getInfo.html) 04:19:50 INFO - PROCESS | 2759 | 04:19:50 INFO - PROCESS | 2759 | (process:2868): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:50 INFO - PROCESS | 2759 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:19:51 INFO - PROCESS | 2759 | __metrics Screen width/height:1600/1200 04:19:51 INFO - PROCESS | 2759 | colorDepth:24 04:19:51 INFO - PROCESS | 2759 | Browser inner width/height: 1024/697 04:19:51 INFO - PROCESS | 2759 | __metrics 04:19:51 ERROR - PROCESS | 2759 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 04:19:52 INFO - TEST-INFO | 2759: exit 0 04:19:52 INFO - Browser initialized. 04:19:52 INFO - Running cycle 1/1 for kraken test... 04:19:52 INFO - TEST-INFO | started process 2931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptTqXNE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:54 INFO - PROCESS | 2931 | 04:19:54 INFO - PROCESS | 2931 | (process:2992): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:20:04 INFO - PROCESS | 2931 | RSS: Main: 165445632 04:20:04 INFO - PROCESS | 2931 | 04:20:07 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43867/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:07 INFO - PROCESS | 2931 | RSS: Main: 170823680 04:20:07 INFO - PROCESS | 2931 | 04:20:10 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43867/tests/kraken/driver.html?testName=audio-dft) 04:20:11 INFO - PROCESS | 2931 | RSS: Main: 171577344 04:20:11 INFO - PROCESS | 2931 | 04:20:13 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43867/tests/kraken/driver.html?testName=audio-fft) 04:20:14 INFO - PROCESS | 2931 | RSS: Main: 164642816 04:20:14 INFO - PROCESS | 2931 | 04:20:16 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43867/tests/kraken/driver.html?testName=audio-oscillator) 04:20:17 INFO - PROCESS | 2931 | RSS: Main: 165150720 04:20:17 INFO - PROCESS | 2931 | 04:20:19 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:20 INFO - PROCESS | 2931 | RSS: Main: 167211008 04:20:20 INFO - PROCESS | 2931 | 04:20:23 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43867/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:23 INFO - PROCESS | 2931 | RSS: Main: 167997440 04:20:23 INFO - PROCESS | 2931 | 04:20:27 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43867/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:27 INFO - PROCESS | 2931 | RSS: Main: 167735296 04:20:27 INFO - PROCESS | 2931 | 04:20:30 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43867/tests/kraken/driver.html?testName=json-parse-financial) 04:20:31 INFO - PROCESS | 2931 | RSS: Main: 167641088 04:20:31 INFO - PROCESS | 2931 | 04:20:33 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:33 INFO - PROCESS | 2931 | RSS: Main: 169267200 04:20:33 INFO - PROCESS | 2931 | 04:20:35 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:36 INFO - PROCESS | 2931 | RSS: Main: 167366656 04:20:36 INFO - PROCESS | 2931 | 04:20:38 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:39 INFO - PROCESS | 2931 | RSS: Main: 167731200 04:20:39 INFO - PROCESS | 2931 | 04:20:41 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:42 INFO - PROCESS | 2931 | RSS: Main: 168349696 04:20:42 INFO - PROCESS | 2931 | 04:20:44 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:45 INFO - PROCESS | 2931 | RSS: Main: 167497728 04:20:45 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | Cycle 1(1): loaded http://localhost:43867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43867/tests/kraken/driver.html?testName=ai-astar) 04:20:47 INFO - PROCESS | 2931 | RSS: Main: 168882176 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | __start_tp_report 04:20:47 INFO - PROCESS | 2931 | _x_x_mozilla_page_load 04:20:47 INFO - PROCESS | 2931 | _x_x_mozilla_page_load_details 04:20:47 INFO - PROCESS | 2931 | |i|pagename|runs| 04:20:47 INFO - PROCESS | 2931 | |0;ai-astar;115;109;115;114;115;125;114;113;113;114 04:20:47 INFO - PROCESS | 2931 | |1;audio-beat-detection;151;130;154;167;131;154;148;133;179;132 04:20:47 INFO - PROCESS | 2931 | |2;audio-dft;166;165;164;165;163;166;169;163;166;165 04:20:47 INFO - PROCESS | 2931 | |3;audio-fft;75;73;75;78;81;73;86;75;147;74 04:20:47 INFO - PROCESS | 2931 | |4;audio-oscillator;94;93;130;93;94;94;135;93;94;134 04:20:47 INFO - PROCESS | 2931 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;118;118;119 04:20:47 INFO - PROCESS | 2931 | |6;imaging-darkroom;148;147;147;147;147;147;147;147;147;147 04:20:47 INFO - PROCESS | 2931 | |7;imaging-desaturate;96;103;98;96;96;101;100;97;97;96 04:20:47 INFO - PROCESS | 2931 | |8;json-parse-financial;67;66;66;67;66;67;67;69;66;66 04:20:47 INFO - PROCESS | 2931 | |9;json-stringify-tinderbox;64;65;64;65;66;66;65;64;65;66 04:20:47 INFO - PROCESS | 2931 | |10;stanford-crypto-aes;83;83;84;85;91;86;91;91;85;85 04:20:47 INFO - PROCESS | 2931 | |11;stanford-crypto-ccm;119;117;120;124;122;126;125;121;124;134 04:20:47 INFO - PROCESS | 2931 | |12;stanford-crypto-pbkdf2;136;154;145;135;148;133;150;144;155;137 04:20:47 INFO - PROCESS | 2931 | |13;stanford-crypto-sha256-iterative;75;70;69;70;70;67;68;68;68;69 04:20:47 INFO - PROCESS | 2931 | __end_tp_report 04:20:47 INFO - PROCESS | 2931 | __start_cc_report 04:20:47 INFO - PROCESS | 2931 | _x_x_mozilla_cycle_collect,923 04:20:47 INFO - PROCESS | 2931 | __end_cc_report 04:20:47 INFO - PROCESS | 2931 | __startTimestamp1458040847562__endTimestamp 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | ------- Summary: start ------- 04:20:47 INFO - PROCESS | 2931 | Number of tests: 14 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:4.03 (3.5%) stddev-sans-first:4.27 04:20:47 INFO - PROCESS | 2931 | Values: 115.0 109.0 115.0 114.0 115.0 125.0 114.0 113.0 113.0 114.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.50 stddev:16.66 (10.9%) stddev-sans-first:17.63 04:20:47 INFO - PROCESS | 2931 | Values: 151.0 130.0 154.0 167.0 131.0 154.0 148.0 133.0 179.0 132.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:1.75 (1.1%) stddev-sans-first:1.83 04:20:47 INFO - PROCESS | 2931 | Values: 166.0 165.0 164.0 165.0 163.0 166.0 169.0 163.0 166.0 165.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#3] audio-fft Cycles:10 Average:83.70 Median:75.00 stddev:22.61 (30.2%) stddev-sans-first:23.76 04:20:47 INFO - PROCESS | 2931 | Values: 75.0 73.0 75.0 78.0 81.0 73.0 86.0 75.0 147.0 74.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:93.50 stddev:19.09 (20.4%) stddev-sans-first:19.80 04:20:47 INFO - PROCESS | 2931 | Values: 94.0 93.0 130.0 93.0 94.0 94.0 135.0 93.0 94.0 134.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:20:47 INFO - PROCESS | 2931 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 119.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 04:20:47 INFO - PROCESS | 2931 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:96.00 stddev:2.49 (2.6%) stddev-sans-first:2.54 04:20:47 INFO - PROCESS | 2931 | Values: 96.0 103.0 98.0 96.0 96.0 101.0 100.0 97.0 97.0 96.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 04:20:47 INFO - PROCESS | 2931 | Values: 67.0 66.0 66.0 67.0 66.0 67.0 67.0 69.0 66.0 66.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 04:20:47 INFO - PROCESS | 2931 | Values: 64.0 65.0 64.0 65.0 66.0 66.0 65.0 64.0 65.0 66.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.50 stddev:3.31 (3.9%) stddev-sans-first:3.27 04:20:47 INFO - PROCESS | 2931 | Values: 83.0 83.0 84.0 85.0 91.0 86.0 91.0 91.0 85.0 85.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:4.73 (3.8%) stddev-sans-first:4.77 04:20:47 INFO - PROCESS | 2931 | Values: 119.0 117.0 120.0 124.0 122.0 126.0 125.0 121.0 124.0 134.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:146.50 stddev:8.08 (5.5%) stddev-sans-first:8.08 04:20:47 INFO - PROCESS | 2931 | Values: 136.0 154.0 145.0 135.0 148.0 133.0 150.0 144.0 155.0 137.0 04:20:47 INFO - PROCESS | 2931 | 04:20:47 INFO - PROCESS | 2931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:2.22 (3.2%) stddev-sans-first:1.09 04:20:47 INFO - PROCESS | 2931 | Values: 75.0 70.0 69.0 70.0 70.0 67.0 68.0 68.0 68.0 69.0 04:20:47 INFO - PROCESS | 2931 | -------- Summary: end -------- 04:20:47 INFO - PROCESS | 2931 | 04:20:48 INFO - TEST-INFO | 2931: exit 0 04:20:48 INFO - TEST-OK | kraken | took 61698ms 04:20:48 INFO - SUITE-END | took 1175s 04:20:48 INFO - Completed test suite (00:19:35) 04:20:48 INFO - javascript benchmark 04:20:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2638.643783089283, 2663.2676014096123, 2690.4484580660965, 2695.272276485348, 2703.2025552462032, 4697.365855609496, 4733.8343157989475, 4737.9763101184535, 4767.237242041269, 4781.689190202635, 4751.501092385293, 4806.6875653082525, 4818.542238487347, 4832.951670483294, 4879.609631229502, 4422.97788511057, 4438.667099967499, 4482.641388688913, 4560.885977850564, 4568.5431456854385, 4434.623057040139, 4447.621952134073, 4480.6639502037315, 4499.7750112494405, 4509.0530988492455, 4354.194474022316, 4361.367601697768, 4373.497047839507, 4395.7142785718825, 4403.229434848889, 4426.114777044604, 4427.712198707074, 4439.64482841372, 4440.222960981815, 4495.910081798378, 4306.203352379788, 4346.587074227943, 4369.868903932887, 4401.867943961686, 4457.1977044132045, 4688.2733176357715, 4709.976450117728, 4728.432588089451, 4733.502982186856, 4777.402824646919, 5097.108006098955, 5134.05020071288, 5137.7944882204665, 5138.229265610151, 5159.638825282232, 5085.313482679865, 5147.176451767699, 5192.143296356135, 5209.947900521022, 5250.05499010178, 4736.8342108026745, 4755.714657120584, 4767.356406885061, 4808.8797780055775, 4817.0365926814775, 5202.817901373433, 5205.0, 5207.192885102815, 5210.348706411699, 5232.136697444879, 4997.800087996439, 5024.171011783015, 5064.974675126601, 5103.0, 5111.182210846247, 4909.361782968192, 5017.54842064216, 5088.77100530477, 5110.744462776846, 5123.180291153398, 5018.146915024455, 5020.623453241022, 5034.848954531297, 5035.269885866602, 5080.110980578458, 4959.727215003138, 5010.924836127461, 5021.648484606042, 5024.572911302507, 5069.493050694901, 4301.483821941324, 4310.482742070972, 4312.353147027909, 4320.049589090395, 4343.891402714958, 3726.5341832270965, 3771.340015497332, 3773.5660399053913, 3799.9740070180897, 3801.9049523761573, 4308.009157893702, 4343.04453020335, 4387.846425375096, 4407.515173330995, 4423.314386270134, 5148.562372198405, 5162.586993040548, 5162.870928226825, 5174.53429191367, 5177.378714554277, 4372.3878656988045, 4427.358033085249, 4429.68992170545, 4439.267520859022, 4485.820567177341, 4561.429821272341, 4577.382053422812, 4581.816727330869, 4610.354550362952, 4635.980084381498, 4765.0946320199055, 4774.832880849153, 4775.2598347256235, 4794.376731024944, 4812.446568644651, 5053.646244762978, 5149.6910185389, 5162.967406518636, 5172.508611681884, 5200.947990520046, 4764.380630518011, 4773.928391074206, 4781.402324709411, 4788.16207163738, 4819.518048195152, 5037.168867136881, 5038.294638750504, 5041.798328066836, 5042.697438153723, 5103.7448127592725, 4953.034158339089, 5086.033653605803, 5098.923516147187, 5126.410462796826, 5152.5877929766275, 4861.076395484846, 4876.878078048077, 4898.608111351012, 4938.802447902188, 4956.851294461172, 4835.492273311252, 4868.440129385166, 4874.5369189928315, 4876.341693871282, 4888.777805548613, 4781.760911954458, 4824.49342818999, 4832.806687732451, 4862.149123903232, 4886.193778026586, 5003.674761140514, 5034.892323688782, 5055.292259083658, 5058.924116138334, 5114.053900028507, 4865.367502224688, 4937.679050861682, 4952.678075925053, 4958.0083983202785, 4982.825601103944], "unit": "score", "name": "dojo.html", "value": 4687.74217848122}, {"lowerIsBetter": false, "replicates": [494.0489557601616, 495.2323897958164, 513.2967834067327, 522.4696932613398, 544.0805039483274, 34284.0, 34923.30153396931, 34947.4757878632, 35021.64978350216, 35066.474002889976, 38278.23443531128, 38624.0, 38835.0, 38839.22321553567, 39128.0, 7727.497712648674, 7818.14000459949, 7866.52800831949, 7868.881966770503, 7916.722914697987, 7618.504797188193, 7709.575973321465, 7738.767836964872, 7739.0, 7742.961285193566, 7807.921920780776, 7942.364610831149, 7943.960280198591, 7951.602419878983, 7985.880211796828, 7821.100573434042, 7921.445498815086, 7935.484193527431, 7981.760547183594, 7989.920100799034, 7743.574103424309, 7795.883061754078, 7848.9607551962445, 7955.164707705665, 7989.96005019977, 38004.0, 38277.80861095704, 38407.0, 38454.0, 38504.0, 2602.921912342633, 3068.1102480280915, 3140.560321554984, 3146.2606287522412, 3167.572377729, 25296.98812047516, 25537.74462255391, 25717.35706607331, 25894.611580826302, 25943.0, 3523.5771707395274, 3537.7169826413824, 3540.168060505779, 3594.4608308753636, 3639.090227443139, 267739.0, 272571.0, 272828.0, 273100.0, 273311.0, 54971.0, 55934.44065559374, 56161.43838561562, 56194.438055619736, 56318.15522767162, 63479.365206348266, 64309.356906431276, 64523.0, 64532.677336613015, 64898.0, 13592.320383980761, 13719.657008574866, 13731.519396821062, 13782.104163229558, 13847.0, 11021.118310535137, 11022.393768342657, 11063.336199828036, 11089.778204435866, 11099.0, 19421.382391852538, 19488.96446487881, 20565.280215192397, 20585.176592936114, 20724.274650387164, 8059.3552515799765, 8141.22658347456, 8213.178682131738, 8214.917850821415, 8313.501189928624, 885.4996926736374, 892.5269607108243, 939.7791518993031, 960.7934294126796, 1098.5180463708052, 26490.0, 27115.593266101023, 27226.72773272242, 27782.861085694847, 27821.16536503908, 962.6390103711109, 1012.1750773119884, 1058.312097136852, 1090.3566895531674, 1155.4280631087497, 13618.910487161202, 14156.150630961969, 14437.711245775236, 14450.205238711762, 14458.638534036732, 290956.0, 428082.0, 428523.0, 435503.0, 436934.0, 50542.494575054516, 50885.23672144921, 50974.0, 51187.74406127945, 51369.486305137216, 1254.2223821230714, 1262.696952731338, 1266.8289780879463, 1267.0940277701488, 1276.4511260158222, 28051.438971220054, 28358.432831342845, 28490.57264140998, 29080.7091929078, 29374.412511750073, 41416.0, 41563.58436415597, 41921.37117943172, 42174.78912605417, 42183.78908105563, 271466.0, 272904.63547682134, 273427.0, 275008.0, 275745.0, 31139.68860311368, 31407.685923140478, 31770.52344214885, 31797.682023179474, 31835.522467162547, 40143.799281004576, 40628.39057414082, 40928.18143637051, 41002.38496422496, 41040.1791964165, 34642.0, 34819.30361392707, 34822.47766283558, 34870.825645871606, 34954.12614684653, 34100.65899341074, 34389.65610343964, 34644.133896652784, 34927.65072349244, 34946.65053349434, 31784.364312713155, 34203.82898085494, 34641.48037779385, 34679.47980780341, 34731.13172170716, 27078.0, 27087.322816929733, 29430.558541622322, 29439.0, 29762.553561697026, 23341.76658233396, 23524.52950941006, 23784.881075595204, 23875.40311492157, 23976.88011559931], "unit": "score", "name": "ext.html", "value": 17570.892684695093}, {"lowerIsBetter": false, "replicates": [350.843969121744, 352.6138877928668, 357.67272945255087, 361.92399596084823, 364.792068520943, 15690.607734806636, 16016.839831601681, 16055.919720401396, 16189.35242590298, 16848.578785530368, 10580.100691441237, 10871.782564348709, 10891.237613367068, 10896.40069796161, 15657.295421706021, 4552.066826300609, 4737.715737055788, 4782.617390608743, 4785.1147537705465, 4786.425628924534, 4628.514006029369, 5060.190369540875, 5233.816816411427, 5244.554212891909, 5253.6322457428, 4981.1283025470575, 5148.819791307305, 5205.063088644042, 5207.895842083156, 5227.0, 5197.48025197481, 5201.739913004372, 5225.2162175673575, 5226.973865130688, 5236.738163091868, 4944.9258261126115, 4994.800207991676, 5279.788808447657, 5312.521873031407, 5325.387580428262, 11792.705182370424, 11877.82183267243, 11949.283043017447, 11992.460339284753, 14179.291035448186, 1892.2714754819356, 1923.6248931458372, 1936.9128389222378, 1949.3664559018234, 1950.473372189515, 8354.916450835535, 9491.905080949171, 9616.23070154386, 11132.554697812078, 12672.556460523838, 1760.5070580237425, 1812.4019073705645, 1821.9180136893872, 1854.3231720422084, 1870.4388683394927, 58429.70785146047, 59311.517212069615, 59776.70111649501, 59975.0, 60968.39031609672, 10178.949105254575, 10240.64157754475, 10312.742181445374, 10381.273310868166, 10545.630902918361, 13407.0, 13412.329383530785, 13441.596752097257, 13493.730125397436, 13536.59390218295, 6321.336259692758, 7108.609026503488, 7271.636418179176, 7305.305995930378, 7355.271511194972, 7079.504434689626, 7105.502614817016, 7198.856022879513, 7221.89167162493, 7235.602041887747, 4288.764117973541, 4376.190404775127, 4409.206342858252, 4420.403245561873, 4433.00257442073, 1836.2838492987746, 1836.9908150459162, 1838.4852241372437, 1847.7967423583395, 1909.207678813277, 829.2950991657164, 889.3774357949331, 900.243795212025, 922.6632279218171, 1024.702836177515, 15467.303971321318, 15919.442819501262, 15929.601759955862, 15996.680066398607, 16357.263923123488, 859.6604341285157, 881.9559022049, 901.324006994754, 916.7616419730919, 933.9392939458913, 9026.097390260922, 9066.09339066088, 9086.136817002374, 9213.216876565568, 9369.297302702325, 425282.0, 428803.0, 435160.0, 444380.0, 446220.0, 69555.0, 71072.28927710657, 71228.2877171232, 71784.64107679532, 72230.0, 958.7890664053897, 962.1821451766083, 970.2722957781664, 978.9427418388124, 985.9852102218473, 13989.370478328703, 14248.0, 14280.0, 14465.927670361581, 14599.197044162673, 32232.033039008867, 32434.189145271557, 33144.50283245801, 33268.50097248495, 33942.0, 42856.0, 43935.340969886114, 44045.77977110094, 44467.0, 44475.77762111169, 7487.625618718933, 7532.623368831427, 7554.395648348229, 7727.574983375968, 7756.92243077562, 9980.500974951368, 11233.831492527455, 11434.199606027498, 11873.525058997544, 12239.87760122423, 10107.69676909694, 10275.845862311922, 10298.279120461795, 10430.37417754937, 10593.09958653523, 10071.295009349275, 10221.284510084222, 10264.538095785856, 10397.948010259901, 10496.422696751752, 10399.94800025995, 10666.36001839892, 10667.946660266649, 10738.73153171177, 10884.564617415532, 7584.886226706493, 7686.577238251726, 7692.346150577264, 7757.642412577889, 7851.528908265523, 10003.549840257352, 10180.643677471253, 10241.74395640115, 10271.281010329205, 10466.162706983576], "unit": "score", "name": "jquery.html", "value": 7896.2463830350025}, {"lowerIsBetter": false, "replicates": [1417.7944198091277, 1427.343422025868, 1574.519771469702, 1751.929922803088, 1774.503139121045, 6498.577592456487, 7162.212156662776, 7303.926960730391, 7477.588732619697, 7512.286332798389, 7168.928310716891, 7214.819629509265, 7244.710211591543, 7250.637468126599, 7263.709451621929, 2258.4128126687096, 2278.2026290798253, 2280.327303445479, 2280.6579013147993, 2286.9085236590518, 2175.1082056356895, 2206.6138425775425, 2226.1540614566525, 2226.2875879718495, 2227.387468446182, 2246.9662955055687, 2262.2082271205027, 2263.7170353705787, 2274.5223503064376, 2297.9195728149516, 2249.7975182233513, 2254.3462395905085, 2277.749447560767, 2279.9202027929027, 2280.133549251274, 2266.6826644269813, 2271.193726227182, 2273.147569661377, 2276.4195130241847, 2283.3264187064688, 7320.560766353982, 7386.889196662054, 7422.480426370156, 7423.74016909411, 7431.628418579104, 4685.109829132488, 4784.067106914154, 4817.975910120462, 4823.662343635947, 4829.058333624945, 3108.2074071111947, 3117.0960421477744, 3276.852541635632, 3284.0640417480904, 3297.4559197732347, 1043.7338478687886, 1045.0698877998586, 1049.6168898352046, 1067.460932229227, 1792.5429015601069, 9891.505424728806, 9892.802143957153, 9897.554610042493, 9934.45360505172, 9972.0, 4130.421740956269, 4225.830966761295, 4296.398504209413, 4304.332828411601, 4316.589923957219, 7990.9200907991335, 8056.637451314587, 8057.83884322322, 8067.596620168968, 8082.434229603871, 4669.95330046702, 4677.32178834074, 4705.247160454311, 4719.0, 4721.315409265637, 3801.676857467091, 4222.936655950163, 4307.353896915488, 4370.2352088384405, 4388.692791504564, 3441.208522039945, 3468.9826550867083, 3509.0, 3531.646835316499, 3540.185757275841, 1072.3726619927274, 1075.3010543147018, 1078.1428764132534, 1078.5038882114316, 1084.5065495199665, 994.6319861651091, 1002.3634991780272, 1018.5212949913529, 1115.59838458155, 1254.8933340665963, 6896.27589103147, 6902.413294869892, 6905.343992320822, 6917.342852429011, 6979.336962988508, 468.9155951928686, 479.4103252998831, 479.8560431870425, 479.9424069111729, 480.4738811001947, 5329.840104796862, 5422.674639521641, 5434.83695489136, 5457.181422786613, 5574.414686457944, 9081.909180908106, 9248.445093294424, 9301.674441394518, 9314.161725444743, 9367.62529498826, 8576.1423857615, 9103.726888193365, 9162.17540421352, 9182.95408522953, 9211.677591284273, 6950.756723514653, 7043.330883566053, 7060.258672839381, 7073.92926070743, 7125.073740413816, 6977.581345119309, 6990.0, 7076.7523136692025, 7078.893816592652, 7095.716171353088, 7852.646630901738, 8066.354691624773, 8077.15189905075, 8154.83690326202, 8192.590370481572, 8026.7591972240925, 8052.436329456882, 8081.272685458337, 8104.756857294291, 8123.984501937258, 6256.31180570146, 6647.501437392311, 6656.800295991128, 6739.42714869222, 6849.315068493111, 6703.765368212089, 6753.763618273337, 6766.0, 6792.422644075309, 6803.353681400259, 6215.098810672517, 6242.625442473466, 6334.8733025338315, 6348.650824204713, 6361.650109244036, 6014.458698717136, 6094.969525152524, 6147.692615369303, 6221.720022598904, 6240.7503699851495, 6639.03733958583, 6667.066610674607, 6679.165104361955, 6709.630970296681, 6725.159355080615, 6066.059760737093, 6088.786892458743, 6165.876682466415, 6173.197484327009, 6192.566520343533, 6118.541109416722, 6142.877142457037, 6168.0, 6175.0, 6191.876162476635], "unit": "score", "name": "mootools.html", "value": 4241.941281450733}, {"lowerIsBetter": false, "replicates": [309.7661265744364, 326.4515613768868, 333.1537893749875, 334.5233042913849, 335.06683885379215, 5710.685912274828, 5720.3993580674005, 5732.5987180897355, 5756.481916627513, 5758.531574448515, 5678.063119585274, 5678.971605141968, 5692.288463942007, 5703.201551782754, 5714.828555143353, 4169.124483858378, 4304.698671093025, 4428.446444194484, 4440.178566965105, 4454.576815202567, 4422.314541246096, 4430.113977204572, 4437.911241775162, 4440.866773996785, 4448.644108471331, 4398.3842262083335, 4403.603675669189, 4408.801603927831, 4410.0, 4411.82352705893, 4399.38408622793, 4407.07451435199, 4414.97792511037, 4416.028473735773, 4426.070525189714, 3896.4350169225586, 3901.375779875235, 3905.3946638271113, 3907.648311651965, 3913.1391093959282, 5513.338399392099, 5523.751431185607, 5524.33707955048, 5539.584531160179, 5544.500994910478, 4789.257665061921, 4980.05378977993, 4999.450060493379, 5002.574781143607, 5102.872428189288, 5934.198883150762, 5996.940030599681, 6004.909926351108, 6021.066734656135, 6028.668423236721, 4072.124493233969, 4093.6111069448652, 4100.302948498763, 4110.527289361732, 4113.424120623115, 6272.65500397478, 6304.842378940517, 6350.9682451587905, 6354.586951848161, 6367.713452894631, 4227.112306415625, 4232.4286221360335, 4241.533431322552, 4242.44848169736, 4251.404803327537, 4152.5432202457705, 4308.310670292738, 4316.784160791948, 4319.07139964909, 4321.632661223831, 4941.579965702956, 4944.728039957837, 4965.478624744422, 4976.104301225814, 5025.296458495814, 6033.849153771103, 6035.969820150871, 6052.243469566304, 6053.636781793107, 6059.091136329585, 1452.1867754057762, 1511.7656763201721, 1513.4702854001232, 1514.545636309103, 1515.0303805564447, 982.8967958364411, 986.6990567876867, 1001.9448930308903, 1014.6753039027441, 1037.9117774989058, 5175.689458632494, 5189.610779191576, 5203.739813009334, 5222.112240919053, 5229.947700522946, 6235.064740288993, 6265.749370025239, 6269.059641053787, 6269.0909818076125, 6282.874342513215, 5000.1749711297225, 5088.92366614501, 5188.870278242998, 5196.636235463481, 5213.322268105122, 3323.916902077419, 3377.037544299912, 3398.966010339865, 3404.4552871540436, 3406.2506248625264, 5841.620294680917, 5843.561732870052, 5844.152597873284, 5850.678212698257, 5856.385079566669, 6460.515461340418, 6466.805995820133, 6481.0602462642655, 6487.18910136233, 6501.349865013555, 5759.136129580513, 5810.767569297265, 5836.766529338779, 5853.239078919713, 5856.385079566584, 6150.600210986271, 6301.243850737941, 6349.301576826638, 6349.936500635119, 6351.460125889351, 6183.227096612924, 6200.503959683305, 6202.131701561695, 6214.5028397728975, 6221.160143380585, 5832.562557808096, 5849.034909239927, 5852.151438041375, 5854.092615644582, 5866.442687944638, 4236.957630423656, 4248.766317852548, 4284.871453856389, 4293.0, 4309.332053531708, 6148.0, 6273.090401891609, 6285.685715714288, 6288.779892703917, 6308.779192728232, 6055.848603784764, 6071.605345652519, 6091.451769340781, 6100.664463454553, 6115.694215289307, 6013.488853447331, 6051.12258722474, 6060.575759696955, 6061.848453788691, 6072.514198864169, 5884.176215329943, 5939.049752039653, 5946.108083787466, 5950.672713000827, 5968.701564921824, 6061.36355682647, 6098.359672234529, 6100.603460775035, 6104.11490333908, 6105.694715264308, 5741.167530708108, 5952.255968003999, 5970.402959704169, 5976.043832986701, 5977.880442391215], "unit": "score", "name": "prototype.html", "value": 4502.908243878071}, {"lowerIsBetter": false, "replicates": [679.463224052998, 707.8513512162446, 734.3684431389008, 756.984860302794, 768.4421130167326, 12186.51253949842, 12329.075319351063, 12362.134650574464, 12404.193727407723, 12409.069319801029, 12644.747105057893, 12657.050721195901, 12671.746565068694, 12688.682782930431, 12721.42753576089, 632.2981490545491, 800.235774835034, 804.7022601637373, 810.7973006748313, 826.0747962282252, 813.369638530141, 814.1776805426503, 817.3787921179917, 818.3984771193168, 818.5416166946529, 860.389123722158, 863.5336918064238, 864.235151890575, 868.4789126524098, 868.9782755431102, 851.2083762101244, 856.04550925718, 857.6740838481369, 859.0679113162226, 859.8237361340911, 633.8795628830508, 634.8539835837737, 635.7679447001857, 636.6434796513921, 637.9649119298437, 11930.642080737593, 11980.041596672245, 11980.281183128953, 11989.400529973467, 11992.220505667105, 12664.17682850621, 12984.805227921588, 13040.282784446852, 13077.888379487755, 13106.082574219809, 10124.94937525315, 10160.847587286196, 10173.186145108373, 10191.0, 10388.324758890723, 3356.077078803324, 3399.1162297802503, 3413.7269018478464, 3439.9852043647184, 3442.3631628148623, 43251.78374108141, 43314.783426082984, 43345.13309733788, 43399.0, 43475.34786978198, 9668.854967175497, 9849.916509183984, 9979.950100249453, 10264.538095785707, 10318.43248621318, 18121.54696132581, 18275.0, 18289.359872404402, 18396.26414943414, 18473.815261847478, 6745.325467453215, 7023.086998690138, 7048.612326321999, 7118.537295075804, 7218.962591381661, 3609.296187243462, 3840.231953609289, 3923.2349691809823, 3931.6068393160454, 3971.5035620547433, 2827.491051610689, 2832.589274555178, 2854.072426461408, 2863.3843723599525, 2864.756495697847, 512.6437126197258, 535.1143856916809, 538.569144684251, 538.9006426889102, 539.6438350688527, 456.19253920560425, 522.0655027500732, 531.9122344813062, 542.4954792043359, 545.4627192215664, 7398.223186565333, 7409.62951852416, 7464.664090115958, 7707.0, 7767.883481747778, 439.0779363337028, 480.82209582454715, 518.1761000010002, 523.8428471458548, 543.6737957225633, 3496.8426420811124, 3554.982225088858, 3636.61815509373, 3684.5578530576504, 3706.258748250361, 47216.29175562369, 53476.73261633667, 53939.460605394226, 53964.0, 54031.0, 44167.116657666666, 44397.55602443934, 45080.0, 45465.77267113643, 45543.54456455459, 42169.36745948813, 42997.570024299355, 43209.13581728411, 43572.346414803804, 43931.34102988522, 8481.15188481147, 8553.61508732121, 8663.306935445275, 8663.870041949502, 8663.91336086631, 32116.518252226702, 32179.35641287208, 32560.34879302448, 33019.33961320712, 33392.49911251382, 38226.426603601525, 38621.6137838618, 40951.97620059522, 41041.58958410497, 42622.36066459068, 10280.228982826467, 10771.46142692878, 10970.670879873616, 11041.72395690082, 11324.0, 11787.233829801036, 12064.517419303129, 12242.449089791158, 12271.877281227431, 12309.076819238413, 11401.20191586581, 12042.578509752117, 12105.75788484243, 12112.515499379926, 12134.089943254115, 11172.49723762449, 11322.60370887015, 11630.360330181922, 12172.087093467848, 12237.510499579917, 10496.632617858339, 10529.842052369373, 10561.049505544537, 10656.520456579628, 10696.465176741287, 9997.200223982209, 10124.797504050026, 10158.441285729356, 10189.235807314333, 10522.736931576466, 9600.950806737499, 10201.74495637615, 10228.795424091626, 10230.130438912776, 10270.435126068138], "unit": "score", "name": "yui.html", "value": 5995.835540034677}], "name": "dromaeo_css", "value": 6486.661959897432}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 114.0, 115.0, 125.0, 114.0, 113.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 154.0, 167.0, 131.0, 154.0, 148.0, 133.0, 179.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [166.0, 165.0, 164.0, 165.0, 163.0, 166.0, 169.0, 163.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 75.0, 78.0, 81.0, 73.0, 86.0, 75.0, 147.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 130.0, 93.0, 94.0, 94.0, 135.0, 93.0, 94.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 103.0, 98.0, 96.0, 96.0, 101.0, 100.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 98.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 69.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 66.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 66.0, 65.0, 64.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 85.0, 91.0, 86.0, 91.0, 91.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 120.0, 124.0, 122.0, 126.0, 125.0, 121.0, 124.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [136.0, 154.0, 145.0, 135.0, 148.0, 133.0, 150.0, 144.0, 155.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [75.0, 70.0, 69.0, 70.0, 70.0, 67.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1534.4000000000003}]} 04:20:48 INFO - Return code: 0 04:20:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:20:48 ERROR - # TBPL SUCCESS # 04:20:48 INFO - Running post-action listener: _resource_record_post_action 04:20:48 INFO - Running post-run listener: _resource_record_post_run 04:20:49 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 521527296; Read time: 0; Write time: 439348 04:20:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232398848; Read time: 0; Write time: 252408 04:20:49 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289128448; Read time: 0; Write time: 186940 04:20:49 INFO - Running post-run listener: _upload_blobber_files 04:20:49 INFO - Blob upload gear active. 04:20:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:49 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 04:20:49 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'] 04:20:49 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 04:20:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:51 INFO - (blobuploader) - INFO - Done attempting. 04:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:51 INFO - (blobuploader) - INFO - Done attempting. 04:20:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:51 INFO - Return code: 0 04:20:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7914a2823f6bbf6379be3765415e32173c42f808d0eb1864f143572f764ed94bdb5f9272887c287d4cd8f32b0da51d355bf9338179bf4bd54bec32a84fd770c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7274b7bb272061cccd3accb0b08937bc604b6cb0be5d92d0d4cfa74ba485f01459de3b077507138eb61dbe926badd1170ae5d69c052eadb13105c8bdf1eee27"} 04:20:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:51 INFO - Contents: 04:20:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7914a2823f6bbf6379be3765415e32173c42f808d0eb1864f143572f764ed94bdb5f9272887c287d4cd8f32b0da51d355bf9338179bf4bd54bec32a84fd770c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7274b7bb272061cccd3accb0b08937bc604b6cb0be5d92d0d4cfa74ba485f01459de3b077507138eb61dbe926badd1170ae5d69c052eadb13105c8bdf1eee27"} 04:20:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:51 INFO - Copying logs to upload dir... 04:20:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.035836 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-15 04:20:50.124166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 04:20:50.127404) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 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/7914a2823f6bbf6379be3765415e32173c42f808d0eb1864f143572f764ed94bdb5f9272887c287d4cd8f32b0da51d355bf9338179bf4bd54bec32a84fd770c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7274b7bb272061cccd3accb0b08937bc604b6cb0be5d92d0d4cfa74ba485f01459de3b077507138eb61dbe926badd1170ae5d69c052eadb13105c8bdf1eee27"} build_url:https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/WTSDjQWCTZK0Tx-_H6o8Cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7914a2823f6bbf6379be3765415e32173c42f808d0eb1864f143572f764ed94bdb5f9272887c287d4cd8f32b0da51d355bf9338179bf4bd54bec32a84fd770c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7274b7bb272061cccd3accb0b08937bc604b6cb0be5d92d0d4cfa74ba485f01459de3b077507138eb61dbe926badd1170ae5d69c052eadb13105c8bdf1eee27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 04:20:50.156690) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:20:50.157067) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458039446.384657-1668582624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005137 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:20:50.242769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 04:20:50.243095) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 04:20:50.243385) ========= ========= Total master_lag: 0.27 =========