builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1459502891.4 results: success (0) buildid: 20160401013245 builduid: 61e68da6483e462ab8353aeee33b3166 revision: b9ad1239e4b24d82932da5794babb9ab98750400 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.398691) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.399082) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.399752) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004501 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.432837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.433109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.449244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.449503) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.503280) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.503543) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.503903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.504177) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 02:28:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.5M=0s 2016-04-01 02:28:11 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.603411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.603708) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:11.654605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 02:28:11.654962) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9ad1239e4b24d82932da5794babb9ab98750400 --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 b9ad1239e4b24d82932da5794babb9ab98750400 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 02:28:12,001 truncating revision to first 12 chars 2016-04-01 02:28:12,002 Setting DEBUG logging. 2016-04-01 02:28:12,002 attempt 1/10 2016-04-01 02:28:12,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9ad1239e4b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 02:28:12,848 unpacking tar archive at: fx-team-b9ad1239e4b2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.146006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 02:28:12.815794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:12.816125) ========= echo b9ad1239e4b24d82932da5794babb9ab98750400 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b9ad1239e4b24d82932da5794babb9ab98750400'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b9ad1239e4b24d82932da5794babb9ab98750400 program finished with exit code 0 elapsedTime=0.004661 script_repo_revision: 'b9ad1239e4b24d82932da5794babb9ab98750400' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:12.873113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:12.873865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 02:28:12.887248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-01 02:28:12.887557) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:28:13 INFO - MultiFileLogger online at 20160401 02:28:13 in /builds/slave/test 02:28:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 02:28:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:28:13 INFO - {'append_to_log': False, 02:28:13 INFO - 'base_work_dir': '/builds/slave/test', 02:28:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:28:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:28:13 INFO - 'branch': 'Fx-Team-Non-PGO', 02:28:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:28:13 INFO - 'config_files': ('talos/linux_config.py',), 02:28:13 INFO - 'default_actions': ('clobber', 02:28:13 INFO - 'read-buildbot-config', 02:28:13 INFO - 'download-and-extract', 02:28:13 INFO - 'populate-webroot', 02:28:13 INFO - 'create-virtualenv', 02:28:13 INFO - 'install', 02:28:13 INFO - 'run-tests'), 02:28:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:28:13 INFO - 'download_minidump_stackwalk': True, 02:28:13 INFO - 'download_symbols': 'ondemand', 02:28:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:28:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:28:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:28:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:28:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:28:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:28:13 INFO - 'installer_path': 'installer.exe', 02:28:13 INFO - 'log_level': 'info', 02:28:13 INFO - 'log_name': 'talos', 02:28:13 INFO - 'log_to_console': True, 02:28:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:28:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:28:13 INFO - 'opt_config_files': (), 02:28:13 INFO - 'pip_index': False, 02:28:13 INFO - 'sps_profile': False, 02:28:13 INFO - 'sps_profile_interval': 0, 02:28:13 INFO - 'suite': 'dromaeojs', 02:28:13 INFO - 'system_bits': '32', 02:28:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:28:13 INFO - 'title': 'talos-linux64-ix-042', 02:28:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:28:13 INFO - 'use_talos_json': True, 02:28:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:28:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:28:13 INFO - 'work_dir': 'build'} 02:28:13 INFO - ##### 02:28:13 INFO - ##### Running clobber step. 02:28:13 INFO - ##### 02:28:13 INFO - Running pre-action listener: _resource_record_pre_action 02:28:13 INFO - Running main action method: clobber 02:28:13 INFO - rmtree: /builds/slave/test/build 02:28:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:13 INFO - Running post-action listener: _resource_record_post_action 02:28:13 INFO - ##### 02:28:13 INFO - ##### Running read-buildbot-config step. 02:28:13 INFO - ##### 02:28:13 INFO - Running pre-action listener: _resource_record_pre_action 02:28:13 INFO - Running main action method: read_buildbot_config 02:28:13 INFO - Using buildbot properties: 02:28:13 INFO - { 02:28:13 INFO - "project": "", 02:28:13 INFO - "product": "firefox", 02:28:13 INFO - "script_repo_revision": "production", 02:28:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:28:13 INFO - "repository": "", 02:28:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:28:13 INFO - "buildid": "20160401013245", 02:28:13 INFO - "pgo_build": "False", 02:28:13 INFO - "basedir": "/builds/slave/test", 02:28:13 INFO - "buildnumber": 2736, 02:28:13 INFO - "slavename": "talos-linux64-ix-042", 02:28:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:28:13 INFO - "platform": "ubuntu64_hw", 02:28:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:28:13 INFO - "branch": "fx-team", 02:28:13 INFO - "repo_path": "integration/fx-team", 02:28:13 INFO - "revision": "b9ad1239e4b24d82932da5794babb9ab98750400", 02:28:13 INFO - "stage_platform": "linux64", 02:28:13 INFO - "builduid": "61e68da6483e462ab8353aeee33b3166", 02:28:13 INFO - "slavebuilddir": "test" 02:28:13 INFO - } 02:28:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:28:13 INFO - Running post-action listener: _resource_record_post_action 02:28:13 INFO - ##### 02:28:13 INFO - ##### Running download-and-extract step. 02:28:13 INFO - ##### 02:28:13 INFO - Running pre-action listener: _resource_record_pre_action 02:28:13 INFO - Running main action method: download_and_extract 02:28:13 INFO - mkdir: /builds/slave/test/build/tests 02:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:13 INFO - https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:28:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:28:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:28:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:15 INFO - Downloaded 1361 bytes. 02:28:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:28:15 INFO - Using the following test package requirements: 02:28:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:28:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:28:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:28:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'jsshell-linux-x86_64.zip'], 02:28:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:28:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:28:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:28:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:28:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:28:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:28:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:28:15 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')]} 02:28:15 INFO - https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:21 INFO - Downloaded 22111534 bytes. 02:28:21 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'] 02:28:21 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 02:28:22 INFO - Return code: 0 02:28:22 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 02:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:22 INFO - https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:28:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:28:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:34 INFO - Downloaded 22111534 bytes. 02:28:34 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'] 02:28:34 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 02:28:36 INFO - Return code: 0 02:28:36 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')]} 02:28:36 INFO - https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:28:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:28:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:28:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:37 INFO - Downloaded 10847534 bytes. 02:28:37 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'] 02:28:37 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 02:28:38 INFO - Return code: 0 02:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:38 INFO - https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:28:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:28:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:28:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/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 02:28:39 INFO - Downloaded 54222102 bytes. 02:28:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:28:39 INFO - mkdir: /builds/slave/test/properties 02:28:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:39 INFO - Contents: 02:28:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:28:40 INFO - Running post-action listener: _resource_record_post_action 02:28:40 INFO - Running post-action listener: set_extra_try_arguments 02:28:40 INFO - ##### 02:28:40 INFO - ##### Running populate-webroot step. 02:28:40 INFO - ##### 02:28:40 INFO - Running pre-action listener: _resource_record_pre_action 02:28:40 INFO - Running main action method: populate_webroot 02:28:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:40 INFO - '--tppagecycles', 02:28:40 INFO - '7'], 02:28:40 INFO - 'tests': ['tsvgm']}}, 02:28:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:28:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:28:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'tests': ['damp', 'tps']}, 02:28:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['damp', 'tps']}, 02:28:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:28:40 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['dromaeo_dom']}, 02:28:40 INFO - 'other': {'tests': ['a11yr', 02:28:40 INFO - 'ts_paint', 02:28:40 INFO - 'tpaint', 02:28:40 INFO - 'sessionrestore', 02:28:40 INFO - 'sessionrestore_no_auto_restore', 02:28:40 INFO - 'tabpaint']}, 02:28:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['a11yr', 02:28:40 INFO - 'ts_paint', 02:28:40 INFO - 'tpaint', 02:28:40 INFO - 'sessionrestore', 02:28:40 INFO - 'sessionrestore_no_auto_restore', 02:28:40 INFO - 'tabpaint']}, 02:28:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['a11yr', 02:28:40 INFO - 'ts_paint', 02:28:40 INFO - 'tpaint', 02:28:40 INFO - 'sessionrestore', 02:28:40 INFO - 'sessionrestore_no_auto_restore', 02:28:40 INFO - 'tabpaint']}, 02:28:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['a11yr', 02:28:40 INFO - 'ts_paint', 02:28:40 INFO - 'tpaint', 02:28:40 INFO - 'sessionrestore', 02:28:40 INFO - 'sessionrestore_no_auto_restore', 02:28:40 INFO - 'tabpaint']}, 02:28:40 INFO - 'other_l64': {'tests': ['a11yr', 02:28:40 INFO - 'ts_paint', 02:28:40 INFO - 'tpaint', 02:28:40 INFO - 'sessionrestore', 02:28:40 INFO - 'sessionrestore_no_auto_restore', 02:28:40 INFO - 'tabpaint']}, 02:28:40 INFO - 'other_nol64': {'tests': ['a11yr', 02:28:40 INFO - 'ts_paint', 02:28:40 INFO - 'tpaint', 02:28:40 INFO - 'sessionrestore', 02:28:40 INFO - 'sessionrestore_no_auto_restore', 02:28:40 INFO - 'tabpaint']}, 02:28:40 INFO - 'svgr': {'tests': ['tsvgx', 02:28:40 INFO - 'tsvgr_opacity', 02:28:40 INFO - 'tart', 02:28:40 INFO - 'tscrollx', 02:28:40 INFO - 'cart']}, 02:28:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['tsvgx', 02:28:40 INFO - 'tsvgr_opacity', 02:28:40 INFO - 'tart', 02:28:40 INFO - 'tscrollx', 02:28:40 INFO - 'cart']}, 02:28:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'tests': ['tp5o']}, 02:28:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'talos_options': ['--e10s'], 02:28:40 INFO - 'tests': ['tp5o']}, 02:28:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'talos_options': ['--xperf_path', 02:28:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:40 INFO - 'tests': ['tp5n']}, 02:28:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:40 INFO - 'talos_options': ['--e10s', 02:28:40 INFO - '--xperf_path', 02:28:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:40 INFO - 'tests': ['tp5n']}}, 02:28:40 INFO - 'talos.zip': {'path': '', 02:28:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:40 INFO - Running post-action listener: _resource_record_post_action 02:28:40 INFO - ##### 02:28:40 INFO - ##### Running create-virtualenv step. 02:28:40 INFO - ##### 02:28:40 INFO - Running pre-action listener: _resource_record_pre_action 02:28:40 INFO - Running main action method: create_virtualenv 02:28:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:40 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 02:28:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:40 INFO - Using real prefix '/usr' 02:28:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:43 INFO - Installing pip.................done. 02:28:43 INFO - Return code: 0 02:28:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:43 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 02:28:43 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 02:28:43 INFO - Using env: {'DISPLAY': ':0', 02:28:43 INFO - 'HOME': '/home/cltbld', 02:28:43 INFO - 'LANG': 'en_US.UTF-8', 02:28:43 INFO - 'LANGUAGE': 'en_US:en', 02:28:43 INFO - 'LOGNAME': 'cltbld', 02:28:43 INFO - 'MAIL': '/var/mail/cltbld', 02:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:43 INFO - 'MOZ_NO_REMOTE': '1', 02:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:43 INFO - 'NO_EM_RESTART': '1', 02:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:43 INFO - 'PWD': '/builds/slave/test', 02:28:43 INFO - 'SHELL': '/bin/bash', 02:28:43 INFO - 'SHLVL': '1', 02:28:43 INFO - 'TERM': 'linux', 02:28:43 INFO - 'TMOUT': '86400', 02:28:43 INFO - 'USER': 'cltbld', 02:28:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:43 INFO - '_': '/tools/buildbot/bin/python'} 02:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:43 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 02:28:43 INFO - Cleaning up... 02:28:43 INFO - Return code: 0 02:28:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:43 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 02:28:43 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 02:28:43 INFO - Using env: {'DISPLAY': ':0', 02:28:43 INFO - 'HOME': '/home/cltbld', 02:28:43 INFO - 'LANG': 'en_US.UTF-8', 02:28:43 INFO - 'LANGUAGE': 'en_US:en', 02:28:43 INFO - 'LOGNAME': 'cltbld', 02:28:43 INFO - 'MAIL': '/var/mail/cltbld', 02:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:43 INFO - 'MOZ_NO_REMOTE': '1', 02:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:43 INFO - 'NO_EM_RESTART': '1', 02:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:43 INFO - 'PWD': '/builds/slave/test', 02:28:43 INFO - 'SHELL': '/bin/bash', 02:28:43 INFO - 'SHLVL': '1', 02:28:43 INFO - 'TERM': 'linux', 02:28:43 INFO - 'TMOUT': '86400', 02:28:43 INFO - 'USER': 'cltbld', 02:28:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:43 INFO - '_': '/tools/buildbot/bin/python'} 02:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:43 INFO - Downloading/unpacking psutil>=0.7.1 02:28:43 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 02:28:43 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 02:28:43 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 02:28:43 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 02:28:43 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 02:28:43 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 02:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:45 INFO - Installing collected packages: psutil 02:28:45 INFO - Running setup.py install for psutil 02:28:46 INFO - building 'psutil._psutil_linux' extension 02:28:46 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 02:28:46 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 02:28:46 INFO - building 'psutil._psutil_posix' extension 02:28:46 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 02:28:46 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 02:28:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:46 INFO - Successfully installed psutil 02:28:46 INFO - Cleaning up... 02:28:46 INFO - Return code: 0 02:28:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:28:46 INFO - Using env: {'DISPLAY': ':0', 02:28:46 INFO - 'HOME': '/home/cltbld', 02:28:46 INFO - 'LANG': 'en_US.UTF-8', 02:28:46 INFO - 'LANGUAGE': 'en_US:en', 02:28:46 INFO - 'LOGNAME': 'cltbld', 02:28:46 INFO - 'MAIL': '/var/mail/cltbld', 02:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:46 INFO - 'MOZ_NO_REMOTE': '1', 02:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:46 INFO - 'NO_EM_RESTART': '1', 02:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:46 INFO - 'PWD': '/builds/slave/test', 02:28:46 INFO - 'SHELL': '/bin/bash', 02:28:46 INFO - 'SHLVL': '1', 02:28:46 INFO - 'TERM': 'linux', 02:28:46 INFO - 'TMOUT': '86400', 02:28:46 INFO - 'USER': 'cltbld', 02:28:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:46 INFO - '_': '/tools/buildbot/bin/python'} 02:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:28:46 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 02:28:46 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 02:28:46 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 02:28:46 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 02:28:46 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 02:28:46 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 02:28:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:28:49 INFO - Installing collected packages: mozsystemmonitor 02:28:49 INFO - Running setup.py install for mozsystemmonitor 02:28:49 INFO - Successfully installed mozsystemmonitor 02:28:49 INFO - Cleaning up... 02:28:49 INFO - Return code: 0 02:28:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:28:49 INFO - Using env: {'DISPLAY': ':0', 02:28:49 INFO - 'HOME': '/home/cltbld', 02:28:49 INFO - 'LANG': 'en_US.UTF-8', 02:28:49 INFO - 'LANGUAGE': 'en_US:en', 02:28:49 INFO - 'LOGNAME': 'cltbld', 02:28:49 INFO - 'MAIL': '/var/mail/cltbld', 02:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:49 INFO - 'MOZ_NO_REMOTE': '1', 02:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:49 INFO - 'NO_EM_RESTART': '1', 02:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:49 INFO - 'PWD': '/builds/slave/test', 02:28:49 INFO - 'SHELL': '/bin/bash', 02:28:49 INFO - 'SHLVL': '1', 02:28:49 INFO - 'TERM': 'linux', 02:28:49 INFO - 'TMOUT': '86400', 02:28:49 INFO - 'USER': 'cltbld', 02:28:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:49 INFO - '_': '/tools/buildbot/bin/python'} 02:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:51 INFO - Downloading docopt-0.6.1.tar.gz 02:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:52 INFO - Running setup.py install for blobuploader 02:28:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:52 INFO - Running setup.py install for requests 02:28:52 INFO - Running setup.py install for docopt 02:28:52 INFO - Successfully installed blobuploader requests docopt 02:28:52 INFO - Cleaning up... 02:28:52 INFO - Return code: 0 02:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:52 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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:52 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 02:28:52 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 02:28:52 INFO - Using env: {'DISPLAY': ':0', 02:28:52 INFO - 'HOME': '/home/cltbld', 02:28:52 INFO - 'LANG': 'en_US.UTF-8', 02:28:52 INFO - 'LANGUAGE': 'en_US:en', 02:28:52 INFO - 'LOGNAME': 'cltbld', 02:28:52 INFO - 'MAIL': '/var/mail/cltbld', 02:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:52 INFO - 'MOZ_NO_REMOTE': '1', 02:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:52 INFO - 'NO_EM_RESTART': '1', 02:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:52 INFO - 'PWD': '/builds/slave/test', 02:28:52 INFO - 'SHELL': '/bin/bash', 02:28:52 INFO - 'SHLVL': '1', 02:28:52 INFO - 'TERM': 'linux', 02:28:52 INFO - 'TMOUT': '86400', 02:28:52 INFO - 'USER': 'cltbld', 02:28:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:52 INFO - '_': '/tools/buildbot/bin/python'} 02:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:52 INFO - Running setup.py (path:/tmp/pip-OAyp3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:52 INFO - Running setup.py (path:/tmp/pip-edufVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:52 INFO - Running setup.py (path:/tmp/pip-Jxi01S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:53 INFO - Running setup.py (path:/tmp/pip-ky__6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:53 INFO - Running setup.py (path:/tmp/pip-yoT4VV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:53 INFO - Running setup.py (path:/tmp/pip-U87Ros-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:53 INFO - Running setup.py (path:/tmp/pip-AWl6ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:53 INFO - Running setup.py (path:/tmp/pip-HjGLvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:53 INFO - Running setup.py (path:/tmp/pip-59AuII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:53 INFO - Running setup.py (path:/tmp/pip-UHKEMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:53 INFO - Running setup.py (path:/tmp/pip-THl5gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:53 INFO - Running setup.py (path:/tmp/pip-KSIllb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:53 INFO - Running setup.py (path:/tmp/pip-gW1XQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:53 INFO - Running setup.py (path:/tmp/pip-hRkVs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:53 INFO - Running setup.py (path:/tmp/pip-38W9h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:53 INFO - Running setup.py (path:/tmp/pip-QWdI4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:53 INFO - Running setup.py (path:/tmp/pip-4ae_JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:54 INFO - Running setup.py install for manifestparser 02:28:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Running setup.py install for mozcrash 02:28:54 INFO - Running setup.py install for mozdebug 02:28:54 INFO - Running setup.py install for mozdevice 02:28:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Running setup.py install for mozfile 02:28:54 INFO - Running setup.py install for mozhttpd 02:28:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Running setup.py install for mozinfo 02:28:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Running setup.py install for mozInstall 02:28:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:54 INFO - Running setup.py install for mozleak 02:28:54 INFO - Running setup.py install for mozlog 02:28:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:55 INFO - Running setup.py install for moznetwork 02:28:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:55 INFO - Running setup.py install for mozprocess 02:28:55 INFO - Running setup.py install for mozprofile 02:28:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:55 INFO - Running setup.py install for mozrunner 02:28:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:55 INFO - Running setup.py install for mozscreenshot 02:28:55 INFO - Running setup.py install for moztest 02:28:55 INFO - Running setup.py install for mozversion 02:28:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:55 INFO - Cleaning up... 02:28:55 INFO - Return code: 0 02:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:55 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 02:28:55 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 02:28:55 INFO - Using env: {'DISPLAY': ':0', 02:28:55 INFO - 'HOME': '/home/cltbld', 02:28:55 INFO - 'LANG': 'en_US.UTF-8', 02:28:55 INFO - 'LANGUAGE': 'en_US:en', 02:28:55 INFO - 'LOGNAME': 'cltbld', 02:28:55 INFO - 'MAIL': '/var/mail/cltbld', 02:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:55 INFO - 'MOZ_NO_REMOTE': '1', 02:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:55 INFO - 'NO_EM_RESTART': '1', 02:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:55 INFO - 'PWD': '/builds/slave/test', 02:28:55 INFO - 'SHELL': '/bin/bash', 02:28:55 INFO - 'SHLVL': '1', 02:28:55 INFO - 'TERM': 'linux', 02:28:55 INFO - 'TMOUT': '86400', 02:28:55 INFO - 'USER': 'cltbld', 02:28:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:55 INFO - '_': '/tools/buildbot/bin/python'} 02:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:56 INFO - Running setup.py (path:/tmp/pip-Oznirk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:56 INFO - Running setup.py (path:/tmp/pip-7XO5em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:56 INFO - Running setup.py (path:/tmp/pip-bcmTAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:56 INFO - Running setup.py (path:/tmp/pip-QBUQ5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:56 INFO - Running setup.py (path:/tmp/pip-vuYH_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:56 INFO - Running setup.py (path:/tmp/pip-0frPte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:56 INFO - Running setup.py (path:/tmp/pip-i4zxHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:56 INFO - Running setup.py (path:/tmp/pip-AfrH5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:56 INFO - Running setup.py (path:/tmp/pip-wGTFVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:56 INFO - Running setup.py (path:/tmp/pip-5XAlJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:56 INFO - Running setup.py (path:/tmp/pip-HYGqHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:56 INFO - Running setup.py (path:/tmp/pip-CzUeKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:56 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)) 02:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:56 INFO - Running setup.py (path:/tmp/pip-Silu5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:56 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)) 02:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:57 INFO - Running setup.py (path:/tmp/pip-byuACA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:57 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)) 02:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:57 INFO - Running setup.py (path:/tmp/pip-lIIcKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:57 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)) 02:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:57 INFO - Running setup.py (path:/tmp/pip-vm7EOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:57 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)) 02:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:57 INFO - Running setup.py (path:/tmp/pip-1al2xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:57 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)) 02:28:57 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)) 02:28:57 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)) 02:28:57 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)) 02:28:57 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)) 02:28:57 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)) 02:28:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - Downloading blessings-1.6.tar.gz 02:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:59 INFO - Installing collected packages: blessings 02:28:59 INFO - Running setup.py install for blessings 02:28:59 INFO - Successfully installed blessings 02:28:59 INFO - Cleaning up... 02:28:59 INFO - Return code: 0 02:28:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:59 INFO - Reading from file tmpfile_stdout 02:28:59 INFO - Current package versions: 02:28:59 INFO - argparse == 1.2.1 02:28:59 INFO - blessings == 1.6 02:28:59 INFO - blobuploader == 1.2.4 02:28:59 INFO - docopt == 0.6.1 02:28:59 INFO - manifestparser == 1.1 02:28:59 INFO - mozInstall == 1.12 02:28:59 INFO - mozcrash == 0.17 02:28:59 INFO - mozdebug == 0.1 02:28:59 INFO - mozdevice == 0.48 02:28:59 INFO - mozfile == 1.2 02:28:59 INFO - mozhttpd == 0.7 02:28:59 INFO - mozinfo == 0.9 02:28:59 INFO - mozleak == 0.1 02:28:59 INFO - mozlog == 3.1 02:28:59 INFO - moznetwork == 0.27 02:28:59 INFO - mozprocess == 0.22 02:28:59 INFO - mozprofile == 0.28 02:28:59 INFO - mozrunner == 6.11 02:28:59 INFO - mozscreenshot == 0.1 02:28:59 INFO - mozsystemmonitor == 0.0 02:28:59 INFO - moztest == 0.7 02:28:59 INFO - mozversion == 1.4 02:28:59 INFO - psutil == 3.1.1 02:28:59 INFO - requests == 1.2.3 02:28:59 INFO - wsgiref == 0.1.2 02:28:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:59 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 02:28:59 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 02:28:59 INFO - Using env: {'DISPLAY': ':0', 02:28:59 INFO - 'HOME': '/home/cltbld', 02:28:59 INFO - 'LANG': 'en_US.UTF-8', 02:28:59 INFO - 'LANGUAGE': 'en_US:en', 02:28:59 INFO - 'LOGNAME': 'cltbld', 02:28:59 INFO - 'MAIL': '/var/mail/cltbld', 02:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:59 INFO - 'MOZ_NO_REMOTE': '1', 02:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:59 INFO - 'NO_EM_RESTART': '1', 02:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:59 INFO - 'PWD': '/builds/slave/test', 02:28:59 INFO - 'SHELL': '/bin/bash', 02:28:59 INFO - 'SHLVL': '1', 02:28:59 INFO - 'TERM': 'linux', 02:28:59 INFO - 'TMOUT': '86400', 02:28:59 INFO - 'USER': 'cltbld', 02:28:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:59 INFO - '_': '/tools/buildbot/bin/python'} 02:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 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)) 02:28:59 INFO - Cleaning up... 02:28:59 INFO - Return code: 0 02:28:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 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 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:28:59 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 02:28:59 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 02:28:59 INFO - Using env: {'DISPLAY': ':0', 02:28:59 INFO - 'HOME': '/home/cltbld', 02:28:59 INFO - 'LANG': 'en_US.UTF-8', 02:28:59 INFO - 'LANGUAGE': 'en_US:en', 02:28:59 INFO - 'LOGNAME': 'cltbld', 02:28:59 INFO - 'MAIL': '/var/mail/cltbld', 02:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:59 INFO - 'MOZ_NO_REMOTE': '1', 02:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:59 INFO - 'NO_EM_RESTART': '1', 02:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:59 INFO - 'PWD': '/builds/slave/test', 02:28:59 INFO - 'SHELL': '/bin/bash', 02:28:59 INFO - 'SHLVL': '1', 02:28:59 INFO - 'TERM': 'linux', 02:28:59 INFO - 'TMOUT': '86400', 02:28:59 INFO - 'USER': 'cltbld', 02:28:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:59 INFO - '_': '/tools/buildbot/bin/python'} 02:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:00 INFO - Downloading/unpacking jsonschema 02:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:29:01 INFO - Downloading/unpacking functools32 (from jsonschema) 02:29:01 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 02:29:01 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 02:29:01 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 02:29:01 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 02:29:01 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 02:29:01 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 02:29:02 INFO - Downloading functools32-3.2.3-2.tar.gz 02:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:29:02 INFO - warning: no files found matching '*.txt' 02:29:02 INFO - no previously-included directories found matching 'build' 02:29:02 INFO - no previously-included directories found matching 'dist' 02:29:02 INFO - no previously-included directories found matching '.git*' 02:29:02 INFO - Installing collected packages: jsonschema, functools32 02:29:02 INFO - Running setup.py install for functools32 02:29:02 INFO - warning: no files found matching '*.txt' 02:29:02 INFO - no previously-included directories found matching 'build' 02:29:02 INFO - no previously-included directories found matching 'dist' 02:29:02 INFO - no previously-included directories found matching '.git*' 02:29:02 INFO - Successfully installed jsonschema functools32 02:29:02 INFO - Cleaning up... 02:29:02 INFO - Return code: 0 02:29:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa0dacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16477d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', '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 02:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:29:02 INFO - Using env: {'DISPLAY': ':0', 02:29:02 INFO - 'HOME': '/home/cltbld', 02:29:02 INFO - 'LANG': 'en_US.UTF-8', 02:29:02 INFO - 'LANGUAGE': 'en_US:en', 02:29:02 INFO - 'LOGNAME': 'cltbld', 02:29:02 INFO - 'MAIL': '/var/mail/cltbld', 02:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:02 INFO - 'MOZ_NO_REMOTE': '1', 02:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:02 INFO - 'NO_EM_RESTART': '1', 02:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:02 INFO - 'PWD': '/builds/slave/test', 02:29:02 INFO - 'SHELL': '/bin/bash', 02:29:02 INFO - 'SHLVL': '1', 02:29:02 INFO - 'TERM': 'linux', 02:29:02 INFO - 'TMOUT': '86400', 02:29:02 INFO - 'USER': 'cltbld', 02:29:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:02 INFO - '_': '/tools/buildbot/bin/python'} 02:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:02 INFO - Downloading/unpacking flake8 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:29:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:29:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:05 INFO - no previously-included directories found matching 'docs/_build' 02:29:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:29:05 INFO - Running setup.py install for pep8 02:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:05 INFO - no previously-included directories found matching 'docs/_build' 02:29:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:29:05 INFO - Cleaning up... 02:29:05 INFO - Return code: 0 02:29:05 INFO - Running post-action listener: _resource_record_post_action 02:29:05 INFO - Running post-action listener: _start_resource_monitoring 02:29:05 INFO - Starting resource monitoring. 02:29:05 INFO - ##### 02:29:05 INFO - ##### Running install step. 02:29:05 INFO - ##### 02:29:05 INFO - Running pre-action listener: _resource_record_pre_action 02:29:05 INFO - Running main action method: install 02:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:05 INFO - Reading from file tmpfile_stdout 02:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:05 INFO - Reading from file tmpfile_stdout 02:29:05 INFO - Output received: 02:29:05 INFO - Usage: mozinstall [options] installer 02:29:05 INFO - Options: 02:29:05 INFO - -h, --help show this help message and exit 02:29:05 INFO - -d DEST, --destination=DEST 02:29:05 INFO - Directory to install application into. [default: 02:29:05 INFO - "/builds/slave/test"] 02:29:05 INFO - --app=APP Application being installed. [default: firefox] 02:29:05 INFO - mkdir: /builds/slave/test/build/application 02:29:05 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'] 02:29:05 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 02:29:21 INFO - Reading from file tmpfile_stdout 02:29:21 INFO - Output received: 02:29:21 INFO - /builds/slave/test/build/application/firefox/firefox 02:29:21 INFO - Running post-action listener: _resource_record_post_action 02:29:21 INFO - ##### 02:29:21 INFO - ##### Running run-tests step. 02:29:21 INFO - ##### 02:29:21 INFO - Running pre-action listener: _resource_record_pre_action 02:29:21 INFO - Running main action method: run_tests 02:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:29:21 INFO - Python 2.7.3 02:29:21 INFO - Return code: 0 02:29:21 INFO - grabbing minidump binary from tooltool 02:29: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')]} 02:29:21 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 0x16d6640>, '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 0x16d7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d79d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:29:21 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 02:29:21 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 02:29:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:29:21 INFO - Return code: 0 02:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:29:22 INFO - Return code: 0 02:29:22 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:29:22 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:29:22 INFO - Using env: {'DISPLAY': ':0', 02:29:22 INFO - 'HOME': '/home/cltbld', 02:29:22 INFO - 'LANG': 'en_US.UTF-8', 02:29:22 INFO - 'LANGUAGE': 'en_US:en', 02:29:22 INFO - 'LOGNAME': 'cltbld', 02:29:22 INFO - 'MAIL': '/var/mail/cltbld', 02:29:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:29:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:22 INFO - 'MOZ_NO_REMOTE': '1', 02:29:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:22 INFO - 'NO_EM_RESTART': '1', 02:29:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:22 INFO - 'PWD': '/builds/slave/test', 02:29:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:29:22 INFO - 'SHELL': '/bin/bash', 02:29:22 INFO - 'SHLVL': '1', 02:29:22 INFO - 'TERM': 'linux', 02:29:22 INFO - 'TMOUT': '86400', 02:29:22 INFO - 'USER': 'cltbld', 02:29:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830', 02:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:22 INFO - '_': '/tools/buildbot/bin/python'} 02:29:22 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:29:22 INFO - mozversion application_buildid: 20160401013245 02:29:22 INFO - mozversion application_changeset: b9ad1239e4b24d82932da5794babb9ab98750400 02:29:22 INFO - mozversion application_display_name: Nightly 02:29:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:29:22 INFO - mozversion application_name: Firefox 02:29:22 INFO - mozversion application_remotingname: firefox 02:29:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:29:22 INFO - mozversion application_vendor: Mozilla 02:29:22 INFO - mozversion application_version: 48.0a1 02:29:22 INFO - mozversion platform_buildid: 20160401013245 02:29:22 INFO - mozversion platform_changeset: b9ad1239e4b24d82932da5794babb9ab98750400 02:29:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:29:22 INFO - mozversion platform_version: 48.0a1 02:29:22 INFO - using testdate: 1459502962 02:29:22 INFO - actual date: 1459502962 02:29:22 INFO - starting webserver on 'localhost:45379' 02:29:22 INFO - SUITE-START | Running 2 tests 02:29:22 INFO - TEST-START | dromaeo_css 02:29:22 INFO - operating with platform_type : linux_ 02:29:22 INFO - Initialising browser for dromaeo_css test... 02:29:22 INFO - TEST-INFO | started process 12668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTbjCZR/profile http://localhost:45379/getInfo.html) 02:29:27 INFO - PROCESS | 12668 | __metrics Screen width/height:1600/1200 02:29:27 INFO - PROCESS | 12668 | colorDepth:24 02:29:27 INFO - PROCESS | 12668 | Browser inner width/height: 1024/697 02:29:27 INFO - PROCESS | 12668 | __metrics 02:29:28 ERROR - PROCESS | 12668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:29:29 INFO - TEST-INFO | 12668: exit 0 02:29:29 INFO - Browser initialized. 02:29:29 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:29 INFO - TEST-INFO | started process 12763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTbjCZR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:41 INFO - PROCESS | 12763 | RSS: Main: 154628096 02:29:41 INFO - PROCESS | 12763 | 02:30:32 INFO - PROCESS | 12763 | 1459503032454 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] 02:32:43 INFO - PROCESS | 12763 | Cycle 1(1): loaded http://localhost:45379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45379/tests/dromaeo/cssquery-ext.html) 02:32:44 INFO - PROCESS | 12763 | RSS: Main: 233975808 02:32:44 INFO - PROCESS | 12763 | 02:35:46 INFO - PROCESS | 12763 | Cycle 1(1): loaded http://localhost:45379/tests/dromaeo/cssquery-ext.html (next: http://localhost:45379/tests/dromaeo/cssquery-jquery.html) 02:35:47 INFO - PROCESS | 12763 | RSS: Main: 238034944 02:35:47 INFO - PROCESS | 12763 | 02:38:49 INFO - PROCESS | 12763 | Cycle 1(1): loaded http://localhost:45379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45379/tests/dromaeo/cssquery-mootools.html) 02:38:49 INFO - PROCESS | 12763 | RSS: Main: 232787968 02:38:49 INFO - PROCESS | 12763 | 02:41:51 INFO - PROCESS | 12763 | Cycle 1(1): loaded http://localhost:45379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45379/tests/dromaeo/cssquery-prototype.html) 02:41:52 INFO - PROCESS | 12763 | RSS: Main: 222679040 02:41:52 INFO - PROCESS | 12763 | 02:44:55 INFO - PROCESS | 12763 | Cycle 1(1): loaded http://localhost:45379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45379/tests/dromaeo/cssquery-yui.html) 02:44:55 INFO - PROCESS | 12763 | RSS: Main: 199139328 02:44:55 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | Cycle 1(1): loaded http://localhost:45379/tests/dromaeo/cssquery-yui.html (next: http://localhost:45379/tests/dromaeo/cssquery-dojo.html) 02:47:58 INFO - PROCESS | 12763 | RSS: Main: 259440640 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | __start_tp_report 02:47:58 INFO - PROCESS | 12763 | _x_x_mozilla_page_load 02:47:58 INFO - PROCESS | 12763 | _x_x_mozilla_page_load_details 02:47:58 INFO - PROCESS | 12763 | |i|pagename|runs| 02:47:58 INFO - PROCESS | 12763 | |0;dojo.html;2528.987355063225;2575.6909170899494;2598.623199636053;2608.3087981684844;2609.9478010439793;4424.800883960222;4516.774161291931;4570.451545814502;4576.885577860555;4593.793279302431;4412.404325416068;4505.30167823987;4526.932096018562;4613.100445413146;4624.653151013679;4102.651274641659;4112.05422752767;4118.691098167635;4153.086321009373;4308.095299987007;4239.597238262376;4271.594198551133;4280.486341639008;4308.913821723564;4324.675649326297;4074.9592504074876;4137.97931010343;4160.084781348099;4202.789860506978;4229.133027729308;4148.937765933513;4162.729422587552;4165.12532368203;4192.05678722285;4209.97895010526;4137.937930931039;4149.751014939083;4154.750714957112;4183.874483765492;4199.286121359346;4328.523862375137;4425.712328698624;4430.335449682541;4520.728756274634;4525.185466616008;4827.58965487934;4850.393700787402;4865;4893.95106048942;4899.265110233458;4860.635452341053;4862.197737373329;4864.343313652647;4865.829695960624;4888.071266459361;4433.290673492258;4488.573585509372;4571.22289210835;4575.084983003413;4583.541645835457;4945.282933974626;4948.777305021211;4974.179260422062;4979.925301120486;5076.340075790197;4643.814247430132;4819.084373968934;4822.083804077214;4824.6863953842885;4826.58973987215;4803.759812009455;4883.51164883516;4887.535684110004;4918.286848406961;4935.111679897653;4792.95207047932;4799.640026997919;4804.327394164819;4804.903901921942;4857.80568777252;4675.742834144086;4784.784684689197;4790.329353890458;4819.734914579662;4834.927476087862;4105.651019663303;4108.301588729923;4137.338025915839;4151.771652559078;4152.086540960984;3578.624244454295;3624.2389098289655;3625.1118475973553;3639.7998110103667;3652.543432070991;4075.2053349596545;4159.563245859141;4165;4170.47869016373;4178.541283948153;4857.247126695368;4862.51374862518;4863.197572400514;4892.755362231946;4912.017596480719;4127.484064491939;4149.792510374469;4150.1284730207;4171.770552619574;4190.141021090669;4261.2542805009;4350.6736994725525;4392.714473559208;4429.092036132585;4429.579189976947;4443.577860103285;4467.15124126415;4468.486124095771;4505.504394516601;4510.075434535978;4768.070226305976;4771.66598338113;4775;4776.59398951093;4818.975905120452;4390.121975604828;4465.732056076646;4512.458504979423;4595.218812801899;4608.677392582487;4813.446453657874;4835.540623640749;4836.202026665561;4841.104395686809;4867.853964381075;4892.0705066037335;4912.852614421573;4915.1644220481885;4917.262410638433;4968.378952630921;4586.2661974083985;4691.953080469151;4740.952590474051;4763.618910487084;4787.210110331756;4774.570288674036;4777.378940737821;4795.376601041842;4796.7361795100205;4856.95143048565;4569.520200378913;4696.037312351028;4707.364505791675;4711.528847115398;4753.572178503951;4703.412073490814;4786.617070634271;4787.593054590398;4817.638677099161;4832.371791667061;4642.280446530793;4671.976640116778;4684.297355396718;4688.835890743808;4691.03833714081 02:47:58 INFO - PROCESS | 12763 | |1;ext.html;537.0655060195262;548.8298627425498;558.8798408342207;563.2818156850016;579.6145563200472;24410.633840492384;24793.256202313936;34332.828335858314;34854.65145348546;34875.651243487555;37215.627843721624;37593.81203093981;37634.0591485213;37712;37833.24333513328;7552.131504876941;7706.961465192666;7735.342495887856;7736.226377362275;7737.110232323299;7525.4355923305975;7618.314351708345;7645.61771911405;7646;7648.158702542716;7785.260400261995;7868.881966770503;7876.684932602689;7883.8423231535335;7925.9603701981405;7808.102068262166;7884.921150788534;7886.329661978739;7891.368690504746;7891.447598668095;7517.962410187969;7552.73565425213;7628.580428076453;7631.847363052763;7635.961820190919;37118.25763484715;37434.251314973546;37567.62432375669;37582.24835503302;37636.623633763586;2994.281372470613;3032.2419395151214;3077.6306843178736;3552.4316109422625;3600.747947643666;28098;28499.43001139986;29399;29698.40603187924;29865;3293.9341213175844;3323.551320571716;3349;3382.30662714143;3388.6780755828404;239917;239921;240200;240365.99999999825;240397;51880;53555.46444535583;53896;53907.73046134744;53977.73011134998;59820.102698458686;60639;60688;60767.39232607617;60837.391626083176;13193.472261109448;13296.202227866359;13371;13411.262380569162;13411.463541458428;9237.815243695088;9244.445333280024;9302.813943721223;9351.39215950961;9960.701178964642;17910.820891791176;18064.18711158001;18125.63748725018;18144.45566633003;18215.817841821412;6950.165980082423;7288.198298187195;7334.559926404433;7343.77968660941;7389.371903388164;892.5135800988477;912.9726108216764;931.9254459643212;982.4350998176077;1022.2486472442748;25557.3610659735;26886.5967010495;27017;27182.864085679445;27206;947.6635794293064;957.818014577228;994.8855881573712;1037.7301901505664;1053.773438710681;14218;14296;14326.928365358106;14479.565613031626;14498.347574358968;288344;292718;292784;293653;294299;46684;47789.761051194524;47846.28230576544;47847;48002;1041.7760181561;1191.255465334166;1212.3938030984507;1236.0235414023;1244.4959791284543;23918.402039949142;24493.877530612233;25251;25295.241142765746;25343.36641583975;32875.67124328822;33152.336953261285;33201.667983320825;33317.66682333242;33741.66258337483;146371;146398;146613;151351.24324378307;152948;26371.07701230448;27709.722902771522;31011.68988310088;31080.533791993592;31090.844545777127;34246.828765857004;34847.47728784121;35420.11449713778;35556.93329200025;35753;31795.84102079475;32752;34341.141471463416;34409.655903440645;34667.13332166615;31144.688553114178;32221.811164548457;32710.182245444055;33076.329608520675;33222.16944576405;33185.66814331826;33235.83382083171;33530.83234583811;33633.15917102092;33651.83174084212;25440;31217.664357274767;33775.49336759902;34316;34497.31005379929;23670.52658946777;23685.526289473768;23690.644640330753;24019.159329423386;24051.879740601184 02:47:58 INFO - PROCESS | 12763 | |2;jquery.html;352.4783320685386;359.4967046135411;363.6363636363636;364.3605472395945;369.2762186115214;14566.344514496846;14972.625684357896;15653.452129175466;16048.59878503038;16051.357945682159;14971.47599834006;15134.16762078088;15685.137317447536;15691.529254122366;15698.293576789043;4920.114379411713;5081.28861959326;5091.159958606844;5146.897062058757;5147.022065807503;4968.925466117993;5077.898442031157;5090.821821236257;5107.872303192413;5112.974435127838;5028.7988480460735;5051.696898186121;5054.014467178883;5058.14011618024;5061.038402703493;4997.825076122318;5166.974165129188;5175.9741201293755;5222.817201397952;5227.947720522803;5009.273655319958;5035.874103147414;5038.345015148044;5038.874028149326;5041.974790126026;13255;17654.382096626556;17665.911670441565;17668.646627067516;17693.38073167433;1800.1629242402346;1893.0440127735544;1923.85571082168;1924.490010147312;1982.5737466444784;8906.242969347613;9196.862047069299;9904.306698531105;10824.891751082467;12606.180598261084;1678.320280286486;1710.8887922285012;1753.8158493358142;1757.66604345174;1820.6904826179582;54282.457175428135;58459.415405846245;58919.41080589225;59105.40894591042;59738.402615974155;9322.347435679438;9381.812363752686;9628.277879159092;9680;9729.659461918798;12664.6833829155;12884.420201090974;12941.870581294255;12979.35103244834;12999.675008124872;6622.437092847162;6721.462283017347;6753.49348798842;6861.382475577222;6944.930550694529;6472.579282346633;6509.609423434515;6557.737690492327;6563.278039415661;6595.526677495939;4072.75563466193;4134.772587507716;4164.229617520768;4220.53574106848;4269.402283680287;1743.2939659437948;1750.912454377276;1803.8647101467443;1813.455963211058;1832.9175187116612;855.2601999270586;863.9438436501733;897.5108565831638;936.3258453913172;958.2812890332251;15601.60995975087;15851.603709907344;15855.127967961873;16300.755488667679;16509.504714858573;817.2685446525445;872.6291326186346;910.239949642043;938.962446496625;969.5936232861111;9000.324975626854;9002.279817614575;9145.679901203559;9150.954245228864;9240;291252;296785;297693;298025;375206;66860.6656966712;71843.28156718366;72077;72550;73112;865.8831057807115;866.0776273268948;872.2193636694996;873.3886279604302;890.1454603580506;11308.773824523629;14470.782938255725;14690.926545367633;14866.702665946405;15141.924290378918;30378.240543986576;30733.53899691551;31532.36935261236;31692;32419;37532.06169845776;37707.245855083296;37718.62281377151;37964.62035379611;38284.808575956944;7110.32451917067;7118.145822501333;7359.963200183965;7406.851862962818;7471.140818805907;8320.04319503265;10811.56753729842;11398.772024559297;11413.828792567952;11525.250858694159;9360.344775865624;9854.408735475894;9906.504674766376;9927.652532161339;10608.628697995533;9598.232141428809;9759.80480390374;9992.00079991995;10501;10689.679309620724;9774.462404567817;10195.592176312864;10323.432211228455;10487.26589138753;10540.420276884844;7440.702371905063;7644.77065688008;7662.6934922604705;7711.305982461381;7713.807154821175;7776.066871975399;10032.297739158188;10342;10603.045725884398;10777.137828973506 02:47:58 INFO - PROCESS | 12763 | |3;mootools.html;1095.9397233152174;1386.9375878085484;1389.7567925613016;1522.6421790879142;1710.4166770615564;6331.176946996896;6355.71399287032;6443.871122577546;6489.545731798776;6497.5126865485045;6781.186257649089;6882.96558517208;6899.310068993098;6931.930680693192;6932.133483314586;1888.9433317000512;1930.806919308065;2144.946376340596;2180.509385388291;2202.922897698581;2196.527746534503;2208.6576580630026;2210.9226177083806;2211.07135003299;2214.047959377467;2121.7559980602196;2148.495103650641;2157.30966090851;2171.9674204886937;2175.042981088316;2081.40679906226;2105.2421128393767;2106.157536985203;2111.123883588317;2111.5354621983215;2114.619368513667;2131.7974792394853;2136.7649558548546;2141.5395689926586;2146.5599552091785;6902.723891044352;6935.757248496278;6943.72225110995;6958.304169583052;6962.895556566656;4173.770442625654;4245.27830268855;4260.659147268211;4272.743635381887;4274.700770946035;2762.240383894425;2873.5545990371525;2876.5828954801436;2891.089306868351;2891.8698658560206;880.1154839386376;920.8987011428737;945.0313428735533;946.2666433514082;947.0198344713258;9666.420014799134;9671.177949874269;9676.12914837668;9687.757806054835;9692.127708506268;3985.0834308109297;4125.66994640428;4133.483314585676;4139.275626765304;4140.627343539096;8313.251807337369;8378;8383.413161078666;8390.370722195737;8395.62219700115;4336.349547567827;4350.3039513678295;4351.586599273064;4355.477342718894;4355.586219309161;3460.2041530448137;3723.1809002019513;3803.258364618928;3818.866339678098;3947.842086316515;3418.7265018798435;3421.640727723603;3462.79223246606;3482.8432720527635;3513.9121521962156;1132.6715252576826;1143.731223162556;1147.988520114805;1157.571698471571;1159.2986243322837;932.4917919733762;977.4086677560116;1153.9134564907665;1160.7620437810228;1162.6976985983536;6839.965800171067;6862.965685171542;6878;6880.277570855088;6911.75808846688;1061.3101484035285;1100.4332768624006;1117.4859564600213;1120.3222050659233;1138.487680543742;5115.232715092691;5179.559737422286;5195.090859099642;5216.008958297912;5216.113260745682;7937.166597507294;7998.240167184108;8155.83688326242;8187.672493100209;8258.091609922903;8088.595570221583;8110.716124935717;8148.755537333889;8156.469829461066;8259.463134896212;6646.102776125258;6648.301928297556;6697.09589205451;6700.262971073178;6703.664816759143;6537.411632953057;6580.177477815273;6597.934020659732;6600.405963463311;6610.438112760469;7674.53952762836;7920.564368959532;7944.602769861368;7982.680692772224;8097.2307630774985;8021.117677055403;8186.918130818854;8276.462029968034;8278.751637450887;8361.707340243061;5541.612087153861;5744.712764361681;5749.8275051748515;6042.063480160582;6151.292601350902;6226.346233645402;6699.8325041872395;6703.631300278532;6720.663966801738;6741.22475915276;6125.050617154348;6139.478144357601;6233.314335423191;6258;6272.466840318624;6083.695815209133;6128.9693551531955;6167.876642467036;6203.503719702323;6213.099100630293;6300.432961033345;6328.683565821782;6365.7135428904885;6489.707963141765;6494.447971922439;5999;6008.188894499362;6027.969860150672;6040.275166979991;6056.878862422639;6038.426349496791;6054.84862878414;6078.179445774764;6094.542909281733;6097.5426842987845 02:47:58 INFO - PROCESS | 12763 | |4;prototype.html;293.3970690231573;312.44852834746666;316.2567965281589;316.7814208196344;318.80712169137655;5366.221897824813;5372.0330340538685;5391.110466772978;5406.351237851453;5424.783008679653;5340;5344.038073146832;5358;5363.892722145555;5381.031414345416;3941.527016757993;4041.8585349512773;4049.068714195737;4050.1494686115952;4052.615001574846;4165.56261592533;4170.70805043647;4178.937315940263;4181.184668989548;4194.056337324108;4124.938125928114;4131.504219493665;4137.524184718751;4155.62599366057;4160.687948403882;3898.2593307271527;3971.245463361952;4154.729942553724;4156.854510092147;4166.041810383614;3501.3872572299747;3516.5604299462566;3523.559555055618;3524.207053412987;3531.4173161428334;4982.975085124551;5025.246213068032;5035.169197082477;5038.697678139323;5048.268001139814;4689.718616882998;4692.319613656001;4696.624270058422;4696.671233013691;4697.976510117427;5570.749316280777;5579.107342825169;5582.748776305076;5583.05088135018;5584.553235741131;3880.20455806559;3890.9805450972563;3893.493845800056;3894.3768996960353;3894.571597124314;5609.831705048855;5774.855628609276;5781.075027995501;5841.7371218295275;5906.438888305604;3982.9601703983167;4035.858744943913;4037.051292946155;4042.636162745367;4047.5750046245307;4069.5320038195396;4073.2260870434525;4076.6331030207425;4078.0416602098485;4086.2849001424634;4531.43357080365;4632.25883858581;4643.721376717408;4645.74448405341;4659.370984917061;5597.636153650081;5618.269624948731;5643.915341269884;5666.716664166775;5670.461306175906;1405.2411697683137;1413.8939579531577;1414.589768966988;1415.3701602786866;1418.2908545727137;921.6497730862229;941.6610020392653;943.5518128888723;957.5738796235609;959.0553304994575;4690.273007683814;4781.569658730731;4881.023795240966;4914.066327397783;4926.45808961014;5843.912341314884;5868.383819698955;5872.119182122716;5875.383084776123;5878.647910980499;4907.779149938261;4912.70523768575;4919.508049195123;4920.778564964585;4921.630877684188;3089.1968088296753;3138.435081685273;3149.527570864343;3156.179393357698;3169.41365847319;5437.809676661298;5462.945370546323;5469.425710300441;5470.64440811354;5472.315960504937;5787.594868359259;6010.068439391901;6035.517158627299;6048.697565121726;6050.788222412282;5439.259436980128;5460.099083651153;5471.316085489314;5478.260434841325;5481.260029895913;5867.442592953663;5873.765049397976;5876.44173803488;5878.3239927408895;5879.470847623564;5764.798232061858;5778.682172480386;5796.855078623068;5797.246357973437;5800.332961709458;5412.918806217831;5435.646682965753;5449.3460784706085;5453.454654534674;5453.573159943946;3854.9421758674202;3977.125032492847;3980.5024371953505;3984.7210695252215;4024.91950161001;5727.198192253005;5750.884982300414;5753.798617048383;5759.971200143972;5762.337331206797;5536.501714845684;5542.0855558833955;5557.972210138923;5558.082916318762;5563.109902415594;5546.473085057075;5553.444655534414;5593.636413633101;5615.326160860723;5622.381538030895;5516.393196748274;5520.66875987442;5528.889422211453;5536.640118392292;5537.473939975695;5445.646033007842;5633.4084921082695;5645.125005624135;5678.943210568007;5688.63023903445;5487.094629386106;5514.558835293247;5518.475744804237;5521.3926468089285;5522.475364840334 02:47:58 INFO - PROCESS | 12763 | |5;yui.html;556.6465294537967;577.1261694985847;615.2463232540139;646.2535771184282;678.9321067893211;11856.76286474271;12050.758984820299;12153.939230303858;12156.331401772899;12171.878281217185;11779.764404711901;13050.151740136884;13065.80401293979;13085.607431777038;13102.475900963975;788.1881661888265;793.0483419896119;794.566961006253;795.5266616363255;796.0526972902256;806.4919100966383;807.422692774666;808.1998821167061;810.0724670252557;810.4691427115249;851.7913111287712;859.325429537813;859.621766422772;859.7420773767876;861.5003298087125;844.7676888855552;845.6997765793117;846.9153084691543;847.2755793796277;852.3266619370689;622.2501885228289;623.183629445428;624.618982420723;627.0061951806392;628.915096461981;11464.426778661116;11543.07655387567;11552.249103808226;11661.12541559378;11861.94069029658;12124.151309408346;12175.391230438443;12231;12280.447379867837;12399.75200495994;9789.559469823804;9830.262730295184;9979.75050623733;9999.300048996573;10214.28500005;3280.6391296957318;3303.966960330414;3306.9007929762147;3320.518524813913;3371.5448414463976;40745.38881916774;41100.79449602763;42011.57988420107;42274.36588451175;42865;9333.953330233306;9411.152996230372;9468.526573671288;9557.665481708107;9593.1366177043;15434.845651543565;15462.226888655523;15483.5354939352;15487.303071361815;15490.535283941499;6136.539759518054;6255.093011513305;6392.105105285264;6434.646094464756;6505.902411463831;3593.6226696196522;3600.693941015043;3620.728445366608;3651.8539258429896;3654.7258955578436;2772.847493387883;2777.6389069420848;2778.902738404146;2781.749642532182;2784.4291920156725;514.812093585846;519.2626470412024;530.9256704061435;537.3659082282944;539.4443722965352;477.0649526927192;508.27817039751596;532.8321578702696;557.4397730281123;590.0117303516593;7480.775576732707;7585.791691751965;7629.351505122016;7759.495632783851;7776.261255180749;465.6740281802752;539.5252178083261;555.430683549357;555.4972749661563;568.769648292434;3424.589049314048;3462.63642317553;3481.5299934508516;3530.541029666127;3624.6012938576737;46955;47626.76186619114;47643.76178119087;49554.25668614974;49833.75083124561;39795.40306895399;40055;40632;40676.59323406728;44123;34798.826005870316;39605.60394396077;40074.198516029515;40621;41369.37945930753;7826.921730782619;8000.079990801132;8116.228958248957;8153.6738530458115;8179.63191656365;31144.532832007084;31399.529007064455;31761.841190793897;32145.196370089998;32211;36376.45435318419;36377.90866274016;38888.611113888495;40077.398839018024;40570;9682.757931051498;9779.559919803483;9810.607575696893;10090.34412763168;10205.489725513844;10747.516361763583;11172.329660220414;11463.770724585629;11677.941610292233;11751.76496470083;10576.312539685203;10614.522346494272;10650;10795.29830561011;10809.35143891369;10033.44816035125;10089.09198172168;10194.74513137148;10216.080552750289;10455.94772026135;10320;10480.266381353233;10484.108850747773;10582.100521455763;10742.140628749525;9299.209567186865;9412.435253884789;9461.952690236505;9462.810743785223;9670.178034866834;9328.626854925727;9482.905170948203;9526.285528585246;9549.188318992963;9602 02:47:58 INFO - PROCESS | 12763 | __end_tp_report 02:47:58 INFO - PROCESS | 12763 | __start_cc_report 02:47:58 INFO - PROCESS | 12763 | _x_x_mozilla_cycle_collect,876 02:47:58 INFO - PROCESS | 12763 | __end_cc_report 02:47:58 INFO - PROCESS | 12763 | __startTimestamp1459504078592__endTimestamp 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | ------- Summary: start ------- 02:47:58 INFO - PROCESS | 12763 | Number of tests: 6 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | [#0] dojo.html Cycles:165 Average:4487.19 Median:4593.79 stddev:465.54 (10.1%) stddev-sans-first:440.90 02:47:58 INFO - PROCESS | 12763 | Values: 2529.0 2575.7 2598.6 2608.3 2609.9 4424.8 4516.8 4570.5 4576.9 4593.8 4412.4 4505.3 4526.9 4613.1 4624.7 4102.7 4112.1 4118.7 4153.1 4308.1 4239.6 4271.6 4280.5 4308.9 4324.7 4075.0 4138.0 4160.1 4202.8 4229.1 4148.9 4162.7 4165.1 4192.1 4210.0 4137.9 4149.8 4154.8 4183.9 4199.3 4328.5 4425.7 4430.3 4520.7 4525.2 4827.6 4850.4 4865.0 4894.0 4899.3 4860.6 4862.2 4864.3 4865.8 4888.1 4433.3 4488.6 4571.2 4575.1 4583.5 4945.3 4948.8 4974.2 4979.9 5076.3 4643.8 4819.1 4822.1 4824.7 4826.6 4803.8 4883.5 4887.5 4918.3 4935.1 4793.0 4799.6 4804.3 4804.9 4857.8 4675.7 4784.8 4790.3 4819.7 4834.9 4105.7 4108.3 4137.3 4151.8 4152.1 3578.6 3624.2 3625.1 3639.8 3652.5 4075.2 4159.6 4165.0 4170.5 4178.5 4857.2 4862.5 4863.2 4892.8 4912.0 4127.5 4149.8 4150.1 4171.8 4190.1 4261.3 4350.7 4392.7 4429.1 4429.6 4443.6 4467.2 4468.5 4505.5 4510.1 4768.1 4771.7 4775.0 4776.6 4819.0 4390.1 4465.7 4512.5 4595.2 4608.7 4813.4 4835.5 4836.2 4841.1 4867.9 4892.1 4912.9 4915.2 4917.3 4968.4 4586.3 4692.0 4741.0 4763.6 4787.2 4774.6 4777.4 4795.4 4796.7 4857.0 4569.5 4696.0 4707.4 4711.5 4753.6 4703.4 4786.6 4787.6 4817.6 4832.4 4642.3 4672.0 4684.3 4688.8 4691.0 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | [#1] ext.html Cycles:180 Average:38717.08 Median:18578.90 stddev:61491.76 (331.0%) stddev-sans-first:61597.43 02:47:58 INFO - PROCESS | 12763 | Values: 537.1 548.8 558.9 563.3 579.6 24410.6 24793.3 34332.8 34854.7 34875.7 37215.6 37593.8 37634.1 37712.0 37833.2 7552.1 7707.0 7735.3 7736.2 7737.1 7525.4 7618.3 7645.6 7646.0 7648.2 7785.3 7868.9 7876.7 7883.8 7926.0 7808.1 7884.9 7886.3 7891.4 7891.4 7518.0 7552.7 7628.6 7631.8 7636.0 37118.3 37434.3 37567.6 37582.2 37636.6 2994.3 3032.2 3077.6 3552.4 3600.7 28098.0 28499.4 29399.0 29698.4 29865.0 3293.9 3323.6 3349.0 3382.3 3388.7 239917.0 239921.0 240200.0 240366.0 240397.0 51880.0 53555.5 53896.0 53907.7 53977.7 59820.1 60639.0 60688.0 60767.4 60837.4 13193.5 13296.2 13371.0 13411.3 13411.5 9237.8 9244.4 9302.8 9351.4 9960.7 17910.8 18064.2 18125.6 18144.5 18215.8 6950.2 7288.2 7334.6 7343.8 7389.4 892.5 913.0 931.9 982.4 1022.2 25557.4 26886.6 27017.0 27182.9 27206.0 947.7 957.8 994.9 1037.7 1053.8 14218.0 14296.0 14326.9 14479.6 14498.3 288344.0 292718.0 292784.0 293653.0 294299.0 46684.0 47789.8 47846.3 47847.0 48002.0 1041.8 1191.3 1212.4 1236.0 1244.5 23918.4 24493.9 25251.0 25295.2 25343.4 32875.7 33152.3 33201.7 33317.7 33741.7 146371.0 146398.0 146613.0 151351.2 152948.0 26371.1 27709.7 31011.7 31080.5 31090.8 34246.8 34847.5 35420.1 35556.9 35753.0 31795.8 32752.0 34341.1 34409.7 34667.1 31144.7 32221.8 32710.2 33076.3 33222.2 33185.7 33235.8 33530.8 33633.2 33651.8 25440.0 31217.7 33775.5 34316.0 34497.3 23670.5 23685.5 23690.6 24019.2 24051.9 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | [#2] jquery.html Cycles:180 Average:20755.75 Median:5019.04 stddev:51823.74 (1032.5%) stddev-sans-first:51946.48 02:47:58 INFO - PROCESS | 12763 | Values: 352.5 359.5 363.6 364.4 369.3 14566.3 14972.6 15653.5 16048.6 16051.4 14971.5 15134.2 15685.1 15691.5 15698.3 4920.1 5081.3 5091.2 5146.9 5147.0 4968.9 5077.9 5090.8 5107.9 5113.0 5028.8 5051.7 5054.0 5058.1 5061.0 4997.8 5167.0 5176.0 5222.8 5227.9 5009.3 5035.9 5038.3 5038.9 5042.0 13255.0 17654.4 17665.9 17668.6 17693.4 1800.2 1893.0 1923.9 1924.5 1982.6 8906.2 9196.9 9904.3 10824.9 12606.2 1678.3 1710.9 1753.8 1757.7 1820.7 54282.5 58459.4 58919.4 59105.4 59738.4 9322.3 9381.8 9628.3 9680.0 9729.7 12664.7 12884.4 12941.9 12979.4 12999.7 6622.4 6721.5 6753.5 6861.4 6944.9 6472.6 6509.6 6557.7 6563.3 6595.5 4072.8 4134.8 4164.2 4220.5 4269.4 1743.3 1750.9 1803.9 1813.5 1832.9 855.3 863.9 897.5 936.3 958.3 15601.6 15851.6 15855.1 16300.8 16509.5 817.3 872.6 910.2 939.0 969.6 9000.3 9002.3 9145.7 9151.0 9240.0 291252.0 296785.0 297693.0 298025.0 375206.0 66860.7 71843.3 72077.0 72550.0 73112.0 865.9 866.1 872.2 873.4 890.1 11308.8 14470.8 14690.9 14866.7 15141.9 30378.2 30733.5 31532.4 31692.0 32419.0 37532.1 37707.2 37718.6 37964.6 38284.8 7110.3 7118.1 7360.0 7406.9 7471.1 8320.0 10811.6 11398.8 11413.8 11525.3 9360.3 9854.4 9906.5 9927.7 10608.6 9598.2 9759.8 9992.0 10501.0 10689.7 9774.5 10195.6 10323.4 10487.3 10540.4 7440.7 7644.8 7662.7 7711.3 7713.8 7776.1 10032.3 10342.0 10603.0 10777.1 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | [#3] mootools.html Cycles:180 Average:4957.77 Median:6089.12 stddev:2516.31 (41.3%) stddev-sans-first:2506.62 02:47:58 INFO - PROCESS | 12763 | Values: 1095.9 1386.9 1389.8 1522.6 1710.4 6331.2 6355.7 6443.9 6489.5 6497.5 6781.2 6883.0 6899.3 6931.9 6932.1 1888.9 1930.8 2144.9 2180.5 2202.9 2196.5 2208.7 2210.9 2211.1 2214.0 2121.8 2148.5 2157.3 2172.0 2175.0 2081.4 2105.2 2106.2 2111.1 2111.5 2114.6 2131.8 2136.8 2141.5 2146.6 6902.7 6935.8 6943.7 6958.3 6962.9 4173.8 4245.3 4260.7 4272.7 4274.7 2762.2 2873.6 2876.6 2891.1 2891.9 880.1 920.9 945.0 946.3 947.0 9666.4 9671.2 9676.1 9687.8 9692.1 3985.1 4125.7 4133.5 4139.3 4140.6 8313.3 8378.0 8383.4 8390.4 8395.6 4336.3 4350.3 4351.6 4355.5 4355.6 3460.2 3723.2 3803.3 3818.9 3947.8 3418.7 3421.6 3462.8 3482.8 3513.9 1132.7 1143.7 1148.0 1157.6 1159.3 932.5 977.4 1153.9 1160.8 1162.7 6840.0 6863.0 6878.0 6880.3 6911.8 1061.3 1100.4 1117.5 1120.3 1138.5 5115.2 5179.6 5195.1 5216.0 5216.1 7937.2 7998.2 8155.8 8187.7 8258.1 8088.6 8110.7 8148.8 8156.5 8259.5 6646.1 6648.3 6697.1 6700.3 6703.7 6537.4 6580.2 6597.9 6600.4 6610.4 7674.5 7920.6 7944.6 7982.7 8097.2 8021.1 8186.9 8276.5 8278.8 8361.7 5541.6 5744.7 5749.8 6042.1 6151.3 6226.3 6699.8 6703.6 6720.7 6741.2 6125.1 6139.5 6233.3 6258.0 6272.5 6083.7 6129.0 6167.9 6203.5 6213.1 6300.4 6328.7 6365.7 6489.7 6494.4 5999.0 6008.2 6028.0 6040.3 6056.9 6038.4 6054.8 6078.2 6094.5 6097.5 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | [#4] prototype.html Cycles:180 Average:4638.66 Median:5376.53 stddev:1372.17 (25.5%) stddev-sans-first:1336.70 02:47:58 INFO - PROCESS | 12763 | Values: 293.4 312.4 316.3 316.8 318.8 5366.2 5372.0 5391.1 5406.4 5424.8 5340.0 5344.0 5358.0 5363.9 5381.0 3941.5 4041.9 4049.1 4050.1 4052.6 4165.6 4170.7 4178.9 4181.2 4194.1 4124.9 4131.5 4137.5 4155.6 4160.7 3898.3 3971.2 4154.7 4156.9 4166.0 3501.4 3516.6 3523.6 3524.2 3531.4 4983.0 5025.2 5035.2 5038.7 5048.3 4689.7 4692.3 4696.6 4696.7 4698.0 5570.7 5579.1 5582.7 5583.1 5584.6 3880.2 3891.0 3893.5 3894.4 3894.6 5609.8 5774.9 5781.1 5841.7 5906.4 3983.0 4035.9 4037.1 4042.6 4047.6 4069.5 4073.2 4076.6 4078.0 4086.3 4531.4 4632.3 4643.7 4645.7 4659.4 5597.6 5618.3 5643.9 5666.7 5670.5 1405.2 1413.9 1414.6 1415.4 1418.3 921.6 941.7 943.6 957.6 959.1 4690.3 4781.6 4881.0 4914.1 4926.5 5843.9 5868.4 5872.1 5875.4 5878.6 4907.8 4912.7 4919.5 4920.8 4921.6 3089.2 3138.4 3149.5 3156.2 3169.4 5437.8 5462.9 5469.4 5470.6 5472.3 5787.6 6010.1 6035.5 6048.7 6050.8 5439.3 5460.1 5471.3 5478.3 5481.3 5867.4 5873.8 5876.4 5878.3 5879.5 5764.8 5778.7 5796.9 5797.2 5800.3 5412.9 5435.6 5449.3 5453.5 5453.6 3854.9 3977.1 3980.5 3984.7 4024.9 5727.2 5750.9 5753.8 5760.0 5762.3 5536.5 5542.1 5558.0 5558.1 5563.1 5546.5 5553.4 5593.6 5615.3 5622.4 5516.4 5520.7 5528.9 5536.6 5537.5 5445.6 5633.4 5645.1 5678.9 5688.6 5487.1 5514.6 5518.5 5521.4 5522.5 02:47:58 INFO - PROCESS | 12763 | 02:47:58 INFO - PROCESS | 12763 | [#5] yui.html Cycles:180 Average:12149.59 Median:42569.68 stddev:13442.54 (31.6%) stddev-sans-first:13452.05 02:47:58 INFO - PROCESS | 12763 | Values: 556.6 577.1 615.2 646.3 678.9 11856.8 12050.8 12153.9 12156.3 12171.9 11779.8 13050.2 13065.8 13085.6 13102.5 788.2 793.0 794.6 795.5 796.1 806.5 807.4 808.2 810.1 810.5 851.8 859.3 859.6 859.7 861.5 844.8 845.7 846.9 847.3 852.3 622.3 623.2 624.6 627.0 628.9 11464.4 11543.1 11552.2 11661.1 11861.9 12124.2 12175.4 12231.0 12280.4 12399.8 9789.6 9830.3 9979.8 9999.3 10214.3 3280.6 3304.0 3306.9 3320.5 3371.5 40745.4 41100.8 42011.6 42274.4 42865.0 9334.0 9411.2 9468.5 9557.7 9593.1 15434.8 15462.2 15483.5 15487.3 15490.5 6136.5 6255.1 6392.1 6434.6 6505.9 3593.6 3600.7 3620.7 3651.9 3654.7 2772.8 2777.6 2778.9 2781.7 2784.4 514.8 519.3 530.9 537.4 539.4 477.1 508.3 532.8 557.4 590.0 7480.8 7585.8 7629.4 7759.5 7776.3 465.7 539.5 555.4 555.5 568.8 3424.6 3462.6 3481.5 3530.5 3624.6 46955.0 47626.8 47643.8 49554.3 49833.8 39795.4 40055.0 40632.0 40676.6 44123.0 34798.8 39605.6 40074.2 40621.0 41369.4 7826.9 8000.1 8116.2 8153.7 8179.6 31144.5 31399.5 31761.8 32145.2 32211.0 36376.5 36377.9 38888.6 40077.4 40570.0 9682.8 9779.6 9810.6 10090.3 10205.5 10747.5 11172.3 11463.8 11677.9 11751.8 10576.3 10614.5 10650.0 10795.3 10809.4 10033.4 10089.1 10194.7 10216.1 10455.9 10320.0 10480.3 10484.1 10582.1 10742.1 9299.2 9412.4 9462.0 9462.8 9670.2 9328.6 9482.9 9526.3 9549.2 9602.0 02:47:58 INFO - PROCESS | 12763 | -------- Summary: end -------- 02:47:58 INFO - PROCESS | 12763 | 02:47:59 INFO - TEST-INFO | 12763: exit 0 02:47:59 INFO - TEST-OK | dromaeo_css | took 1116400ms 02:47:59 INFO - TEST-START | kraken 02:47:59 INFO - operating with platform_type : linux_ 02:47:59 INFO - Initialising browser for kraken test... 02:47:59 INFO - TEST-INFO | started process 12942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVwcp47/profile http://localhost:45379/getInfo.html) 02:48:03 INFO - PROCESS | 12942 | __metrics Screen width/height:1600/1200 02:48:03 INFO - PROCESS | 12942 | colorDepth:24 02:48:03 INFO - PROCESS | 12942 | Browser inner width/height: 1024/697 02:48:03 INFO - PROCESS | 12942 | __metrics 02:48:04 ERROR - PROCESS | 12942 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:48:05 INFO - TEST-INFO | 12942: exit 0 02:48:05 INFO - Browser initialized. 02:48:05 INFO - Running cycle 1/1 for kraken test... 02:48:05 INFO - TEST-INFO | started process 13025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVwcp47/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:17 INFO - PROCESS | 13025 | RSS: Main: 154652672 02:48:17 INFO - PROCESS | 13025 | 02:48:20 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45379/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:20 INFO - PROCESS | 13025 | RSS: Main: 197459968 02:48:20 INFO - PROCESS | 13025 | 02:48:23 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45379/tests/kraken/driver.html?testName=audio-dft) 02:48:24 INFO - PROCESS | 13025 | RSS: Main: 187928576 02:48:24 INFO - PROCESS | 13025 | 02:48:27 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45379/tests/kraken/driver.html?testName=audio-fft) 02:48:27 INFO - PROCESS | 13025 | RSS: Main: 171106304 02:48:27 INFO - PROCESS | 13025 | 02:48:29 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45379/tests/kraken/driver.html?testName=audio-oscillator) 02:48:30 INFO - PROCESS | 13025 | RSS: Main: 173072384 02:48:30 INFO - PROCESS | 13025 | 02:48:32 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:33 INFO - PROCESS | 13025 | RSS: Main: 174075904 02:48:33 INFO - PROCESS | 13025 | 02:48:36 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45379/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:36 INFO - PROCESS | 13025 | RSS: Main: 174891008 02:48:36 INFO - PROCESS | 13025 | 02:48:40 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45379/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:41 INFO - PROCESS | 13025 | RSS: Main: 172584960 02:48:41 INFO - PROCESS | 13025 | 02:48:43 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45379/tests/kraken/driver.html?testName=json-parse-financial) 02:48:44 INFO - PROCESS | 13025 | RSS: Main: 173154304 02:48:44 INFO - PROCESS | 13025 | 02:48:46 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:46 INFO - PROCESS | 13025 | RSS: Main: 186814464 02:48:46 INFO - PROCESS | 13025 | 02:48:48 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:49 INFO - PROCESS | 13025 | RSS: Main: 184590336 02:48:49 INFO - PROCESS | 13025 | 02:48:51 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:51 INFO - PROCESS | 13025 | RSS: Main: 197042176 02:48:51 INFO - PROCESS | 13025 | 02:48:54 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:55 INFO - PROCESS | 13025 | RSS: Main: 202346496 02:48:55 INFO - PROCESS | 13025 | 02:48:57 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:58 INFO - PROCESS | 13025 | RSS: Main: 200925184 02:48:58 INFO - PROCESS | 13025 | 02:48:59 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:45379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45379/tests/kraken/driver.html?testName=ai-astar) 02:49:00 INFO - PROCESS | 13025 | RSS: Main: 262590464 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | __start_tp_report 02:49:00 INFO - PROCESS | 13025 | _x_x_mozilla_page_load 02:49:00 INFO - PROCESS | 13025 | _x_x_mozilla_page_load_details 02:49:00 INFO - PROCESS | 13025 | |i|pagename|runs| 02:49:00 INFO - PROCESS | 13025 | |0;ai-astar;112;115;107;112;112;112;102;112;112;111 02:49:00 INFO - PROCESS | 13025 | |1;audio-beat-detection;160;132;154;170;133;159;155;129;172;141 02:49:00 INFO - PROCESS | 13025 | |2;audio-dft;162;163;163;162;162;161;164;164;164;161 02:49:00 INFO - PROCESS | 13025 | |3;audio-fft;76;74;87;106;75;73;73;117;98;75 02:49:00 INFO - PROCESS | 13025 | |4;audio-oscillator;93;94;137;95;94;93;139;94;94;140 02:49:00 INFO - PROCESS | 13025 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;118 02:49:00 INFO - PROCESS | 13025 | |6;imaging-darkroom;147;145;147;146;146;146;146;145;145;145 02:49:00 INFO - PROCESS | 13025 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 02:49:00 INFO - PROCESS | 13025 | |8;json-parse-financial;65;65;65;65;66;66;65;75;65;64 02:49:00 INFO - PROCESS | 13025 | |9;json-stringify-tinderbox;63;63;63;63;64;64;65;64;64;64 02:49:00 INFO - PROCESS | 13025 | |10;stanford-crypto-aes;84;92;83;84;83;82;82;84;85;85 02:49:00 INFO - PROCESS | 13025 | |11;stanford-crypto-ccm;117;121;121;117;125;115;133;119;119;128 02:49:00 INFO - PROCESS | 13025 | |12;stanford-crypto-pbkdf2;145;134;144;143;145;133;147;147;141;146 02:49:00 INFO - PROCESS | 13025 | |13;stanford-crypto-sha256-iterative;68;70;66;68;67;65;66;70;68;67 02:49:00 INFO - PROCESS | 13025 | __end_tp_report 02:49:00 INFO - PROCESS | 13025 | __start_cc_report 02:49:00 INFO - PROCESS | 13025 | _x_x_mozilla_cycle_collect,1188 02:49:00 INFO - PROCESS | 13025 | __end_cc_report 02:49:00 INFO - PROCESS | 13025 | __startTimestamp1459504140211__endTimestamp 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | ------- Summary: start ------- 02:49:00 INFO - PROCESS | 13025 | Number of tests: 14 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.62 (3.2%) stddev-sans-first:3.81 02:49:00 INFO - PROCESS | 13025 | Values: 112.0 115.0 107.0 112.0 112.0 112.0 102.0 112.0 112.0 111.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:157.00 stddev:15.77 (10.0%) stddev-sans-first:16.35 02:49:00 INFO - PROCESS | 13025 | Values: 160.0 132.0 154.0 170.0 133.0 159.0 155.0 129.0 172.0 141.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 02:49:00 INFO - PROCESS | 13025 | Values: 162.0 163.0 163.0 162.0 162.0 161.0 164.0 164.0 164.0 161.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:16.08 (21.4%) stddev-sans-first:16.69 02:49:00 INFO - PROCESS | 13025 | Values: 76.0 74.0 87.0 106.0 75.0 73.0 73.0 117.0 98.0 75.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.66 (23.0%) stddev-sans-first:22.35 02:49:00 INFO - PROCESS | 13025 | Values: 93.0 94.0 137.0 95.0 94.0 93.0 139.0 94.0 94.0 140.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:49:00 INFO - PROCESS | 13025 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 02:49:00 INFO - PROCESS | 13025 | Values: 147.0 145.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:49:00 INFO - PROCESS | 13025 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:3.18 (4.9%) stddev-sans-first:3.35 02:49:00 INFO - PROCESS | 13025 | Values: 65.0 65.0 65.0 65.0 66.0 66.0 65.0 75.0 65.0 64.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 02:49:00 INFO - PROCESS | 13025 | Values: 63.0 63.0 63.0 63.0 64.0 64.0 65.0 64.0 64.0 64.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.88 (3.4%) stddev-sans-first:3.05 02:49:00 INFO - PROCESS | 13025 | Values: 84.0 92.0 83.0 84.0 83.0 82.0 82.0 84.0 85.0 85.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.00 stddev:5.60 (4.6%) stddev-sans-first:5.70 02:49:00 INFO - PROCESS | 13025 | Values: 117.0 121.0 121.0 117.0 125.0 115.0 133.0 119.0 119.0 128.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:145.00 stddev:5.08 (3.5%) stddev-sans-first:5.31 02:49:00 INFO - PROCESS | 13025 | Values: 145.0 134.0 144.0 143.0 145.0 133.0 147.0 147.0 141.0 146.0 02:49:00 INFO - PROCESS | 13025 | 02:49:00 INFO - PROCESS | 13025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.74 02:49:00 INFO - PROCESS | 13025 | Values: 68.0 70.0 66.0 68.0 67.0 65.0 66.0 70.0 68.0 67.0 02:49:00 INFO - PROCESS | 13025 | -------- Summary: end -------- 02:49:00 INFO - PROCESS | 13025 | 02:49:01 INFO - TEST-INFO | 13025: exit 0 02:49:01 INFO - TEST-OK | kraken | took 61869ms 02:49:01 INFO - SUITE-END | took 1178s 02:49:01 INFO - Completed test suite (00:19:38) 02:49:01 INFO - javascript benchmark 02:49:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2528.987355063225, 2575.6909170899494, 2598.623199636053, 2608.3087981684844, 2609.9478010439793, 4424.800883960222, 4516.774161291931, 4570.451545814502, 4576.885577860555, 4593.793279302431, 4412.404325416068, 4505.30167823987, 4526.932096018562, 4613.100445413146, 4624.653151013679, 4102.651274641659, 4112.05422752767, 4118.691098167635, 4153.086321009373, 4308.095299987007, 4239.597238262376, 4271.594198551133, 4280.486341639008, 4308.913821723564, 4324.675649326297, 4074.9592504074876, 4137.97931010343, 4160.084781348099, 4202.789860506978, 4229.133027729308, 4148.937765933513, 4162.729422587552, 4165.12532368203, 4192.05678722285, 4209.97895010526, 4137.937930931039, 4149.751014939083, 4154.750714957112, 4183.874483765492, 4199.286121359346, 4328.523862375137, 4425.712328698624, 4430.335449682541, 4520.728756274634, 4525.185466616008, 4827.58965487934, 4850.393700787402, 4865.0, 4893.95106048942, 4899.265110233458, 4860.635452341053, 4862.197737373329, 4864.343313652647, 4865.829695960624, 4888.071266459361, 4433.290673492258, 4488.573585509372, 4571.22289210835, 4575.084983003413, 4583.541645835457, 4945.282933974626, 4948.777305021211, 4974.179260422062, 4979.925301120486, 5076.340075790197, 4643.814247430132, 4819.084373968934, 4822.083804077214, 4824.6863953842885, 4826.58973987215, 4803.759812009455, 4883.51164883516, 4887.535684110004, 4918.286848406961, 4935.111679897653, 4792.95207047932, 4799.640026997919, 4804.327394164819, 4804.903901921942, 4857.80568777252, 4675.742834144086, 4784.784684689197, 4790.329353890458, 4819.734914579662, 4834.927476087862, 4105.651019663303, 4108.301588729923, 4137.338025915839, 4151.771652559078, 4152.086540960984, 3578.624244454295, 3624.2389098289655, 3625.1118475973553, 3639.7998110103667, 3652.543432070991, 4075.2053349596545, 4159.563245859141, 4165.0, 4170.47869016373, 4178.541283948153, 4857.247126695368, 4862.51374862518, 4863.197572400514, 4892.755362231946, 4912.017596480719, 4127.484064491939, 4149.792510374469, 4150.1284730207, 4171.770552619574, 4190.141021090669, 4261.2542805009, 4350.6736994725525, 4392.714473559208, 4429.092036132585, 4429.579189976947, 4443.577860103285, 4467.15124126415, 4468.486124095771, 4505.504394516601, 4510.075434535978, 4768.070226305976, 4771.66598338113, 4775.0, 4776.59398951093, 4818.975905120452, 4390.121975604828, 4465.732056076646, 4512.458504979423, 4595.218812801899, 4608.677392582487, 4813.446453657874, 4835.540623640749, 4836.202026665561, 4841.104395686809, 4867.853964381075, 4892.0705066037335, 4912.852614421573, 4915.1644220481885, 4917.262410638433, 4968.378952630921, 4586.2661974083985, 4691.953080469151, 4740.952590474051, 4763.618910487084, 4787.210110331756, 4774.570288674036, 4777.378940737821, 4795.376601041842, 4796.7361795100205, 4856.95143048565, 4569.520200378913, 4696.037312351028, 4707.364505791675, 4711.528847115398, 4753.572178503951, 4703.412073490814, 4786.617070634271, 4787.593054590398, 4817.638677099161, 4832.371791667061, 4642.280446530793, 4671.976640116778, 4684.297355396718, 4688.835890743808, 4691.03833714081], "unit": "score", "name": "dojo.html", "value": 4458.197801966193}, {"lowerIsBetter": false, "replicates": [537.0655060195262, 548.8298627425498, 558.8798408342207, 563.2818156850016, 579.6145563200472, 24410.633840492384, 24793.256202313936, 34332.828335858314, 34854.65145348546, 34875.651243487555, 37215.627843721624, 37593.81203093981, 37634.0591485213, 37712.0, 37833.24333513328, 7552.131504876941, 7706.961465192666, 7735.342495887856, 7736.226377362275, 7737.110232323299, 7525.4355923305975, 7618.314351708345, 7645.61771911405, 7646.0, 7648.158702542716, 7785.260400261995, 7868.881966770503, 7876.684932602689, 7883.8423231535335, 7925.9603701981405, 7808.102068262166, 7884.921150788534, 7886.329661978739, 7891.368690504746, 7891.447598668095, 7517.962410187969, 7552.73565425213, 7628.580428076453, 7631.847363052763, 7635.961820190919, 37118.25763484715, 37434.251314973546, 37567.62432375669, 37582.24835503302, 37636.623633763586, 2994.281372470613, 3032.2419395151214, 3077.6306843178736, 3552.4316109422625, 3600.747947643666, 28098.0, 28499.43001139986, 29399.0, 29698.40603187924, 29865.0, 3293.9341213175844, 3323.551320571716, 3349.0, 3382.30662714143, 3388.6780755828404, 239917.0, 239921.0, 240200.0, 240365.99999999825, 240397.0, 51880.0, 53555.46444535583, 53896.0, 53907.73046134744, 53977.73011134998, 59820.102698458686, 60639.0, 60688.0, 60767.39232607617, 60837.391626083176, 13193.472261109448, 13296.202227866359, 13371.0, 13411.262380569162, 13411.463541458428, 9237.815243695088, 9244.445333280024, 9302.813943721223, 9351.39215950961, 9960.701178964642, 17910.820891791176, 18064.18711158001, 18125.63748725018, 18144.45566633003, 18215.817841821412, 6950.165980082423, 7288.198298187195, 7334.559926404433, 7343.77968660941, 7389.371903388164, 892.5135800988477, 912.9726108216764, 931.9254459643212, 982.4350998176077, 1022.2486472442748, 25557.3610659735, 26886.5967010495, 27017.0, 27182.864085679445, 27206.0, 947.6635794293064, 957.818014577228, 994.8855881573712, 1037.7301901505664, 1053.773438710681, 14218.0, 14296.0, 14326.928365358106, 14479.565613031626, 14498.347574358968, 288344.0, 292718.0, 292784.0, 293653.0, 294299.0, 46684.0, 47789.761051194524, 47846.28230576544, 47847.0, 48002.0, 1041.7760181561, 1191.255465334166, 1212.3938030984507, 1236.0235414023, 1244.4959791284543, 23918.402039949142, 24493.877530612233, 25251.0, 25295.241142765746, 25343.36641583975, 32875.67124328822, 33152.336953261285, 33201.667983320825, 33317.66682333242, 33741.66258337483, 146371.0, 146398.0, 146613.0, 151351.24324378307, 152948.0, 26371.07701230448, 27709.722902771522, 31011.68988310088, 31080.533791993592, 31090.844545777127, 34246.828765857004, 34847.47728784121, 35420.11449713778, 35556.93329200025, 35753.0, 31795.84102079475, 32752.0, 34341.141471463416, 34409.655903440645, 34667.13332166615, 31144.688553114178, 32221.811164548457, 32710.182245444055, 33076.329608520675, 33222.16944576405, 33185.66814331826, 33235.83382083171, 33530.83234583811, 33633.15917102092, 33651.83174084212, 25440.0, 31217.664357274767, 33775.49336759902, 34316.0, 34497.31005379929, 23670.52658946777, 23685.526289473768, 23690.644640330753, 24019.159329423386, 24051.879740601184], "unit": "score", "name": "ext.html", "value": 16425.889987181894}, {"lowerIsBetter": false, "replicates": [352.4783320685386, 359.4967046135411, 363.6363636363636, 364.3605472395945, 369.2762186115214, 14566.344514496846, 14972.625684357896, 15653.452129175466, 16048.59878503038, 16051.357945682159, 14971.47599834006, 15134.16762078088, 15685.137317447536, 15691.529254122366, 15698.293576789043, 4920.114379411713, 5081.28861959326, 5091.159958606844, 5146.897062058757, 5147.022065807503, 4968.925466117993, 5077.898442031157, 5090.821821236257, 5107.872303192413, 5112.974435127838, 5028.7988480460735, 5051.696898186121, 5054.014467178883, 5058.14011618024, 5061.038402703493, 4997.825076122318, 5166.974165129188, 5175.9741201293755, 5222.817201397952, 5227.947720522803, 5009.273655319958, 5035.874103147414, 5038.345015148044, 5038.874028149326, 5041.974790126026, 13255.0, 17654.382096626556, 17665.911670441565, 17668.646627067516, 17693.38073167433, 1800.1629242402346, 1893.0440127735544, 1923.85571082168, 1924.490010147312, 1982.5737466444784, 8906.242969347613, 9196.862047069299, 9904.306698531105, 10824.891751082467, 12606.180598261084, 1678.320280286486, 1710.8887922285012, 1753.8158493358142, 1757.66604345174, 1820.6904826179582, 54282.457175428135, 58459.415405846245, 58919.41080589225, 59105.40894591042, 59738.402615974155, 9322.347435679438, 9381.812363752686, 9628.277879159092, 9680.0, 9729.659461918798, 12664.6833829155, 12884.420201090974, 12941.870581294255, 12979.35103244834, 12999.675008124872, 6622.437092847162, 6721.462283017347, 6753.49348798842, 6861.382475577222, 6944.930550694529, 6472.579282346633, 6509.609423434515, 6557.737690492327, 6563.278039415661, 6595.526677495939, 4072.75563466193, 4134.772587507716, 4164.229617520768, 4220.53574106848, 4269.402283680287, 1743.2939659437948, 1750.912454377276, 1803.8647101467443, 1813.455963211058, 1832.9175187116612, 855.2601999270586, 863.9438436501733, 897.5108565831638, 936.3258453913172, 958.2812890332251, 15601.60995975087, 15851.603709907344, 15855.127967961873, 16300.755488667679, 16509.504714858573, 817.2685446525445, 872.6291326186346, 910.239949642043, 938.962446496625, 969.5936232861111, 9000.324975626854, 9002.279817614575, 9145.679901203559, 9150.954245228864, 9240.0, 291252.0, 296785.0, 297693.0, 298025.0, 375206.0, 66860.6656966712, 71843.28156718366, 72077.0, 72550.0, 73112.0, 865.8831057807115, 866.0776273268948, 872.2193636694996, 873.3886279604302, 890.1454603580506, 11308.773824523629, 14470.782938255725, 14690.926545367633, 14866.702665946405, 15141.924290378918, 30378.240543986576, 30733.53899691551, 31532.36935261236, 31692.0, 32419.0, 37532.06169845776, 37707.245855083296, 37718.62281377151, 37964.62035379611, 38284.808575956944, 7110.32451917067, 7118.145822501333, 7359.963200183965, 7406.851862962818, 7471.140818805907, 8320.04319503265, 10811.56753729842, 11398.772024559297, 11413.828792567952, 11525.250858694159, 9360.344775865624, 9854.408735475894, 9906.504674766376, 9927.652532161339, 10608.628697995533, 9598.232141428809, 9759.80480390374, 9992.00079991995, 10501.0, 10689.679309620724, 9774.462404567817, 10195.592176312864, 10323.432211228455, 10487.26589138753, 10540.420276884844, 7440.702371905063, 7644.77065688008, 7662.6934922604705, 7711.305982461381, 7713.807154821175, 7776.066871975399, 10032.297739158188, 10342.0, 10603.045725884398, 10777.137828973506], "unit": "score", "name": "jquery.html", "value": 7727.94662212768}, {"lowerIsBetter": false, "replicates": [1095.9397233152174, 1386.9375878085484, 1389.7567925613016, 1522.6421790879142, 1710.4166770615564, 6331.176946996896, 6355.71399287032, 6443.871122577546, 6489.545731798776, 6497.5126865485045, 6781.186257649089, 6882.96558517208, 6899.310068993098, 6931.930680693192, 6932.133483314586, 1888.9433317000512, 1930.806919308065, 2144.946376340596, 2180.509385388291, 2202.922897698581, 2196.527746534503, 2208.6576580630026, 2210.9226177083806, 2211.07135003299, 2214.047959377467, 2121.7559980602196, 2148.495103650641, 2157.30966090851, 2171.9674204886937, 2175.042981088316, 2081.40679906226, 2105.2421128393767, 2106.157536985203, 2111.123883588317, 2111.5354621983215, 2114.619368513667, 2131.7974792394853, 2136.7649558548546, 2141.5395689926586, 2146.5599552091785, 6902.723891044352, 6935.757248496278, 6943.72225110995, 6958.304169583052, 6962.895556566656, 4173.770442625654, 4245.27830268855, 4260.659147268211, 4272.743635381887, 4274.700770946035, 2762.240383894425, 2873.5545990371525, 2876.5828954801436, 2891.089306868351, 2891.8698658560206, 880.1154839386376, 920.8987011428737, 945.0313428735533, 946.2666433514082, 947.0198344713258, 9666.420014799134, 9671.177949874269, 9676.12914837668, 9687.757806054835, 9692.127708506268, 3985.0834308109297, 4125.66994640428, 4133.483314585676, 4139.275626765304, 4140.627343539096, 8313.251807337369, 8378.0, 8383.413161078666, 8390.370722195737, 8395.62219700115, 4336.349547567827, 4350.3039513678295, 4351.586599273064, 4355.477342718894, 4355.586219309161, 3460.2041530448137, 3723.1809002019513, 3803.258364618928, 3818.866339678098, 3947.842086316515, 3418.7265018798435, 3421.640727723603, 3462.79223246606, 3482.8432720527635, 3513.9121521962156, 1132.6715252576826, 1143.731223162556, 1147.988520114805, 1157.571698471571, 1159.2986243322837, 932.4917919733762, 977.4086677560116, 1153.9134564907665, 1160.7620437810228, 1162.6976985983536, 6839.965800171067, 6862.965685171542, 6878.0, 6880.277570855088, 6911.75808846688, 1061.3101484035285, 1100.4332768624006, 1117.4859564600213, 1120.3222050659233, 1138.487680543742, 5115.232715092691, 5179.559737422286, 5195.090859099642, 5216.008958297912, 5216.113260745682, 7937.166597507294, 7998.240167184108, 8155.83688326242, 8187.672493100209, 8258.091609922903, 8088.595570221583, 8110.716124935717, 8148.755537333889, 8156.469829461066, 8259.463134896212, 6646.102776125258, 6648.301928297556, 6697.09589205451, 6700.262971073178, 6703.664816759143, 6537.411632953057, 6580.177477815273, 6597.934020659732, 6600.405963463311, 6610.438112760469, 7674.53952762836, 7920.564368959532, 7944.602769861368, 7982.680692772224, 8097.2307630774985, 8021.117677055403, 8186.918130818854, 8276.462029968034, 8278.751637450887, 8361.707340243061, 5541.612087153861, 5744.712764361681, 5749.8275051748515, 6042.063480160582, 6151.292601350902, 6226.346233645402, 6699.8325041872395, 6703.631300278532, 6720.663966801738, 6741.22475915276, 6125.050617154348, 6139.478144357601, 6233.314335423191, 6258.0, 6272.466840318624, 6083.695815209133, 6128.9693551531955, 6167.876642467036, 6203.503719702323, 6213.099100630293, 6300.432961033345, 6328.683565821782, 6365.7135428904885, 6489.707963141765, 6494.447971922439, 5999.0, 6008.188894499362, 6027.969860150672, 6040.275166979991, 6056.878862422639, 6038.426349496791, 6054.84862878414, 6078.179445774764, 6094.542909281733, 6097.5426842987845], "unit": "score", "name": "mootools.html", "value": 4114.968708684383}, {"lowerIsBetter": false, "replicates": [293.3970690231573, 312.44852834746666, 316.2567965281589, 316.7814208196344, 318.80712169137655, 5366.221897824813, 5372.0330340538685, 5391.110466772978, 5406.351237851453, 5424.783008679653, 5340.0, 5344.038073146832, 5358.0, 5363.892722145555, 5381.031414345416, 3941.527016757993, 4041.8585349512773, 4049.068714195737, 4050.1494686115952, 4052.615001574846, 4165.56261592533, 4170.70805043647, 4178.937315940263, 4181.184668989548, 4194.056337324108, 4124.938125928114, 4131.504219493665, 4137.524184718751, 4155.62599366057, 4160.687948403882, 3898.2593307271527, 3971.245463361952, 4154.729942553724, 4156.854510092147, 4166.041810383614, 3501.3872572299747, 3516.5604299462566, 3523.559555055618, 3524.207053412987, 3531.4173161428334, 4982.975085124551, 5025.246213068032, 5035.169197082477, 5038.697678139323, 5048.268001139814, 4689.718616882998, 4692.319613656001, 4696.624270058422, 4696.671233013691, 4697.976510117427, 5570.749316280777, 5579.107342825169, 5582.748776305076, 5583.05088135018, 5584.553235741131, 3880.20455806559, 3890.9805450972563, 3893.493845800056, 3894.3768996960353, 3894.571597124314, 5609.831705048855, 5774.855628609276, 5781.075027995501, 5841.7371218295275, 5906.438888305604, 3982.9601703983167, 4035.858744943913, 4037.051292946155, 4042.636162745367, 4047.5750046245307, 4069.5320038195396, 4073.2260870434525, 4076.6331030207425, 4078.0416602098485, 4086.2849001424634, 4531.43357080365, 4632.25883858581, 4643.721376717408, 4645.74448405341, 4659.370984917061, 5597.636153650081, 5618.269624948731, 5643.915341269884, 5666.716664166775, 5670.461306175906, 1405.2411697683137, 1413.8939579531577, 1414.589768966988, 1415.3701602786866, 1418.2908545727137, 921.6497730862229, 941.6610020392653, 943.5518128888723, 957.5738796235609, 959.0553304994575, 4690.273007683814, 4781.569658730731, 4881.023795240966, 4914.066327397783, 4926.45808961014, 5843.912341314884, 5868.383819698955, 5872.119182122716, 5875.383084776123, 5878.647910980499, 4907.779149938261, 4912.70523768575, 4919.508049195123, 4920.778564964585, 4921.630877684188, 3089.1968088296753, 3138.435081685273, 3149.527570864343, 3156.179393357698, 3169.41365847319, 5437.809676661298, 5462.945370546323, 5469.425710300441, 5470.64440811354, 5472.315960504937, 5787.594868359259, 6010.068439391901, 6035.517158627299, 6048.697565121726, 6050.788222412282, 5439.259436980128, 5460.099083651153, 5471.316085489314, 5478.260434841325, 5481.260029895913, 5867.442592953663, 5873.765049397976, 5876.44173803488, 5878.3239927408895, 5879.470847623564, 5764.798232061858, 5778.682172480386, 5796.855078623068, 5797.246357973437, 5800.332961709458, 5412.918806217831, 5435.646682965753, 5449.3460784706085, 5453.454654534674, 5453.573159943946, 3854.9421758674202, 3977.125032492847, 3980.5024371953505, 3984.7210695252215, 4024.91950161001, 5727.198192253005, 5750.884982300414, 5753.798617048383, 5759.971200143972, 5762.337331206797, 5536.501714845684, 5542.0855558833955, 5557.972210138923, 5558.082916318762, 5563.109902415594, 5546.473085057075, 5553.444655534414, 5593.636413633101, 5615.326160860723, 5622.381538030895, 5516.393196748274, 5520.66875987442, 5528.889422211453, 5536.640118392292, 5537.473939975695, 5445.646033007842, 5633.4084921082695, 5645.125005624135, 5678.943210568007, 5688.63023903445, 5487.094629386106, 5514.558835293247, 5518.475744804237, 5521.3926468089285, 5522.475364840334], "unit": "score", "name": "prototype.html", "value": 4197.579373898595}, {"lowerIsBetter": false, "replicates": [556.6465294537967, 577.1261694985847, 615.2463232540139, 646.2535771184282, 678.9321067893211, 11856.76286474271, 12050.758984820299, 12153.939230303858, 12156.331401772899, 12171.878281217185, 11779.764404711901, 13050.151740136884, 13065.80401293979, 13085.607431777038, 13102.475900963975, 788.1881661888265, 793.0483419896119, 794.566961006253, 795.5266616363255, 796.0526972902256, 806.4919100966383, 807.422692774666, 808.1998821167061, 810.0724670252557, 810.4691427115249, 851.7913111287712, 859.325429537813, 859.621766422772, 859.7420773767876, 861.5003298087125, 844.7676888855552, 845.6997765793117, 846.9153084691543, 847.2755793796277, 852.3266619370689, 622.2501885228289, 623.183629445428, 624.618982420723, 627.0061951806392, 628.915096461981, 11464.426778661116, 11543.07655387567, 11552.249103808226, 11661.12541559378, 11861.94069029658, 12124.151309408346, 12175.391230438443, 12231.0, 12280.447379867837, 12399.75200495994, 9789.559469823804, 9830.262730295184, 9979.75050623733, 9999.300048996573, 10214.28500005, 3280.6391296957318, 3303.966960330414, 3306.9007929762147, 3320.518524813913, 3371.5448414463976, 40745.38881916774, 41100.79449602763, 42011.57988420107, 42274.36588451175, 42865.0, 9333.953330233306, 9411.152996230372, 9468.526573671288, 9557.665481708107, 9593.1366177043, 15434.845651543565, 15462.226888655523, 15483.5354939352, 15487.303071361815, 15490.535283941499, 6136.539759518054, 6255.093011513305, 6392.105105285264, 6434.646094464756, 6505.902411463831, 3593.6226696196522, 3600.693941015043, 3620.728445366608, 3651.8539258429896, 3654.7258955578436, 2772.847493387883, 2777.6389069420848, 2778.902738404146, 2781.749642532182, 2784.4291920156725, 514.812093585846, 519.2626470412024, 530.9256704061435, 537.3659082282944, 539.4443722965352, 477.0649526927192, 508.27817039751596, 532.8321578702696, 557.4397730281123, 590.0117303516593, 7480.775576732707, 7585.791691751965, 7629.351505122016, 7759.495632783851, 7776.261255180749, 465.6740281802752, 539.5252178083261, 555.430683549357, 555.4972749661563, 568.769648292434, 3424.589049314048, 3462.63642317553, 3481.5299934508516, 3530.541029666127, 3624.6012938576737, 46955.0, 47626.76186619114, 47643.76178119087, 49554.25668614974, 49833.75083124561, 39795.40306895399, 40055.0, 40632.0, 40676.59323406728, 44123.0, 34798.826005870316, 39605.60394396077, 40074.198516029515, 40621.0, 41369.37945930753, 7826.921730782619, 8000.079990801132, 8116.228958248957, 8153.6738530458115, 8179.63191656365, 31144.532832007084, 31399.529007064455, 31761.841190793897, 32145.196370089998, 32211.0, 36376.45435318419, 36377.90866274016, 38888.611113888495, 40077.398839018024, 40570.0, 9682.757931051498, 9779.559919803483, 9810.607575696893, 10090.34412763168, 10205.489725513844, 10747.516361763583, 11172.329660220414, 11463.770724585629, 11677.941610292233, 11751.76496470083, 10576.312539685203, 10614.522346494272, 10650.0, 10795.29830561011, 10809.35143891369, 10033.44816035125, 10089.09198172168, 10194.74513137148, 10216.080552750289, 10455.94772026135, 10320.0, 10480.266381353233, 10484.108850747773, 10582.100521455763, 10742.140628749525, 9299.209567186865, 9412.435253884789, 9461.952690236505, 9462.810743785223, 9670.178034866834, 9328.626854925727, 9482.905170948203, 9526.285528585246, 9549.188318992963, 9602.0], "unit": "score", "name": "yui.html", "value": 5721.35341163503}], "name": "dromaeo_css", "value": 6184.1027263444175}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 107.0, 112.0, 112.0, 112.0, 102.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [160.0, 132.0, 154.0, 170.0, 133.0, 159.0, 155.0, 129.0, 172.0, 141.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 164.0, 164.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 87.0, 106.0, 75.0, 73.0, 73.0, 117.0, 98.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 137.0, 95.0, 94.0, 93.0, 139.0, 94.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 75.0, 65.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 83.0, 84.0, 83.0, 82.0, 82.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 121.0, 117.0, 125.0, 115.0, 133.0, 119.0, 119.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [145.0, 134.0, 144.0, 143.0, 145.0, 133.0, 147.0, 147.0, 141.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 66.0, 68.0, 67.0, 65.0, 66.0, 70.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1520.1000000000001}]} 02:49:01 INFO - Return code: 0 02:49:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:49:01 ERROR - # TBPL SUCCESS # 02:49:01 INFO - Running post-action listener: _resource_record_post_action 02:49:01 INFO - Running post-run listener: _resource_record_post_run 02:49:02 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 520364032; Read time: 264; Write time: 602264 02:49:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239570944; Read time: 0; Write time: 311228 02:49:02 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280793088; Read time: 264; Write time: 291036 02:49:02 INFO - Running post-run listener: _upload_blobber_files 02:49:02 INFO - Blob upload gear active. 02:49:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:49:02 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 02:49:02 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'] 02:49:02 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 02:49:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:03 INFO - (blobuploader) - INFO - Done attempting. 02:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:04 INFO - (blobuploader) - INFO - Done attempting. 02:49:04 INFO - (blobuploader) - INFO - Iteration through files over. 02:49:04 INFO - Return code: 0 02:49:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:49:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:49:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35e07609c3ffe582e9e12dcbaa966814b3ad1bed23fd38c94be0a780d33ca3c8f5c05bdbb5ce077c2beb668017e762654efd1a2bb23c0be3a2bab5f4955203c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c30bed501e3112b89496a5cc815d80dff0d53d5d760482ea9452d2bae4bb674f078c1cd586b374fc73f62aef0301caa06ba1bd673969f349cf487d13581958a"} 02:49:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:49:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:49:04 INFO - Contents: 02:49:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35e07609c3ffe582e9e12dcbaa966814b3ad1bed23fd38c94be0a780d33ca3c8f5c05bdbb5ce077c2beb668017e762654efd1a2bb23c0be3a2bab5f4955203c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c30bed501e3112b89496a5cc815d80dff0d53d5d760482ea9452d2bae4bb674f078c1cd586b374fc73f62aef0301caa06ba1bd673969f349cf487d13581958a"} 02:49:04 INFO - Running post-run listener: copy_logs_to_upload_dir 02:49:04 INFO - Copying logs to upload dir... 02:49:04 INFO - mkdir: /builds/slave/test/build/upload/logs 02:49:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.603457 ========= master_lag: 3.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-01 02:49:08.078752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 02:49:08.083070) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35e07609c3ffe582e9e12dcbaa966814b3ad1bed23fd38c94be0a780d33ca3c8f5c05bdbb5ce077c2beb668017e762654efd1a2bb23c0be3a2bab5f4955203c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c30bed501e3112b89496a5cc815d80dff0d53d5d760482ea9452d2bae4bb674f078c1cd586b374fc73f62aef0301caa06ba1bd673969f349cf487d13581958a"} build_url:https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/Rd2gIP1GQomdTNwUKkm8jQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35e07609c3ffe582e9e12dcbaa966814b3ad1bed23fd38c94be0a780d33ca3c8f5c05bdbb5ce077c2beb668017e762654efd1a2bb23c0be3a2bab5f4955203c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c30bed501e3112b89496a5cc815d80dff0d53d5d760482ea9452d2bae4bb674f078c1cd586b374fc73f62aef0301caa06ba1bd673969f349cf487d13581958a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 02:49:08.115916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:49:08.116247) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1459502877.483399-45183830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:49:08.268106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 02:49:08.269788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 02:49:08.270457) ========= ========= Total master_lag: 3.94 =========