builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1459201149.8 results: success (0) buildid: 20160328130938 builduid: 103553cdf13b4cf9b2fb740cac259b6e revision: f40c52c4b8005e98065133bf4baaa33b5ca62084 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.797229) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.797707) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.798023) ========= 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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006381 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.821843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.822163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.835728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.836119) ========= 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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.885913) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.886322) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.886729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:09.887050) ========= 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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 14:39:10-- 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% 95.6M=0s 2016-03-28 14:39:11 (95.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.210416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.110620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.110946) ========= 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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014397 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.162699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.163057) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f40c52c4b8005e98065133bf4baaa33b5ca62084 --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 f40c52c4b8005e98065133bf4baaa33b5ca62084 --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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 14:39:11,221 truncating revision to first 12 chars 2016-03-28 14:39:11,221 Setting DEBUG logging. 2016-03-28 14:39:11,222 attempt 1/10 2016-03-28 14:39:11,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f40c52c4b800?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 14:39:11,503 unpacking tar archive at: fx-team-f40c52c4b800/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538652 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.717733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.718085) ========= echo f40c52c4b8005e98065133bf4baaa33b5ca62084 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f40c52c4b8005e98065133bf4baaa33b5ca62084'] 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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f40c52c4b8005e98065133bf4baaa33b5ca62084 program finished with exit code 0 elapsedTime=0.004719 script_repo_revision: 'f40c52c4b8005e98065133bf4baaa33b5ca62084' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.773326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.774054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 14:39:10.785740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-28 14:39:10.786020) ========= /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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:11 INFO - MultiFileLogger online at 20160328 14:39:11 in /builds/slave/test 14:39:11 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 14:39:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:11 INFO - {'append_to_log': False, 14:39:11 INFO - 'base_work_dir': '/builds/slave/test', 14:39:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:39:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:11 INFO - 'branch': 'Fx-Team-Non-PGO', 14:39:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:11 INFO - 'config_files': ('talos/linux_config.py',), 14:39:11 INFO - 'default_actions': ('clobber', 14:39:11 INFO - 'read-buildbot-config', 14:39:11 INFO - 'download-and-extract', 14:39:11 INFO - 'populate-webroot', 14:39:11 INFO - 'create-virtualenv', 14:39:11 INFO - 'install', 14:39:11 INFO - 'run-tests'), 14:39:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:11 INFO - 'download_minidump_stackwalk': True, 14:39:11 INFO - 'download_symbols': 'ondemand', 14:39:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:11 INFO - 'installer_path': 'installer.exe', 14:39:11 INFO - 'log_level': 'info', 14:39:11 INFO - 'log_name': 'talos', 14:39:11 INFO - 'log_to_console': True, 14:39:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:11 INFO - 'opt_config_files': (), 14:39:11 INFO - 'pip_index': False, 14:39:11 INFO - 'sps_profile': False, 14:39:11 INFO - 'sps_profile_interval': 0, 14:39:11 INFO - 'suite': 'dromaeojs', 14:39:11 INFO - 'system_bits': '32', 14:39:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:11 INFO - 'title': 'talos-linux64-ix-035', 14:39:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:11 INFO - 'use_talos_json': True, 14:39:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:11 INFO - 'work_dir': 'build'} 14:39:11 INFO - ##### 14:39:11 INFO - ##### Running clobber step. 14:39:11 INFO - ##### 14:39:11 INFO - Running pre-action listener: _resource_record_pre_action 14:39:11 INFO - Running main action method: clobber 14:39:11 INFO - rmtree: /builds/slave/test/build 14:39:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:12 INFO - Running post-action listener: _resource_record_post_action 14:39:12 INFO - ##### 14:39:12 INFO - ##### Running read-buildbot-config step. 14:39:12 INFO - ##### 14:39:12 INFO - Running pre-action listener: _resource_record_pre_action 14:39:12 INFO - Running main action method: read_buildbot_config 14:39:12 INFO - Using buildbot properties: 14:39:12 INFO - { 14:39:12 INFO - "project": "", 14:39:12 INFO - "product": "firefox", 14:39:12 INFO - "script_repo_revision": "production", 14:39:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:39:12 INFO - "repository": "", 14:39:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:39:12 INFO - "buildid": "20160328130938", 14:39:12 INFO - "pgo_build": "False", 14:39:12 INFO - "basedir": "/builds/slave/test", 14:39:12 INFO - "buildnumber": 1578, 14:39:12 INFO - "slavename": "talos-linux64-ix-035", 14:39:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:39:12 INFO - "platform": "ubuntu64_hw", 14:39:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:39:12 INFO - "branch": "fx-team", 14:39:12 INFO - "repo_path": "integration/fx-team", 14:39:12 INFO - "revision": "f40c52c4b8005e98065133bf4baaa33b5ca62084", 14:39:12 INFO - "stage_platform": "linux64", 14:39:12 INFO - "builduid": "103553cdf13b4cf9b2fb740cac259b6e", 14:39:12 INFO - "slavebuilddir": "test" 14:39:12 INFO - } 14:39:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:39:12 INFO - Running post-action listener: _resource_record_post_action 14:39:12 INFO - ##### 14:39:12 INFO - ##### Running download-and-extract step. 14:39:12 INFO - ##### 14:39:12 INFO - Running pre-action listener: _resource_record_pre_action 14:39:12 INFO - Running main action method: download_and_extract 14:39:12 INFO - mkdir: /builds/slave/test/build/tests 14:39:12 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')]} 14:39:12 INFO - https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:39:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:39:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:39:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:13 INFO - Downloaded 1361 bytes. 14:39:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:39:13 INFO - Using the following test package requirements: 14:39:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:39:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'jsshell-linux-x86_64.zip'], 14:39:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:39:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:39:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:13 INFO - https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:39:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:39:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:15 INFO - Downloaded 22085591 bytes. 14:39:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:39:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:39:16 INFO - Return code: 0 14:39:16 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 14:39:16 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')]} 14:39:16 INFO - https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:39:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:39:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:18 INFO - Downloaded 22085591 bytes. 14:39:18 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'] 14:39:18 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 14:39:19 INFO - Return code: 0 14:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:19 INFO - https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:39:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:39:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:39:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:21 INFO - Downloaded 10847531 bytes. 14:39:21 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'] 14:39:21 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 14:39:21 INFO - Return code: 0 14:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:21 INFO - https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:39:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:39:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:39:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AaFiIJTPTfOT-SANSnHWHA/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 14:39:24 INFO - Downloaded 54254466 bytes. 14:39:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:39:24 INFO - mkdir: /builds/slave/test/properties 14:39:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:24 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:24 INFO - Contents: 14:39:24 INFO - build_url:https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:39:25 INFO - Running post-action listener: _resource_record_post_action 14:39:25 INFO - Running post-action listener: set_extra_try_arguments 14:39:25 INFO - ##### 14:39:25 INFO - ##### Running populate-webroot step. 14:39:25 INFO - ##### 14:39:25 INFO - Running pre-action listener: _resource_record_pre_action 14:39:25 INFO - Running main action method: populate_webroot 14:39:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:25 INFO - '--tppagecycles', 14:39:25 INFO - '7'], 14:39:25 INFO - 'tests': ['tsvgm']}}, 14:39:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:39:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:39:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'tests': ['damp', 'tps']}, 14:39:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['damp', 'tps']}, 14:39:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:39:25 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['dromaeo_dom']}, 14:39:25 INFO - 'other': {'tests': ['a11yr', 14:39:25 INFO - 'ts_paint', 14:39:25 INFO - 'tpaint', 14:39:25 INFO - 'sessionrestore', 14:39:25 INFO - 'sessionrestore_no_auto_restore', 14:39:25 INFO - 'tabpaint']}, 14:39:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['a11yr', 14:39:25 INFO - 'ts_paint', 14:39:25 INFO - 'tpaint', 14:39:25 INFO - 'sessionrestore', 14:39:25 INFO - 'sessionrestore_no_auto_restore', 14:39:25 INFO - 'tabpaint']}, 14:39:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['a11yr', 14:39:25 INFO - 'ts_paint', 14:39:25 INFO - 'tpaint', 14:39:25 INFO - 'sessionrestore', 14:39:25 INFO - 'sessionrestore_no_auto_restore', 14:39:25 INFO - 'tabpaint']}, 14:39:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['a11yr', 14:39:25 INFO - 'ts_paint', 14:39:25 INFO - 'tpaint', 14:39:25 INFO - 'sessionrestore', 14:39:25 INFO - 'sessionrestore_no_auto_restore', 14:39:25 INFO - 'tabpaint']}, 14:39:25 INFO - 'other_l64': {'tests': ['a11yr', 14:39:25 INFO - 'ts_paint', 14:39:25 INFO - 'tpaint', 14:39:25 INFO - 'sessionrestore', 14:39:25 INFO - 'sessionrestore_no_auto_restore', 14:39:25 INFO - 'tabpaint']}, 14:39:25 INFO - 'other_nol64': {'tests': ['a11yr', 14:39:25 INFO - 'ts_paint', 14:39:25 INFO - 'tpaint', 14:39:25 INFO - 'sessionrestore', 14:39:25 INFO - 'sessionrestore_no_auto_restore', 14:39:25 INFO - 'tabpaint']}, 14:39:25 INFO - 'svgr': {'tests': ['tsvgx', 14:39:25 INFO - 'tsvgr_opacity', 14:39:25 INFO - 'tart', 14:39:25 INFO - 'tscrollx', 14:39:25 INFO - 'cart']}, 14:39:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['tsvgx', 14:39:25 INFO - 'tsvgr_opacity', 14:39:25 INFO - 'tart', 14:39:25 INFO - 'tscrollx', 14:39:25 INFO - 'cart']}, 14:39:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'tests': ['tp5o']}, 14:39:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'talos_options': ['--e10s'], 14:39:25 INFO - 'tests': ['tp5o']}, 14:39:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'talos_options': ['--xperf_path', 14:39:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:25 INFO - 'tests': ['tp5n']}, 14:39:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:25 INFO - 'talos_options': ['--e10s', 14:39:25 INFO - '--xperf_path', 14:39:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:25 INFO - 'tests': ['tp5n']}}, 14:39:25 INFO - 'talos.zip': {'path': '', 14:39:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:25 INFO - Running post-action listener: _resource_record_post_action 14:39:25 INFO - ##### 14:39:25 INFO - ##### Running create-virtualenv step. 14:39:25 INFO - ##### 14:39:25 INFO - Running pre-action listener: _resource_record_pre_action 14:39:25 INFO - Running main action method: create_virtualenv 14:39:25 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:25 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 14:39:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:25 INFO - Using real prefix '/usr' 14:39:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:25 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:27 INFO - Installing pip.................done. 14:39:27 INFO - Return code: 0 14:39:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:27 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')]} 14:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:27 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')]} 14:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:27 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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:27 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 14:39:27 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 14:39:27 INFO - Using env: {'DISPLAY': ':0', 14:39:27 INFO - 'HOME': '/home/cltbld', 14:39:27 INFO - 'LANG': 'en_US.UTF-8', 14:39:27 INFO - 'LANGUAGE': 'en_US:en', 14:39:27 INFO - 'LOGNAME': 'cltbld', 14:39:27 INFO - 'MAIL': '/var/mail/cltbld', 14:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:27 INFO - 'MOZ_NO_REMOTE': '1', 14:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:27 INFO - 'NO_EM_RESTART': '1', 14:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:27 INFO - 'PWD': '/builds/slave/test', 14:39:27 INFO - 'SHELL': '/bin/bash', 14:39:27 INFO - 'SHLVL': '1', 14:39:27 INFO - 'TERM': 'linux', 14:39:27 INFO - 'TMOUT': '86400', 14:39:27 INFO - 'USER': 'cltbld', 14:39:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:27 INFO - '_': '/tools/buildbot/bin/python'} 14:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:28 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 14:39:28 INFO - Cleaning up... 14:39:28 INFO - Return code: 0 14:39:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:28 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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:28 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 14:39:28 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 14:39:28 INFO - Using env: {'DISPLAY': ':0', 14:39:28 INFO - 'HOME': '/home/cltbld', 14:39:28 INFO - 'LANG': 'en_US.UTF-8', 14:39:28 INFO - 'LANGUAGE': 'en_US:en', 14:39:28 INFO - 'LOGNAME': 'cltbld', 14:39:28 INFO - 'MAIL': '/var/mail/cltbld', 14:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:28 INFO - 'MOZ_NO_REMOTE': '1', 14:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:28 INFO - 'NO_EM_RESTART': '1', 14:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:28 INFO - 'PWD': '/builds/slave/test', 14:39:28 INFO - 'SHELL': '/bin/bash', 14:39:28 INFO - 'SHLVL': '1', 14:39:28 INFO - 'TERM': 'linux', 14:39:28 INFO - 'TMOUT': '86400', 14:39:28 INFO - 'USER': 'cltbld', 14:39:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:28 INFO - '_': '/tools/buildbot/bin/python'} 14:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:28 INFO - Downloading/unpacking psutil>=0.7.1 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:30 INFO - Installing collected packages: psutil 14:39:30 INFO - Running setup.py install for psutil 14:39:30 INFO - building 'psutil._psutil_linux' extension 14:39:30 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 14:39:30 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 14:39:30 INFO - building 'psutil._psutil_posix' extension 14:39:30 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 14:39:30 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 14:39:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:30 INFO - Successfully installed psutil 14:39:30 INFO - Cleaning up... 14:39:31 INFO - Return code: 0 14:39:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:39:31 INFO - Using env: {'DISPLAY': ':0', 14:39:31 INFO - 'HOME': '/home/cltbld', 14:39:31 INFO - 'LANG': 'en_US.UTF-8', 14:39:31 INFO - 'LANGUAGE': 'en_US:en', 14:39:31 INFO - 'LOGNAME': 'cltbld', 14:39:31 INFO - 'MAIL': '/var/mail/cltbld', 14:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:31 INFO - 'MOZ_NO_REMOTE': '1', 14:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:31 INFO - 'NO_EM_RESTART': '1', 14:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:31 INFO - 'PWD': '/builds/slave/test', 14:39:31 INFO - 'SHELL': '/bin/bash', 14:39:31 INFO - 'SHLVL': '1', 14:39:31 INFO - 'TERM': 'linux', 14:39:31 INFO - 'TMOUT': '86400', 14:39:31 INFO - 'USER': 'cltbld', 14:39:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:31 INFO - '_': '/tools/buildbot/bin/python'} 14:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:39:31 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 14:39:31 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 14:39:31 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 14:39:31 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 14:39:31 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 14:39:31 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 14:39:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:39:33 INFO - Installing collected packages: mozsystemmonitor 14:39:33 INFO - Running setup.py install for mozsystemmonitor 14:39:33 INFO - Successfully installed mozsystemmonitor 14:39:33 INFO - Cleaning up... 14:39:33 INFO - Return code: 0 14:39:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:33 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')]} 14:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:33 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')]} 14:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:33 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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:33 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 14:39:33 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 14:39:33 INFO - Using env: {'DISPLAY': ':0', 14:39:33 INFO - 'HOME': '/home/cltbld', 14:39:33 INFO - 'LANG': 'en_US.UTF-8', 14:39:33 INFO - 'LANGUAGE': 'en_US:en', 14:39:33 INFO - 'LOGNAME': 'cltbld', 14:39:33 INFO - 'MAIL': '/var/mail/cltbld', 14:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:33 INFO - 'MOZ_NO_REMOTE': '1', 14:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:33 INFO - 'NO_EM_RESTART': '1', 14:39:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:33 INFO - 'PWD': '/builds/slave/test', 14:39:33 INFO - 'SHELL': '/bin/bash', 14:39:33 INFO - 'SHLVL': '1', 14:39:33 INFO - 'TERM': 'linux', 14:39:33 INFO - 'TMOUT': '86400', 14:39:33 INFO - 'USER': 'cltbld', 14:39:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:33 INFO - '_': '/tools/buildbot/bin/python'} 14:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:33 INFO - Downloading/unpacking blobuploader==1.2.4 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:35 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:35 INFO - Downloading docopt-0.6.1.tar.gz 14:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:36 INFO - Running setup.py install for blobuploader 14:39:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:36 INFO - Running setup.py install for requests 14:39:36 INFO - Running setup.py install for docopt 14:39:36 INFO - Successfully installed blobuploader requests docopt 14:39:36 INFO - Cleaning up... 14:39:36 INFO - Return code: 0 14:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:36 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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:36 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 14:39:36 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 14:39:36 INFO - Using env: {'DISPLAY': ':0', 14:39:36 INFO - 'HOME': '/home/cltbld', 14:39:36 INFO - 'LANG': 'en_US.UTF-8', 14:39:36 INFO - 'LANGUAGE': 'en_US:en', 14:39:36 INFO - 'LOGNAME': 'cltbld', 14:39:36 INFO - 'MAIL': '/var/mail/cltbld', 14:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:36 INFO - 'MOZ_NO_REMOTE': '1', 14:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:36 INFO - 'NO_EM_RESTART': '1', 14:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:36 INFO - 'PWD': '/builds/slave/test', 14:39:36 INFO - 'SHELL': '/bin/bash', 14:39:36 INFO - 'SHLVL': '1', 14:39:36 INFO - 'TERM': 'linux', 14:39:36 INFO - 'TMOUT': '86400', 14:39:36 INFO - 'USER': 'cltbld', 14:39:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:36 INFO - '_': '/tools/buildbot/bin/python'} 14:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:36 INFO - Running setup.py (path:/tmp/pip-w38Oz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:36 INFO - Running setup.py (path:/tmp/pip-V29SwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:36 INFO - Running setup.py (path:/tmp/pip-sx2hgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:37 INFO - Running setup.py (path:/tmp/pip-BbWl0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:37 INFO - Running setup.py (path:/tmp/pip-DvD5ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:37 INFO - Running setup.py (path:/tmp/pip-rPlaWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:37 INFO - Running setup.py (path:/tmp/pip-0XtTgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:37 INFO - Running setup.py (path:/tmp/pip-mYsNXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:37 INFO - Running setup.py (path:/tmp/pip-Rcfmux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:37 INFO - Running setup.py (path:/tmp/pip-wY3u_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:37 INFO - Running setup.py (path:/tmp/pip-e944FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:37 INFO - Running setup.py (path:/tmp/pip-ioHytw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:37 INFO - Running setup.py (path:/tmp/pip-IXcC8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:37 INFO - Running setup.py (path:/tmp/pip-cgyhHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:37 INFO - Running setup.py (path:/tmp/pip-uvlzF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:37 INFO - Running setup.py (path:/tmp/pip-IZhIAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:38 INFO - Running setup.py (path:/tmp/pip-QDQuO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:38 INFO - Running setup.py install for manifestparser 14:39:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozcrash 14:39:38 INFO - Running setup.py install for mozdebug 14:39:38 INFO - Running setup.py install for mozdevice 14:39:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozfile 14:39:38 INFO - Running setup.py install for mozhttpd 14:39:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozinfo 14:39:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozInstall 14:39:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:38 INFO - Running setup.py install for mozleak 14:39:38 INFO - Running setup.py install for mozlog 14:39:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for moznetwork 14:39:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for mozprocess 14:39:39 INFO - Running setup.py install for mozprofile 14:39:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for mozrunner 14:39:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Running setup.py install for mozscreenshot 14:39:39 INFO - Running setup.py install for moztest 14:39:39 INFO - Running setup.py install for mozversion 14:39:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:39 INFO - Cleaning up... 14:39:39 INFO - Return code: 0 14:39:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:39 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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:39 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 14:39:39 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 14:39:39 INFO - Using env: {'DISPLAY': ':0', 14:39:39 INFO - 'HOME': '/home/cltbld', 14:39:39 INFO - 'LANG': 'en_US.UTF-8', 14:39:39 INFO - 'LANGUAGE': 'en_US:en', 14:39:39 INFO - 'LOGNAME': 'cltbld', 14:39:39 INFO - 'MAIL': '/var/mail/cltbld', 14:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:39 INFO - 'MOZ_NO_REMOTE': '1', 14:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:39 INFO - 'NO_EM_RESTART': '1', 14:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:39 INFO - 'PWD': '/builds/slave/test', 14:39:39 INFO - 'SHELL': '/bin/bash', 14:39:39 INFO - 'SHLVL': '1', 14:39:39 INFO - 'TERM': 'linux', 14:39:39 INFO - 'TMOUT': '86400', 14:39:39 INFO - 'USER': 'cltbld', 14:39:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:39 INFO - '_': '/tools/buildbot/bin/python'} 14:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:40 INFO - Running setup.py (path:/tmp/pip-H6nITe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:40 INFO - Running setup.py (path:/tmp/pip-nJyW9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:40 INFO - Running setup.py (path:/tmp/pip-BtnNJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:40 INFO - Running setup.py (path:/tmp/pip-Ml3mEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:40 INFO - Running setup.py (path:/tmp/pip-4uTkq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:40 INFO - Running setup.py (path:/tmp/pip-lHvWsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:40 INFO - Running setup.py (path:/tmp/pip-UhhgN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:40 INFO - Running setup.py (path:/tmp/pip-SJ1ZuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:40 INFO - Running setup.py (path:/tmp/pip-xw3g2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:40 INFO - Running setup.py (path:/tmp/pip-dwuWqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:40 INFO - Running setup.py (path:/tmp/pip-F4yh9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:40 INFO - Running setup.py (path:/tmp/pip-LUFbU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:40 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)) 14:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:40 INFO - Running setup.py (path:/tmp/pip-7ArLTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:41 INFO - Running setup.py (path:/tmp/pip-doOwbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:41 INFO - Running setup.py (path:/tmp/pip-EMk3eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:41 INFO - Running setup.py (path:/tmp/pip-EGaDN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:41 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)) 14:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:41 INFO - Running setup.py (path:/tmp/pip-jykifY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:41 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)) 14:39:41 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)) 14:39:41 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)) 14:39:41 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)) 14:39:41 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)) 14:39:41 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)) 14:39:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:43 INFO - Downloading blessings-1.6.tar.gz 14:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:43 INFO - Installing collected packages: blessings 14:39:43 INFO - Running setup.py install for blessings 14:39:43 INFO - Successfully installed blessings 14:39:43 INFO - Cleaning up... 14:39:43 INFO - Return code: 0 14:39:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:39:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:43 INFO - Reading from file tmpfile_stdout 14:39:43 INFO - Current package versions: 14:39:43 INFO - argparse == 1.2.1 14:39:43 INFO - blessings == 1.6 14:39:43 INFO - blobuploader == 1.2.4 14:39:43 INFO - docopt == 0.6.1 14:39:43 INFO - manifestparser == 1.1 14:39:43 INFO - mozInstall == 1.12 14:39:43 INFO - mozcrash == 0.17 14:39:43 INFO - mozdebug == 0.1 14:39:43 INFO - mozdevice == 0.48 14:39:43 INFO - mozfile == 1.2 14:39:43 INFO - mozhttpd == 0.7 14:39:43 INFO - mozinfo == 0.9 14:39:43 INFO - mozleak == 0.1 14:39:43 INFO - mozlog == 3.1 14:39:43 INFO - moznetwork == 0.27 14:39:43 INFO - mozprocess == 0.22 14:39:43 INFO - mozprofile == 0.28 14:39:43 INFO - mozrunner == 6.11 14:39:43 INFO - mozscreenshot == 0.1 14:39:43 INFO - mozsystemmonitor == 0.0 14:39:43 INFO - moztest == 0.7 14:39:43 INFO - mozversion == 1.4 14:39:43 INFO - psutil == 3.1.1 14:39:43 INFO - requests == 1.2.3 14:39:43 INFO - wsgiref == 0.1.2 14:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:43 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 14:39:43 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 14:39:43 INFO - Using env: {'DISPLAY': ':0', 14:39:43 INFO - 'HOME': '/home/cltbld', 14:39:43 INFO - 'LANG': 'en_US.UTF-8', 14:39:43 INFO - 'LANGUAGE': 'en_US:en', 14:39:43 INFO - 'LOGNAME': 'cltbld', 14:39:43 INFO - 'MAIL': '/var/mail/cltbld', 14:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:43 INFO - 'MOZ_NO_REMOTE': '1', 14:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:43 INFO - 'NO_EM_RESTART': '1', 14:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:43 INFO - 'PWD': '/builds/slave/test', 14:39:43 INFO - 'SHELL': '/bin/bash', 14:39:43 INFO - 'SHLVL': '1', 14:39:43 INFO - 'TERM': 'linux', 14:39:43 INFO - 'TMOUT': '86400', 14:39:43 INFO - 'USER': 'cltbld', 14:39:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:43 INFO - '_': '/tools/buildbot/bin/python'} 14:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 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)) 14:39:44 INFO - Cleaning up... 14:39:44 INFO - Return code: 0 14:39:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:39:44 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')]} 14:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 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')]} 14:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 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 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:44 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 14:39:44 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 14:39:44 INFO - Using env: {'DISPLAY': ':0', 14:39:44 INFO - 'HOME': '/home/cltbld', 14:39:44 INFO - 'LANG': 'en_US.UTF-8', 14:39:44 INFO - 'LANGUAGE': 'en_US:en', 14:39:44 INFO - 'LOGNAME': 'cltbld', 14:39:44 INFO - 'MAIL': '/var/mail/cltbld', 14:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:44 INFO - 'MOZ_NO_REMOTE': '1', 14:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:44 INFO - 'NO_EM_RESTART': '1', 14:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:44 INFO - 'PWD': '/builds/slave/test', 14:39:44 INFO - 'SHELL': '/bin/bash', 14:39:44 INFO - 'SHLVL': '1', 14:39:44 INFO - 'TERM': 'linux', 14:39:44 INFO - 'TMOUT': '86400', 14:39:44 INFO - 'USER': 'cltbld', 14:39:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:44 INFO - '_': '/tools/buildbot/bin/python'} 14:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:44 INFO - Downloading/unpacking jsonschema 14:39:44 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 14:39:44 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 14:39:44 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 14:39:44 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 14:39:44 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 14:39:44 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 14:39:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:46 INFO - Downloading/unpacking functools32 (from jsonschema) 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:46 INFO - warning: no files found matching '*.txt' 14:39:46 INFO - no previously-included directories found matching 'build' 14:39:46 INFO - no previously-included directories found matching 'dist' 14:39:46 INFO - no previously-included directories found matching '.git*' 14:39:46 INFO - Installing collected packages: jsonschema, functools32 14:39:46 INFO - Running setup.py install for functools32 14:39:46 INFO - warning: no files found matching '*.txt' 14:39:46 INFO - no previously-included directories found matching 'build' 14:39:46 INFO - no previously-included directories found matching 'dist' 14:39:46 INFO - no previously-included directories found matching '.git*' 14:39:46 INFO - Successfully installed jsonschema functools32 14:39:46 INFO - Cleaning up... 14:39:46 INFO - Return code: 0 14:39:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a9b89bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21027d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', '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 14:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:39:46 INFO - Using env: {'DISPLAY': ':0', 14:39:46 INFO - 'HOME': '/home/cltbld', 14:39:46 INFO - 'LANG': 'en_US.UTF-8', 14:39:46 INFO - 'LANGUAGE': 'en_US:en', 14:39:46 INFO - 'LOGNAME': 'cltbld', 14:39:46 INFO - 'MAIL': '/var/mail/cltbld', 14:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:46 INFO - 'MOZ_NO_REMOTE': '1', 14:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:46 INFO - 'NO_EM_RESTART': '1', 14:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:46 INFO - 'PWD': '/builds/slave/test', 14:39:46 INFO - 'SHELL': '/bin/bash', 14:39:46 INFO - 'SHLVL': '1', 14:39:46 INFO - 'TERM': 'linux', 14:39:46 INFO - 'TMOUT': '86400', 14:39:46 INFO - 'USER': 'cltbld', 14:39:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:46 INFO - '_': '/tools/buildbot/bin/python'} 14:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:47 INFO - Downloading/unpacking flake8 14:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:39:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:39:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:49 INFO - no previously-included directories found matching 'docs/_build' 14:39:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:39:49 INFO - Running setup.py install for pep8 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:49 INFO - no previously-included directories found matching 'docs/_build' 14:39:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:39:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:39:49 INFO - Cleaning up... 14:39:49 INFO - Return code: 0 14:39:49 INFO - Running post-action listener: _resource_record_post_action 14:39:49 INFO - Running post-action listener: _start_resource_monitoring 14:39:49 INFO - Starting resource monitoring. 14:39:49 INFO - ##### 14:39:49 INFO - ##### Running install step. 14:39:49 INFO - ##### 14:39:49 INFO - Running pre-action listener: _resource_record_pre_action 14:39:49 INFO - Running main action method: install 14:39:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:50 INFO - Reading from file tmpfile_stdout 14:39:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:50 INFO - Reading from file tmpfile_stdout 14:39:50 INFO - Output received: 14:39:50 INFO - Usage: mozinstall [options] installer 14:39:50 INFO - Options: 14:39:50 INFO - -h, --help show this help message and exit 14:39:50 INFO - -d DEST, --destination=DEST 14:39:50 INFO - Directory to install application into. [default: 14:39:50 INFO - "/builds/slave/test"] 14:39:50 INFO - --app=APP Application being installed. [default: firefox] 14:39:50 INFO - mkdir: /builds/slave/test/build/application 14:39:50 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'] 14:39:50 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 14:40:05 INFO - Reading from file tmpfile_stdout 14:40:05 INFO - Output received: 14:40:05 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:05 INFO - Running post-action listener: _resource_record_post_action 14:40:05 INFO - ##### 14:40:05 INFO - ##### Running run-tests step. 14:40:05 INFO - ##### 14:40:05 INFO - Running pre-action listener: _resource_record_pre_action 14:40:05 INFO - Running main action method: run_tests 14:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:05 INFO - Python 2.7.3 14:40:05 INFO - Return code: 0 14:40:05 INFO - grabbing minidump binary from tooltool 14:40: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')]} 14:40:05 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 0x2191640>, '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 0x2192540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21929d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:05 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 14:40:05 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 14:40:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:05 INFO - Return code: 0 14:40:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:40:06 INFO - Return code: 0 14:40:06 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/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 14:40:06 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/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 14:40:06 INFO - Using env: {'DISPLAY': ':0', 14:40:06 INFO - 'HOME': '/home/cltbld', 14:40:06 INFO - 'LANG': 'en_US.UTF-8', 14:40:06 INFO - 'LANGUAGE': 'en_US:en', 14:40:06 INFO - 'LOGNAME': 'cltbld', 14:40:06 INFO - 'MAIL': '/var/mail/cltbld', 14:40:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:06 INFO - 'MOZ_NO_REMOTE': '1', 14:40:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:06 INFO - 'NO_EM_RESTART': '1', 14:40:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:06 INFO - 'PWD': '/builds/slave/test', 14:40:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:06 INFO - 'SHELL': '/bin/bash', 14:40:06 INFO - 'SHLVL': '1', 14:40:06 INFO - 'TERM': 'linux', 14:40:06 INFO - 'TMOUT': '86400', 14:40:06 INFO - 'USER': 'cltbld', 14:40:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963', 14:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:06 INFO - '_': '/tools/buildbot/bin/python'} 14:40:06 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/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 14:40:07 INFO - mozversion application_buildid: 20160328130938 14:40:07 INFO - mozversion application_changeset: f40c52c4b8005e98065133bf4baaa33b5ca62084 14:40:07 INFO - mozversion application_display_name: Nightly 14:40:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:07 INFO - mozversion application_name: Firefox 14:40:07 INFO - mozversion application_remotingname: firefox 14:40:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:40:07 INFO - mozversion application_vendor: Mozilla 14:40:07 INFO - mozversion application_version: 48.0a1 14:40:07 INFO - mozversion platform_buildid: 20160328130938 14:40:07 INFO - mozversion platform_changeset: f40c52c4b8005e98065133bf4baaa33b5ca62084 14:40:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:40:07 INFO - mozversion platform_version: 48.0a1 14:40:07 INFO - using testdate: 1459201207 14:40:07 INFO - actual date: 1459201207 14:40:07 INFO - starting webserver on 'localhost:52540' 14:40:07 INFO - SUITE-START | Running 2 tests 14:40:07 INFO - TEST-START | dromaeo_css 14:40:07 INFO - operating with platform_type : linux_ 14:40:07 INFO - Initialising browser for dromaeo_css test... 14:40:07 INFO - TEST-INFO | started process 21946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGAJNPv/profile http://localhost:52540/getInfo.html) 14:40:11 INFO - PROCESS | 21946 | __metrics Screen width/height:1600/1200 14:40:11 INFO - PROCESS | 21946 | colorDepth:24 14:40:11 INFO - PROCESS | 21946 | Browser inner width/height: 1024/697 14:40:11 INFO - PROCESS | 21946 | __metrics 14:40:12 ERROR - PROCESS | 21946 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:40:12 INFO - PROCESS | 21946 | 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. 14:40:13 INFO - TEST-INFO | 21946: exit 0 14:40:13 INFO - Browser initialized. 14:40:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:13 INFO - TEST-INFO | started process 22040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGAJNPv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:25 INFO - PROCESS | 22040 | RSS: Main: 154406912 14:40:25 INFO - PROCESS | 22040 | 14:41:16 INFO - PROCESS | 22040 | 1459201276182 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] 14:43:27 INFO - PROCESS | 22040 | Cycle 1(1): loaded http://localhost:52540/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52540/tests/dromaeo/cssquery-ext.html) 14:43:28 INFO - PROCESS | 22040 | RSS: Main: 235520000 14:43:28 INFO - PROCESS | 22040 | 14:46:31 INFO - PROCESS | 22040 | Cycle 1(1): loaded http://localhost:52540/tests/dromaeo/cssquery-ext.html (next: http://localhost:52540/tests/dromaeo/cssquery-jquery.html) 14:46:31 INFO - PROCESS | 22040 | RSS: Main: 230494208 14:46:31 INFO - PROCESS | 22040 | 14:49:33 INFO - PROCESS | 22040 | Cycle 1(1): loaded http://localhost:52540/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52540/tests/dromaeo/cssquery-mootools.html) 14:49:34 INFO - PROCESS | 22040 | RSS: Main: 232013824 14:49:34 INFO - PROCESS | 22040 | 14:52:36 INFO - PROCESS | 22040 | Cycle 1(1): loaded http://localhost:52540/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52540/tests/dromaeo/cssquery-prototype.html) 14:52:36 INFO - PROCESS | 22040 | RSS: Main: 218955776 14:52:36 INFO - PROCESS | 22040 | 14:55:39 INFO - PROCESS | 22040 | Cycle 1(1): loaded http://localhost:52540/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52540/tests/dromaeo/cssquery-yui.html) 14:55:39 INFO - PROCESS | 22040 | RSS: Main: 200224768 14:55:39 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | Cycle 1(1): loaded http://localhost:52540/tests/dromaeo/cssquery-yui.html (next: http://localhost:52540/tests/dromaeo/cssquery-dojo.html) 14:58:42 INFO - PROCESS | 22040 | RSS: Main: 270958592 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | __start_tp_report 14:58:42 INFO - PROCESS | 22040 | _x_x_mozilla_page_load 14:58:42 INFO - PROCESS | 22040 | _x_x_mozilla_page_load_details 14:58:42 INFO - PROCESS | 22040 | |i|pagename|runs| 14:58:42 INFO - PROCESS | 22040 | |0;dojo.html;2604.374950011997;2633.7102918678943;2644.457886133343;2650.4831557846214;2670.7996900232483;4536.500984891668;4595.724256544601;4597.287420449828;4599.103174880899;4614.676972611918;4598;4660.673752837302;4666.160091183586;4668.019715859665;4685.648576356778;4237.322028475444;4256.574342565742;4288.442502474674;4318.956810431887;4395.05506316142;4285.335772955197;4343;4356.520782713899;4363.825446982117;4389.978050109745;4198.811053502584;4225.3239481683095;4311.547287534827;4323.891902702458;4333.848315308949;4248.915021699549;4276.700630955835;4288.935665964982;4301.182775272689;4324.2648749712625;4278.069542275419;4286.507051689065;4288.378185163134;4318.892027699333;4326.978365108154;4394.824207031715;4436.866893993185;4543.8182472701055;4597.356370108188;4629.675922685414;4938.876528086791;4953.0589188054155;4958.231474121517;4963.4292056413615;5007.54932056113;4865.95134048662;4981.352424184833;4991.450940396553;4995.325631039799;4998.300237966688;4640.350350950869;4677.041206552649;4692.7653617319;4720.716756994591;4728.881777955578;5133.12736834739;5155.407128180307;5156.922646160236;5161.922571161435;5165.173572228426;4817.229243321122;4944.1100601891285;4946.530079642428;4946.530079642428;4992.201247800334;4987.251912213124;4996.075725990703;5027.949720502821;5033.043721692867;5061.645684802029;4917.385326834145;4937.23472861707;4937.851864444073;4944.060628480577;4978.402591688948;4751.52484751529;4890.266460031024;4917.7786999585105;4924.75376231187;4975.800967961313;4213.620774130343;4215.59951804578;4223.1975924574235;4239.194553034913;4245.532991370947;3604.459331100356;3609.1157666371905;3623.1123374772824;3647.6534729200685;3665.083729067733;4164.770937598461;4206.116715489781;4244.681648876347;4279.33670281107;4286.121345124242;5008.799648014038;5014.6991180529285;5020.623453241022;5027.2207807789855;5076.492350764894;4297.67767417445;4304.246756817607;4306.763128027926;4307.806148723315;4358.65130789536;4356.978215108904;4496.685232033727;4523.072770082125;4529.479109902338;4575.267957126844;4723.929141062956;4743.241081426955;4745.738984355894;4776.904461910743;4791.6406269529225;4981.153203955264;4990.176620857518;4992.900141997213;4993.900121997613;5028.069807085701;4536.931946020746;4702.482726900107;4708.858734237979;4760.714357138583;4778.354922085613;4825.638077144298;4839.322494850794;4850.733209673361;4852.296417019583;4901.240307752304;4952.8761780955765;4960;4960.206366981266;4965.45380008206;5014.824481143289;4656.3713898623255;4813.470518242921;4858.125537403302;4875.098106850244;4908.9263661045825;4794.808207671654;4819.7108173509705;4820.493848145894;4822.734749588806;4872.098661747588;4649.86050418488;4750.714957102585;4752.9049419010735;4766.7854946526795;4775.928361074517;4907.926381104215;4946.060248552763;4947.282644016669;4966.950330496793;5003.099442100457;4705.694129881546;4725.716457012591;4726.574608285271;4728.574428301469;4776.188048031912 14:58:42 INFO - PROCESS | 22040 | |1;ext.html;539.7948779463803;542.1001138110735;557.1892895836559;561.5788158880841;578.4967078641582;34229.315413691744;34821;34856.302873942535;34867;34963.4755478668;38008.42987355185;38417.80791096047;38505.22989540207;38527.42208866869;38586.42120368189;7553.962230188855;7755.728549500768;7790.065192176919;7804;7804.414668899827;7619.771406857803;7764.262395072487;7768.883466748003;7858.528488290693;7893.684252629888;7831.373490120776;7911.8417631647335;7913;7913.446058775888;7915.2084791520965;7813.531188128702;7870.606469676551;7884.408669349793;7894.447388682795;7900.091489478726;7685.5004424712215;7839.412044096659;7840.529568225925;7843.450958432855;7846.489978151402;38196.42705359422;38919.61080389188;39015;39019.60980390188;39119.80440097781;2791.916242512728;2847.145856243119;2938.397628486155;3023.1988523041414;3618.493410922473;29217;29770.255743606365;29795.10614681563;30133.849330753426;30934.84532577345;3506.964930350715;3522.7181825453904;3524.788512689247;3599.370110230699;3664.1022949377575;236178;239461;239525.99999999825;240883;240939;42547;53487.19769203465;53700.462995370326;53718;53742.73128634332;64191.358086418535;65294;65323.346766532675;65389.673051635385;65394.34605653882;15096.773548396783;15321.923390382977;15399.769003464957;15406.691866162613;15411.537653870178;10693.144548436107;11198.888011119785;11692.70768230801;11894.643160705193;11916.344601046852;20107.698384524243;20433.69349459759;20544.486387840425;20560.79439205619;20605;7049.400800931979;7293.9635301823155;7311.415086793044;7313.707451701979;7484.625768711543;867.6876324523166;886.9733907982771;918.3387960668308;925.0887875442684;932.7481579973505;25162.748372516406;25681.961467626083;25835.22494325173;26018.479630407284;26077.217683469527;976.4922240434934;989.9604015839429;992.5880759484733;1048.6434612231878;1052.3580615824342;14021.719565608631;14270.643233919234;14489.058211216237;14534.636634084232;14555.05392149507;287377;291080;291264;291800;291966.321347148;48658.27012594814;49174;49243;49421.25868111981;49476;1112.6328311657135;1247.2080229054616;1264.879836415539;1290.14205553306;1372.4373007067254;24092;28445;32145.678543215203;32267.51598725974;32383.676163238066;45893.54106458893;46164.307535386324;46656.7667161662;46676.53323466722;46749.2987605193;281766;284887;285726;285974;286654;34062.48906266358;40044.59955400409;41605.1678966425;41653.375199371425;41782.37326440045;36954.63045369512;37879.43180852234;38225.61774382332;38384.42423363707;45254.54745452635;32252;32565.18587035343;32580.674193258714;32663.836680816443;32827.34345313033;34427.4835877457;34933.301333973686;34938.47592286169;35090.473642895886;35332.116697082776;35024.824875875456;35250.823745881105;35378.292434151685;35631;35698.643013569534;29924;31549.526757098203;31558;31656.208594785316;31683.84158079195;24238.272851814472;24370.512589747752;24371.512569748153;24558.386040348418;24728 14:58:42 INFO - PROCESS | 22040 | |2;jquery.html;352.38157034404617;354.9290141971605;358.5446482966632;364.42239051103996;366.2071614953625;15410.3835846566;15841.84158158418;16976.320947162116;17313.567160820985;17368.82631173688;15315.387384504607;15632.374705011785;15942.760858587131;15944.724422046238;15948.521544353658;4991.32617096691;5061.898762024757;5080.542751152396;5087.033463641897;5164.354455693038;3615.2769446110883;5567.137093750475;5842.561807864406;5843.415658434144;5850.210221620069;5773.913391299134;5785.3925337839555;5786.884262314751;5806.535477161838;5815.941840581582;5652.63257888238;5729.541636669056;5789.421057894219;5792.247007888989;5828.184054232411;5042.571381432583;5051.520105589963;5052.595792336604;5060.089183946888;5135.871603209912;18998.52503687405;19794;19874.60250794976;19890.602187956305;19902.60194796096;1770.106096421299;1871.4946964319558;2002.8097330753556;2087.081684059009;2423.987880060606;12498.562550310695;12825.935870320682;12996.740065198737;13333.733325333536;13535.932320338434;1722.285251620576;1794.6859299622645;1799.3252530301138;1817.318505560415;1817.455163111358;55278.44721552773;58082.7095864518;58220.12669809914;58539.414605853824;58769;9009.189172974464;9030.548472576345;9281.767955801159;9336.533173341306;9513.238940884712;12557.183783054072;12586.37068146589;12664.113512054251;12668.429920653592;12673.746525069448;7173.856522869618;7217.92782072183;7443.665035073434;7621.847563048708;7639.236076392316;7240.4569657275915;7370.742024029133;7377.114746230487;7424.257574242532;7463.253674632493;5762.855928601734;5836.8540786479825;5841.1238314253205;5857.238558987389;5882.382349853289;1600.6798640271993;1631.0702899347496;1678.1357600835336;1678.8992660440413;1691.5686499942683;761.8876887912827;844.8056946902124;870.8606622940426;898.955052247385;930.5393830054031;16240.106794126437;16628.83371166297;16786.748198776782;17363.56591085233;18377.632447350978;887.4675194883018;919.8436265834824;939.4645052320249;955.3790036476346;979.5347210075157;9981.351212171186;10093.949530252448;10140.794511805952;10207.795844083077;10313.48432578368;357532;386586;387881;389275;389327;64200.357996419436;66663;68918.65540672364;70301.64849175824;71632.28367716256;940.5955439161227;958.1711819276276;969.4231932000307;976.2190247801731;982.7641366072235;13612.591622251348;15220.771688424904;15692.92153539225;15722.842771572137;16156.67686646284;29707.257318567208;30883.691163088082;31015;31156.53265201069;31205.531917021715;38863.611363886;40007.59992400039;40306.1938761229;40794.79602601968;41253.38119928264;7318.1949985502615;7343.596102214429;7413.888791668237;7513.924860751323;7587.165411804807;7804.024496937883;9641.939386667602;10814.567417303535;10890.836637450286;11333.773324533298;7536.773896783106;9326.766830829283;9416.05839416053;9543.236541076558;9743.464109474047;9233.722988310361;9448.811023779623;9744.317897747089;10051.346662466916;10059.195264378686;9535.856962145712;9572.56923438461;9601.37591056579;10029.398236105857;10224.948875255575;7451.92548074534;7498.775036748906;7503.2496750324535;7525.36034437079;7811.648475818488;8853.203211710977;9906.455144967096;10173.898261017295;10307.123894468754;10315.226358023028 14:58:42 INFO - PROCESS | 22040 | |3;mootools.html;1313.5139998200668;1418.6240646228748;1435.0958895895587;1587.6348439858832;1798.1728404933722;7020.7191712331505;7235.2764723527625;7254.746083887065;7270.091238595176;7290.052293201889;7146.464015198855;7290;7294.9635251823665;7300.744473943413;7314.817129571763;1814.5372929902921;2136.359092272312;2169.251608195174;2186.639204531258;2206.933791986243;2202.4383782135533;2210.635245184543;2214.6124428225075;2215.3686199433164;2216.92240771573;2100;2193.331034034619;2193.5503221839563;2196.0556960506974;2202.966955495661;2160.362693005567;2179.6512557990723;2195.747489038757;2213.2585583829436;2222.8777417242045;2165.4153378587853;2191.8465707400487;2203.7575866654656;2207.1061220205843;2208.569328980849;7414.888776668355;7480.364169045638;7480.401567874557;7486.064241969754;7491.063617047869;4493.9101217975785;4582.885427864297;4586.082783443291;4614.723116613014;4618.65360097994;2939.088882446448;2987.6564195117403;3021.9848900755355;3025.3495498467937;3083.6762139975203;951.3483263964138;955.2883102088919;968.6803354892868;974.9317547771659;981.043482604462;10173.84739228912;10178.18574514037;10191.54138063789;10206.336588121749;10220.02909723575;4057.776822274744;4166.270902592034;4212.368144778307;4243.087736136746;4266.104118135165;8648.351373646876;8684.305255579538;8685.696000639948;8692.869606955901;8712.564371781385;3960.4653371795016;4410.669199810027;4445.066536027471;4450.532694067077;4450.888727781767;3978.3236849735613;4013.8795836124964;4017.216642754693;4051.1290072634524;4051.9392209116886;3490.406630872707;3580.6240344763946;3615.132368231658;3650.580183278904;3665.8533658653887;1199.154596009811;1210.3766560221493;1212.4483360071147;1216.4465168348381;1230.267990545624;1229.8647148813623;1241.0567968344124;1251.5244207201206;1264.5068423314915;1264.778663733843;6990.580565166005;7035;7065.717371305193;7078.964605177044;7094.219635840053;448.9730616162975;450.17617759500035;454.8521730437621;455.18294661083434;463.69859591265947;5405.594580406407;5444.646098003617;5471.753771080311;5487.396386397493;5544.556435485151;8666.566671666518;8837.29301655866;9063.41087829289;9177.816443671089;9181.77045573866;8848.823023539493;8889.111088891059;9003.819923601492;9011.053839346905;9040.141186587263;6720.361565651256;6848.828779280459;6887.793366199022;6927.411170050501;6955.095837541188;6739.865202695821;6771.458283337222;6776.627285499148;6795.3204679531655;6826.249112597709;8006.239407256301;8198.016238051472;8199.0980992092;8221.79445513843;8369.623366948625;8171.305439037748;8453.577321133796;8580.14198580137;8623.051464338792;8651.91348086511;6079.817605471843;6267.1539342188225;6273.52948528853;6565.835854103686;6670.799876003728;6683.966580167068;6684.398404143651;6718.160229971254;6718.664066796543;6728.394444500019;5926.318473375617;6176.474999625082;6274.811755647338;6288.308286088435;6298.905516417166;6005.819825405245;6089.54328425361;6146.200993870768;6160.568760186744;6215.875682486235;6386.744530218739;6434.774782882577;6442.871142577216;6448.967755161194;6452.709628066842;5875.853103672443;5934.762609495572;5944.256967879015;5949.464548190684;5953.821385358273;6008.8798224036145;6131.877362452815;6134.263888333428;6140.5701600887505;6155.169052177898 14:58:42 INFO - PROCESS | 22040 | |4;prototype.html;301.19130135585954;306.54631145904057;310.9113902537777;318.7911917693911;320.04785762357005;5118.974405127974;5189.896202075956;5221.477852214776;5311.2298716686155;5369.677819330843;5054.469280725517;5122.743862806854;5134.178531434971;5206.349206349207;5216.217567364897;3903;3959.8416063357577;4099.8770036898795;4111.5477297497255;4122.793860306981;4093.9181216375655;4096.385542168684;4099.0777075158;4101.692373072016;4112.198121366335;4054.97972510137;4059.4316795648633;4072.511298644167;4074.5517993020744;4076.653484453825;3885;3974.602539746031;4036.1725846201457;4072.9796351018354;4084.979575102135;3578.499010138583;3591.120175556979;3593.478945552906;3594.730395220369;3599.046252742999;5013.824516141954;5023.598112151019;5025.070361983008;5025.773840177201;5041.294218809369;4718.221493453576;4722.126406614787;4726.71639701619;4731.929021064687;4740.431148262231;5507;5509.256250406184;5512.751926163332;5517.393086760453;5524.779008839641;3963.989182758407;3966.643002129822;3970.801459927021;3981.7411868228473;3986.3023970804993;5536.446355364431;5704.372519022904;5775.653460792324;5782.479576838105;5792.710364481759;3871.8838434847;3904.531456225271;3920.5295364556437;3922.431247469101;3928.4107383892647;3973.5033120859894;3973.980130099331;3977.980110099431;3979;3987.202559488056;4570.177368073712;4570.542945705402;4580.152671755736;4587.220172570671;4597.218472859622;5501.972490137604;5505.3393592768325;5506.063969125258;5517.69652669107;5523.116301391758;1430.5064752660317;1450.0284809177876;1450.9637259068397;1452.1432354910442;1453.3605213705935;932.8227636748996;958.9232861371073;986.0927946289431;999.2954966748425;1009.4548943570389;4802.783874725646;4860.6111511079025;4863.2461968394955;4866.148424025781;4874.707517548958;5678.119891416837;5759.395263497357;5772.249607551075;5772.913406298909;5775.653460792366;4892.143874821892;4921.286413470027;4927.384076990376;4929.088118698052;4931.654784165074;3037.346970401374;3080.1683545442606;3085.3212293295437;3095.2261934516373;3096.9934771199;5477.342718873681;5497.422770609109;5503;5503.422140675171;5509.173623956439;5675.716214189274;5888.911666325009;5912.3496415394275;5916;5925.170476133345;5470.288862447936;5480.561555075664;5482.2873026506295;5482.506574408322;5489.643173193809;5725.799597014085;5728.828135155952;5731.541476681939;5742.08126699726;5743.4543718346695;5637.689927054052;5642.125470552071;5654.971725141348;5657.773689052392;5659.094544872965;5438.537724293479;5479.0411677957;5482.28730265079;5491.203775452457;5492.203630473479;3795.5445346557485;3892.3188442021965;3901.8634347798825;3905.297046531538;3921.509811273591;5595.972020139873;5659.886802264014;5708.486236238592;5709.3719690834805;5716.9428305718075;5512.4211957743855;5525.4474552544425;5533.6126471148245;5536.584756143386;5539.224508568723;5526.17107433872;5537.5569954404355;5544.362398324244;5548.41870067029;5549;5423.9186412204635;5445.40100588927;5455.427180146027;5456.645318054314;5462.180672899097;5390.110631745718;5557.666540007613;5570.554355651457;5573.916391254053;5574.5261652758345;5374.328208973879;5386.865328366822;5394.892102157856;5402.810901618424;5408.378036525693 14:58:42 INFO - PROCESS | 22040 | |5;yui.html;620.8230654263534;654.273756130695;666.8411979431656;677.8305423644086;742.9524370637403;12013.63959081228;12458.31479268641;12509.374531273423;12514.874851251485;12533.874661253385;11588;11637.650870473879;11638.301701897892;11689.59086431975;11760;644.2237104289344;776.4526009163526;778.3267473635293;794.1621589223367;794.5590197440418;791.4973991515401;798.7803354077618;800.1878093734864;800.2437696376926;800.6677228950008;834.7662654456732;837.1293854391456;838.4131108224237;838.584900474263;838.6058552480324;673.0476375928056;821.1583127294571;834.4576025583359;835.2816577743137;837.1377481194379;611.6880391000577;612.146056251531;612.8222815383533;613.2702084519408;613.4632196827775;11769.2938423694;11798.174127811057;11840.052795776317;11843.230190037706;11853.111016673784;11738.706532336675;11853.762924741543;12262.877371226352;12588.244705317711;12661.113722039461;9600.279979001532;9719.902800971971;9727.854082188773;10007;10050.195984321237;3322.734181265493;3390.3727810354917;3394.932101357984;3413.2320227948762;3488.0930957950864;40242.79878600618;40541.59458405407;40626.79686601578;40627.7968610158;40918.38622420666;9603.615855365708;9980.401175929323;9988.800223995479;10196.184305255561;10196.235282353853;17546.47360579159;17587.29650813979;17738;17747.556311092325;17859.73210401845;6761.256261811197;6774.593524388454;6840.281770414134;6952.165740111118;6957.130358705162;3680.9815950920074;3698.5007024051947;3716.201016781405;3736.252749450121;3751.8686845960806;2728.181545536331;2742.931426714308;2750.092469485065;2750.339918419565;2769.819961702483;490.3404920382152;559.1082223852948;570.9857253568694;574.4341823304043;588.9911651325234;549.7553588653011;550.309361751;625.8091282158986;642.0786171843326;655.3217419970308;7288.70845166198;7376.557406555624;7424.406047516294;7566.924330756732;7714.807129821687;576.6943519934441;599.1342510072902;605.3492495567194;606.342118801097;612.1491127333011;3617.620149884277;3668.63313668631;3726.6087060858217;3833.310004199215;3847;48688;49004.75497622489;49076;49173.75413122983;49460;43338.56661433345;43409.34885976713;43498;44027;45110.323345149845;39748.80125599354;39797.60202397939;39927;40078.79960600178;40142.799286003385;7367.77896663101;7443.144038435649;7554.735584254525;7615.162332143571;7716.8456630868195;31886.681133188373;32056.67943320537;32475.512867307483;32535.349293014482;32691.34617307593;36732.081697956695;37842.43236351512;37862.62137378591;38075.619243808316;40278;9317.11487408695;9322.394044387092;9325.393849399767;9378.249740020645;9395.577199025924;10324.277300588887;10386.584536618753;10640.308379955279;12044.819327710267;12052.75894482123;7768.650410731644;9186.598117378131;10395.792084158425;10697.411642359433;10942.726431839268;11151.498182581641;11206.831897521706;11303.660890173307;11467.885321146681;11797.764044718886;10391.792164156523;10422;10652.573897044342;10665.36007839532;11100.11199104086;9215.723528294162;9375;9477;9535.427874327563;9770.572771449146;9296.302777291596;9651.17964972957;9673.081057299545;9808.264380171659;9840.55717492729 14:58:42 INFO - PROCESS | 22040 | __end_tp_report 14:58:42 INFO - PROCESS | 22040 | __start_cc_report 14:58:42 INFO - PROCESS | 22040 | _x_x_mozilla_cycle_collect,887 14:58:42 INFO - PROCESS | 22040 | __end_cc_report 14:58:42 INFO - PROCESS | 22040 | __startTimestamp1459202322661__endTimestamp 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | ------- Summary: start ------- 14:58:42 INFO - PROCESS | 22040 | Number of tests: 6 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | [#0] dojo.html Cycles:165 Average:4598.97 Median:4726.57 stddev:480.53 (10.2%) stddev-sans-first:455.82 14:58:42 INFO - PROCESS | 22040 | Values: 2604.4 2633.7 2644.5 2650.5 2670.8 4536.5 4595.7 4597.3 4599.1 4614.7 4598.0 4660.7 4666.2 4668.0 4685.6 4237.3 4256.6 4288.4 4319.0 4395.1 4285.3 4343.0 4356.5 4363.8 4390.0 4198.8 4225.3 4311.5 4323.9 4333.8 4248.9 4276.7 4288.9 4301.2 4324.3 4278.1 4286.5 4288.4 4318.9 4327.0 4394.8 4436.9 4543.8 4597.4 4629.7 4938.9 4953.1 4958.2 4963.4 5007.5 4866.0 4981.4 4991.5 4995.3 4998.3 4640.4 4677.0 4692.8 4720.7 4728.9 5133.1 5155.4 5156.9 5161.9 5165.2 4817.2 4944.1 4946.5 4946.5 4992.2 4987.3 4996.1 5027.9 5033.0 5061.6 4917.4 4937.2 4937.9 4944.1 4978.4 4751.5 4890.3 4917.8 4924.8 4975.8 4213.6 4215.6 4223.2 4239.2 4245.5 3604.5 3609.1 3623.1 3647.7 3665.1 4164.8 4206.1 4244.7 4279.3 4286.1 5008.8 5014.7 5020.6 5027.2 5076.5 4297.7 4304.2 4306.8 4307.8 4358.7 4357.0 4496.7 4523.1 4529.5 4575.3 4723.9 4743.2 4745.7 4776.9 4791.6 4981.2 4990.2 4992.9 4993.9 5028.1 4536.9 4702.5 4708.9 4760.7 4778.4 4825.6 4839.3 4850.7 4852.3 4901.2 4952.9 4960.0 4960.2 4965.5 5014.8 4656.4 4813.5 4858.1 4875.1 4908.9 4794.8 4819.7 4820.5 4822.7 4872.1 4649.9 4750.7 4752.9 4766.8 4775.9 4907.9 4946.1 4947.3 4967.0 5003.1 4705.7 4725.7 4726.6 4728.6 4776.2 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | [#1] ext.html Cycles:180 Average:43918.30 Median:35291.47 stddev:71181.77 (201.7%) stddev-sans-first:71306.94 14:58:42 INFO - PROCESS | 22040 | Values: 539.8 542.1 557.2 561.6 578.5 34229.3 34821.0 34856.3 34867.0 34963.5 38008.4 38417.8 38505.2 38527.4 38586.4 7554.0 7755.7 7790.1 7804.0 7804.4 7619.8 7764.3 7768.9 7858.5 7893.7 7831.4 7911.8 7913.0 7913.4 7915.2 7813.5 7870.6 7884.4 7894.4 7900.1 7685.5 7839.4 7840.5 7843.5 7846.5 38196.4 38919.6 39015.0 39019.6 39119.8 2791.9 2847.1 2938.4 3023.2 3618.5 29217.0 29770.3 29795.1 30133.8 30934.8 3507.0 3522.7 3524.8 3599.4 3664.1 236178.0 239461.0 239526.0 240883.0 240939.0 42547.0 53487.2 53700.5 53718.0 53742.7 64191.4 65294.0 65323.3 65389.7 65394.3 15096.8 15321.9 15399.8 15406.7 15411.5 10693.1 11198.9 11692.7 11894.6 11916.3 20107.7 20433.7 20544.5 20560.8 20605.0 7049.4 7294.0 7311.4 7313.7 7484.6 867.7 887.0 918.3 925.1 932.7 25162.7 25682.0 25835.2 26018.5 26077.2 976.5 990.0 992.6 1048.6 1052.4 14021.7 14270.6 14489.1 14534.6 14555.1 287377.0 291080.0 291264.0 291800.0 291966.3 48658.3 49174.0 49243.0 49421.3 49476.0 1112.6 1247.2 1264.9 1290.1 1372.4 24092.0 28445.0 32145.7 32267.5 32383.7 45893.5 46164.3 46656.8 46676.5 46749.3 281766.0 284887.0 285726.0 285974.0 286654.0 34062.5 40044.6 41605.2 41653.4 41782.4 36954.6 37879.4 38225.6 38384.4 45254.5 32252.0 32565.2 32580.7 32663.8 32827.3 34427.5 34933.3 34938.5 35090.5 35332.1 35024.8 35250.8 35378.3 35631.0 35698.6 29924.0 31549.5 31558.0 31656.2 31683.8 24238.3 24370.5 24371.5 24558.4 24728.0 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | [#2] jquery.html Cycles:180 Average:23016.91 Median:5071.22 stddev:62653.47 (1235.5%) stddev-sans-first:62806.12 14:58:42 INFO - PROCESS | 22040 | Values: 352.4 354.9 358.5 364.4 366.2 15410.4 15841.8 16976.3 17313.6 17368.8 15315.4 15632.4 15942.8 15944.7 15948.5 4991.3 5061.9 5080.5 5087.0 5164.4 3615.3 5567.1 5842.6 5843.4 5850.2 5773.9 5785.4 5786.9 5806.5 5815.9 5652.6 5729.5 5789.4 5792.2 5828.2 5042.6 5051.5 5052.6 5060.1 5135.9 18998.5 19794.0 19874.6 19890.6 19902.6 1770.1 1871.5 2002.8 2087.1 2424.0 12498.6 12825.9 12996.7 13333.7 13535.9 1722.3 1794.7 1799.3 1817.3 1817.5 55278.4 58082.7 58220.1 58539.4 58769.0 9009.2 9030.5 9281.8 9336.5 9513.2 12557.2 12586.4 12664.1 12668.4 12673.7 7173.9 7217.9 7443.7 7621.8 7639.2 7240.5 7370.7 7377.1 7424.3 7463.3 5762.9 5836.9 5841.1 5857.2 5882.4 1600.7 1631.1 1678.1 1678.9 1691.6 761.9 844.8 870.9 899.0 930.5 16240.1 16628.8 16786.7 17363.6 18377.6 887.5 919.8 939.5 955.4 979.5 9981.4 10093.9 10140.8 10207.8 10313.5 357532.0 386586.0 387881.0 389275.0 389327.0 64200.4 66663.0 68918.7 70301.6 71632.3 940.6 958.2 969.4 976.2 982.8 13612.6 15220.8 15692.9 15722.8 16156.7 29707.3 30883.7 31015.0 31156.5 31205.5 38863.6 40007.6 40306.2 40794.8 41253.4 7318.2 7343.6 7413.9 7513.9 7587.2 7804.0 9641.9 10814.6 10890.8 11333.8 7536.8 9326.8 9416.1 9543.2 9743.5 9233.7 9448.8 9744.3 10051.3 10059.2 9535.9 9572.6 9601.4 10029.4 10224.9 7451.9 7498.8 7503.2 7525.4 7811.6 8853.2 9906.5 10173.9 10307.1 10315.2 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | [#3] mootools.html Cycles:180 Average:5153.96 Median:5979.82 stddev:2686.70 (44.9%) stddev-sans-first:2678.73 14:58:42 INFO - PROCESS | 22040 | Values: 1313.5 1418.6 1435.1 1587.6 1798.2 7020.7 7235.3 7254.7 7270.1 7290.1 7146.5 7290.0 7295.0 7300.7 7314.8 1814.5 2136.4 2169.3 2186.6 2206.9 2202.4 2210.6 2214.6 2215.4 2216.9 2100.0 2193.3 2193.6 2196.1 2203.0 2160.4 2179.7 2195.7 2213.3 2222.9 2165.4 2191.8 2203.8 2207.1 2208.6 7414.9 7480.4 7480.4 7486.1 7491.1 4493.9 4582.9 4586.1 4614.7 4618.7 2939.1 2987.7 3022.0 3025.3 3083.7 951.3 955.3 968.7 974.9 981.0 10173.8 10178.2 10191.5 10206.3 10220.0 4057.8 4166.3 4212.4 4243.1 4266.1 8648.4 8684.3 8685.7 8692.9 8712.6 3960.5 4410.7 4445.1 4450.5 4450.9 3978.3 4013.9 4017.2 4051.1 4051.9 3490.4 3580.6 3615.1 3650.6 3665.9 1199.2 1210.4 1212.4 1216.4 1230.3 1229.9 1241.1 1251.5 1264.5 1264.8 6990.6 7035.0 7065.7 7079.0 7094.2 449.0 450.2 454.9 455.2 463.7 5405.6 5444.6 5471.8 5487.4 5544.6 8666.6 8837.3 9063.4 9177.8 9181.8 8848.8 8889.1 9003.8 9011.1 9040.1 6720.4 6848.8 6887.8 6927.4 6955.1 6739.9 6771.5 6776.6 6795.3 6826.2 8006.2 8198.0 8199.1 8221.8 8369.6 8171.3 8453.6 8580.1 8623.1 8651.9 6079.8 6267.2 6273.5 6565.8 6670.8 6684.0 6684.4 6718.2 6718.7 6728.4 5926.3 6176.5 6274.8 6288.3 6298.9 6005.8 6089.5 6146.2 6160.6 6215.9 6386.7 6434.8 6442.9 6449.0 6452.7 5875.9 5934.8 5944.3 5949.5 5953.8 6008.9 6131.9 6134.3 6140.6 6155.2 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | [#4] prototype.html Cycles:180 Average:4588.65 Median:5198.12 stddev:1343.22 (25.8%) stddev-sans-first:1307.87 14:58:42 INFO - PROCESS | 22040 | Values: 301.2 306.5 310.9 318.8 320.0 5119.0 5189.9 5221.5 5311.2 5369.7 5054.5 5122.7 5134.2 5206.3 5216.2 3903.0 3959.8 4099.9 4111.5 4122.8 4093.9 4096.4 4099.1 4101.7 4112.2 4055.0 4059.4 4072.5 4074.6 4076.7 3885.0 3974.6 4036.2 4073.0 4085.0 3578.5 3591.1 3593.5 3594.7 3599.0 5013.8 5023.6 5025.1 5025.8 5041.3 4718.2 4722.1 4726.7 4731.9 4740.4 5507.0 5509.3 5512.8 5517.4 5524.8 3964.0 3966.6 3970.8 3981.7 3986.3 5536.4 5704.4 5775.7 5782.5 5792.7 3871.9 3904.5 3920.5 3922.4 3928.4 3973.5 3974.0 3978.0 3979.0 3987.2 4570.2 4570.5 4580.2 4587.2 4597.2 5502.0 5505.3 5506.1 5517.7 5523.1 1430.5 1450.0 1451.0 1452.1 1453.4 932.8 958.9 986.1 999.3 1009.5 4802.8 4860.6 4863.2 4866.1 4874.7 5678.1 5759.4 5772.2 5772.9 5775.7 4892.1 4921.3 4927.4 4929.1 4931.7 3037.3 3080.2 3085.3 3095.2 3097.0 5477.3 5497.4 5503.0 5503.4 5509.2 5675.7 5888.9 5912.3 5916.0 5925.2 5470.3 5480.6 5482.3 5482.5 5489.6 5725.8 5728.8 5731.5 5742.1 5743.5 5637.7 5642.1 5655.0 5657.8 5659.1 5438.5 5479.0 5482.3 5491.2 5492.2 3795.5 3892.3 3901.9 3905.3 3921.5 5596.0 5659.9 5708.5 5709.4 5716.9 5512.4 5525.4 5533.6 5536.6 5539.2 5526.2 5537.6 5544.4 5548.4 5549.0 5423.9 5445.4 5455.4 5456.6 5462.2 5390.1 5557.7 5570.6 5573.9 5574.5 5374.3 5386.9 5394.9 5402.8 5408.4 14:58:42 INFO - PROCESS | 22040 | 14:58:42 INFO - PROCESS | 22040 | [#5] yui.html Cycles:180 Average:12297.45 Median:44568.66 stddev:13649.94 (30.6%) stddev-sans-first:13660.06 14:58:42 INFO - PROCESS | 22040 | Values: 620.8 654.3 666.8 677.8 743.0 12013.6 12458.3 12509.4 12514.9 12533.9 11588.0 11637.7 11638.3 11689.6 11760.0 644.2 776.5 778.3 794.2 794.6 791.5 798.8 800.2 800.2 800.7 834.8 837.1 838.4 838.6 838.6 673.0 821.2 834.5 835.3 837.1 611.7 612.1 612.8 613.3 613.5 11769.3 11798.2 11840.1 11843.2 11853.1 11738.7 11853.8 12262.9 12588.2 12661.1 9600.3 9719.9 9727.9 10007.0 10050.2 3322.7 3390.4 3394.9 3413.2 3488.1 40242.8 40541.6 40626.8 40627.8 40918.4 9603.6 9980.4 9988.8 10196.2 10196.2 17546.5 17587.3 17738.0 17747.6 17859.7 6761.3 6774.6 6840.3 6952.2 6957.1 3681.0 3698.5 3716.2 3736.3 3751.9 2728.2 2742.9 2750.1 2750.3 2769.8 490.3 559.1 571.0 574.4 589.0 549.8 550.3 625.8 642.1 655.3 7288.7 7376.6 7424.4 7566.9 7714.8 576.7 599.1 605.3 606.3 612.1 3617.6 3668.6 3726.6 3833.3 3847.0 48688.0 49004.8 49076.0 49173.8 49460.0 43338.6 43409.3 43498.0 44027.0 45110.3 39748.8 39797.6 39927.0 40078.8 40142.8 7367.8 7443.1 7554.7 7615.2 7716.8 31886.7 32056.7 32475.5 32535.3 32691.3 36732.1 37842.4 37862.6 38075.6 40278.0 9317.1 9322.4 9325.4 9378.2 9395.6 10324.3 10386.6 10640.3 12044.8 12052.8 7768.7 9186.6 10395.8 10697.4 10942.7 11151.5 11206.8 11303.7 11467.9 11797.8 10391.8 10422.0 10652.6 10665.4 11100.1 9215.7 9375.0 9477.0 9535.4 9770.6 9296.3 9651.2 9673.1 9808.3 9840.6 14:58:42 INFO - PROCESS | 22040 | -------- Summary: end -------- 14:58:42 INFO - PROCESS | 22040 | 14:58:43 INFO - TEST-INFO | 22040: exit 0 14:58:43 INFO - TEST-OK | dromaeo_css | took 1116243ms 14:58:43 INFO - TEST-START | kraken 14:58:43 INFO - operating with platform_type : linux_ 14:58:43 INFO - Initialising browser for kraken test... 14:58:43 INFO - TEST-INFO | started process 22221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprWOTep/profile http://localhost:52540/getInfo.html) 14:58:47 INFO - PROCESS | 22221 | __metrics Screen width/height:1600/1200 14:58:47 INFO - PROCESS | 22221 | colorDepth:24 14:58:47 INFO - PROCESS | 22221 | Browser inner width/height: 1024/697 14:58:47 INFO - PROCESS | 22221 | __metrics 14:58:48 ERROR - PROCESS | 22221 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:58:49 INFO - TEST-INFO | 22221: exit 0 14:58:49 INFO - Browser initialized. 14:58:49 INFO - Running cycle 1/1 for kraken test... 14:58:49 INFO - TEST-INFO | started process 22304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprWOTep/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:01 INFO - PROCESS | 22304 | RSS: Main: 154955776 14:59:01 INFO - PROCESS | 22304 | 14:59:03 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52540/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:04 INFO - PROCESS | 22304 | RSS: Main: 195194880 14:59:04 INFO - PROCESS | 22304 | 14:59:07 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52540/tests/kraken/driver.html?testName=audio-dft) 14:59:07 INFO - PROCESS | 22304 | RSS: Main: 185520128 14:59:07 INFO - PROCESS | 22304 | 14:59:10 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52540/tests/kraken/driver.html?testName=audio-fft) 14:59:11 INFO - PROCESS | 22304 | RSS: Main: 170409984 14:59:11 INFO - PROCESS | 22304 | 14:59:13 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52540/tests/kraken/driver.html?testName=audio-oscillator) 14:59:13 INFO - PROCESS | 22304 | RSS: Main: 173010944 14:59:13 INFO - PROCESS | 22304 | 14:59:16 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52540/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:16 INFO - PROCESS | 22304 | RSS: Main: 173842432 14:59:16 INFO - PROCESS | 22304 | 14:59:19 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52540/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:20 INFO - PROCESS | 22304 | RSS: Main: 174866432 14:59:20 INFO - PROCESS | 22304 | 14:59:23 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52540/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:24 INFO - PROCESS | 22304 | RSS: Main: 175579136 14:59:24 INFO - PROCESS | 22304 | 14:59:27 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52540/tests/kraken/driver.html?testName=json-parse-financial) 14:59:28 INFO - PROCESS | 22304 | RSS: Main: 174649344 14:59:28 INFO - PROCESS | 22304 | 14:59:29 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52540/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:30 INFO - PROCESS | 22304 | RSS: Main: 184115200 14:59:30 INFO - PROCESS | 22304 | 14:59:32 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:32 INFO - PROCESS | 22304 | RSS: Main: 182394880 14:59:32 INFO - PROCESS | 22304 | 14:59:34 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:35 INFO - PROCESS | 22304 | RSS: Main: 194048000 14:59:35 INFO - PROCESS | 22304 | 14:59:38 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:38 INFO - PROCESS | 22304 | RSS: Main: 198004736 14:59:38 INFO - PROCESS | 22304 | 14:59:41 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:41 INFO - PROCESS | 22304 | RSS: Main: 197349376 14:59:41 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | Cycle 1(1): loaded http://localhost:52540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52540/tests/kraken/driver.html?testName=ai-astar) 14:59:43 INFO - PROCESS | 22304 | RSS: Main: 259575808 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | __start_tp_report 14:59:43 INFO - PROCESS | 22304 | _x_x_mozilla_page_load 14:59:43 INFO - PROCESS | 22304 | _x_x_mozilla_page_load_details 14:59:43 INFO - PROCESS | 22304 | |i|pagename|runs| 14:59:43 INFO - PROCESS | 22304 | |0;ai-astar;111;112;108;111;114;112;105;111;111;110 14:59:43 INFO - PROCESS | 22304 | |1;audio-beat-detection;157;131;157;177;132;163;157;134;185;133 14:59:43 INFO - PROCESS | 22304 | |2;audio-dft;163;162;161;161;160;161;164;160;161;161 14:59:43 INFO - PROCESS | 22304 | |3;audio-fft;73;74;111;95;73;73;73;118;95;74 14:59:43 INFO - PROCESS | 22304 | |4;audio-oscillator;94;94;141;98;93;93;143;94;93;138 14:59:43 INFO - PROCESS | 22304 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;117 14:59:43 INFO - PROCESS | 22304 | |6;imaging-darkroom;146;146;145;146;145;146;145;145;146;145 14:59:43 INFO - PROCESS | 22304 | |7;imaging-desaturate;95;96;96;95;95;95;95;96;95;95 14:59:43 INFO - PROCESS | 22304 | |8;json-parse-financial;63;65;66;63;63;64;63;73;62;62 14:59:43 INFO - PROCESS | 22304 | |9;json-stringify-tinderbox;65;65;65;65;66;66;67;65;66;65 14:59:43 INFO - PROCESS | 22304 | |10;stanford-crypto-aes;81;82;82;82;89;88;83;91;82;83 14:59:43 INFO - PROCESS | 22304 | |11;stanford-crypto-ccm;116;128;115;117;125;118;119;117;116;125 14:59:43 INFO - PROCESS | 22304 | |12;stanford-crypto-pbkdf2;143;146;142;141;143;132;143;142;154;131 14:59:43 INFO - PROCESS | 22304 | |13;stanford-crypto-sha256-iterative;67;69;70;66;66;65;66;65;66;66 14:59:43 INFO - PROCESS | 22304 | __end_tp_report 14:59:43 INFO - PROCESS | 22304 | __start_cc_report 14:59:43 INFO - PROCESS | 22304 | _x_x_mozilla_cycle_collect,1154 14:59:43 INFO - PROCESS | 22304 | __end_cc_report 14:59:43 INFO - PROCESS | 22304 | __startTimestamp1459202383819__endTimestamp 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | ------- Summary: start ------- 14:59:43 INFO - PROCESS | 22304 | Number of tests: 14 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.46 (2.2%) stddev-sans-first:2.60 14:59:43 INFO - PROCESS | 22304 | Values: 111.0 112.0 108.0 111.0 114.0 112.0 105.0 111.0 111.0 110.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:157.00 stddev:19.53 (12.4%) stddev-sans-first:20.65 14:59:43 INFO - PROCESS | 22304 | Values: 157.0 131.0 157.0 177.0 132.0 163.0 157.0 134.0 185.0 133.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 14:59:43 INFO - PROCESS | 22304 | Values: 163.0 162.0 161.0 161.0 160.0 161.0 164.0 160.0 161.0 161.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#3] audio-fft Cycles:10 Average:85.90 Median:73.50 stddev:17.56 (23.9%) stddev-sans-first:17.99 14:59:43 INFO - PROCESS | 22304 | Values: 73.0 74.0 111.0 95.0 73.0 73.0 73.0 118.0 95.0 74.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.50 stddev:22.55 (24.1%) stddev-sans-first:23.33 14:59:43 INFO - PROCESS | 22304 | Values: 94.0 94.0 141.0 98.0 93.0 93.0 143.0 94.0 93.0 138.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:59:43 INFO - PROCESS | 22304 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:59:43 INFO - PROCESS | 22304 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:59:43 INFO - PROCESS | 22304 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:63.50 stddev:3.27 (5.2%) stddev-sans-first:3.43 14:59:43 INFO - PROCESS | 22304 | Values: 63.0 65.0 66.0 63.0 63.0 64.0 63.0 73.0 62.0 62.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 14:59:43 INFO - PROCESS | 22304 | Values: 65.0 65.0 65.0 65.0 66.0 66.0 67.0 65.0 66.0 65.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.59 (4.3%) stddev-sans-first:3.61 14:59:43 INFO - PROCESS | 22304 | Values: 81.0 82.0 82.0 82.0 89.0 88.0 83.0 91.0 82.0 83.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:118.50 stddev:4.62 (3.9%) stddev-sans-first:4.72 14:59:43 INFO - PROCESS | 22304 | Values: 116.0 128.0 115.0 117.0 125.0 118.0 119.0 117.0 116.0 125.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:143.00 stddev:6.53 (4.6%) stddev-sans-first:6.91 14:59:43 INFO - PROCESS | 22304 | Values: 143.0 146.0 142.0 141.0 143.0 132.0 143.0 142.0 154.0 131.0 14:59:43 INFO - PROCESS | 22304 | 14:59:43 INFO - PROCESS | 22304 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.74 14:59:43 INFO - PROCESS | 22304 | Values: 67.0 69.0 70.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 14:59:43 INFO - PROCESS | 22304 | -------- Summary: end -------- 14:59:43 INFO - PROCESS | 22304 | 14:59:44 INFO - TEST-INFO | 22304: exit 0 14:59:44 INFO - TEST-OK | kraken | took 61436ms 14:59:44 INFO - SUITE-END | took 1177s 14:59:44 INFO - Completed test suite (00:19:37) 14:59:44 INFO - javascript benchmark 14:59:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2604.374950011997, 2633.7102918678943, 2644.457886133343, 2650.4831557846214, 2670.7996900232483, 4536.500984891668, 4595.724256544601, 4597.287420449828, 4599.103174880899, 4614.676972611918, 4598.0, 4660.673752837302, 4666.160091183586, 4668.019715859665, 4685.648576356778, 4237.322028475444, 4256.574342565742, 4288.442502474674, 4318.956810431887, 4395.05506316142, 4285.335772955197, 4343.0, 4356.520782713899, 4363.825446982117, 4389.978050109745, 4198.811053502584, 4225.3239481683095, 4311.547287534827, 4323.891902702458, 4333.848315308949, 4248.915021699549, 4276.700630955835, 4288.935665964982, 4301.182775272689, 4324.2648749712625, 4278.069542275419, 4286.507051689065, 4288.378185163134, 4318.892027699333, 4326.978365108154, 4394.824207031715, 4436.866893993185, 4543.8182472701055, 4597.356370108188, 4629.675922685414, 4938.876528086791, 4953.0589188054155, 4958.231474121517, 4963.4292056413615, 5007.54932056113, 4865.95134048662, 4981.352424184833, 4991.450940396553, 4995.325631039799, 4998.300237966688, 4640.350350950869, 4677.041206552649, 4692.7653617319, 4720.716756994591, 4728.881777955578, 5133.12736834739, 5155.407128180307, 5156.922646160236, 5161.922571161435, 5165.173572228426, 4817.229243321122, 4944.1100601891285, 4946.530079642428, 4946.530079642428, 4992.201247800334, 4987.251912213124, 4996.075725990703, 5027.949720502821, 5033.043721692867, 5061.645684802029, 4917.385326834145, 4937.23472861707, 4937.851864444073, 4944.060628480577, 4978.402591688948, 4751.52484751529, 4890.266460031024, 4917.7786999585105, 4924.75376231187, 4975.800967961313, 4213.620774130343, 4215.59951804578, 4223.1975924574235, 4239.194553034913, 4245.532991370947, 3604.459331100356, 3609.1157666371905, 3623.1123374772824, 3647.6534729200685, 3665.083729067733, 4164.770937598461, 4206.116715489781, 4244.681648876347, 4279.33670281107, 4286.121345124242, 5008.799648014038, 5014.6991180529285, 5020.623453241022, 5027.2207807789855, 5076.492350764894, 4297.67767417445, 4304.246756817607, 4306.763128027926, 4307.806148723315, 4358.65130789536, 4356.978215108904, 4496.685232033727, 4523.072770082125, 4529.479109902338, 4575.267957126844, 4723.929141062956, 4743.241081426955, 4745.738984355894, 4776.904461910743, 4791.6406269529225, 4981.153203955264, 4990.176620857518, 4992.900141997213, 4993.900121997613, 5028.069807085701, 4536.931946020746, 4702.482726900107, 4708.858734237979, 4760.714357138583, 4778.354922085613, 4825.638077144298, 4839.322494850794, 4850.733209673361, 4852.296417019583, 4901.240307752304, 4952.8761780955765, 4960.0, 4960.206366981266, 4965.45380008206, 5014.824481143289, 4656.3713898623255, 4813.470518242921, 4858.125537403302, 4875.098106850244, 4908.9263661045825, 4794.808207671654, 4819.7108173509705, 4820.493848145894, 4822.734749588806, 4872.098661747588, 4649.86050418488, 4750.714957102585, 4752.9049419010735, 4766.7854946526795, 4775.928361074517, 4907.926381104215, 4946.060248552763, 4947.282644016669, 4966.950330496793, 5003.099442100457, 4705.694129881546, 4725.716457012591, 4726.574608285271, 4728.574428301469, 4776.188048031912], "unit": "score", "name": "dojo.html", "value": 4568.683108130937}, {"lowerIsBetter": false, "replicates": [539.7948779463803, 542.1001138110735, 557.1892895836559, 561.5788158880841, 578.4967078641582, 34229.315413691744, 34821.0, 34856.302873942535, 34867.0, 34963.4755478668, 38008.42987355185, 38417.80791096047, 38505.22989540207, 38527.42208866869, 38586.42120368189, 7553.962230188855, 7755.728549500768, 7790.065192176919, 7804.0, 7804.414668899827, 7619.771406857803, 7764.262395072487, 7768.883466748003, 7858.528488290693, 7893.684252629888, 7831.373490120776, 7911.8417631647335, 7913.0, 7913.446058775888, 7915.2084791520965, 7813.531188128702, 7870.606469676551, 7884.408669349793, 7894.447388682795, 7900.091489478726, 7685.5004424712215, 7839.412044096659, 7840.529568225925, 7843.450958432855, 7846.489978151402, 38196.42705359422, 38919.61080389188, 39015.0, 39019.60980390188, 39119.80440097781, 2791.916242512728, 2847.145856243119, 2938.397628486155, 3023.1988523041414, 3618.493410922473, 29217.0, 29770.255743606365, 29795.10614681563, 30133.849330753426, 30934.84532577345, 3506.964930350715, 3522.7181825453904, 3524.788512689247, 3599.370110230699, 3664.1022949377575, 236178.0, 239461.0, 239525.99999999825, 240883.0, 240939.0, 42547.0, 53487.19769203465, 53700.462995370326, 53718.0, 53742.73128634332, 64191.358086418535, 65294.0, 65323.346766532675, 65389.673051635385, 65394.34605653882, 15096.773548396783, 15321.923390382977, 15399.769003464957, 15406.691866162613, 15411.537653870178, 10693.144548436107, 11198.888011119785, 11692.70768230801, 11894.643160705193, 11916.344601046852, 20107.698384524243, 20433.69349459759, 20544.486387840425, 20560.79439205619, 20605.0, 7049.400800931979, 7293.9635301823155, 7311.415086793044, 7313.707451701979, 7484.625768711543, 867.6876324523166, 886.9733907982771, 918.3387960668308, 925.0887875442684, 932.7481579973505, 25162.748372516406, 25681.961467626083, 25835.22494325173, 26018.479630407284, 26077.217683469527, 976.4922240434934, 989.9604015839429, 992.5880759484733, 1048.6434612231878, 1052.3580615824342, 14021.719565608631, 14270.643233919234, 14489.058211216237, 14534.636634084232, 14555.05392149507, 287377.0, 291080.0, 291264.0, 291800.0, 291966.321347148, 48658.27012594814, 49174.0, 49243.0, 49421.25868111981, 49476.0, 1112.6328311657135, 1247.2080229054616, 1264.879836415539, 1290.14205553306, 1372.4373007067254, 24092.0, 28445.0, 32145.678543215203, 32267.51598725974, 32383.676163238066, 45893.54106458893, 46164.307535386324, 46656.7667161662, 46676.53323466722, 46749.2987605193, 281766.0, 284887.0, 285726.0, 285974.0, 286654.0, 34062.48906266358, 40044.59955400409, 41605.1678966425, 41653.375199371425, 41782.37326440045, 36954.63045369512, 37879.43180852234, 38225.61774382332, 38384.42423363707, 45254.54745452635, 32252.0, 32565.18587035343, 32580.674193258714, 32663.836680816443, 32827.34345313033, 34427.4835877457, 34933.301333973686, 34938.47592286169, 35090.473642895886, 35332.116697082776, 35024.824875875456, 35250.823745881105, 35378.292434151685, 35631.0, 35698.643013569534, 29924.0, 31549.526757098203, 31558.0, 31656.208594785316, 31683.84158079195, 24238.272851814472, 24370.512589747752, 24371.512569748153, 24558.386040348418, 24728.0], "unit": "score", "name": "ext.html", "value": 17589.653536103415}, {"lowerIsBetter": false, "replicates": [352.38157034404617, 354.9290141971605, 358.5446482966632, 364.42239051103996, 366.2071614953625, 15410.3835846566, 15841.84158158418, 16976.320947162116, 17313.567160820985, 17368.82631173688, 15315.387384504607, 15632.374705011785, 15942.760858587131, 15944.724422046238, 15948.521544353658, 4991.32617096691, 5061.898762024757, 5080.542751152396, 5087.033463641897, 5164.354455693038, 3615.2769446110883, 5567.137093750475, 5842.561807864406, 5843.415658434144, 5850.210221620069, 5773.913391299134, 5785.3925337839555, 5786.884262314751, 5806.535477161838, 5815.941840581582, 5652.63257888238, 5729.541636669056, 5789.421057894219, 5792.247007888989, 5828.184054232411, 5042.571381432583, 5051.520105589963, 5052.595792336604, 5060.089183946888, 5135.871603209912, 18998.52503687405, 19794.0, 19874.60250794976, 19890.602187956305, 19902.60194796096, 1770.106096421299, 1871.4946964319558, 2002.8097330753556, 2087.081684059009, 2423.987880060606, 12498.562550310695, 12825.935870320682, 12996.740065198737, 13333.733325333536, 13535.932320338434, 1722.285251620576, 1794.6859299622645, 1799.3252530301138, 1817.318505560415, 1817.455163111358, 55278.44721552773, 58082.7095864518, 58220.12669809914, 58539.414605853824, 58769.0, 9009.189172974464, 9030.548472576345, 9281.767955801159, 9336.533173341306, 9513.238940884712, 12557.183783054072, 12586.37068146589, 12664.113512054251, 12668.429920653592, 12673.746525069448, 7173.856522869618, 7217.92782072183, 7443.665035073434, 7621.847563048708, 7639.236076392316, 7240.4569657275915, 7370.742024029133, 7377.114746230487, 7424.257574242532, 7463.253674632493, 5762.855928601734, 5836.8540786479825, 5841.1238314253205, 5857.238558987389, 5882.382349853289, 1600.6798640271993, 1631.0702899347496, 1678.1357600835336, 1678.8992660440413, 1691.5686499942683, 761.8876887912827, 844.8056946902124, 870.8606622940426, 898.955052247385, 930.5393830054031, 16240.106794126437, 16628.83371166297, 16786.748198776782, 17363.56591085233, 18377.632447350978, 887.4675194883018, 919.8436265834824, 939.4645052320249, 955.3790036476346, 979.5347210075157, 9981.351212171186, 10093.949530252448, 10140.794511805952, 10207.795844083077, 10313.48432578368, 357532.0, 386586.0, 387881.0, 389275.0, 389327.0, 64200.357996419436, 66663.0, 68918.65540672364, 70301.64849175824, 71632.28367716256, 940.5955439161227, 958.1711819276276, 969.4231932000307, 976.2190247801731, 982.7641366072235, 13612.591622251348, 15220.771688424904, 15692.92153539225, 15722.842771572137, 16156.67686646284, 29707.257318567208, 30883.691163088082, 31015.0, 31156.53265201069, 31205.531917021715, 38863.611363886, 40007.59992400039, 40306.1938761229, 40794.79602601968, 41253.38119928264, 7318.1949985502615, 7343.596102214429, 7413.888791668237, 7513.924860751323, 7587.165411804807, 7804.024496937883, 9641.939386667602, 10814.567417303535, 10890.836637450286, 11333.773324533298, 7536.773896783106, 9326.766830829283, 9416.05839416053, 9543.236541076558, 9743.464109474047, 9233.722988310361, 9448.811023779623, 9744.317897747089, 10051.346662466916, 10059.195264378686, 9535.856962145712, 9572.56923438461, 9601.37591056579, 10029.398236105857, 10224.948875255575, 7451.92548074534, 7498.775036748906, 7503.2496750324535, 7525.36034437079, 7811.648475818488, 8853.203211710977, 9906.455144967096, 10173.898261017295, 10307.123894468754, 10315.226358023028], "unit": "score", "name": "jquery.html", "value": 8082.177177042437}, {"lowerIsBetter": false, "replicates": [1313.5139998200668, 1418.6240646228748, 1435.0958895895587, 1587.6348439858832, 1798.1728404933722, 7020.7191712331505, 7235.2764723527625, 7254.746083887065, 7270.091238595176, 7290.052293201889, 7146.464015198855, 7290.0, 7294.9635251823665, 7300.744473943413, 7314.817129571763, 1814.5372929902921, 2136.359092272312, 2169.251608195174, 2186.639204531258, 2206.933791986243, 2202.4383782135533, 2210.635245184543, 2214.6124428225075, 2215.3686199433164, 2216.92240771573, 2100.0, 2193.331034034619, 2193.5503221839563, 2196.0556960506974, 2202.966955495661, 2160.362693005567, 2179.6512557990723, 2195.747489038757, 2213.2585583829436, 2222.8777417242045, 2165.4153378587853, 2191.8465707400487, 2203.7575866654656, 2207.1061220205843, 2208.569328980849, 7414.888776668355, 7480.364169045638, 7480.401567874557, 7486.064241969754, 7491.063617047869, 4493.9101217975785, 4582.885427864297, 4586.082783443291, 4614.723116613014, 4618.65360097994, 2939.088882446448, 2987.6564195117403, 3021.9848900755355, 3025.3495498467937, 3083.6762139975203, 951.3483263964138, 955.2883102088919, 968.6803354892868, 974.9317547771659, 981.043482604462, 10173.84739228912, 10178.18574514037, 10191.54138063789, 10206.336588121749, 10220.02909723575, 4057.776822274744, 4166.270902592034, 4212.368144778307, 4243.087736136746, 4266.104118135165, 8648.351373646876, 8684.305255579538, 8685.696000639948, 8692.869606955901, 8712.564371781385, 3960.4653371795016, 4410.669199810027, 4445.066536027471, 4450.532694067077, 4450.888727781767, 3978.3236849735613, 4013.8795836124964, 4017.216642754693, 4051.1290072634524, 4051.9392209116886, 3490.406630872707, 3580.6240344763946, 3615.132368231658, 3650.580183278904, 3665.8533658653887, 1199.154596009811, 1210.3766560221493, 1212.4483360071147, 1216.4465168348381, 1230.267990545624, 1229.8647148813623, 1241.0567968344124, 1251.5244207201206, 1264.5068423314915, 1264.778663733843, 6990.580565166005, 7035.0, 7065.717371305193, 7078.964605177044, 7094.219635840053, 448.9730616162975, 450.17617759500035, 454.8521730437621, 455.18294661083434, 463.69859591265947, 5405.594580406407, 5444.646098003617, 5471.753771080311, 5487.396386397493, 5544.556435485151, 8666.566671666518, 8837.29301655866, 9063.41087829289, 9177.816443671089, 9181.77045573866, 8848.823023539493, 8889.111088891059, 9003.819923601492, 9011.053839346905, 9040.141186587263, 6720.361565651256, 6848.828779280459, 6887.793366199022, 6927.411170050501, 6955.095837541188, 6739.865202695821, 6771.458283337222, 6776.627285499148, 6795.3204679531655, 6826.249112597709, 8006.239407256301, 8198.016238051472, 8199.0980992092, 8221.79445513843, 8369.623366948625, 8171.305439037748, 8453.577321133796, 8580.14198580137, 8623.051464338792, 8651.91348086511, 6079.817605471843, 6267.1539342188225, 6273.52948528853, 6565.835854103686, 6670.799876003728, 6683.966580167068, 6684.398404143651, 6718.160229971254, 6718.664066796543, 6728.394444500019, 5926.318473375617, 6176.474999625082, 6274.811755647338, 6288.308286088435, 6298.905516417166, 6005.819825405245, 6089.54328425361, 6146.200993870768, 6160.568760186744, 6215.875682486235, 6386.744530218739, 6434.774782882577, 6442.871142577216, 6448.967755161194, 6452.709628066842, 5875.853103672443, 5934.762609495572, 5944.256967879015, 5949.464548190684, 5953.821385358273, 6008.8798224036145, 6131.877362452815, 6134.263888333428, 6140.5701600887505, 6155.169052177898], "unit": "score", "name": "mootools.html", "value": 4183.203200552997}, {"lowerIsBetter": false, "replicates": [301.19130135585954, 306.54631145904057, 310.9113902537777, 318.7911917693911, 320.04785762357005, 5118.974405127974, 5189.896202075956, 5221.477852214776, 5311.2298716686155, 5369.677819330843, 5054.469280725517, 5122.743862806854, 5134.178531434971, 5206.349206349207, 5216.217567364897, 3903.0, 3959.8416063357577, 4099.8770036898795, 4111.5477297497255, 4122.793860306981, 4093.9181216375655, 4096.385542168684, 4099.0777075158, 4101.692373072016, 4112.198121366335, 4054.97972510137, 4059.4316795648633, 4072.511298644167, 4074.5517993020744, 4076.653484453825, 3885.0, 3974.602539746031, 4036.1725846201457, 4072.9796351018354, 4084.979575102135, 3578.499010138583, 3591.120175556979, 3593.478945552906, 3594.730395220369, 3599.046252742999, 5013.824516141954, 5023.598112151019, 5025.070361983008, 5025.773840177201, 5041.294218809369, 4718.221493453576, 4722.126406614787, 4726.71639701619, 4731.929021064687, 4740.431148262231, 5507.0, 5509.256250406184, 5512.751926163332, 5517.393086760453, 5524.779008839641, 3963.989182758407, 3966.643002129822, 3970.801459927021, 3981.7411868228473, 3986.3023970804993, 5536.446355364431, 5704.372519022904, 5775.653460792324, 5782.479576838105, 5792.710364481759, 3871.8838434847, 3904.531456225271, 3920.5295364556437, 3922.431247469101, 3928.4107383892647, 3973.5033120859894, 3973.980130099331, 3977.980110099431, 3979.0, 3987.202559488056, 4570.177368073712, 4570.542945705402, 4580.152671755736, 4587.220172570671, 4597.218472859622, 5501.972490137604, 5505.3393592768325, 5506.063969125258, 5517.69652669107, 5523.116301391758, 1430.5064752660317, 1450.0284809177876, 1450.9637259068397, 1452.1432354910442, 1453.3605213705935, 932.8227636748996, 958.9232861371073, 986.0927946289431, 999.2954966748425, 1009.4548943570389, 4802.783874725646, 4860.6111511079025, 4863.2461968394955, 4866.148424025781, 4874.707517548958, 5678.119891416837, 5759.395263497357, 5772.249607551075, 5772.913406298909, 5775.653460792366, 4892.143874821892, 4921.286413470027, 4927.384076990376, 4929.088118698052, 4931.654784165074, 3037.346970401374, 3080.1683545442606, 3085.3212293295437, 3095.2261934516373, 3096.9934771199, 5477.342718873681, 5497.422770609109, 5503.0, 5503.422140675171, 5509.173623956439, 5675.716214189274, 5888.911666325009, 5912.3496415394275, 5916.0, 5925.170476133345, 5470.288862447936, 5480.561555075664, 5482.2873026506295, 5482.506574408322, 5489.643173193809, 5725.799597014085, 5728.828135155952, 5731.541476681939, 5742.08126699726, 5743.4543718346695, 5637.689927054052, 5642.125470552071, 5654.971725141348, 5657.773689052392, 5659.094544872965, 5438.537724293479, 5479.0411677957, 5482.28730265079, 5491.203775452457, 5492.203630473479, 3795.5445346557485, 3892.3188442021965, 3901.8634347798825, 3905.297046531538, 3921.509811273591, 5595.972020139873, 5659.886802264014, 5708.486236238592, 5709.3719690834805, 5716.9428305718075, 5512.4211957743855, 5525.4474552544425, 5533.6126471148245, 5536.584756143386, 5539.224508568723, 5526.17107433872, 5537.5569954404355, 5544.362398324244, 5548.41870067029, 5549.0, 5423.9186412204635, 5445.40100588927, 5455.427180146027, 5456.645318054314, 5462.180672899097, 5390.110631745718, 5557.666540007613, 5570.554355651457, 5573.916391254053, 5574.5261652758345, 5374.328208973879, 5386.865328366822, 5394.892102157856, 5402.810901618424, 5408.378036525693], "unit": "score", "name": "prototype.html", "value": 4161.973330551694}, {"lowerIsBetter": false, "replicates": [620.8230654263534, 654.273756130695, 666.8411979431656, 677.8305423644086, 742.9524370637403, 12013.63959081228, 12458.31479268641, 12509.374531273423, 12514.874851251485, 12533.874661253385, 11588.0, 11637.650870473879, 11638.301701897892, 11689.59086431975, 11760.0, 644.2237104289344, 776.4526009163526, 778.3267473635293, 794.1621589223367, 794.5590197440418, 791.4973991515401, 798.7803354077618, 800.1878093734864, 800.2437696376926, 800.6677228950008, 834.7662654456732, 837.1293854391456, 838.4131108224237, 838.584900474263, 838.6058552480324, 673.0476375928056, 821.1583127294571, 834.4576025583359, 835.2816577743137, 837.1377481194379, 611.6880391000577, 612.146056251531, 612.8222815383533, 613.2702084519408, 613.4632196827775, 11769.2938423694, 11798.174127811057, 11840.052795776317, 11843.230190037706, 11853.111016673784, 11738.706532336675, 11853.762924741543, 12262.877371226352, 12588.244705317711, 12661.113722039461, 9600.279979001532, 9719.902800971971, 9727.854082188773, 10007.0, 10050.195984321237, 3322.734181265493, 3390.3727810354917, 3394.932101357984, 3413.2320227948762, 3488.0930957950864, 40242.79878600618, 40541.59458405407, 40626.79686601578, 40627.7968610158, 40918.38622420666, 9603.615855365708, 9980.401175929323, 9988.800223995479, 10196.184305255561, 10196.235282353853, 17546.47360579159, 17587.29650813979, 17738.0, 17747.556311092325, 17859.73210401845, 6761.256261811197, 6774.593524388454, 6840.281770414134, 6952.165740111118, 6957.130358705162, 3680.9815950920074, 3698.5007024051947, 3716.201016781405, 3736.252749450121, 3751.8686845960806, 2728.181545536331, 2742.931426714308, 2750.092469485065, 2750.339918419565, 2769.819961702483, 490.3404920382152, 559.1082223852948, 570.9857253568694, 574.4341823304043, 588.9911651325234, 549.7553588653011, 550.309361751, 625.8091282158986, 642.0786171843326, 655.3217419970308, 7288.70845166198, 7376.557406555624, 7424.406047516294, 7566.924330756732, 7714.807129821687, 576.6943519934441, 599.1342510072902, 605.3492495567194, 606.342118801097, 612.1491127333011, 3617.620149884277, 3668.63313668631, 3726.6087060858217, 3833.310004199215, 3847.0, 48688.0, 49004.75497622489, 49076.0, 49173.75413122983, 49460.0, 43338.56661433345, 43409.34885976713, 43498.0, 44027.0, 45110.323345149845, 39748.80125599354, 39797.60202397939, 39927.0, 40078.79960600178, 40142.799286003385, 7367.77896663101, 7443.144038435649, 7554.735584254525, 7615.162332143571, 7716.8456630868195, 31886.681133188373, 32056.67943320537, 32475.512867307483, 32535.349293014482, 32691.34617307593, 36732.081697956695, 37842.43236351512, 37862.62137378591, 38075.619243808316, 40278.0, 9317.11487408695, 9322.394044387092, 9325.393849399767, 9378.249740020645, 9395.577199025924, 10324.277300588887, 10386.584536618753, 10640.308379955279, 12044.819327710267, 12052.75894482123, 7768.650410731644, 9186.598117378131, 10395.792084158425, 10697.411642359433, 10942.726431839268, 11151.498182581641, 11206.831897521706, 11303.660890173307, 11467.885321146681, 11797.764044718886, 10391.792164156523, 10422.0, 10652.573897044342, 10665.36007839532, 11100.11199104086, 9215.723528294162, 9375.0, 9477.0, 9535.427874327563, 9770.572771449146, 9296.302777291596, 9651.17964972957, 9673.081057299545, 9808.264380171659, 9840.55717492729], "unit": "score", "name": "yui.html", "value": 5798.269510086632}], "name": "dromaeo_css", "value": 6350.212459947578}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 108.0, 111.0, 114.0, 112.0, 105.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 157.0, 177.0, 132.0, 163.0, 157.0, 134.0, 185.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 161.0, 160.0, 161.0, 164.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 111.0, 95.0, 73.0, 73.0, 73.0, 118.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 98.0, 93.0, 93.0, 143.0, 94.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 66.0, 63.0, 63.0, 64.0, 63.0, 73.0, 62.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 64.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 67.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 89.0, 88.0, 83.0, 91.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [116.0, 128.0, 115.0, 117.0, 125.0, 118.0, 119.0, 117.0, 116.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [143.0, 146.0, 142.0, 141.0, 143.0, 132.0, 143.0, 142.0, 154.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 70.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1518.1999999999998}]} 14:59:45 INFO - Return code: 0 14:59:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:59:45 ERROR - # TBPL SUCCESS # 14:59:45 INFO - Running post-action listener: _resource_record_post_action 14:59:45 INFO - Running post-run listener: _resource_record_post_run 14:59:46 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527212544; Read time: 4; Write time: 505164 14:59:46 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 212807680; Read time: 0; Write time: 325928 14:59:46 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282161152; Read time: 4; Write time: 173164 14:59:46 INFO - Running post-run listener: _upload_blobber_files 14:59:46 INFO - Blob upload gear active. 14:59:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:59:46 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:59:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:59:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:47 INFO - (blobuploader) - INFO - Done attempting. 14:59:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:59:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:48 INFO - (blobuploader) - INFO - Done attempting. 14:59:48 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:48 INFO - Return code: 0 14:59:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dbf497de4d06e190aba2216a8c7cb715a1358c01cfd1530ac430d417adca7a4ed1192a573d499f1eaff57b8dd8b32fdc5aa7759e0d66d65e30771b5ff5e095d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc63831b7724892d13497b3059bee061cccc1e9a3034942591e7f5c3e17afe155f6d65ee018c73b6e0514965364b6663170f7649112bdc4e33e499c41d8ceed6"} 14:59:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:48 INFO - Contents: 14:59:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dbf497de4d06e190aba2216a8c7cb715a1358c01cfd1530ac430d417adca7a4ed1192a573d499f1eaff57b8dd8b32fdc5aa7759e0d66d65e30771b5ff5e095d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc63831b7724892d13497b3059bee061cccc1e9a3034942591e7f5c3e17afe155f6d65ee018c73b6e0514965364b6663170f7649112bdc4e33e499c41d8ceed6"} 14:59:48 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:48 INFO - Copying logs to upload dir... 14:59:48 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.439387 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-28 14:59:47.243503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 14:59:47.246671) ========= 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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 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/8dbf497de4d06e190aba2216a8c7cb715a1358c01cfd1530ac430d417adca7a4ed1192a573d499f1eaff57b8dd8b32fdc5aa7759e0d66d65e30771b5ff5e095d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc63831b7724892d13497b3059bee061cccc1e9a3034942591e7f5c3e17afe155f6d65ee018c73b6e0514965364b6663170f7649112bdc4e33e499c41d8ceed6"} build_url:https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/AaFiIJTPTfOT-SANSnHWHA/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/8dbf497de4d06e190aba2216a8c7cb715a1358c01cfd1530ac430d417adca7a4ed1192a573d499f1eaff57b8dd8b32fdc5aa7759e0d66d65e30771b5ff5e095d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc63831b7724892d13497b3059bee061cccc1e9a3034942591e7f5c3e17afe155f6d65ee018c73b6e0514965364b6663170f7649112bdc4e33e499c41d8ceed6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 14:59:47.274481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:59:47.275114) ========= 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=ed14279e38b05397cf4aa391000001a4-1459200672.85740-202603963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 14:59:47.356002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 14:59:47.356453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 14:59:47.356844) ========= ========= Total master_lag: 0.29 =========