builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1458950874.66 results: success (0) buildid: 20160325165039 builduid: 0970b2e723fa4df4a0929483891ee182 revision: 070628989f86334dfd35ae04c5f5151bdb8589a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.664346) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.664850) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.665148) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006421 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.691097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.691403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.708125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.708475) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.756766) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.757048) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.757423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.757699) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 17:07:55-- 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% 17.0M=0.001s 2016-03-25 17:07:56 (17.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.933426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.933756) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017821 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.982737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:54.983055) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 070628989f86334dfd35ae04c5f5151bdb8589a3 --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 070628989f86334dfd35ae04c5f5151bdb8589a3 --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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 17:07:56,210 truncating revision to first 12 chars 2016-03-25 17:07:56,210 Setting DEBUG logging. 2016-03-25 17:07:56,210 attempt 1/10 2016-03-25 17:07:56,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/070628989f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 17:07:56,478 unpacking tar archive at: fx-team-070628989f86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:55.561891) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:55.562221) ========= echo 070628989f86334dfd35ae04c5f5151bdb8589a3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'070628989f86334dfd35ae04c5f5151bdb8589a3'] 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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 070628989f86334dfd35ae04c5f5151bdb8589a3 program finished with exit code 0 elapsedTime=0.004290 script_repo_revision: '070628989f86334dfd35ae04c5f5151bdb8589a3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:55.612692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:55.612993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 17:07:55.623304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-25 17:07:55.623659) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:07:56 INFO - MultiFileLogger online at 20160325 17:07:56 in /builds/slave/test 17:07:56 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 17:07:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:07:56 INFO - {'append_to_log': False, 17:07:56 INFO - 'base_work_dir': '/builds/slave/test', 17:07:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:07:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:07:56 INFO - 'branch': 'Fx-Team-Non-PGO', 17:07:56 INFO - 'buildbot_json_path': 'buildprops.json', 17:07:56 INFO - 'config_files': ('talos/linux_config.py',), 17:07:56 INFO - 'default_actions': ('clobber', 17:07:56 INFO - 'read-buildbot-config', 17:07:56 INFO - 'download-and-extract', 17:07:56 INFO - 'populate-webroot', 17:07:56 INFO - 'create-virtualenv', 17:07:56 INFO - 'install', 17:07:56 INFO - 'run-tests'), 17:07:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:07:56 INFO - 'download_minidump_stackwalk': True, 17:07:56 INFO - 'download_symbols': 'ondemand', 17:07:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:07:56 INFO - 'tooltool.py': '/tools/tooltool.py', 17:07:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:07:56 INFO - '/tools/misc-python/virtualenv.py')}, 17:07:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:07:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:07:56 INFO - 'installer_path': 'installer.exe', 17:07:56 INFO - 'log_level': 'info', 17:07:56 INFO - 'log_name': 'talos', 17:07:56 INFO - 'log_to_console': True, 17:07:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:07:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:07:56 INFO - 'opt_config_files': (), 17:07:56 INFO - 'pip_index': False, 17:07:56 INFO - 'sps_profile': False, 17:07:56 INFO - 'sps_profile_interval': 0, 17:07:56 INFO - 'suite': 'dromaeojs', 17:07:56 INFO - 'system_bits': '32', 17:07:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:07:56 INFO - 'title': 'talos-linux64-ix-005', 17:07:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:07:56 INFO - 'use_talos_json': True, 17:07:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:07:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:07:56 INFO - 'work_dir': 'build'} 17:07:56 INFO - ##### 17:07:56 INFO - ##### Running clobber step. 17:07:56 INFO - ##### 17:07:56 INFO - Running pre-action listener: _resource_record_pre_action 17:07:56 INFO - Running main action method: clobber 17:07:56 INFO - rmtree: /builds/slave/test/build 17:07:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:07:57 INFO - Running post-action listener: _resource_record_post_action 17:07:57 INFO - ##### 17:07:57 INFO - ##### Running read-buildbot-config step. 17:07:57 INFO - ##### 17:07:57 INFO - Running pre-action listener: _resource_record_pre_action 17:07:57 INFO - Running main action method: read_buildbot_config 17:07:57 INFO - Using buildbot properties: 17:07:57 INFO - { 17:07:57 INFO - "project": "", 17:07:57 INFO - "product": "firefox", 17:07:57 INFO - "script_repo_revision": "production", 17:07:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:07:57 INFO - "repository": "", 17:07:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:07:57 INFO - "buildid": "20160325165039", 17:07:57 INFO - "pgo_build": "False", 17:07:57 INFO - "basedir": "/builds/slave/test", 17:07:57 INFO - "buildnumber": 1507, 17:07:57 INFO - "slavename": "talos-linux64-ix-005", 17:07:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:07:57 INFO - "platform": "ubuntu64_hw", 17:07:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:07:57 INFO - "branch": "fx-team", 17:07:57 INFO - "repo_path": "integration/fx-team", 17:07:57 INFO - "revision": "070628989f86334dfd35ae04c5f5151bdb8589a3", 17:07:57 INFO - "stage_platform": "linux64", 17:07:57 INFO - "builduid": "0970b2e723fa4df4a0929483891ee182", 17:07:57 INFO - "slavebuilddir": "test" 17:07:57 INFO - } 17:07:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:07:57 INFO - Running post-action listener: _resource_record_post_action 17:07:57 INFO - ##### 17:07:57 INFO - ##### Running download-and-extract step. 17:07:57 INFO - ##### 17:07:57 INFO - Running pre-action listener: _resource_record_pre_action 17:07:57 INFO - Running main action method: download_and_extract 17:07:57 INFO - mkdir: /builds/slave/test/build/tests 17:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:57 INFO - https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:07:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:07:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:07:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:05 INFO - Downloaded 1361 bytes. 17:08:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:05 INFO - Using the following test package requirements: 17:08:05 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:08:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'jsshell-linux-x86_64.zip'], 17:08:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:05 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:05 INFO - https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:07 INFO - Downloaded 22085846 bytes. 17:08:07 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'] 17:08:07 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 17:08:08 INFO - Return code: 0 17:08:08 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 17:08:08 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')]} 17:08:08 INFO - https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:12 INFO - Downloaded 22085846 bytes. 17:08:12 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'] 17:08:12 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 17:08:14 INFO - Return code: 0 17:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:14 INFO - https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:15 INFO - Downloaded 10847531 bytes. 17:08:15 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'] 17:08:15 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 17:08:15 INFO - Return code: 0 17:08: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')]} 17:08:15 INFO - https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YELyz3QCTfiXwkzP3zmvDA/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 17:08:16 INFO - Downloaded 54260364 bytes. 17:08:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:16 INFO - mkdir: /builds/slave/test/properties 17:08:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:16 INFO - Contents: 17:08:16 INFO - build_url:https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:17 INFO - Running post-action listener: _resource_record_post_action 17:08:18 INFO - Running post-action listener: set_extra_try_arguments 17:08:18 INFO - ##### 17:08:18 INFO - ##### Running populate-webroot step. 17:08:18 INFO - ##### 17:08:18 INFO - Running pre-action listener: _resource_record_pre_action 17:08:18 INFO - Running main action method: populate_webroot 17:08:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:18 INFO - '--tppagecycles', 17:08:18 INFO - '7'], 17:08:18 INFO - 'tests': ['tsvgm']}}, 17:08:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:08:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:08:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'tests': ['damp', 'tps']}, 17:08:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['damp', 'tps']}, 17:08:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:08:18 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['dromaeo_dom']}, 17:08:18 INFO - 'other': {'tests': ['a11yr', 17:08:18 INFO - 'ts_paint', 17:08:18 INFO - 'tpaint', 17:08:18 INFO - 'sessionrestore', 17:08:18 INFO - 'sessionrestore_no_auto_restore', 17:08:18 INFO - 'tabpaint']}, 17:08:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['a11yr', 17:08:18 INFO - 'ts_paint', 17:08:18 INFO - 'tpaint', 17:08:18 INFO - 'sessionrestore', 17:08:18 INFO - 'sessionrestore_no_auto_restore', 17:08:18 INFO - 'tabpaint']}, 17:08:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['a11yr', 17:08:18 INFO - 'ts_paint', 17:08:18 INFO - 'tpaint', 17:08:18 INFO - 'sessionrestore', 17:08:18 INFO - 'sessionrestore_no_auto_restore', 17:08:18 INFO - 'tabpaint']}, 17:08:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['a11yr', 17:08:18 INFO - 'ts_paint', 17:08:18 INFO - 'tpaint', 17:08:18 INFO - 'sessionrestore', 17:08:18 INFO - 'sessionrestore_no_auto_restore', 17:08:18 INFO - 'tabpaint']}, 17:08:18 INFO - 'other_l64': {'tests': ['a11yr', 17:08:18 INFO - 'ts_paint', 17:08:18 INFO - 'tpaint', 17:08:18 INFO - 'sessionrestore', 17:08:18 INFO - 'sessionrestore_no_auto_restore', 17:08:18 INFO - 'tabpaint']}, 17:08:18 INFO - 'other_nol64': {'tests': ['a11yr', 17:08:18 INFO - 'ts_paint', 17:08:18 INFO - 'tpaint', 17:08:18 INFO - 'sessionrestore', 17:08:18 INFO - 'sessionrestore_no_auto_restore', 17:08:18 INFO - 'tabpaint']}, 17:08:18 INFO - 'svgr': {'tests': ['tsvgx', 17:08:18 INFO - 'tsvgr_opacity', 17:08:18 INFO - 'tart', 17:08:18 INFO - 'tscrollx', 17:08:18 INFO - 'cart']}, 17:08:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['tsvgx', 17:08:18 INFO - 'tsvgr_opacity', 17:08:18 INFO - 'tart', 17:08:18 INFO - 'tscrollx', 17:08:18 INFO - 'cart']}, 17:08:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'tests': ['tp5o']}, 17:08:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'talos_options': ['--e10s'], 17:08:18 INFO - 'tests': ['tp5o']}, 17:08:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'talos_options': ['--xperf_path', 17:08:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:18 INFO - 'tests': ['tp5n']}, 17:08:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:18 INFO - 'talos_options': ['--e10s', 17:08:18 INFO - '--xperf_path', 17:08:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:18 INFO - 'tests': ['tp5n']}}, 17:08:18 INFO - 'talos.zip': {'path': '', 17:08:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:18 INFO - Running post-action listener: _resource_record_post_action 17:08:18 INFO - ##### 17:08:18 INFO - ##### Running create-virtualenv step. 17:08:18 INFO - ##### 17:08:18 INFO - Running pre-action listener: _resource_record_pre_action 17:08:18 INFO - Running main action method: create_virtualenv 17:08:18 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:18 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 17:08:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:18 INFO - Using real prefix '/usr' 17:08:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:18 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:20 INFO - Installing pip.................done. 17:08:20 INFO - Return code: 0 17:08:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:20 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')]} 17:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:20 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')]} 17:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:20 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:20 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 17:08:20 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 17:08:20 INFO - Using env: {'DISPLAY': ':0', 17:08:20 INFO - 'HOME': '/home/cltbld', 17:08:20 INFO - 'LANG': 'en_US.UTF-8', 17:08:20 INFO - 'LANGUAGE': 'en_US:en', 17:08:20 INFO - 'LOGNAME': 'cltbld', 17:08:20 INFO - 'MAIL': '/var/mail/cltbld', 17:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:20 INFO - 'MOZ_NO_REMOTE': '1', 17:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:20 INFO - 'NO_EM_RESTART': '1', 17:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:20 INFO - 'PWD': '/builds/slave/test', 17:08:20 INFO - 'SHELL': '/bin/bash', 17:08:20 INFO - 'SHLVL': '1', 17:08:20 INFO - 'TERM': 'linux', 17:08:20 INFO - 'TMOUT': '86400', 17:08:20 INFO - 'USER': 'cltbld', 17:08:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:20 INFO - '_': '/tools/buildbot/bin/python'} 17:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:20 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 17:08:20 INFO - Cleaning up... 17:08:20 INFO - Return code: 0 17:08:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08:20 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')]} 17:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:20 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')]} 17:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:20 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:20 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 17:08:20 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 17:08:20 INFO - Using env: {'DISPLAY': ':0', 17:08:20 INFO - 'HOME': '/home/cltbld', 17:08:20 INFO - 'LANG': 'en_US.UTF-8', 17:08:20 INFO - 'LANGUAGE': 'en_US:en', 17:08:20 INFO - 'LOGNAME': 'cltbld', 17:08:20 INFO - 'MAIL': '/var/mail/cltbld', 17:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:20 INFO - 'MOZ_NO_REMOTE': '1', 17:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:20 INFO - 'NO_EM_RESTART': '1', 17:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:20 INFO - 'PWD': '/builds/slave/test', 17:08:20 INFO - 'SHELL': '/bin/bash', 17:08:20 INFO - 'SHLVL': '1', 17:08:20 INFO - 'TERM': 'linux', 17:08:20 INFO - 'TMOUT': '86400', 17:08:20 INFO - 'USER': 'cltbld', 17:08:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:20 INFO - '_': '/tools/buildbot/bin/python'} 17:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:21 INFO - Downloading/unpacking psutil>=0.7.1 17:08:21 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 17:08:21 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 17:08:21 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 17:08:21 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 17:08:21 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 17:08:21 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 17:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:23 INFO - Installing collected packages: psutil 17:08:23 INFO - Running setup.py install for psutil 17:08:23 INFO - building 'psutil._psutil_linux' extension 17:08:23 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 17:08:23 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 17:08:23 INFO - building 'psutil._psutil_posix' extension 17:08:23 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 17:08:23 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 17:08:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:23 INFO - Successfully installed psutil 17:08:23 INFO - Cleaning up... 17:08:23 INFO - Return code: 0 17:08:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:23 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:23 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 17:08:23 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 17:08:23 INFO - Using env: {'DISPLAY': ':0', 17:08:23 INFO - 'HOME': '/home/cltbld', 17:08:23 INFO - 'LANG': 'en_US.UTF-8', 17:08:23 INFO - 'LANGUAGE': 'en_US:en', 17:08:23 INFO - 'LOGNAME': 'cltbld', 17:08:23 INFO - 'MAIL': '/var/mail/cltbld', 17:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:23 INFO - 'MOZ_NO_REMOTE': '1', 17:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:23 INFO - 'NO_EM_RESTART': '1', 17:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:23 INFO - 'PWD': '/builds/slave/test', 17:08:23 INFO - 'SHELL': '/bin/bash', 17:08:23 INFO - 'SHLVL': '1', 17:08:23 INFO - 'TERM': 'linux', 17:08:23 INFO - 'TMOUT': '86400', 17:08:23 INFO - 'USER': 'cltbld', 17:08:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:23 INFO - '_': '/tools/buildbot/bin/python'} 17:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08:23 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 17:08:23 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 17:08:23 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 17:08:23 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 17:08:23 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 17:08:23 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 17:08:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:08:25 INFO - Installing collected packages: mozsystemmonitor 17:08:25 INFO - Running setup.py install for mozsystemmonitor 17:08:25 INFO - Successfully installed mozsystemmonitor 17:08:25 INFO - Cleaning up... 17:08:25 INFO - Return code: 0 17:08:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:25 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:25 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 17:08:25 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 17:08:25 INFO - Using env: {'DISPLAY': ':0', 17:08:25 INFO - 'HOME': '/home/cltbld', 17:08:25 INFO - 'LANG': 'en_US.UTF-8', 17:08:25 INFO - 'LANGUAGE': 'en_US:en', 17:08:25 INFO - 'LOGNAME': 'cltbld', 17:08:25 INFO - 'MAIL': '/var/mail/cltbld', 17:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:25 INFO - 'MOZ_NO_REMOTE': '1', 17:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:25 INFO - 'NO_EM_RESTART': '1', 17:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:25 INFO - 'PWD': '/builds/slave/test', 17:08:25 INFO - 'SHELL': '/bin/bash', 17:08:25 INFO - 'SHLVL': '1', 17:08:25 INFO - 'TERM': 'linux', 17:08:25 INFO - 'TMOUT': '86400', 17:08:25 INFO - 'USER': 'cltbld', 17:08:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:25 INFO - '_': '/tools/buildbot/bin/python'} 17:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:26 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:26 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 17:08:26 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 17:08:26 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 17:08:26 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 17:08:26 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 17:08:26 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 17:08:27 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 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 17:08:28 INFO - Downloading docopt-0.6.1.tar.gz 17:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:28 INFO - Running setup.py install for blobuploader 17:08:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:28 INFO - Running setup.py install for requests 17:08:29 INFO - Running setup.py install for docopt 17:08:29 INFO - Successfully installed blobuploader requests docopt 17:08:29 INFO - Cleaning up... 17:08:29 INFO - Return code: 0 17:08:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:29 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:29 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 17:08:29 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 17:08:29 INFO - Using env: {'DISPLAY': ':0', 17:08:29 INFO - 'HOME': '/home/cltbld', 17:08:29 INFO - 'LANG': 'en_US.UTF-8', 17:08:29 INFO - 'LANGUAGE': 'en_US:en', 17:08:29 INFO - 'LOGNAME': 'cltbld', 17:08:29 INFO - 'MAIL': '/var/mail/cltbld', 17:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:29 INFO - 'MOZ_NO_REMOTE': '1', 17:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:29 INFO - 'NO_EM_RESTART': '1', 17:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:29 INFO - 'PWD': '/builds/slave/test', 17:08:29 INFO - 'SHELL': '/bin/bash', 17:08:29 INFO - 'SHLVL': '1', 17:08:29 INFO - 'TERM': 'linux', 17:08:29 INFO - 'TMOUT': '86400', 17:08:29 INFO - 'USER': 'cltbld', 17:08:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:29 INFO - '_': '/tools/buildbot/bin/python'} 17:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:29 INFO - Running setup.py (path:/tmp/pip-y_gsMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:29 INFO - Running setup.py (path:/tmp/pip-MeREFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:29 INFO - Running setup.py (path:/tmp/pip-iHb2ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:29 INFO - Running setup.py (path:/tmp/pip-YN54XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:29 INFO - Running setup.py (path:/tmp/pip-Ah3p9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:29 INFO - Running setup.py (path:/tmp/pip-7r3jBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:29 INFO - Running setup.py (path:/tmp/pip-YJx4e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:30 INFO - Running setup.py (path:/tmp/pip-qYJdyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:30 INFO - Running setup.py (path:/tmp/pip-aIstHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:30 INFO - Running setup.py (path:/tmp/pip-VuAA0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:30 INFO - Running setup.py (path:/tmp/pip-XcHt3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:30 INFO - Running setup.py (path:/tmp/pip-FKeNYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:30 INFO - Running setup.py (path:/tmp/pip-fbTS84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:30 INFO - Running setup.py (path:/tmp/pip-tigKdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:30 INFO - Running setup.py (path:/tmp/pip-mqo6FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:30 INFO - Running setup.py (path:/tmp/pip-XyLlm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:30 INFO - Running setup.py (path:/tmp/pip-cm08Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:30 INFO - Running setup.py install for manifestparser 17:08:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:30 INFO - Running setup.py install for mozcrash 17:08:30 INFO - Running setup.py install for mozdebug 17:08:31 INFO - Running setup.py install for mozdevice 17:08:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Running setup.py install for mozfile 17:08:31 INFO - Running setup.py install for mozhttpd 17:08:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Running setup.py install for mozinfo 17:08:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Running setup.py install for mozInstall 17:08:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Running setup.py install for mozleak 17:08:31 INFO - Running setup.py install for mozlog 17:08:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Running setup.py install for moznetwork 17:08:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:31 INFO - Running setup.py install for mozprocess 17:08:31 INFO - Running setup.py install for mozprofile 17:08:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:32 INFO - Running setup.py install for mozrunner 17:08:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:32 INFO - Running setup.py install for mozscreenshot 17:08:32 INFO - Running setup.py install for moztest 17:08:32 INFO - Running setup.py install for mozversion 17:08:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:32 INFO - Cleaning up... 17:08:32 INFO - Return code: 0 17:08:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:32 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:32 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 17:08:32 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 17:08:32 INFO - Using env: {'DISPLAY': ':0', 17:08:32 INFO - 'HOME': '/home/cltbld', 17:08:32 INFO - 'LANG': 'en_US.UTF-8', 17:08:32 INFO - 'LANGUAGE': 'en_US:en', 17:08:32 INFO - 'LOGNAME': 'cltbld', 17:08:32 INFO - 'MAIL': '/var/mail/cltbld', 17:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:32 INFO - 'MOZ_NO_REMOTE': '1', 17:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:32 INFO - 'NO_EM_RESTART': '1', 17:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:32 INFO - 'PWD': '/builds/slave/test', 17:08:32 INFO - 'SHELL': '/bin/bash', 17:08:32 INFO - 'SHLVL': '1', 17:08:32 INFO - 'TERM': 'linux', 17:08:32 INFO - 'TMOUT': '86400', 17:08:32 INFO - 'USER': 'cltbld', 17:08:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:32 INFO - '_': '/tools/buildbot/bin/python'} 17:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:32 INFO - Running setup.py (path:/tmp/pip-xNs5Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:32 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)) 17:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:32 INFO - Running setup.py (path:/tmp/pip-gZNfB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:32 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)) 17:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:32 INFO - Running setup.py (path:/tmp/pip-K3pJUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:32 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)) 17:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:32 INFO - Running setup.py (path:/tmp/pip-1njq47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:33 INFO - Running setup.py (path:/tmp/pip-sC_lQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:33 INFO - Running setup.py (path:/tmp/pip-y7vgPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:33 INFO - Running setup.py (path:/tmp/pip-g6pXnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:33 INFO - Running setup.py (path:/tmp/pip-UVTZGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:33 INFO - Running setup.py (path:/tmp/pip-TyNjn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:33 INFO - Running setup.py (path:/tmp/pip-oijdI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:33 INFO - Running setup.py (path:/tmp/pip-5ILum9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:33 INFO - Running setup.py (path:/tmp/pip-LbeTK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:33 INFO - Running setup.py (path:/tmp/pip-zRjN1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:33 INFO - Running setup.py (path:/tmp/pip-crIcHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:33 INFO - Running setup.py (path:/tmp/pip-Qk5ms6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:33 INFO - Running setup.py (path:/tmp/pip-30rFNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:33 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)) 17:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:33 INFO - Running setup.py (path:/tmp/pip-KepctO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:33 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)) 17:08:33 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)) 17:08:33 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)) 17:08:33 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)) 17:08:33 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)) 17:08:33 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)) 17:08:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:33 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 17:08:33 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 17:08:33 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 17:08:33 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 17:08:33 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 17:08:33 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 17:08:35 INFO - Downloading blessings-1.6.tar.gz 17:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:36 INFO - Installing collected packages: blessings 17:08:36 INFO - Running setup.py install for blessings 17:08:36 INFO - Successfully installed blessings 17:08:36 INFO - Cleaning up... 17:08:36 INFO - Return code: 0 17:08:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:36 INFO - Reading from file tmpfile_stdout 17:08:36 INFO - Current package versions: 17:08:36 INFO - argparse == 1.2.1 17:08:36 INFO - blessings == 1.6 17:08:36 INFO - blobuploader == 1.2.4 17:08:36 INFO - docopt == 0.6.1 17:08:36 INFO - manifestparser == 1.1 17:08:36 INFO - mozInstall == 1.12 17:08:36 INFO - mozcrash == 0.17 17:08:36 INFO - mozdebug == 0.1 17:08:36 INFO - mozdevice == 0.48 17:08:36 INFO - mozfile == 1.2 17:08:36 INFO - mozhttpd == 0.7 17:08:36 INFO - mozinfo == 0.9 17:08:36 INFO - mozleak == 0.1 17:08:36 INFO - mozlog == 3.1 17:08:36 INFO - moznetwork == 0.27 17:08:36 INFO - mozprocess == 0.22 17:08:36 INFO - mozprofile == 0.28 17:08:36 INFO - mozrunner == 6.11 17:08:36 INFO - mozscreenshot == 0.1 17:08:36 INFO - mozsystemmonitor == 0.0 17:08:36 INFO - moztest == 0.7 17:08:36 INFO - mozversion == 1.4 17:08:36 INFO - psutil == 3.1.1 17:08:36 INFO - requests == 1.2.3 17:08:36 INFO - wsgiref == 0.1.2 17:08:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:36 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:36 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 17:08:36 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 17:08:36 INFO - Using env: {'DISPLAY': ':0', 17:08:36 INFO - 'HOME': '/home/cltbld', 17:08:36 INFO - 'LANG': 'en_US.UTF-8', 17:08:36 INFO - 'LANGUAGE': 'en_US:en', 17:08:36 INFO - 'LOGNAME': 'cltbld', 17:08:36 INFO - 'MAIL': '/var/mail/cltbld', 17:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:36 INFO - 'MOZ_NO_REMOTE': '1', 17:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:36 INFO - 'NO_EM_RESTART': '1', 17:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:36 INFO - 'PWD': '/builds/slave/test', 17:08:36 INFO - 'SHELL': '/bin/bash', 17:08:36 INFO - 'SHLVL': '1', 17:08:36 INFO - 'TERM': 'linux', 17:08:36 INFO - 'TMOUT': '86400', 17:08:36 INFO - 'USER': 'cltbld', 17:08:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:36 INFO - '_': '/tools/buildbot/bin/python'} 17:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 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)) 17:08:36 INFO - Cleaning up... 17:08:36 INFO - Return code: 0 17:08:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:36 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 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:36 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 17:08:36 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 17:08:36 INFO - Using env: {'DISPLAY': ':0', 17:08:36 INFO - 'HOME': '/home/cltbld', 17:08:36 INFO - 'LANG': 'en_US.UTF-8', 17:08:36 INFO - 'LANGUAGE': 'en_US:en', 17:08:36 INFO - 'LOGNAME': 'cltbld', 17:08:36 INFO - 'MAIL': '/var/mail/cltbld', 17:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:36 INFO - 'MOZ_NO_REMOTE': '1', 17:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:36 INFO - 'NO_EM_RESTART': '1', 17:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:36 INFO - 'PWD': '/builds/slave/test', 17:08:36 INFO - 'SHELL': '/bin/bash', 17:08:36 INFO - 'SHLVL': '1', 17:08:36 INFO - 'TERM': 'linux', 17:08:36 INFO - 'TMOUT': '86400', 17:08:36 INFO - 'USER': 'cltbld', 17:08:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:36 INFO - '_': '/tools/buildbot/bin/python'} 17:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:36 INFO - Downloading/unpacking jsonschema 17:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:38 INFO - Downloading/unpacking functools32 (from jsonschema) 17:08:38 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 17:08:38 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 17:08:38 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 17:08:38 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 17:08:38 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 17:08:38 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 17:08:39 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:39 INFO - warning: no files found matching '*.txt' 17:08:39 INFO - no previously-included directories found matching 'build' 17:08:39 INFO - no previously-included directories found matching 'dist' 17:08:39 INFO - no previously-included directories found matching '.git*' 17:08:39 INFO - Installing collected packages: jsonschema, functools32 17:08:39 INFO - Running setup.py install for functools32 17:08:39 INFO - warning: no files found matching '*.txt' 17:08:39 INFO - no previously-included directories found matching 'build' 17:08:39 INFO - no previously-included directories found matching 'dist' 17:08:39 INFO - no previously-included directories found matching '.git*' 17:08:39 INFO - Successfully installed jsonschema functools32 17:08:39 INFO - Cleaning up... 17:08:39 INFO - Return code: 0 17:08:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c213df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', '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 17:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:08:39 INFO - Using env: {'DISPLAY': ':0', 17:08:39 INFO - 'HOME': '/home/cltbld', 17:08:39 INFO - 'LANG': 'en_US.UTF-8', 17:08:39 INFO - 'LANGUAGE': 'en_US:en', 17:08:39 INFO - 'LOGNAME': 'cltbld', 17:08:39 INFO - 'MAIL': '/var/mail/cltbld', 17:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:39 INFO - 'MOZ_NO_REMOTE': '1', 17:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:39 INFO - 'NO_EM_RESTART': '1', 17:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:39 INFO - 'PWD': '/builds/slave/test', 17:08:39 INFO - 'SHELL': '/bin/bash', 17:08:39 INFO - 'SHLVL': '1', 17:08:39 INFO - 'TERM': 'linux', 17:08:39 INFO - 'TMOUT': '86400', 17:08:39 INFO - 'USER': 'cltbld', 17:08:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:39 INFO - '_': '/tools/buildbot/bin/python'} 17:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:39 INFO - Downloading/unpacking flake8 17:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:08:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:08:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:42 INFO - no previously-included directories found matching 'docs/_build' 17:08:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:08:42 INFO - Running setup.py install for pep8 17:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:42 INFO - no previously-included directories found matching 'docs/_build' 17:08:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:08:42 INFO - Cleaning up... 17:08:42 INFO - Return code: 0 17:08:42 INFO - Running post-action listener: _resource_record_post_action 17:08:42 INFO - Running post-action listener: _start_resource_monitoring 17:08:42 INFO - Starting resource monitoring. 17:08:42 INFO - ##### 17:08:42 INFO - ##### Running install step. 17:08:42 INFO - ##### 17:08:42 INFO - Running pre-action listener: _resource_record_pre_action 17:08:42 INFO - Running main action method: install 17:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:43 INFO - Reading from file tmpfile_stdout 17:08:43 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:43 INFO - Reading from file tmpfile_stdout 17:08:43 INFO - Output received: 17:08:43 INFO - Usage: mozinstall [options] installer 17:08:43 INFO - Options: 17:08:43 INFO - -h, --help show this help message and exit 17:08:43 INFO - -d DEST, --destination=DEST 17:08:43 INFO - Directory to install application into. [default: 17:08:43 INFO - "/builds/slave/test"] 17:08:43 INFO - --app=APP Application being installed. [default: firefox] 17:08:43 INFO - mkdir: /builds/slave/test/build/application 17:08:43 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'] 17:08:43 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 17:08:58 INFO - Reading from file tmpfile_stdout 17:08:58 INFO - Output received: 17:08:58 INFO - /builds/slave/test/build/application/firefox/firefox 17:08:58 INFO - Running post-action listener: _resource_record_post_action 17:08:58 INFO - ##### 17:08:58 INFO - ##### Running run-tests step. 17:08:58 INFO - ##### 17:08:58 INFO - Running pre-action listener: _resource_record_pre_action 17:08:58 INFO - Running main action method: run_tests 17:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:08:58 INFO - Python 2.7.3 17:08:58 INFO - Return code: 0 17:08:58 INFO - grabbing minidump binary from tooltool 17:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:58 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 0x2852410>, '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 0x2853310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28537a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:08:58 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 17:08:58 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 17:08:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:08:58 INFO - Return code: 0 17:08:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:08:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:08:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:08:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:08:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:08:59 INFO - Return code: 0 17:08:59 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/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 17:08:59 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/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 17:08:59 INFO - Using env: {'DISPLAY': ':0', 17:08:59 INFO - 'HOME': '/home/cltbld', 17:08:59 INFO - 'LANG': 'en_US.UTF-8', 17:08:59 INFO - 'LANGUAGE': 'en_US:en', 17:08:59 INFO - 'LOGNAME': 'cltbld', 17:08:59 INFO - 'MAIL': '/var/mail/cltbld', 17:08:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:08:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:59 INFO - 'MOZ_NO_REMOTE': '1', 17:08:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:59 INFO - 'NO_EM_RESTART': '1', 17:08:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:59 INFO - 'PWD': '/builds/slave/test', 17:08:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:08:59 INFO - 'SHELL': '/bin/bash', 17:08:59 INFO - 'SHLVL': '1', 17:08:59 INFO - 'TERM': 'linux', 17:08:59 INFO - 'TMOUT': '86400', 17:08:59 INFO - 'USER': 'cltbld', 17:08:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665', 17:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:59 INFO - '_': '/tools/buildbot/bin/python'} 17:08:59 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/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 17:09:00 INFO - mozversion application_buildid: 20160325165039 17:09:00 INFO - mozversion application_changeset: 070628989f86334dfd35ae04c5f5151bdb8589a3 17:09:00 INFO - mozversion application_display_name: Nightly 17:09:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:00 INFO - mozversion application_name: Firefox 17:09:00 INFO - mozversion application_remotingname: firefox 17:09:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:00 INFO - mozversion application_vendor: Mozilla 17:09:00 INFO - mozversion application_version: 48.0a1 17:09:00 INFO - mozversion platform_buildid: 20160325165039 17:09:00 INFO - mozversion platform_changeset: 070628989f86334dfd35ae04c5f5151bdb8589a3 17:09:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:00 INFO - mozversion platform_version: 48.0a1 17:09:00 INFO - using testdate: 1458950940 17:09:00 INFO - actual date: 1458950940 17:09:00 INFO - starting webserver on 'localhost:41042' 17:09:00 INFO - SUITE-START | Running 2 tests 17:09:00 INFO - TEST-START | dromaeo_css 17:09:00 INFO - operating with platform_type : linux_ 17:09:00 INFO - Initialising browser for dromaeo_css test... 17:09:00 INFO - TEST-INFO | started process 15056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6lIqD/profile http://localhost:41042/getInfo.html) 17:09:04 INFO - PROCESS | 15056 | __metrics Screen width/height:1600/1200 17:09:04 INFO - PROCESS | 15056 | colorDepth:24 17:09:04 INFO - PROCESS | 15056 | Browser inner width/height: 1024/697 17:09:04 INFO - PROCESS | 15056 | __metrics 17:09:05 ERROR - PROCESS | 15056 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:09:05 INFO - PROCESS | 15056 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:09:06 INFO - TEST-INFO | 15056: exit 0 17:09:06 INFO - Browser initialized. 17:09:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:06 INFO - TEST-INFO | started process 15151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6lIqD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:18 INFO - PROCESS | 15151 | RSS: Main: 155054080 17:09:18 INFO - PROCESS | 15151 | 17:10:09 INFO - PROCESS | 15151 | 1458951009458 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] 17:12:20 INFO - PROCESS | 15151 | Cycle 1(1): loaded http://localhost:41042/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41042/tests/dromaeo/cssquery-ext.html) 17:12:21 INFO - PROCESS | 15151 | RSS: Main: 232333312 17:12:21 INFO - PROCESS | 15151 | 17:15:24 INFO - PROCESS | 15151 | Cycle 1(1): loaded http://localhost:41042/tests/dromaeo/cssquery-ext.html (next: http://localhost:41042/tests/dromaeo/cssquery-jquery.html) 17:15:24 INFO - PROCESS | 15151 | RSS: Main: 241532928 17:15:24 INFO - PROCESS | 15151 | 17:18:26 INFO - PROCESS | 15151 | Cycle 1(1): loaded http://localhost:41042/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41042/tests/dromaeo/cssquery-mootools.html) 17:18:27 INFO - PROCESS | 15151 | RSS: Main: 244690944 17:18:27 INFO - PROCESS | 15151 | 17:21:29 INFO - PROCESS | 15151 | Cycle 1(1): loaded http://localhost:41042/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41042/tests/dromaeo/cssquery-prototype.html) 17:21:29 INFO - PROCESS | 15151 | RSS: Main: 212533248 17:21:29 INFO - PROCESS | 15151 | 17:24:32 INFO - PROCESS | 15151 | Cycle 1(1): loaded http://localhost:41042/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41042/tests/dromaeo/cssquery-yui.html) 17:24:33 INFO - PROCESS | 15151 | RSS: Main: 203702272 17:24:33 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | Cycle 1(1): loaded http://localhost:41042/tests/dromaeo/cssquery-yui.html (next: http://localhost:41042/tests/dromaeo/cssquery-dojo.html) 17:27:35 INFO - PROCESS | 15151 | RSS: Main: 269647872 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | __start_tp_report 17:27:35 INFO - PROCESS | 15151 | _x_x_mozilla_page_load 17:27:35 INFO - PROCESS | 15151 | _x_x_mozilla_page_load_details 17:27:35 INFO - PROCESS | 15151 | |i|pagename|runs| 17:27:35 INFO - PROCESS | 15151 | |0;dojo.html;2638.9472210555787;2711.783057355412;2733.111738684928;2740.438210166917;2765.115163147793;4592.989542300688;4709.128811169936;4722.7874745636445;4724.905501889964;4735.218688916329;4663.743494107823;4675.906481870361;4701.694389864657;4755.643326750499;4760;4262.381954616579;4294.441722576069;4310.310350343945;4370.934435983463;4448.110377924412;4359.607635312821;4395.120975804852;4410.2723050696595;4421.624161946223;4448.421705178323;4244.469441319835;4288.678349123828;4322.200392927302;4339.435873336478;4354.238008348558;4312.978435107836;4318.179545886303;4356.6514678825615;4356.673249506268;4373.365861949999;4262.296721041055;4271.572842715735;4290.356446533014;4301.870943871689;4333.025069359401;4488.349189367556;4529.954700452986;4568.177728008957;4613.238815595423;4645.5586719261955;4943.530364615356;4945.381827271591;4948.035133149037;4952.727599981999;4976.079425306294;4952.777125029383;4966.528179822911;4967.925481117786;4989.65072444929;5007.273945277914;4544.545545445462;4614.215583350839;4644.628429725613;4650.930236046462;4694.554017368345;5140.228965655107;5152.02111598795;5157.871053223625;5166.328377310925;5190.740462976836;4947.431045429822;4955.975220123948;4961.70229786214;4964.975175124174;5013;4859.781309841065;4886.413630364308;4891.828785992473;4956.330895329156;4967.975160124176;4893.584045356185;4929;4929.186684197139;4934.8649810543775;4980.12847751642;4792.904141917142;4926.916078462733;4927;4930.211166213388;4979.4771548987555;4248.681348898845;4280.507741609755;4283.464566929134;4320.524742278347;4326.372675961968;3696.9260614787554;3705.888823335304;3712.925741485209;3717.5167228260693;3727.918903518004;4252.234597772369;4310.741355518679;4315.331123675835;4325.6106950374615;4347.869563913087;4950.059488697208;4978.4025916890205;4983.277424773388;5033.47148549397;5036.974815125975;4317.7193482423545;4336.479622445264;4339.153864996296;4362.781860906942;4388.407564978687;4423.734575925455;4492.9550704493195;4533.274676051816;4533.455985281787;4534.206513860061;4718.952810471851;4735.17134501454;4741.83403580873;4746.762661866893;4789.377380940456;4999.300097986212;5006.424261210008;5007.574356179765;5008.874778130576;5055;4645.2103142465185;4689.788959496899;4729.8108075677965;4790.257510085942;4802.447718512416;4959.3552838132255;4978.377702787152;4978.850634480971;4988.27669987857;5004;5032.6980381177245;5035.0685123252315;5042.495750424928;5044.798208071636;5077.92383114261;4744.359511465908;4852.902941941071;4902.779374928065;4932.605391568738;4936.827211047596;4861.586765125004;4862.197737373435;4878.536539028929;4884.12085824555;4922.433920099091;4812.35033270518;4823.975880120717;4826.1795494766675;4841.75791210431;4887.853364399074;4793.640476964172;4906.116898958222;4942.851714448572;4959.479254678206;4991.675541089818;4785.665003449725;4799.9760001199775;4817.879553011063;4824.204006338915;4885.951140488692 17:27:35 INFO - PROCESS | 15151 | |1;ext.html;522.7856578802689;531.9148936170212;538.036913924076;544.741247907244;566.3373852592466;26002.60996085058;26416.471670566578;34318.82840585794;34873.3025339493;34875.651243487555;37635.553689010194;38015.80992095043;38027.429588556195;38087.80956095223;38107.80946095266;7516.736914207991;7721.22787721229;7729.497582657137;7732.922670773305;7744.341730952876;7536.397088232929;7628.8855667165035;7630.809229769245;7662.195469475709;7672.9232707673045;7760.883586746203;7765.495242809227;7804.492707973992;7871.252231038042;7875.645595948167;7708.498947568418;7802.492837965542;7816.531008139473;7846.646900889474;7856.528608283521;7768.456208065438;7888.053433587948;7890.526568405857;7899.091604465502;7903.249191326815;35711.28577428437;35828.46257306143;36182.63817361819;36189.095272618135;36271.818640906626;3099.5040793473163;3180.3957248122783;3198.98400507996;3638;3954.980225098885;28282.434351313063;28430.28924276889;29105.12684619465;29305.85347073251;29749.553756693665;3381.830908454592;3401.8809341672923;3422.5892892853017;3432.7940323580665;3463.428534291839;226809;360762;364041;364994;365980;56672.71663641655;56934.14598781022;57171;57206.14190787142;57259.14111288334;52984.47015529795;60592.39407605956;60838;62043;62528.68735656293;13577.660558486117;13697.931510342385;13749.381277842522;13752;13776.242306673028;10569.894301057046;10656.573737050587;10656.680299591024;10658.413787241776;10659.467026648637;17324.39364622232;19628.901855490916;20293.695594566092;20295.4926126848;20319.79680203179;7079.362857342864;7400.966473272079;7478.3643390311345;7598.544087354777;7691.346235569928;939.5506064823993;950.2160717408166;971.708487453761;991.4051569058507;1011.0748664971616;27135.321616959733;27360.702349478965;27561;27637.170884873085;27832.582511262346;983.6508039645965;1017.5065093429681;1057.9259451838298;1064.4252103863982;1067.8024565455416;13744.518941836988;14219.289035548389;14459.27703614815;14569.781453278209;14593;278305;281332;281801;282824;283506;47711.28433073506;48463.75768121137;48509;48529.27206091912;48709.26936095962;1042.2912419554625;1214.5081242096965;1227.9631611051682;1229.5020516690754;1277.1060257819563;24338.63492047656;25190.370240744127;25441.745582544678;25502.23493295204;25603.23190304294;36701.44947825732;36713.81643091767;36717.26565468729;36717.63282367142;37488.625113748516;200149;201328;201963;202233;202431;31373;32972.67027329696;32975.835120824246;32985.34029319448;33065.17337066496;40133.79933100316;40949;41267.174656506104;42151.57848421599;42216.577834222495;34987.7754278599;35043.64956350404;35261.47107793334;35299.29401411906;35667.82166089153;34532.30935381329;35476.822615886755;35695.28609427745;35754.64245357617;35983;34856.12859678528;35065;35220.823895880356;35467.46798797968;35547;29718;31366.372672545964;31471.84264078665;31617;31861;23972.64041039351;24752.876235618707;24775.380615484035;24804.37989050216;25004.62493062569 17:27:35 INFO - PROCESS | 15151 | |2;jquery.html;342.85771404866983;353.9752217344785;354.99536312236376;356.1790073879707;366.166970142925;14920.77618835717;15107.622309442255;15669;16560.58598535037;16576.17119144044;15734.921325393358;16025.83974160258;16870.409535666255;16872.746908796347;16885.746713799304;4849.757512124397;4930.950690493103;4958.950410495885;5043.722595257259;5048.29323894655;4797.0645724083815;4908.361912951312;4941.925871111936;4946.837493189098;4996.275540046691;4939.259111133323;4949.628777841676;4952.281919121725;4954.603631709472;4961.875953101183;4673.976630116845;4856.223004319292;4867.123917694814;4872.707637541759;4883.99878025004;4290.570942905716;4302.526722060571;4312.072904325553;4317.460317460317;4325.264705000158;18894.48844092483;19186.904065479583;19432.70850937237;19572.119254633577;19598.51003724904;2051.589682063593;2100.0654708654656;2326.430024643956;2459.96681393815;2479.157086590568;12583.685407864785;12687.746245075046;12706.110572259946;12905.612831615066;13223.140495867738;1733.3413302944925;1734.7744793176932;1775.4673597920573;1776.5114593486765;1842.2630947620926;56882;59316.70341648264;59750;59762.402375976555;61034.389656102874;8513.10612385703;8531.957340213383;8884;9036.096390361043;9040.09599040104;11653.59212427561;11914.821277680841;11961.162718609614;11973.341466219441;12024.639260822189;6892.827679308058;6895.965520172367;6921.446284297244;7002.719891204295;7014.859702805916;6800.08198893153;6823.420009299166;6897.3447522485285;6918.481113916477;6925.549839260432;5484.122540393518;5526.668399896019;5601.7759289628775;5646.97176514123;5763.798267060716;1586.5557643859738;1620.5219460259252;1646.2674110021164;1666.5750233690574;1704.2586474883465;811.9634616442274;891.5007595746403;904.7647611620895;912;1010.6967909627083;15785.921070394574;16126;16351;16614.418495352606;16793.580160496087;867.5228624256633;902.8961669407971;908.4776253654176;926.712719057081;954.160338901762;9431.858522122173;9553.570089345858;9814.803703925882;9815;9991.950040249752;360589;362503;362546;389444;395147;62695;63203.36796632067;64046.6797666018;64250;66726.66636666883;934.8831396075491;944.3059351376733;957.7557722780647;967.9758006050046;971.1696499492832;14479.710405791615;14576.813477978389;14682.045667031609;14777.482788102365;15038.924805375904;30614;31394.529082064244;31729.20676983094;31774;31938;41554.168916620896;41575;41720.582794172886;41890.79054604707;42334.57665423306;7088.326608972139;7305.489593518792;7356.227596102332;7381.704731810667;7602.50583712057;10511.369317840954;11804.645860624196;11944.522219111139;12032.819507707567;12202.450889709808;9806;9941.30410871232;10196.490175491344;10379.273450858367;10613.20400969915;10188;10230.795384092127;10336.586536538454;10409.635662751767;10476.266661333633;10297.469113589996;10504.317219380715;10539.367637941748;10573;10671.199660025684;7080.787576372717;7259.963700181676;7264.782056538313;7285.890711639436;7359.484836061424;10375.688729338131;10496.107830834158;10573.731152261778;10631.94684026575;10742.785144297226 17:27:35 INFO - PROCESS | 15151 | |3;mootools.html;1279.2644229568;1406.9085509441886;1420.353739048733;1578.2503310927311;1768.831960963708;7349.595772232532;7499.775006749793;7509.699612015513;7510.474266801326;7523.811904702392;7328.890066649004;7522.924770752291;7525.285097915689;7534.472586918918;7545.434092443075;1921.4715953112936;2170.294654237371;2202.9559408811815;2225.643896976484;2234.6201145805253;2215.5679642469727;2221.733391992955;2231.0741042467357;2231.2859884836857;2241.4620491082105;2116.5978464091772;2154.224479187499;2154.407537927067;2158.3740715192575;2159.211887661008;2146.849720519572;2171.446281198292;2172.6197915364746;2217.0466699319286;2224.998750562237;2187.6499760038478;2192.2217612747563;2193.901274442654;2195.857269277492;2197.9890100549555;7624.961875190588;7681.7695469136015;7686.461947663665;7688.654010569538;7697.153313135606;4450.799714012877;4519.141363140992;4562.110388474249;4565.771711414449;4568.200564901129;3068.3096303331795;3078.907632770998;3117.1427857339186;3171.9682803171904;3206.88775892845;976.2287792643874;1003.6286573967678;1004.1665417703362;1004.3622299839582;1051.0382999555397;10371.274010819247;10394.740131496697;10431.530581123792;10456.477176141163;10461.581536738597;4037.2329257440992;4200.3699445082875;4257.574242575718;4265.616094551505;4274.871753847389;8229.05365882931;8286.8342633147;8295.419320647617;8295.585220738938;8298.54358010303;4057.878263652095;4672.95327046732;4676.69601475903;4706.905861882743;4707.458642256116;4073.6944729145434;4129.566395528486;4147.668186545069;4151.605597468236;4166.125113726091;3332.9333413331597;3400.2009527760956;3425.828708564562;3449.0515108345407;3449.49982252577;1051.269367789379;1051.64244156987;1055.6199768083484;1057.4244375879885;1058.222206678091;1023.8720159980003;1043.0925095167254;1051.8106740786732;1114.1309778372881;1207.2334067866793;7211.567305961659;7244.673989670478;7255.238199988925;7311.41508679315;7312.378447831994;1125.3529220697967;1128.5260190719916;1142.9771404571861;1169.7660467906283;1170.3913964738288;5322;5505.944940550543;5516.420775818481;5523.061079616475;5524.033294173503;8912.955435222782;8918.37571369998;9078.319126065571;9177;9358.625654973725;9021.684241051531;9174.357794954289;9197.792529792936;9198.172164505093;9228.5847136879;7163.283671632795;7219.711211551584;7240.637968101574;7278.890816637755;7327.487075904635;6818.795436136924;6881.89677154833;6902.758403455855;6937.7224911002995;6939.236683964659;8203.865100416768;8387.119352467904;8392.20274073962;8528.786780330542;8572.785680358042;8593.828123437372;8629.525376104375;8749.693760718344;8784.516851573226;8886.644534218558;5477.75350109238;5774.105013722879;5937.643741375531;6308.243010838545;6368.87262254743;7145.928540714526;7153.35619794221;7191.2449192834;7205.891911621225;7226.963865180641;6280.214973128359;6549.24683661385;6574.178227721535;6575.408213260829;6623.569467984566;6513.967430162819;6517.73929042833;6562.77030303937;6586;6597.703103360264;6877.415419689382;6932.514723969273;6948.722051118101;6955;6965.686544105629;6312.747490100344;6324.114623952558;6366.936330636634;6385.680715964276;6389.808305750835;6375;6376.553641245254;6397.936020639734;6408.839779005562;6422.582532135396 17:27:35 INFO - PROCESS | 15151 | |4;prototype.html;310.7250083675947;311.60737470786813;317.4444721736961;327.9163813227625;331.0729956122855;5220.582353411727;5440.5375543078835;5445.319335083114;5451.454854514546;5461.672299662013;5264.736763161836;5357.196420536921;5362.1420572708375;5366.114591092465;5388.218708287296;3914.667253283474;3988.940165897514;4120.526139493952;4128.3601041838565;4135.069609337905;4109.0959988802415;4112.424260603518;4116.115035267417;4118.505779306487;4119.773412462313;4056.797160141996;4057.797110144496;4063.08580569371;4068.3897415387783;4069.532003819554;3842.4620553122445;3943.3099207638547;3948.8223029963433;3956.742811717258;4065.10567675111;3508.7368447366293;3519.560054993126;3528.59421166564;3532.964670353315;3535.699465545432;5003.774830132653;5005.824796132118;5063.417706963673;5078.771455284485;5087.949120508784;4681.5318468153255;4682.1338052460405;4684.953150468486;4688.906221875577;4694.108119457293;5608;5610.214569960209;5621.156826476021;5626.9437305626825;5627.521660658849;3901.8634347797692;3906.4726261954843;3906.882793516199;3910.706696997708;3911.882643520699;5650.237217975562;5756.107803290497;5864.266966629171;5890.910181616372;5899.498542623882;3971.940420893689;3988;4001.779902105412;4011.4584531088512;4011.659008984269;4063.6952228582973;4064.8170832312617;4066.840950329142;4071.3485842265095;4071.5521292657786;4668.4631267404;4670.182718024332;4672.813087476463;4679.204535229019;4687.156311863897;5606.327240731139;5611.915821262684;5616.466435688603;5617.466340697627;5620.3255609326325;1395.9790603140962;1407.7958695989025;1409.5418988828671;1412.173878281217;1412.4632639596887;925.5511077127723;941.1200527506667;957.8371676814958;959.4627008875052;962.7881865989472;4767.61859051275;4841.515848415131;4921.040397122527;4921.434035085939;4932.087563800708;5790.855228619318;5792.913106303409;5816.243888294494;5816.389279125716;5817.069268916953;4917.385326834145;4924.975375123101;4926.8768280793265;4958.380202474691;4966.329545511382;3099.4421004219457;3133.827639479805;3137.654857965622;3143.8899638512544;3146.65386807451;5502.5597952163735;5524.944750552523;5527.695976721319;5530.2810634618045;5531.502164805187;5831.708414579254;5996.4603185713495;5998.670073145931;6023.578349515492;6027.065804800175;5514.972425137928;5520.834374968757;5544.528715059185;5553.111502159635;5556.999999999919;5870.5010074144175;5884.35272120075;5890.823275301748;5891.705414729332;5893.410658934073;5708.115242137475;5739.655620662774;5751.367349591458;5751.8562035949435;5757.3954734753925;5540.030494663337;5544.306961629796;5551.916721249266;5553.250311208097;5559.221708960829;3855.787931663673;3938.232044751246;3965.6232657897453;3968.4444177814553;3986.202759448064;5739.311282645942;5761.740721667451;5815.854603634943;5828.446297601721;5832.096025116114;5618.971905140448;5626.831195063991;5627.662340259598;5632.85917852057;5634.915476267777;5628.902364038973;5677.432256774289;5677.829665110054;5680.77276908919;5689.431056894277;5542;5542.528885044816;5545.195946587642;5545.473180047889;5549.916751248654;5517.420670829505;5686.658800471985;5729.169270455844;5730.341010783646;5736.4550367715;5552.805651802168;5581.553475721851;5583.134614134816;5587.944120558905;5603.355614104267 17:27:35 INFO - PROCESS | 15151 | |5;yui.html;693.9548929319594;721.4553012475584;745.3999530378047;762.3139174742735;773.3503856760321;12362.629121126369;12450.377481125954;12484.126111172221;12499.562515311978;12512;11994.220375675575;12063.939680301586;12094.69763255919;12208.755824883498;12283.877161228385;658.1575583253443;789.9328557072656;801.3268854162502;808.9231523005305;817.7587611654546;803.93568514519;804.6982381606897;814.3403842887251;814.698561532234;815.7063457155419;824.8680211166214;835.1940377535677;836.9121242269565;836.9204925532065;837.9958100209491;681.3254877671119;688.8587839492917;826.4834478450969;830.5515021888173;832.5296207642663;604.4016423740509;606.7754930675634;608.6439432931741;612.2408213814882;612.3539665652735;12577.182483138567;12605;12630.557930472389;12710.936445317806;12714.872851271553;12487.812682809765;12966.286854223014;12978.286194259312;13057.542985995444;13168.86831131686;10022.89977100227;10060.849087263698;10071.597136114546;10090.697279081565;10395.480225988671;3339.148517128117;3388.8644454221803;3405.6083550391772;3428.0915557377316;3485.4771784232316;39226.215475690326;39611.20777584432;39688.007799804946;39724.40413393801;39796.403053954215;9089.09109089099;9223.861642075375;9232.90767092334;9769.560369783378;9773.169280611228;16150.35398584067;16290.755638665429;16322;16332;16339.83660163407;6669.699863506057;6738.663066846736;6932.792016239521;6983.336583024605;7015.333543313479;3880.359740642819;3923.431102490123;3963.841446342172;3971.225611005826;4006.1587066715733;2956.7191116843865;2968.079895232485;2971.539411391238;2973.3904549567287;2986.163874115251;534.5696714145073;539.8110661268524;561.4329527177498;563.0653115827706;565.3498476751769;448.6679856905866;567.6820980251073;567.9772809087673;567.9943200568024;568.8520984543966;8122.537943170286;8184.6316915738935;8366.205210504992;8410.705625303084;8525.57372131391;629.2920464477463;641.1184621145925;648.3192647719875;669.5045666206972;681.9011243369683;3894.980525097413;3895.14306852492;3898.766074035567;3965.643092121723;4043.0700938784244;53784.73107634515;54366;54368.18447723287;54475.727621362435;54618.45381546213;46365.30452043222;46545.534544654794;46918.296225556645;46967;47006.5299347009;41849.37225941613;42194;42429.57570424318;42534.787326063175;42678.14643707108;7878.290953814184;7944.364450843803;8090.757277281691;8220.671173153007;8238.50568965864;30153.246168845955;31754.841225793723;32453.18867028249;32459;32702.182445438102;40929;41399;41835.7908210457;42462.363064553436;42692;9639.180669642878;9693;9764.560594773395;9784.461854598065;9814.165795907427;10666.253362264877;10738.516766745359;10844.132469402586;10932.453377331261;11152.275102118336;10099.596016159565;10111.595536178766;10387.324823886423;10394.532246048795;10574.577016919546;9104.226140778108;9210.815783684422;9299.02360252191;9664;9879;9918.454485003105;9935.354201977138;9973.60105595768;10025.398476091457;10599.62901298451;8686.305095592212;8717.65129394817;8766.474011559327;8971.551422428984;9071.455712657262;8638.26574741129;8708.56457177126;8940.061293564082;9885.85171222418;10107.89892101099 17:27:35 INFO - PROCESS | 15151 | __end_tp_report 17:27:35 INFO - PROCESS | 15151 | __start_cc_report 17:27:35 INFO - PROCESS | 15151 | _x_x_mozilla_cycle_collect,999 17:27:35 INFO - PROCESS | 15151 | __end_cc_report 17:27:35 INFO - PROCESS | 15151 | __startTimestamp1458952055758__endTimestamp 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | ------- Summary: start ------- 17:27:35 INFO - PROCESS | 15151 | Number of tests: 6 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | [#0] dojo.html Cycles:165 Average:4631.89 Median:4760.00 stddev:464.36 (9.8%) stddev-sans-first:438.68 17:27:35 INFO - PROCESS | 15151 | Values: 2638.9 2711.8 2733.1 2740.4 2765.1 4593.0 4709.1 4722.8 4724.9 4735.2 4663.7 4675.9 4701.7 4755.6 4760.0 4262.4 4294.4 4310.3 4370.9 4448.1 4359.6 4395.1 4410.3 4421.6 4448.4 4244.5 4288.7 4322.2 4339.4 4354.2 4313.0 4318.2 4356.7 4356.7 4373.4 4262.3 4271.6 4290.4 4301.9 4333.0 4488.3 4530.0 4568.2 4613.2 4645.6 4943.5 4945.4 4948.0 4952.7 4976.1 4952.8 4966.5 4967.9 4989.7 5007.3 4544.5 4614.2 4644.6 4650.9 4694.6 5140.2 5152.0 5157.9 5166.3 5190.7 4947.4 4956.0 4961.7 4965.0 5013.0 4859.8 4886.4 4891.8 4956.3 4968.0 4893.6 4929.0 4929.2 4934.9 4980.1 4792.9 4926.9 4927.0 4930.2 4979.5 4248.7 4280.5 4283.5 4320.5 4326.4 3696.9 3705.9 3712.9 3717.5 3727.9 4252.2 4310.7 4315.3 4325.6 4347.9 4950.1 4978.4 4983.3 5033.5 5037.0 4317.7 4336.5 4339.2 4362.8 4388.4 4423.7 4493.0 4533.3 4533.5 4534.2 4719.0 4735.2 4741.8 4746.8 4789.4 4999.3 5006.4 5007.6 5008.9 5055.0 4645.2 4689.8 4729.8 4790.3 4802.4 4959.4 4978.4 4978.9 4988.3 5004.0 5032.7 5035.1 5042.5 5044.8 5077.9 4744.4 4852.9 4902.8 4932.6 4936.8 4861.6 4862.2 4878.5 4884.1 4922.4 4812.4 4824.0 4826.2 4841.8 4887.9 4793.6 4906.1 4942.9 4959.5 4991.7 4785.7 4800.0 4817.9 4824.2 4886.0 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | [#1] ext.html Cycles:180 Average:43325.96 Median:35280.38 stddev:73708.32 (208.9%) stddev-sans-first:73845.03 17:27:35 INFO - PROCESS | 15151 | Values: 522.8 531.9 538.0 544.7 566.3 26002.6 26416.5 34318.8 34873.3 34875.7 37635.6 38015.8 38027.4 38087.8 38107.8 7516.7 7721.2 7729.5 7732.9 7744.3 7536.4 7628.9 7630.8 7662.2 7672.9 7760.9 7765.5 7804.5 7871.3 7875.6 7708.5 7802.5 7816.5 7846.6 7856.5 7768.5 7888.1 7890.5 7899.1 7903.2 35711.3 35828.5 36182.6 36189.1 36271.8 3099.5 3180.4 3199.0 3638.0 3955.0 28282.4 28430.3 29105.1 29305.9 29749.6 3381.8 3401.9 3422.6 3432.8 3463.4 226809.0 360762.0 364041.0 364994.0 365980.0 56672.7 56934.1 57171.0 57206.1 57259.1 52984.5 60592.4 60838.0 62043.0 62528.7 13577.7 13697.9 13749.4 13752.0 13776.2 10569.9 10656.6 10656.7 10658.4 10659.5 17324.4 19628.9 20293.7 20295.5 20319.8 7079.4 7401.0 7478.4 7598.5 7691.3 939.6 950.2 971.7 991.4 1011.1 27135.3 27360.7 27561.0 27637.2 27832.6 983.7 1017.5 1057.9 1064.4 1067.8 13744.5 14219.3 14459.3 14569.8 14593.0 278305.0 281332.0 281801.0 282824.0 283506.0 47711.3 48463.8 48509.0 48529.3 48709.3 1042.3 1214.5 1228.0 1229.5 1277.1 24338.6 25190.4 25441.7 25502.2 25603.2 36701.4 36713.8 36717.3 36717.6 37488.6 200149.0 201328.0 201963.0 202233.0 202431.0 31373.0 32972.7 32975.8 32985.3 33065.2 40133.8 40949.0 41267.2 42151.6 42216.6 34987.8 35043.6 35261.5 35299.3 35667.8 34532.3 35476.8 35695.3 35754.6 35983.0 34856.1 35065.0 35220.8 35467.5 35547.0 29718.0 31366.4 31471.8 31617.0 31861.0 23972.6 24752.9 24775.4 24804.4 25004.6 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | [#2] jquery.html Cycles:180 Average:22691.16 Median:41647.79 stddev:61356.93 (147.3%) stddev-sans-first:61506.10 17:27:35 INFO - PROCESS | 15151 | Values: 342.9 354.0 355.0 356.2 366.2 14920.8 15107.6 15669.0 16560.6 16576.2 15734.9 16025.8 16870.4 16872.7 16885.7 4849.8 4931.0 4959.0 5043.7 5048.3 4797.1 4908.4 4941.9 4946.8 4996.3 4939.3 4949.6 4952.3 4954.6 4961.9 4674.0 4856.2 4867.1 4872.7 4884.0 4290.6 4302.5 4312.1 4317.5 4325.3 18894.5 19186.9 19432.7 19572.1 19598.5 2051.6 2100.1 2326.4 2460.0 2479.2 12583.7 12687.7 12706.1 12905.6 13223.1 1733.3 1734.8 1775.5 1776.5 1842.3 56882.0 59316.7 59750.0 59762.4 61034.4 8513.1 8532.0 8884.0 9036.1 9040.1 11653.6 11914.8 11961.2 11973.3 12024.6 6892.8 6896.0 6921.4 7002.7 7014.9 6800.1 6823.4 6897.3 6918.5 6925.5 5484.1 5526.7 5601.8 5647.0 5763.8 1586.6 1620.5 1646.3 1666.6 1704.3 812.0 891.5 904.8 912.0 1010.7 15785.9 16126.0 16351.0 16614.4 16793.6 867.5 902.9 908.5 926.7 954.2 9431.9 9553.6 9814.8 9815.0 9992.0 360589.0 362503.0 362546.0 389444.0 395147.0 62695.0 63203.4 64046.7 64250.0 66726.7 934.9 944.3 957.8 968.0 971.2 14479.7 14576.8 14682.0 14777.5 15038.9 30614.0 31394.5 31729.2 31774.0 31938.0 41554.2 41575.0 41720.6 41890.8 42334.6 7088.3 7305.5 7356.2 7381.7 7602.5 10511.4 11804.6 11944.5 12032.8 12202.5 9806.0 9941.3 10196.5 10379.3 10613.2 10188.0 10230.8 10336.6 10409.6 10476.3 10297.5 10504.3 10539.4 10573.0 10671.2 7080.8 7260.0 7264.8 7285.9 7359.5 10375.7 10496.1 10573.7 10631.9 10742.8 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | [#3] mootools.html Cycles:180 Average:5284.28 Median:5855.87 stddev:2747.55 (46.9%) stddev-sans-first:2738.77 17:27:35 INFO - PROCESS | 15151 | Values: 1279.3 1406.9 1420.4 1578.3 1768.8 7349.6 7499.8 7509.7 7510.5 7523.8 7328.9 7522.9 7525.3 7534.5 7545.4 1921.5 2170.3 2203.0 2225.6 2234.6 2215.6 2221.7 2231.1 2231.3 2241.5 2116.6 2154.2 2154.4 2158.4 2159.2 2146.8 2171.4 2172.6 2217.0 2225.0 2187.6 2192.2 2193.9 2195.9 2198.0 7625.0 7681.8 7686.5 7688.7 7697.2 4450.8 4519.1 4562.1 4565.8 4568.2 3068.3 3078.9 3117.1 3172.0 3206.9 976.2 1003.6 1004.2 1004.4 1051.0 10371.3 10394.7 10431.5 10456.5 10461.6 4037.2 4200.4 4257.6 4265.6 4274.9 8229.1 8286.8 8295.4 8295.6 8298.5 4057.9 4673.0 4676.7 4706.9 4707.5 4073.7 4129.6 4147.7 4151.6 4166.1 3332.9 3400.2 3425.8 3449.1 3449.5 1051.3 1051.6 1055.6 1057.4 1058.2 1023.9 1043.1 1051.8 1114.1 1207.2 7211.6 7244.7 7255.2 7311.4 7312.4 1125.4 1128.5 1143.0 1169.8 1170.4 5322.0 5505.9 5516.4 5523.1 5524.0 8913.0 8918.4 9078.3 9177.0 9358.6 9021.7 9174.4 9197.8 9198.2 9228.6 7163.3 7219.7 7240.6 7278.9 7327.5 6818.8 6881.9 6902.8 6937.7 6939.2 8203.9 8387.1 8392.2 8528.8 8572.8 8593.8 8629.5 8749.7 8784.5 8886.6 5477.8 5774.1 5937.6 6308.2 6368.9 7145.9 7153.4 7191.2 7205.9 7227.0 6280.2 6549.2 6574.2 6575.4 6623.6 6514.0 6517.7 6562.8 6586.0 6597.7 6877.4 6932.5 6948.7 6955.0 6965.7 6312.7 6324.1 6366.9 6385.7 6389.8 6375.0 6376.6 6397.9 6408.8 6422.6 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | [#4] prototype.html Cycles:180 Average:4649.48 Median:5414.38 stddev:1384.86 (25.6%) stddev-sans-first:1349.91 17:27:35 INFO - PROCESS | 15151 | Values: 310.7 311.6 317.4 327.9 331.1 5220.6 5440.5 5445.3 5451.5 5461.7 5264.7 5357.2 5362.1 5366.1 5388.2 3914.7 3988.9 4120.5 4128.4 4135.1 4109.1 4112.4 4116.1 4118.5 4119.8 4056.8 4057.8 4063.1 4068.4 4069.5 3842.5 3943.3 3948.8 3956.7 4065.1 3508.7 3519.6 3528.6 3533.0 3535.7 5003.8 5005.8 5063.4 5078.8 5087.9 4681.5 4682.1 4685.0 4688.9 4694.1 5608.0 5610.2 5621.2 5626.9 5627.5 3901.9 3906.5 3906.9 3910.7 3911.9 5650.2 5756.1 5864.3 5890.9 5899.5 3971.9 3988.0 4001.8 4011.5 4011.7 4063.7 4064.8 4066.8 4071.3 4071.6 4668.5 4670.2 4672.8 4679.2 4687.2 5606.3 5611.9 5616.5 5617.5 5620.3 1396.0 1407.8 1409.5 1412.2 1412.5 925.6 941.1 957.8 959.5 962.8 4767.6 4841.5 4921.0 4921.4 4932.1 5790.9 5792.9 5816.2 5816.4 5817.1 4917.4 4925.0 4926.9 4958.4 4966.3 3099.4 3133.8 3137.7 3143.9 3146.7 5502.6 5524.9 5527.7 5530.3 5531.5 5831.7 5996.5 5998.7 6023.6 6027.1 5515.0 5520.8 5544.5 5553.1 5557.0 5870.5 5884.4 5890.8 5891.7 5893.4 5708.1 5739.7 5751.4 5751.9 5757.4 5540.0 5544.3 5551.9 5553.3 5559.2 3855.8 3938.2 3965.6 3968.4 3986.2 5739.3 5761.7 5815.9 5828.4 5832.1 5619.0 5626.8 5627.7 5632.9 5634.9 5628.9 5677.4 5677.8 5680.8 5689.4 5542.0 5542.5 5545.2 5545.5 5549.9 5517.4 5686.7 5729.2 5730.3 5736.5 5552.8 5581.6 5583.1 5587.9 5603.4 17:27:35 INFO - PROCESS | 15151 | 17:27:35 INFO - PROCESS | 15151 | [#5] yui.html Cycles:180 Average:12643.50 Median:27162.27 stddev:14488.11 (53.3%) stddev-sans-first:14500.96 17:27:35 INFO - PROCESS | 15151 | Values: 694.0 721.5 745.4 762.3 773.4 12362.6 12450.4 12484.1 12499.6 12512.0 11994.2 12063.9 12094.7 12208.8 12283.9 658.2 789.9 801.3 808.9 817.8 803.9 804.7 814.3 814.7 815.7 824.9 835.2 836.9 836.9 838.0 681.3 688.9 826.5 830.6 832.5 604.4 606.8 608.6 612.2 612.4 12577.2 12605.0 12630.6 12710.9 12714.9 12487.8 12966.3 12978.3 13057.5 13168.9 10022.9 10060.8 10071.6 10090.7 10395.5 3339.1 3388.9 3405.6 3428.1 3485.5 39226.2 39611.2 39688.0 39724.4 39796.4 9089.1 9223.9 9232.9 9769.6 9773.2 16150.4 16290.8 16322.0 16332.0 16339.8 6669.7 6738.7 6932.8 6983.3 7015.3 3880.4 3923.4 3963.8 3971.2 4006.2 2956.7 2968.1 2971.5 2973.4 2986.2 534.6 539.8 561.4 563.1 565.3 448.7 567.7 568.0 568.0 568.9 8122.5 8184.6 8366.2 8410.7 8525.6 629.3 641.1 648.3 669.5 681.9 3895.0 3895.1 3898.8 3965.6 4043.1 53784.7 54366.0 54368.2 54475.7 54618.5 46365.3 46545.5 46918.3 46967.0 47006.5 41849.4 42194.0 42429.6 42534.8 42678.1 7878.3 7944.4 8090.8 8220.7 8238.5 30153.2 31754.8 32453.2 32459.0 32702.2 40929.0 41399.0 41835.8 42462.4 42692.0 9639.2 9693.0 9764.6 9784.5 9814.2 10666.3 10738.5 10844.1 10932.5 11152.3 10099.6 10111.6 10387.3 10394.5 10574.6 9104.2 9210.8 9299.0 9664.0 9879.0 9918.5 9935.4 9973.6 10025.4 10599.6 8686.3 8717.7 8766.5 8971.6 9071.5 8638.3 8708.6 8940.1 9885.9 10107.9 17:27:35 INFO - PROCESS | 15151 | -------- Summary: end -------- 17:27:35 INFO - PROCESS | 15151 | 17:27:36 INFO - TEST-INFO | 15151: exit 0 17:27:36 INFO - TEST-OK | dromaeo_css | took 1116392ms 17:27:36 INFO - TEST-START | kraken 17:27:36 INFO - operating with platform_type : linux_ 17:27:36 INFO - Initialising browser for kraken test... 17:27:36 INFO - TEST-INFO | started process 15332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KCbfm/profile http://localhost:41042/getInfo.html) 17:27:40 INFO - PROCESS | 15332 | __metrics Screen width/height:1600/1200 17:27:40 INFO - PROCESS | 15332 | colorDepth:24 17:27:40 INFO - PROCESS | 15332 | Browser inner width/height: 1024/697 17:27:40 INFO - PROCESS | 15332 | __metrics 17:27:41 ERROR - PROCESS | 15332 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:27:42 INFO - TEST-INFO | 15332: exit 0 17:27:42 INFO - Browser initialized. 17:27:42 INFO - Running cycle 1/1 for kraken test... 17:27:42 INFO - TEST-INFO | started process 15415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KCbfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:54 INFO - PROCESS | 15415 | RSS: Main: 154648576 17:27:54 INFO - PROCESS | 15415 | 17:27:56 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41042/tests/kraken/driver.html?testName=audio-beat-detection) 17:27:57 INFO - PROCESS | 15415 | RSS: Main: 195411968 17:27:57 INFO - PROCESS | 15415 | 17:28:00 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41042/tests/kraken/driver.html?testName=audio-dft) 17:28:00 INFO - PROCESS | 15415 | RSS: Main: 185688064 17:28:00 INFO - PROCESS | 15415 | 17:28:03 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41042/tests/kraken/driver.html?testName=audio-fft) 17:28:04 INFO - PROCESS | 15415 | RSS: Main: 171786240 17:28:04 INFO - PROCESS | 15415 | 17:28:06 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41042/tests/kraken/driver.html?testName=audio-oscillator) 17:28:07 INFO - PROCESS | 15415 | RSS: Main: 172777472 17:28:07 INFO - PROCESS | 15415 | 17:28:09 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41042/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:09 INFO - PROCESS | 15415 | RSS: Main: 174907392 17:28:09 INFO - PROCESS | 15415 | 17:28:13 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41042/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:13 INFO - PROCESS | 15415 | RSS: Main: 174698496 17:28:13 INFO - PROCESS | 15415 | 17:28:17 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41042/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:17 INFO - PROCESS | 15415 | RSS: Main: 174972928 17:28:17 INFO - PROCESS | 15415 | 17:28:20 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41042/tests/kraken/driver.html?testName=json-parse-financial) 17:28:21 INFO - PROCESS | 15415 | RSS: Main: 175591424 17:28:21 INFO - PROCESS | 15415 | 17:28:22 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41042/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:23 INFO - PROCESS | 15415 | RSS: Main: 187097088 17:28:23 INFO - PROCESS | 15415 | 17:28:25 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:25 INFO - PROCESS | 15415 | RSS: Main: 186101760 17:28:25 INFO - PROCESS | 15415 | 17:28:27 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:28 INFO - PROCESS | 15415 | RSS: Main: 191500288 17:28:28 INFO - PROCESS | 15415 | 17:28:31 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:31 INFO - PROCESS | 15415 | RSS: Main: 200036352 17:28:31 INFO - PROCESS | 15415 | 17:28:34 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:34 INFO - PROCESS | 15415 | RSS: Main: 198201344 17:28:34 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | Cycle 1(1): loaded http://localhost:41042/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41042/tests/kraken/driver.html?testName=ai-astar) 17:28:36 INFO - PROCESS | 15415 | RSS: Main: 261132288 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | __start_tp_report 17:28:36 INFO - PROCESS | 15415 | _x_x_mozilla_page_load 17:28:36 INFO - PROCESS | 15415 | _x_x_mozilla_page_load_details 17:28:36 INFO - PROCESS | 15415 | |i|pagename|runs| 17:28:36 INFO - PROCESS | 15415 | |0;ai-astar;112;113;108;113;116;111;101;112;111;113 17:28:36 INFO - PROCESS | 15415 | |1;audio-beat-detection;162;130;161;167;140;156;162;131;175;132 17:28:36 INFO - PROCESS | 15415 | |2;audio-dft;165;162;163;161;163;161;160;160;160;162 17:28:36 INFO - PROCESS | 15415 | |3;audio-fft;73;74;100;100;74;73;74;110;97;73 17:28:36 INFO - PROCESS | 15415 | |4;audio-oscillator;93;95;140;94;94;93;136;94;94;138 17:28:36 INFO - PROCESS | 15415 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;117;117;117 17:28:36 INFO - PROCESS | 15415 | |6;imaging-darkroom;147;146;146;145;146;146;146;146;146;146 17:28:36 INFO - PROCESS | 15415 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 17:28:36 INFO - PROCESS | 15415 | |8;json-parse-financial;63;65;63;63;63;64;64;73;63;61 17:28:36 INFO - PROCESS | 15415 | |9;json-stringify-tinderbox;63;64;64;64;64;65;64;64;64;64 17:28:36 INFO - PROCESS | 15415 | |10;stanford-crypto-aes;83;85;83;81;85;84;83;83;85;83 17:28:36 INFO - PROCESS | 15415 | |11;stanford-crypto-ccm;117;131;124;117;119;128;118;126;117;119 17:28:36 INFO - PROCESS | 15415 | |12;stanford-crypto-pbkdf2;142;136;143;142;155;134;143;140;141;142 17:28:36 INFO - PROCESS | 15415 | |13;stanford-crypto-sha256-iterative;67;70;67;69;69;66;67;66;67;65 17:28:36 INFO - PROCESS | 15415 | __end_tp_report 17:28:36 INFO - PROCESS | 15415 | __start_cc_report 17:28:36 INFO - PROCESS | 15415 | _x_x_mozilla_cycle_collect,1134 17:28:36 INFO - PROCESS | 15415 | __end_cc_report 17:28:36 INFO - PROCESS | 15415 | __startTimestamp1458952116774__endTimestamp 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | ------- Summary: start ------- 17:28:36 INFO - PROCESS | 15415 | Number of tests: 14 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:4.06 (3.6%) stddev-sans-first:4.28 17:28:36 INFO - PROCESS | 15415 | Values: 112.0 113.0 108.0 113.0 116.0 111.0 101.0 112.0 111.0 113.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:161.50 stddev:16.73 (10.4%) stddev-sans-first:17.31 17:28:36 INFO - PROCESS | 15415 | Values: 162.0 130.0 161.0 167.0 140.0 156.0 162.0 131.0 175.0 132.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.64 (1.0%) stddev-sans-first:1.22 17:28:36 INFO - PROCESS | 15415 | Values: 165.0 162.0 163.0 161.0 163.0 161.0 160.0 160.0 160.0 162.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#3] audio-fft Cycles:10 Average:84.80 Median:73.50 stddev:14.96 (20.4%) stddev-sans-first:15.24 17:28:36 INFO - PROCESS | 15415 | Values: 73.0 74.0 100.0 100.0 74.0 73.0 74.0 110.0 97.0 73.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:21.35 (22.7%) stddev-sans-first:22.03 17:28:36 INFO - PROCESS | 15415 | Values: 93.0 95.0 140.0 94.0 94.0 93.0 136.0 94.0 94.0 138.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:28:36 INFO - PROCESS | 15415 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 17:28:36 INFO - PROCESS | 15415 | Values: 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:28:36 INFO - PROCESS | 15415 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:63.50 stddev:3.26 (5.1%) stddev-sans-first:3.43 17:28:36 INFO - PROCESS | 15415 | Values: 63.0 65.0 63.0 63.0 63.0 64.0 64.0 73.0 63.0 61.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 17:28:36 INFO - PROCESS | 15415 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.27 (1.5%) stddev-sans-first:1.33 17:28:36 INFO - PROCESS | 15415 | Values: 83.0 85.0 83.0 81.0 85.0 84.0 83.0 83.0 85.0 83.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.50 stddev:5.21 (4.3%) stddev-sans-first:5.25 17:28:36 INFO - PROCESS | 15415 | Values: 117.0 131.0 124.0 117.0 119.0 128.0 118.0 126.0 117.0 119.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:142.00 stddev:5.53 (3.9%) stddev-sans-first:5.87 17:28:36 INFO - PROCESS | 15415 | Values: 142.0 136.0 143.0 142.0 155.0 134.0 143.0 140.0 141.0 142.0 17:28:36 INFO - PROCESS | 15415 | 17:28:36 INFO - PROCESS | 15415 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 17:28:36 INFO - PROCESS | 15415 | Values: 67.0 70.0 67.0 69.0 69.0 66.0 67.0 66.0 67.0 65.0 17:28:36 INFO - PROCESS | 15415 | -------- Summary: end -------- 17:28:36 INFO - PROCESS | 15415 | 17:28:37 INFO - TEST-INFO | 15415: exit 0 17:28:37 INFO - TEST-OK | kraken | took 61196ms 17:28:37 INFO - SUITE-END | took 1177s 17:28:37 INFO - Completed test suite (00:19:37) 17:28:37 INFO - javascript benchmark 17:28:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2638.9472210555787, 2711.783057355412, 2733.111738684928, 2740.438210166917, 2765.115163147793, 4592.989542300688, 4709.128811169936, 4722.7874745636445, 4724.905501889964, 4735.218688916329, 4663.743494107823, 4675.906481870361, 4701.694389864657, 4755.643326750499, 4760.0, 4262.381954616579, 4294.441722576069, 4310.310350343945, 4370.934435983463, 4448.110377924412, 4359.607635312821, 4395.120975804852, 4410.2723050696595, 4421.624161946223, 4448.421705178323, 4244.469441319835, 4288.678349123828, 4322.200392927302, 4339.435873336478, 4354.238008348558, 4312.978435107836, 4318.179545886303, 4356.6514678825615, 4356.673249506268, 4373.365861949999, 4262.296721041055, 4271.572842715735, 4290.356446533014, 4301.870943871689, 4333.025069359401, 4488.349189367556, 4529.954700452986, 4568.177728008957, 4613.238815595423, 4645.5586719261955, 4943.530364615356, 4945.381827271591, 4948.035133149037, 4952.727599981999, 4976.079425306294, 4952.777125029383, 4966.528179822911, 4967.925481117786, 4989.65072444929, 5007.273945277914, 4544.545545445462, 4614.215583350839, 4644.628429725613, 4650.930236046462, 4694.554017368345, 5140.228965655107, 5152.02111598795, 5157.871053223625, 5166.328377310925, 5190.740462976836, 4947.431045429822, 4955.975220123948, 4961.70229786214, 4964.975175124174, 5013.0, 4859.781309841065, 4886.413630364308, 4891.828785992473, 4956.330895329156, 4967.975160124176, 4893.584045356185, 4929.0, 4929.186684197139, 4934.8649810543775, 4980.12847751642, 4792.904141917142, 4926.916078462733, 4927.0, 4930.211166213388, 4979.4771548987555, 4248.681348898845, 4280.507741609755, 4283.464566929134, 4320.524742278347, 4326.372675961968, 3696.9260614787554, 3705.888823335304, 3712.925741485209, 3717.5167228260693, 3727.918903518004, 4252.234597772369, 4310.741355518679, 4315.331123675835, 4325.6106950374615, 4347.869563913087, 4950.059488697208, 4978.4025916890205, 4983.277424773388, 5033.47148549397, 5036.974815125975, 4317.7193482423545, 4336.479622445264, 4339.153864996296, 4362.781860906942, 4388.407564978687, 4423.734575925455, 4492.9550704493195, 4533.274676051816, 4533.455985281787, 4534.206513860061, 4718.952810471851, 4735.17134501454, 4741.83403580873, 4746.762661866893, 4789.377380940456, 4999.300097986212, 5006.424261210008, 5007.574356179765, 5008.874778130576, 5055.0, 4645.2103142465185, 4689.788959496899, 4729.8108075677965, 4790.257510085942, 4802.447718512416, 4959.3552838132255, 4978.377702787152, 4978.850634480971, 4988.27669987857, 5004.0, 5032.6980381177245, 5035.0685123252315, 5042.495750424928, 5044.798208071636, 5077.92383114261, 4744.359511465908, 4852.902941941071, 4902.779374928065, 4932.605391568738, 4936.827211047596, 4861.586765125004, 4862.197737373435, 4878.536539028929, 4884.12085824555, 4922.433920099091, 4812.35033270518, 4823.975880120717, 4826.1795494766675, 4841.75791210431, 4887.853364399074, 4793.640476964172, 4906.116898958222, 4942.851714448572, 4959.479254678206, 4991.675541089818, 4785.665003449725, 4799.9760001199775, 4817.879553011063, 4824.204006338915, 4885.951140488692], "unit": "score", "name": "dojo.html", "value": 4603.898240229392}, {"lowerIsBetter": false, "replicates": [522.7856578802689, 531.9148936170212, 538.036913924076, 544.741247907244, 566.3373852592466, 26002.60996085058, 26416.471670566578, 34318.82840585794, 34873.3025339493, 34875.651243487555, 37635.553689010194, 38015.80992095043, 38027.429588556195, 38087.80956095223, 38107.80946095266, 7516.736914207991, 7721.22787721229, 7729.497582657137, 7732.922670773305, 7744.341730952876, 7536.397088232929, 7628.8855667165035, 7630.809229769245, 7662.195469475709, 7672.9232707673045, 7760.883586746203, 7765.495242809227, 7804.492707973992, 7871.252231038042, 7875.645595948167, 7708.498947568418, 7802.492837965542, 7816.531008139473, 7846.646900889474, 7856.528608283521, 7768.456208065438, 7888.053433587948, 7890.526568405857, 7899.091604465502, 7903.249191326815, 35711.28577428437, 35828.46257306143, 36182.63817361819, 36189.095272618135, 36271.818640906626, 3099.5040793473163, 3180.3957248122783, 3198.98400507996, 3638.0, 3954.980225098885, 28282.434351313063, 28430.28924276889, 29105.12684619465, 29305.85347073251, 29749.553756693665, 3381.830908454592, 3401.8809341672923, 3422.5892892853017, 3432.7940323580665, 3463.428534291839, 226809.0, 360762.0, 364041.0, 364994.0, 365980.0, 56672.71663641655, 56934.14598781022, 57171.0, 57206.14190787142, 57259.14111288334, 52984.47015529795, 60592.39407605956, 60838.0, 62043.0, 62528.68735656293, 13577.660558486117, 13697.931510342385, 13749.381277842522, 13752.0, 13776.242306673028, 10569.894301057046, 10656.573737050587, 10656.680299591024, 10658.413787241776, 10659.467026648637, 17324.39364622232, 19628.901855490916, 20293.695594566092, 20295.4926126848, 20319.79680203179, 7079.362857342864, 7400.966473272079, 7478.3643390311345, 7598.544087354777, 7691.346235569928, 939.5506064823993, 950.2160717408166, 971.708487453761, 991.4051569058507, 1011.0748664971616, 27135.321616959733, 27360.702349478965, 27561.0, 27637.170884873085, 27832.582511262346, 983.6508039645965, 1017.5065093429681, 1057.9259451838298, 1064.4252103863982, 1067.8024565455416, 13744.518941836988, 14219.289035548389, 14459.27703614815, 14569.781453278209, 14593.0, 278305.0, 281332.0, 281801.0, 282824.0, 283506.0, 47711.28433073506, 48463.75768121137, 48509.0, 48529.27206091912, 48709.26936095962, 1042.2912419554625, 1214.5081242096965, 1227.9631611051682, 1229.5020516690754, 1277.1060257819563, 24338.63492047656, 25190.370240744127, 25441.745582544678, 25502.23493295204, 25603.23190304294, 36701.44947825732, 36713.81643091767, 36717.26565468729, 36717.63282367142, 37488.625113748516, 200149.0, 201328.0, 201963.0, 202233.0, 202431.0, 31373.0, 32972.67027329696, 32975.835120824246, 32985.34029319448, 33065.17337066496, 40133.79933100316, 40949.0, 41267.174656506104, 42151.57848421599, 42216.577834222495, 34987.7754278599, 35043.64956350404, 35261.47107793334, 35299.29401411906, 35667.82166089153, 34532.30935381329, 35476.822615886755, 35695.28609427745, 35754.64245357617, 35983.0, 34856.12859678528, 35065.0, 35220.823895880356, 35467.46798797968, 35547.0, 29718.0, 31366.372672545964, 31471.84264078665, 31617.0, 31861.0, 23972.64041039351, 24752.876235618707, 24775.380615484035, 24804.37989050216, 25004.62493062569], "unit": "score", "name": "ext.html", "value": 17200.921922560105}, {"lowerIsBetter": false, "replicates": [342.85771404866983, 353.9752217344785, 354.99536312236376, 356.1790073879707, 366.166970142925, 14920.77618835717, 15107.622309442255, 15669.0, 16560.58598535037, 16576.17119144044, 15734.921325393358, 16025.83974160258, 16870.409535666255, 16872.746908796347, 16885.746713799304, 4849.757512124397, 4930.950690493103, 4958.950410495885, 5043.722595257259, 5048.29323894655, 4797.0645724083815, 4908.361912951312, 4941.925871111936, 4946.837493189098, 4996.275540046691, 4939.259111133323, 4949.628777841676, 4952.281919121725, 4954.603631709472, 4961.875953101183, 4673.976630116845, 4856.223004319292, 4867.123917694814, 4872.707637541759, 4883.99878025004, 4290.570942905716, 4302.526722060571, 4312.072904325553, 4317.460317460317, 4325.264705000158, 18894.48844092483, 19186.904065479583, 19432.70850937237, 19572.119254633577, 19598.51003724904, 2051.589682063593, 2100.0654708654656, 2326.430024643956, 2459.96681393815, 2479.157086590568, 12583.685407864785, 12687.746245075046, 12706.110572259946, 12905.612831615066, 13223.140495867738, 1733.3413302944925, 1734.7744793176932, 1775.4673597920573, 1776.5114593486765, 1842.2630947620926, 56882.0, 59316.70341648264, 59750.0, 59762.402375976555, 61034.389656102874, 8513.10612385703, 8531.957340213383, 8884.0, 9036.096390361043, 9040.09599040104, 11653.59212427561, 11914.821277680841, 11961.162718609614, 11973.341466219441, 12024.639260822189, 6892.827679308058, 6895.965520172367, 6921.446284297244, 7002.719891204295, 7014.859702805916, 6800.08198893153, 6823.420009299166, 6897.3447522485285, 6918.481113916477, 6925.549839260432, 5484.122540393518, 5526.668399896019, 5601.7759289628775, 5646.97176514123, 5763.798267060716, 1586.5557643859738, 1620.5219460259252, 1646.2674110021164, 1666.5750233690574, 1704.2586474883465, 811.9634616442274, 891.5007595746403, 904.7647611620895, 912.0, 1010.6967909627083, 15785.921070394574, 16126.0, 16351.0, 16614.418495352606, 16793.580160496087, 867.5228624256633, 902.8961669407971, 908.4776253654176, 926.712719057081, 954.160338901762, 9431.858522122173, 9553.570089345858, 9814.803703925882, 9815.0, 9991.950040249752, 360589.0, 362503.0, 362546.0, 389444.0, 395147.0, 62695.0, 63203.36796632067, 64046.6797666018, 64250.0, 66726.66636666883, 934.8831396075491, 944.3059351376733, 957.7557722780647, 967.9758006050046, 971.1696499492832, 14479.710405791615, 14576.813477978389, 14682.045667031609, 14777.482788102365, 15038.924805375904, 30614.0, 31394.529082064244, 31729.20676983094, 31774.0, 31938.0, 41554.168916620896, 41575.0, 41720.582794172886, 41890.79054604707, 42334.57665423306, 7088.326608972139, 7305.489593518792, 7356.227596102332, 7381.704731810667, 7602.50583712057, 10511.369317840954, 11804.645860624196, 11944.522219111139, 12032.819507707567, 12202.450889709808, 9806.0, 9941.30410871232, 10196.490175491344, 10379.273450858367, 10613.20400969915, 10188.0, 10230.795384092127, 10336.586536538454, 10409.635662751767, 10476.266661333633, 10297.469113589996, 10504.317219380715, 10539.367637941748, 10573.0, 10671.199660025684, 7080.787576372717, 7259.963700181676, 7264.782056538313, 7285.890711639436, 7359.484836061424, 10375.688729338131, 10496.107830834158, 10573.731152261778, 10631.94684026575, 10742.785144297226], "unit": "score", "name": "jquery.html", "value": 7961.149317465224}, {"lowerIsBetter": false, "replicates": [1279.2644229568, 1406.9085509441886, 1420.353739048733, 1578.2503310927311, 1768.831960963708, 7349.595772232532, 7499.775006749793, 7509.699612015513, 7510.474266801326, 7523.811904702392, 7328.890066649004, 7522.924770752291, 7525.285097915689, 7534.472586918918, 7545.434092443075, 1921.4715953112936, 2170.294654237371, 2202.9559408811815, 2225.643896976484, 2234.6201145805253, 2215.5679642469727, 2221.733391992955, 2231.0741042467357, 2231.2859884836857, 2241.4620491082105, 2116.5978464091772, 2154.224479187499, 2154.407537927067, 2158.3740715192575, 2159.211887661008, 2146.849720519572, 2171.446281198292, 2172.6197915364746, 2217.0466699319286, 2224.998750562237, 2187.6499760038478, 2192.2217612747563, 2193.901274442654, 2195.857269277492, 2197.9890100549555, 7624.961875190588, 7681.7695469136015, 7686.461947663665, 7688.654010569538, 7697.153313135606, 4450.799714012877, 4519.141363140992, 4562.110388474249, 4565.771711414449, 4568.200564901129, 3068.3096303331795, 3078.907632770998, 3117.1427857339186, 3171.9682803171904, 3206.88775892845, 976.2287792643874, 1003.6286573967678, 1004.1665417703362, 1004.3622299839582, 1051.0382999555397, 10371.274010819247, 10394.740131496697, 10431.530581123792, 10456.477176141163, 10461.581536738597, 4037.2329257440992, 4200.3699445082875, 4257.574242575718, 4265.616094551505, 4274.871753847389, 8229.05365882931, 8286.8342633147, 8295.419320647617, 8295.585220738938, 8298.54358010303, 4057.878263652095, 4672.95327046732, 4676.69601475903, 4706.905861882743, 4707.458642256116, 4073.6944729145434, 4129.566395528486, 4147.668186545069, 4151.605597468236, 4166.125113726091, 3332.9333413331597, 3400.2009527760956, 3425.828708564562, 3449.0515108345407, 3449.49982252577, 1051.269367789379, 1051.64244156987, 1055.6199768083484, 1057.4244375879885, 1058.222206678091, 1023.8720159980003, 1043.0925095167254, 1051.8106740786732, 1114.1309778372881, 1207.2334067866793, 7211.567305961659, 7244.673989670478, 7255.238199988925, 7311.41508679315, 7312.378447831994, 1125.3529220697967, 1128.5260190719916, 1142.9771404571861, 1169.7660467906283, 1170.3913964738288, 5322.0, 5505.944940550543, 5516.420775818481, 5523.061079616475, 5524.033294173503, 8912.955435222782, 8918.37571369998, 9078.319126065571, 9177.0, 9358.625654973725, 9021.684241051531, 9174.357794954289, 9197.792529792936, 9198.172164505093, 9228.5847136879, 7163.283671632795, 7219.711211551584, 7240.637968101574, 7278.890816637755, 7327.487075904635, 6818.795436136924, 6881.89677154833, 6902.758403455855, 6937.7224911002995, 6939.236683964659, 8203.865100416768, 8387.119352467904, 8392.20274073962, 8528.786780330542, 8572.785680358042, 8593.828123437372, 8629.525376104375, 8749.693760718344, 8784.516851573226, 8886.644534218558, 5477.75350109238, 5774.105013722879, 5937.643741375531, 6308.243010838545, 6368.87262254743, 7145.928540714526, 7153.35619794221, 7191.2449192834, 7205.891911621225, 7226.963865180641, 6280.214973128359, 6549.24683661385, 6574.178227721535, 6575.408213260829, 6623.569467984566, 6513.967430162819, 6517.73929042833, 6562.77030303937, 6586.0, 6597.703103360264, 6877.415419689382, 6932.514723969273, 6948.722051118101, 6955.0, 6965.686544105629, 6312.747490100344, 6324.114623952558, 6366.936330636634, 6385.680715964276, 6389.808305750835, 6375.0, 6376.553641245254, 6397.936020639734, 6408.839779005562, 6422.582532135396], "unit": "score", "name": "mootools.html", "value": 4338.525849613772}, {"lowerIsBetter": false, "replicates": [310.7250083675947, 311.60737470786813, 317.4444721736961, 327.9163813227625, 331.0729956122855, 5220.582353411727, 5440.5375543078835, 5445.319335083114, 5451.454854514546, 5461.672299662013, 5264.736763161836, 5357.196420536921, 5362.1420572708375, 5366.114591092465, 5388.218708287296, 3914.667253283474, 3988.940165897514, 4120.526139493952, 4128.3601041838565, 4135.069609337905, 4109.0959988802415, 4112.424260603518, 4116.115035267417, 4118.505779306487, 4119.773412462313, 4056.797160141996, 4057.797110144496, 4063.08580569371, 4068.3897415387783, 4069.532003819554, 3842.4620553122445, 3943.3099207638547, 3948.8223029963433, 3956.742811717258, 4065.10567675111, 3508.7368447366293, 3519.560054993126, 3528.59421166564, 3532.964670353315, 3535.699465545432, 5003.774830132653, 5005.824796132118, 5063.417706963673, 5078.771455284485, 5087.949120508784, 4681.5318468153255, 4682.1338052460405, 4684.953150468486, 4688.906221875577, 4694.108119457293, 5608.0, 5610.214569960209, 5621.156826476021, 5626.9437305626825, 5627.521660658849, 3901.8634347797692, 3906.4726261954843, 3906.882793516199, 3910.706696997708, 3911.882643520699, 5650.237217975562, 5756.107803290497, 5864.266966629171, 5890.910181616372, 5899.498542623882, 3971.940420893689, 3988.0, 4001.779902105412, 4011.4584531088512, 4011.659008984269, 4063.6952228582973, 4064.8170832312617, 4066.840950329142, 4071.3485842265095, 4071.5521292657786, 4668.4631267404, 4670.182718024332, 4672.813087476463, 4679.204535229019, 4687.156311863897, 5606.327240731139, 5611.915821262684, 5616.466435688603, 5617.466340697627, 5620.3255609326325, 1395.9790603140962, 1407.7958695989025, 1409.5418988828671, 1412.173878281217, 1412.4632639596887, 925.5511077127723, 941.1200527506667, 957.8371676814958, 959.4627008875052, 962.7881865989472, 4767.61859051275, 4841.515848415131, 4921.040397122527, 4921.434035085939, 4932.087563800708, 5790.855228619318, 5792.913106303409, 5816.243888294494, 5816.389279125716, 5817.069268916953, 4917.385326834145, 4924.975375123101, 4926.8768280793265, 4958.380202474691, 4966.329545511382, 3099.4421004219457, 3133.827639479805, 3137.654857965622, 3143.8899638512544, 3146.65386807451, 5502.5597952163735, 5524.944750552523, 5527.695976721319, 5530.2810634618045, 5531.502164805187, 5831.708414579254, 5996.4603185713495, 5998.670073145931, 6023.578349515492, 6027.065804800175, 5514.972425137928, 5520.834374968757, 5544.528715059185, 5553.111502159635, 5556.999999999919, 5870.5010074144175, 5884.35272120075, 5890.823275301748, 5891.705414729332, 5893.410658934073, 5708.115242137475, 5739.655620662774, 5751.367349591458, 5751.8562035949435, 5757.3954734753925, 5540.030494663337, 5544.306961629796, 5551.916721249266, 5553.250311208097, 5559.221708960829, 3855.787931663673, 3938.232044751246, 3965.6232657897453, 3968.4444177814553, 3986.202759448064, 5739.311282645942, 5761.740721667451, 5815.854603634943, 5828.446297601721, 5832.096025116114, 5618.971905140448, 5626.831195063991, 5627.662340259598, 5632.85917852057, 5634.915476267777, 5628.902364038973, 5677.432256774289, 5677.829665110054, 5680.77276908919, 5689.431056894277, 5542.0, 5542.528885044816, 5545.195946587642, 5545.473180047889, 5549.916751248654, 5517.420670829505, 5686.658800471985, 5729.169270455844, 5730.341010783646, 5736.4550367715, 5552.805651802168, 5581.553475721851, 5583.134614134816, 5587.944120558905, 5603.355614104267], "unit": "score", "name": "prototype.html", "value": 4206.99913047339}, {"lowerIsBetter": false, "replicates": [693.9548929319594, 721.4553012475584, 745.3999530378047, 762.3139174742735, 773.3503856760321, 12362.629121126369, 12450.377481125954, 12484.126111172221, 12499.562515311978, 12512.0, 11994.220375675575, 12063.939680301586, 12094.69763255919, 12208.755824883498, 12283.877161228385, 658.1575583253443, 789.9328557072656, 801.3268854162502, 808.9231523005305, 817.7587611654546, 803.93568514519, 804.6982381606897, 814.3403842887251, 814.698561532234, 815.7063457155419, 824.8680211166214, 835.1940377535677, 836.9121242269565, 836.9204925532065, 837.9958100209491, 681.3254877671119, 688.8587839492917, 826.4834478450969, 830.5515021888173, 832.5296207642663, 604.4016423740509, 606.7754930675634, 608.6439432931741, 612.2408213814882, 612.3539665652735, 12577.182483138567, 12605.0, 12630.557930472389, 12710.936445317806, 12714.872851271553, 12487.812682809765, 12966.286854223014, 12978.286194259312, 13057.542985995444, 13168.86831131686, 10022.89977100227, 10060.849087263698, 10071.597136114546, 10090.697279081565, 10395.480225988671, 3339.148517128117, 3388.8644454221803, 3405.6083550391772, 3428.0915557377316, 3485.4771784232316, 39226.215475690326, 39611.20777584432, 39688.007799804946, 39724.40413393801, 39796.403053954215, 9089.09109089099, 9223.861642075375, 9232.90767092334, 9769.560369783378, 9773.169280611228, 16150.35398584067, 16290.755638665429, 16322.0, 16332.0, 16339.83660163407, 6669.699863506057, 6738.663066846736, 6932.792016239521, 6983.336583024605, 7015.333543313479, 3880.359740642819, 3923.431102490123, 3963.841446342172, 3971.225611005826, 4006.1587066715733, 2956.7191116843865, 2968.079895232485, 2971.539411391238, 2973.3904549567287, 2986.163874115251, 534.5696714145073, 539.8110661268524, 561.4329527177498, 563.0653115827706, 565.3498476751769, 448.6679856905866, 567.6820980251073, 567.9772809087673, 567.9943200568024, 568.8520984543966, 8122.537943170286, 8184.6316915738935, 8366.205210504992, 8410.705625303084, 8525.57372131391, 629.2920464477463, 641.1184621145925, 648.3192647719875, 669.5045666206972, 681.9011243369683, 3894.980525097413, 3895.14306852492, 3898.766074035567, 3965.643092121723, 4043.0700938784244, 53784.73107634515, 54366.0, 54368.18447723287, 54475.727621362435, 54618.45381546213, 46365.30452043222, 46545.534544654794, 46918.296225556645, 46967.0, 47006.5299347009, 41849.37225941613, 42194.0, 42429.57570424318, 42534.787326063175, 42678.14643707108, 7878.290953814184, 7944.364450843803, 8090.757277281691, 8220.671173153007, 8238.50568965864, 30153.246168845955, 31754.841225793723, 32453.18867028249, 32459.0, 32702.182445438102, 40929.0, 41399.0, 41835.7908210457, 42462.363064553436, 42692.0, 9639.180669642878, 9693.0, 9764.560594773395, 9784.461854598065, 9814.165795907427, 10666.253362264877, 10738.516766745359, 10844.132469402586, 10932.453377331261, 11152.275102118336, 10099.596016159565, 10111.595536178766, 10387.324823886423, 10394.532246048795, 10574.577016919546, 9104.226140778108, 9210.815783684422, 9299.02360252191, 9664.0, 9879.0, 9918.454485003105, 9935.354201977138, 9973.60105595768, 10025.398476091457, 10599.62901298451, 8686.305095592212, 8717.65129394817, 8766.474011559327, 8971.551422428984, 9071.455712657262, 8638.26574741129, 8708.56457177126, 8940.061293564082, 9885.85171222418, 10107.89892101099], "unit": "score", "name": "yui.html", "value": 5877.005924682711}], "name": "dromaeo_css", "value": 6383.04409441307}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 113.0, 116.0, 111.0, 101.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [162.0, 130.0, 161.0, 167.0, 140.0, 156.0, 162.0, 131.0, 175.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 163.0, 161.0, 163.0, 161.0, 160.0, 160.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 100.0, 100.0, 74.0, 73.0, 74.0, 110.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 140.0, 94.0, 94.0, 93.0, 136.0, 94.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 63.0, 63.0, 64.0, 64.0, 73.0, 63.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 83.0, 81.0, 85.0, 84.0, 83.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [117.0, 131.0, 124.0, 117.0, 119.0, 128.0, 118.0, 126.0, 117.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [142.0, 136.0, 143.0, 142.0, 155.0, 134.0, 143.0, 140.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 67.0, 69.0, 69.0, 66.0, 67.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1516.3999999999999}]} 17:28:38 INFO - Return code: 0 17:28:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:28:38 ERROR - # TBPL SUCCESS # 17:28:38 INFO - Running post-action listener: _resource_record_post_action 17:28:38 INFO - Running post-run listener: _resource_record_post_run 17:28:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 520560640; Read time: 0; Write time: 352956 17:28:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233086976; Read time: 0; Write time: 197068 17:28:39 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 287473664; Read time: 0; Write time: 155888 17:28:39 INFO - Running post-run listener: _upload_blobber_files 17:28:39 INFO - Blob upload gear active. 17:28:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:39 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 17:28:39 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'] 17:28:39 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 17:28:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:28:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:41 INFO - (blobuploader) - INFO - Done attempting. 17:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:43 INFO - (blobuploader) - INFO - Done attempting. 17:28:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:43 INFO - Return code: 0 17:28:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5a8d5eab3f5b2999503014538602ce61aac3fee6a322cb8f8993c4db8d450aabb06d8a91b8f636ab7c9c2f5330867c0b4fc37a05232e27e8ca57b8c65987940", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a541ac3a2dff789227ad36e3229d1b7a5119671b03eefa479c349706e193b8169d40eb15d83c118e8abbdb28f12f29dd8212d59e6d70045742dfa33240167e7"} 17:28:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:43 INFO - Contents: 17:28:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5a8d5eab3f5b2999503014538602ce61aac3fee6a322cb8f8993c4db8d450aabb06d8a91b8f636ab7c9c2f5330867c0b4fc37a05232e27e8ca57b8c65987940", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a541ac3a2dff789227ad36e3229d1b7a5119671b03eefa479c349706e193b8169d40eb15d83c118e8abbdb28f12f29dd8212d59e6d70045742dfa33240167e7"} 17:28:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:43 INFO - Copying logs to upload dir... 17:28:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.245349 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-25 17:28:41.882749) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 17:28:41.887771) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 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/d5a8d5eab3f5b2999503014538602ce61aac3fee6a322cb8f8993c4db8d450aabb06d8a91b8f636ab7c9c2f5330867c0b4fc37a05232e27e8ca57b8c65987940", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a541ac3a2dff789227ad36e3229d1b7a5119671b03eefa479c349706e193b8169d40eb15d83c118e8abbdb28f12f29dd8212d59e6d70045742dfa33240167e7"} build_url:https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/YELyz3QCTfiXwkzP3zmvDA/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/d5a8d5eab3f5b2999503014538602ce61aac3fee6a322cb8f8993c4db8d450aabb06d8a91b8f636ab7c9c2f5330867c0b4fc37a05232e27e8ca57b8c65987940", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a541ac3a2dff789227ad36e3229d1b7a5119671b03eefa479c349706e193b8169d40eb15d83c118e8abbdb28f12f29dd8212d59e6d70045742dfa33240167e7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 17:28:41.929483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:28:41.929799) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458949397.422267-1874503665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004735 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:28:42.029721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 17:28:42.030030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 17:28:42.030373) ========= ========= Total master_lag: 0.31 =========