builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1450694373.2 results: success (0) buildid: 20151221015828 builduid: 8a933936994c4903b214b308a96b8d10 revision: 3e3f7dd7190fe8e048994a7c90a494f19524f5eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.202060) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.202588) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.202924) ========= 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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006324 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.228687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.229082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.249370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.249862) ========= 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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.299491) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.299800) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.300176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.300495) ========= 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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 02:39:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-21 02:39:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.517561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.517915) ========= 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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017058 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:33.567141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 02:39:33.567524) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e3f7dd7190fe8e048994a7c90a494f19524f5eb --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 3e3f7dd7190fe8e048994a7c90a494f19524f5eb --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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 02:39:34,298 truncating revision to first 12 chars 2015-12-21 02:39:34,298 Setting DEBUG logging. 2015-12-21 02:39:34,298 attempt 1/10 2015-12-21 02:39:34,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e3f7dd7190f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 02:39:35,190 unpacking tar archive at: fx-team-3e3f7dd7190f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.177514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 02:39:34.758805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:34.759157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:34.769211) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:34.769551) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:34.770020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 02:39:34.770352) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:39:35 INFO - MultiFileLogger online at 20151221 02:39:35 in /builds/slave/test 02:39:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:39:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:39:35 INFO - {'append_to_log': False, 02:39:35 INFO - 'base_work_dir': '/builds/slave/test', 02:39:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:39:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:39:35 INFO - 'branch': 'Fx-Team-Non-PGO', 02:39:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:39:35 INFO - 'config_files': ('talos/linux_config.py',), 02:39:35 INFO - 'default_actions': ('clobber', 02:39:35 INFO - 'read-buildbot-config', 02:39:35 INFO - 'download-and-extract', 02:39:35 INFO - 'populate-webroot', 02:39:35 INFO - 'create-virtualenv', 02:39:35 INFO - 'install', 02:39:35 INFO - 'run-tests'), 02:39:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:39:35 INFO - 'download_minidump_stackwalk': True, 02:39:35 INFO - 'download_symbols': 'ondemand', 02:39:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:39:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:39:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:39:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:39:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:39:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:39:35 INFO - 'installer_path': 'installer.exe', 02:39:35 INFO - 'log_level': 'info', 02:39:35 INFO - 'log_name': 'talos', 02:39:35 INFO - 'log_to_console': True, 02:39:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:39:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:39:35 INFO - 'opt_config_files': (), 02:39:35 INFO - 'pip_index': False, 02:39:35 INFO - 'sps_profile': False, 02:39:35 INFO - 'sps_profile_interval': 0, 02:39:35 INFO - 'suite': 'dromaeojs', 02:39:35 INFO - 'system_bits': '64', 02:39:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:39:35 INFO - 'title': 'talos-linux64-ix-044', 02:39:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:39:35 INFO - 'use_talos_json': True, 02:39:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:39:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:39:35 INFO - 'work_dir': 'build'} 02:39:35 INFO - ##### 02:39:35 INFO - ##### Running clobber step. 02:39:35 INFO - ##### 02:39:35 INFO - Running pre-action listener: _resource_record_pre_action 02:39:35 INFO - Running main action method: clobber 02:39:35 INFO - rmtree: /builds/slave/test/build 02:39:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:39:36 INFO - Running post-action listener: _resource_record_post_action 02:39:36 INFO - ##### 02:39:36 INFO - ##### Running read-buildbot-config step. 02:39:36 INFO - ##### 02:39:36 INFO - Running pre-action listener: _resource_record_pre_action 02:39:36 INFO - Running main action method: read_buildbot_config 02:39:36 INFO - Using buildbot properties: 02:39:36 INFO - { 02:39:36 INFO - "project": "", 02:39:36 INFO - "product": "firefox", 02:39:36 INFO - "script_repo_revision": "production", 02:39:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:39:36 INFO - "repository": "", 02:39:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:39:36 INFO - "buildid": "20151221015828", 02:39:36 INFO - "pgo_build": "False", 02:39:36 INFO - "basedir": "/builds/slave/test", 02:39:36 INFO - "buildnumber": 1034, 02:39:36 INFO - "slavename": "talos-linux64-ix-044", 02:39:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:39:36 INFO - "platform": "ubuntu64_hw", 02:39:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:39:36 INFO - "branch": "fx-team", 02:39:36 INFO - "repo_path": "integration/fx-team", 02:39:36 INFO - "revision": "3e3f7dd7190fe8e048994a7c90a494f19524f5eb", 02:39:36 INFO - "stage_platform": "linux64", 02:39:36 INFO - "builduid": "8a933936994c4903b214b308a96b8d10", 02:39:36 INFO - "slavebuilddir": "test" 02:39:36 INFO - } 02:39:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:39:36 INFO - Running post-action listener: _resource_record_post_action 02:39:36 INFO - ##### 02:39:36 INFO - ##### Running download-and-extract step. 02:39:36 INFO - ##### 02:39:36 INFO - Running pre-action listener: _resource_record_pre_action 02:39:36 INFO - Running main action method: download_and_extract 02:39:36 INFO - mkdir: /builds/slave/test/build/tests 02: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')]} 02:39:36 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:39:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json 02:39:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json 02:39:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:39:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:39:38 INFO - Downloaded 1302 bytes. 02:39:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:39:38 INFO - Using the following test package requirements: 02:39:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:39:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'jsshell-linux-x86_64.zip'], 02:39:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:39:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:39:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:39:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:39:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:39:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:38 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:39:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:39:40 INFO - Downloaded 21872076 bytes. 02:39:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:39:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:39:41 INFO - Return code: 0 02:39:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:41 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:39:42 INFO - Downloaded 21872076 bytes. 02:39:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:39:44 INFO - Return code: 0 02: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')]} 02:39:44 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:39:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:39:45 INFO - Downloaded 11132039 bytes. 02:39:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:39:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:39:46 INFO - Return code: 0 02: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')]} 02:39:46 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:39:48 INFO - Downloaded 53061442 bytes. 02:39:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:48 INFO - mkdir: /builds/slave/test/properties 02:39:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:48 INFO - Contents: 02:39:48 INFO - build_url:https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:48 INFO - Running post-action listener: _resource_record_post_action 02:39:48 INFO - Running post-action listener: set_extra_try_arguments 02:39:48 INFO - ##### 02:39:48 INFO - ##### Running populate-webroot step. 02:39:48 INFO - ##### 02:39:48 INFO - Running pre-action listener: _resource_record_pre_action 02:39:48 INFO - Running main action method: populate_webroot 02:39:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:48 INFO - '--tppagecycles', 02:39:48 INFO - '7'], 02:39:48 INFO - 'tests': ['tsvgm']}}, 02:39:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:39:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:39:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:39:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'tests': ['damp', 'tps']}, 02:39:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['damp', 'tps']}, 02:39:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:39:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:48 INFO - 'other': {'tests': ['a11yr', 02:39:48 INFO - 'ts_paint', 02:39:48 INFO - 'tpaint', 02:39:48 INFO - 'sessionrestore', 02:39:48 INFO - 'sessionrestore_no_auto_restore']}, 02:39:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['a11yr', 02:39:48 INFO - 'ts_paint', 02:39:48 INFO - 'tpaint', 02:39:48 INFO - 'sessionrestore', 02:39:48 INFO - 'sessionrestore_no_auto_restore']}, 02:39:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['a11yr', 02:39:48 INFO - 'ts_paint', 02:39:48 INFO - 'tpaint', 02:39:48 INFO - 'sessionrestore', 02:39:48 INFO - 'sessionrestore_no_auto_restore']}, 02:39:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['a11yr', 02:39:48 INFO - 'ts_paint', 02:39:48 INFO - 'tpaint', 02:39:48 INFO - 'sessionrestore', 02:39:48 INFO - 'sessionrestore_no_auto_restore']}, 02:39:48 INFO - 'other_l64': {'tests': ['a11yr', 02:39:48 INFO - 'ts_paint', 02:39:48 INFO - 'tpaint', 02:39:48 INFO - 'sessionrestore', 02:39:48 INFO - 'sessionrestore_no_auto_restore']}, 02:39:48 INFO - 'other_nol64': {'tests': ['a11yr', 02:39:48 INFO - 'ts_paint', 02:39:48 INFO - 'tpaint', 02:39:48 INFO - 'sessionrestore', 02:39:48 INFO - 'sessionrestore_no_auto_restore']}, 02:39:48 INFO - 'svgr': {'tests': ['tsvgx', 02:39:48 INFO - 'tsvgr_opacity', 02:39:48 INFO - 'tart', 02:39:48 INFO - 'tscrollx', 02:39:48 INFO - 'cart']}, 02:39:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['tsvgx', 02:39:48 INFO - 'tsvgr_opacity', 02:39:48 INFO - 'tart', 02:39:48 INFO - 'tscrollx', 02:39:48 INFO - 'cart']}, 02:39:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'tests': ['tp5o']}, 02:39:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'talos_options': ['--e10s'], 02:39:48 INFO - 'tests': ['tp5o']}, 02:39:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'talos_options': ['--xperf_path', 02:39:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:48 INFO - 'tests': ['tp5n']}, 02:39:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:48 INFO - 'talos_options': ['--e10s', 02:39:48 INFO - '--xperf_path', 02:39:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:48 INFO - 'tests': ['tp5n']}}, 02:39:48 INFO - 'talos.zip': {'path': '', 02:39:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:48 INFO - Running post-action listener: _resource_record_post_action 02:39:48 INFO - ##### 02:39:48 INFO - ##### Running create-virtualenv step. 02:39:48 INFO - ##### 02:39:48 INFO - Running pre-action listener: _resource_record_pre_action 02:39:48 INFO - Running main action method: create_virtualenv 02:39:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:39:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:48 INFO - Using real prefix '/usr' 02:39:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:48 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:51 INFO - Installing pip.................done. 02:39:51 INFO - Return code: 0 02:39:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:39:51 INFO - Using env: {'DISPLAY': ':0', 02:39:51 INFO - 'HOME': '/home/cltbld', 02:39:51 INFO - 'LANG': 'en_US.UTF-8', 02:39:51 INFO - 'LANGUAGE': 'en_US:en', 02:39:51 INFO - 'LOGNAME': 'cltbld', 02:39:51 INFO - 'MAIL': '/var/mail/cltbld', 02:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:51 INFO - 'MOZ_NO_REMOTE': '1', 02:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:51 INFO - 'NO_EM_RESTART': '1', 02:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:51 INFO - 'PWD': '/builds/slave/test', 02:39:51 INFO - 'SHELL': '/bin/bash', 02:39:51 INFO - 'SHLVL': '1', 02:39:51 INFO - 'TERM': 'linux', 02:39:51 INFO - 'TMOUT': '86400', 02:39:51 INFO - 'USER': 'cltbld', 02:39:51 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:51 INFO - '_': '/tools/buildbot/bin/python'} 02:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:39:51 INFO - Cleaning up... 02:39:51 INFO - Return code: 0 02:39:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:39:51 INFO - Using env: {'DISPLAY': ':0', 02:39:51 INFO - 'HOME': '/home/cltbld', 02:39:51 INFO - 'LANG': 'en_US.UTF-8', 02:39:51 INFO - 'LANGUAGE': 'en_US:en', 02:39:51 INFO - 'LOGNAME': 'cltbld', 02:39:51 INFO - 'MAIL': '/var/mail/cltbld', 02:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:51 INFO - 'MOZ_NO_REMOTE': '1', 02:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:51 INFO - 'NO_EM_RESTART': '1', 02:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:51 INFO - 'PWD': '/builds/slave/test', 02:39:51 INFO - 'SHELL': '/bin/bash', 02:39:51 INFO - 'SHLVL': '1', 02:39:51 INFO - 'TERM': 'linux', 02:39:51 INFO - 'TMOUT': '86400', 02:39:51 INFO - 'USER': 'cltbld', 02:39:51 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:51 INFO - '_': '/tools/buildbot/bin/python'} 02:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:51 INFO - Downloading/unpacking psutil>=0.7.1 02:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:39:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:53 INFO - Installing collected packages: psutil 02:39:53 INFO - Running setup.py install for psutil 02:39:53 INFO - building 'psutil._psutil_linux' extension 02:39:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:39:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:39:53 INFO - building 'psutil._psutil_posix' extension 02:39:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:39:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:54 INFO - Successfully installed psutil 02:39:54 INFO - Cleaning up... 02:39:54 INFO - Return code: 0 02:39:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:39:54 INFO - Using env: {'DISPLAY': ':0', 02:39:54 INFO - 'HOME': '/home/cltbld', 02:39:54 INFO - 'LANG': 'en_US.UTF-8', 02:39:54 INFO - 'LANGUAGE': 'en_US:en', 02:39:54 INFO - 'LOGNAME': 'cltbld', 02:39:54 INFO - 'MAIL': '/var/mail/cltbld', 02:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:54 INFO - 'MOZ_NO_REMOTE': '1', 02:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:54 INFO - 'NO_EM_RESTART': '1', 02:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:54 INFO - 'PWD': '/builds/slave/test', 02:39:54 INFO - 'SHELL': '/bin/bash', 02:39:54 INFO - 'SHLVL': '1', 02:39:54 INFO - 'TERM': 'linux', 02:39:54 INFO - 'TMOUT': '86400', 02:39:54 INFO - 'USER': 'cltbld', 02:39:54 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:54 INFO - '_': '/tools/buildbot/bin/python'} 02:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:39:56 INFO - Installing collected packages: mozsystemmonitor 02:39:56 INFO - Running setup.py install for mozsystemmonitor 02:39:56 INFO - Successfully installed mozsystemmonitor 02:39:56 INFO - Cleaning up... 02:39:56 INFO - Return code: 0 02:39:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:56 INFO - Using env: {'DISPLAY': ':0', 02:39:56 INFO - 'HOME': '/home/cltbld', 02:39:56 INFO - 'LANG': 'en_US.UTF-8', 02:39:56 INFO - 'LANGUAGE': 'en_US:en', 02:39:56 INFO - 'LOGNAME': 'cltbld', 02:39:56 INFO - 'MAIL': '/var/mail/cltbld', 02:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:56 INFO - 'MOZ_NO_REMOTE': '1', 02:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:56 INFO - 'NO_EM_RESTART': '1', 02:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:56 INFO - 'PWD': '/builds/slave/test', 02:39:56 INFO - 'SHELL': '/bin/bash', 02:39:56 INFO - 'SHLVL': '1', 02:39:56 INFO - 'TERM': 'linux', 02:39:56 INFO - 'TMOUT': '86400', 02:39:56 INFO - 'USER': 'cltbld', 02:39:56 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:56 INFO - '_': '/tools/buildbot/bin/python'} 02:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:56 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:58 INFO - Downloading docopt-0.6.1.tar.gz 02:39:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:59 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:59 INFO - Running setup.py install for blobuploader 02:39:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:59 INFO - Running setup.py install for requests 02:39:59 INFO - Running setup.py install for docopt 02:39:59 INFO - Successfully installed blobuploader requests docopt 02:39:59 INFO - Cleaning up... 02:39:59 INFO - Return code: 0 02:39:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:59 INFO - Using env: {'DISPLAY': ':0', 02:39:59 INFO - 'HOME': '/home/cltbld', 02:39:59 INFO - 'LANG': 'en_US.UTF-8', 02:39:59 INFO - 'LANGUAGE': 'en_US:en', 02:39:59 INFO - 'LOGNAME': 'cltbld', 02:39:59 INFO - 'MAIL': '/var/mail/cltbld', 02:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:59 INFO - 'MOZ_NO_REMOTE': '1', 02:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:59 INFO - 'NO_EM_RESTART': '1', 02:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:59 INFO - 'PWD': '/builds/slave/test', 02:39:59 INFO - 'SHELL': '/bin/bash', 02:39:59 INFO - 'SHLVL': '1', 02:39:59 INFO - 'TERM': 'linux', 02:39:59 INFO - 'TMOUT': '86400', 02:39:59 INFO - 'USER': 'cltbld', 02:39:59 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:59 INFO - '_': '/tools/buildbot/bin/python'} 02:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:59 INFO - Running setup.py (path:/tmp/pip-TAQEmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:59 INFO - Running setup.py (path:/tmp/pip-7atX6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:59 INFO - Running setup.py (path:/tmp/pip-OLk1_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:00 INFO - Running setup.py (path:/tmp/pip-zdAmUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:00 INFO - Running setup.py (path:/tmp/pip-vTmJBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:00 INFO - Running setup.py (path:/tmp/pip-7upxkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:00 INFO - Running setup.py (path:/tmp/pip-EVyRCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:00 INFO - Running setup.py (path:/tmp/pip-Dw3l6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:00 INFO - Running setup.py (path:/tmp/pip-oXq7Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:00 INFO - Running setup.py (path:/tmp/pip-1HdB0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:00 INFO - Running setup.py (path:/tmp/pip-kGdqXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:00 INFO - Running setup.py (path:/tmp/pip-LIVt1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:00 INFO - Running setup.py (path:/tmp/pip-zbElie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:00 INFO - Running setup.py (path:/tmp/pip-Bu0HJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:00 INFO - Running setup.py (path:/tmp/pip-62P4Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:00 INFO - Running setup.py (path:/tmp/pip-XTq4CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:00 INFO - Running setup.py (path:/tmp/pip-zj9g9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:40:01 INFO - Running setup.py install for manifestparser 02:40:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Running setup.py install for mozcrash 02:40:01 INFO - Running setup.py install for mozdebug 02:40:01 INFO - Running setup.py install for mozdevice 02:40:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Running setup.py install for mozfile 02:40:01 INFO - Running setup.py install for mozhttpd 02:40:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Running setup.py install for mozinfo 02:40:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Running setup.py install for mozInstall 02:40:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:40:01 INFO - Running setup.py install for mozleak 02:40:01 INFO - Running setup.py install for mozlog 02:40:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for moznetwork 02:40:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for mozprocess 02:40:02 INFO - Running setup.py install for mozprofile 02:40:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for mozrunner 02:40:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for mozscreenshot 02:40:02 INFO - Running setup.py install for moztest 02:40:02 INFO - Running setup.py install for mozversion 02:40:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:40:02 INFO - Cleaning up... 02:40:02 INFO - Return code: 0 02:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:02 INFO - Using env: {'DISPLAY': ':0', 02:40:02 INFO - 'HOME': '/home/cltbld', 02:40:02 INFO - 'LANG': 'en_US.UTF-8', 02:40:02 INFO - 'LANGUAGE': 'en_US:en', 02:40:02 INFO - 'LOGNAME': 'cltbld', 02:40:02 INFO - 'MAIL': '/var/mail/cltbld', 02:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:02 INFO - 'MOZ_NO_REMOTE': '1', 02:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:02 INFO - 'NO_EM_RESTART': '1', 02:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:02 INFO - 'PWD': '/builds/slave/test', 02:40:02 INFO - 'SHELL': '/bin/bash', 02:40:02 INFO - 'SHLVL': '1', 02:40:02 INFO - 'TERM': 'linux', 02:40:02 INFO - 'TMOUT': '86400', 02:40:02 INFO - 'USER': 'cltbld', 02:40:02 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:02 INFO - '_': '/tools/buildbot/bin/python'} 02:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:03 INFO - Running setup.py (path:/tmp/pip-AlK9iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:03 INFO - Running setup.py (path:/tmp/pip-ckntNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:03 INFO - Running setup.py (path:/tmp/pip-1PRuOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:03 INFO - Running setup.py (path:/tmp/pip-qi_cPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:03 INFO - Running setup.py (path:/tmp/pip-5q2Zs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:03 INFO - Running setup.py (path:/tmp/pip-GbMpV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:03 INFO - Running setup.py (path:/tmp/pip-wwrK4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:03 INFO - Running setup.py (path:/tmp/pip-onEA1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:03 INFO - Running setup.py (path:/tmp/pip-kmGgEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:03 INFO - Running setup.py (path:/tmp/pip-UAsSCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:03 INFO - Running setup.py (path:/tmp/pip-Pa0Uwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:03 INFO - Running setup.py (path:/tmp/pip-CqFj5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:03 INFO - Running setup.py (path:/tmp/pip-tW4ja1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:04 INFO - Running setup.py (path:/tmp/pip-AQARg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:04 INFO - Running setup.py (path:/tmp/pip-4bCXni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:04 INFO - Running setup.py (path:/tmp/pip-VSY2zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:04 INFO - Running setup.py (path:/tmp/pip-8B0A4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:04 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:04 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:05 INFO - Downloading blessings-1.5.1.tar.gz 02:40:05 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:40:06 INFO - Installing collected packages: blessings 02:40:06 INFO - Running setup.py install for blessings 02:40:06 INFO - Successfully installed blessings 02:40:06 INFO - Cleaning up... 02:40:06 INFO - Return code: 0 02:40:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:40:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:06 INFO - Reading from file tmpfile_stdout 02:40:06 INFO - Current package versions: 02:40:06 INFO - argparse == 1.2.1 02:40:06 INFO - blessings == 1.5.1 02:40:06 INFO - blobuploader == 1.2.4 02:40:06 INFO - docopt == 0.6.1 02:40:06 INFO - manifestparser == 1.1 02:40:06 INFO - mozInstall == 1.12 02:40:06 INFO - mozcrash == 0.16 02:40:06 INFO - mozdebug == 0.1 02:40:06 INFO - mozdevice == 0.47 02:40:06 INFO - mozfile == 1.2 02:40:06 INFO - mozhttpd == 0.7 02:40:06 INFO - mozinfo == 0.9 02:40:06 INFO - mozleak == 0.1 02:40:06 INFO - mozlog == 3.1 02:40:06 INFO - moznetwork == 0.27 02:40:06 INFO - mozprocess == 0.22 02:40:06 INFO - mozprofile == 0.27 02:40:06 INFO - mozrunner == 6.11 02:40:06 INFO - mozscreenshot == 0.1 02:40:06 INFO - mozsystemmonitor == 0.0 02:40:06 INFO - moztest == 0.7 02:40:06 INFO - mozversion == 1.4 02:40:06 INFO - psutil == 3.1.1 02:40:06 INFO - requests == 1.2.3 02:40:06 INFO - wsgiref == 0.1.2 02:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:06 INFO - Using env: {'DISPLAY': ':0', 02:40:06 INFO - 'HOME': '/home/cltbld', 02:40:06 INFO - 'LANG': 'en_US.UTF-8', 02:40:06 INFO - 'LANGUAGE': 'en_US:en', 02:40:06 INFO - 'LOGNAME': 'cltbld', 02:40:06 INFO - 'MAIL': '/var/mail/cltbld', 02:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:06 INFO - 'MOZ_NO_REMOTE': '1', 02:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:06 INFO - 'NO_EM_RESTART': '1', 02:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:06 INFO - 'PWD': '/builds/slave/test', 02:40:06 INFO - 'SHELL': '/bin/bash', 02:40:06 INFO - 'SHLVL': '1', 02:40:06 INFO - 'TERM': 'linux', 02:40:06 INFO - 'TMOUT': '86400', 02:40:06 INFO - 'USER': 'cltbld', 02:40:06 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:06 INFO - '_': '/tools/buildbot/bin/python'} 02:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:06 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 1)) 02:40:06 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 2)) 02:40:06 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 3)) 02:40:06 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 4)) 02:40:06 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 5)) 02:40:06 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 6)) 02:40:06 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 7)) 02:40:06 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 8)) 02:40:06 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:06 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 3)) 02:40:06 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:06 INFO - Cleaning up... 02:40:06 INFO - Return code: 0 02:40:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:40:06 INFO - Using env: {'DISPLAY': ':0', 02:40:06 INFO - 'HOME': '/home/cltbld', 02:40:06 INFO - 'LANG': 'en_US.UTF-8', 02:40:06 INFO - 'LANGUAGE': 'en_US:en', 02:40:06 INFO - 'LOGNAME': 'cltbld', 02:40:06 INFO - 'MAIL': '/var/mail/cltbld', 02:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:06 INFO - 'MOZ_NO_REMOTE': '1', 02:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:06 INFO - 'NO_EM_RESTART': '1', 02:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:06 INFO - 'PWD': '/builds/slave/test', 02:40:06 INFO - 'SHELL': '/bin/bash', 02:40:06 INFO - 'SHLVL': '1', 02:40:06 INFO - 'TERM': 'linux', 02:40:06 INFO - 'TMOUT': '86400', 02:40:06 INFO - 'USER': 'cltbld', 02:40:06 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:06 INFO - '_': '/tools/buildbot/bin/python'} 02:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:06 INFO - Downloading/unpacking jsonschema 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:40:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:40:08 INFO - Downloading/unpacking functools32 (from jsonschema) 02:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:40:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:40:08 INFO - warning: no files found matching '*.txt' 02:40:08 INFO - no previously-included directories found matching 'build' 02:40:08 INFO - no previously-included directories found matching 'dist' 02:40:08 INFO - no previously-included directories found matching '.git*' 02:40:08 INFO - Installing collected packages: jsonschema, functools32 02:40:08 INFO - Running setup.py install for functools32 02:40:08 INFO - warning: no files found matching '*.txt' 02:40:08 INFO - no previously-included directories found matching 'build' 02:40:08 INFO - no previously-included directories found matching 'dist' 02:40:08 INFO - no previously-included directories found matching '.git*' 02:40:08 INFO - Successfully installed jsonschema functools32 02:40:08 INFO - Cleaning up... 02:40:09 INFO - Return code: 0 02:40:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f16630b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ba240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, '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': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:40:09 INFO - Using env: {'DISPLAY': ':0', 02:40:09 INFO - 'HOME': '/home/cltbld', 02:40:09 INFO - 'LANG': 'en_US.UTF-8', 02:40:09 INFO - 'LANGUAGE': 'en_US:en', 02:40:09 INFO - 'LOGNAME': 'cltbld', 02:40:09 INFO - 'MAIL': '/var/mail/cltbld', 02:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:09 INFO - 'MOZ_NO_REMOTE': '1', 02:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:09 INFO - 'NO_EM_RESTART': '1', 02:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:09 INFO - 'PWD': '/builds/slave/test', 02:40:09 INFO - 'SHELL': '/bin/bash', 02:40:09 INFO - 'SHLVL': '1', 02:40:09 INFO - 'TERM': 'linux', 02:40:09 INFO - 'TMOUT': '86400', 02:40:09 INFO - 'USER': 'cltbld', 02:40:09 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:09 INFO - '_': '/tools/buildbot/bin/python'} 02:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:09 INFO - Downloading/unpacking flake8 02:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:40:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:40:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:40:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:40:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:40:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:40:11 INFO - no previously-included directories found matching 'docs/_build' 02:40:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:40:11 INFO - Running setup.py install for pep8 02:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:40:11 INFO - no previously-included directories found matching 'docs/_build' 02:40:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:40:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:40:11 INFO - Cleaning up... 02:40:11 INFO - Return code: 0 02:40:11 INFO - Running post-action listener: _resource_record_post_action 02:40:11 INFO - Running post-action listener: _start_resource_monitoring 02:40:11 INFO - Starting resource monitoring. 02:40:11 INFO - ##### 02:40:11 INFO - ##### Running install step. 02:40:11 INFO - ##### 02:40:11 INFO - Running pre-action listener: _resource_record_pre_action 02:40:11 INFO - Running main action method: install 02:40:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:12 INFO - Reading from file tmpfile_stdout 02:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 02:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:40:12 INFO - Reading from file tmpfile_stdout 02:40:12 INFO - Output received: 02:40:12 INFO - Usage: mozinstall [options] installer 02:40:12 INFO - Options: 02:40:12 INFO - -h, --help show this help message and exit 02:40:12 INFO - -d DEST, --destination=DEST 02:40:12 INFO - Directory to install application into. [default: 02:40:12 INFO - "/builds/slave/test"] 02:40:12 INFO - --app=APP Application being installed. [default: firefox] 02:40:12 INFO - mkdir: /builds/slave/test/build/application 02:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:40:27 INFO - Reading from file tmpfile_stdout 02:40:27 INFO - Output received: 02:40:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:40:27 INFO - Running post-action listener: _resource_record_post_action 02:40:27 INFO - ##### 02:40:27 INFO - ##### Running run-tests step. 02:40:27 INFO - ##### 02:40:27 INFO - Running pre-action listener: _resource_record_pre_action 02:40:27 INFO - Running main action method: run_tests 02:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:27 INFO - Python 2.7.3 02:40:27 INFO - Return code: 0 02:40:27 INFO - grabbing minidump binary from tooltool 02:40: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')]} 02:40:27 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 0x21490b0>, '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 0x2149fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:40:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:40:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:27 INFO - Return code: 0 02:40:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:40:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:40:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:40:28 INFO - Return code: 0 02:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] in /builds/slave/test/build 02:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost 02:40:28 INFO - Using env: {'DISPLAY': ':0', 02:40:28 INFO - 'HOME': '/home/cltbld', 02:40:28 INFO - 'LANG': 'en_US.UTF-8', 02:40:28 INFO - 'LANGUAGE': 'en_US:en', 02:40:28 INFO - 'LOGNAME': 'cltbld', 02:40:28 INFO - 'MAIL': '/var/mail/cltbld', 02:40:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:28 INFO - 'MOZ_NO_REMOTE': '1', 02:40:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:28 INFO - 'NO_EM_RESTART': '1', 02:40:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:28 INFO - 'PWD': '/builds/slave/test', 02:40:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:28 INFO - 'SHELL': '/bin/bash', 02:40:28 INFO - 'SHLVL': '1', 02:40:28 INFO - 'TERM': 'linux', 02:40:28 INFO - 'TMOUT': '86400', 02:40:28 INFO - 'USER': 'cltbld', 02:40:28 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700', 02:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:28 INFO - '_': '/tools/buildbot/bin/python'} 02:40:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] with output_timeout 3600 02:40:28 INFO - mozversion INFO | application_buildid: 20151221015828 02:40:28 INFO - mozversion INFO | application_changeset: 3e3f7dd7190fe8e048994a7c90a494f19524f5eb 02:40:28 INFO - mozversion INFO | application_display_name: Nightly 02:40:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:28 INFO - mozversion INFO | application_name: Firefox 02:40:28 INFO - mozversion INFO | application_remotingname: firefox 02:40:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:40:28 INFO - mozversion INFO | application_vendor: Mozilla 02:40:28 INFO - mozversion INFO | application_version: 46.0a1 02:40:28 INFO - mozversion INFO | platform_buildid: 20151221015828 02:40:28 INFO - mozversion INFO | platform_changeset: 3e3f7dd7190fe8e048994a7c90a494f19524f5eb 02:40:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:40:28 INFO - mozversion INFO | platform_version: 46.0a1 02:40:28 INFO - 2015-12-21 02:40:28,726 DEBUG : using testdate: 1450694428 02:40:28 INFO - 2015-12-21 02:40:28,726 DEBUG : actual date: 1450694428 02:40:28 INFO - 2015-12-21 02:40:28,734 INFO : starting webserver on 'localhost:53880' 02:40:28 INFO - 2015-12-21 02:40:28,735 INFO : Starting test suite talos-linux64-ix-044 02:40:28 INFO - 2015-12-21 02:40:28,735 INFO : Starting test dromaeo_css 02:40:28 INFO - 2015-12-21 02:40:28,736 DEBUG : operating with platform_type : linux_ 02:40:28 INFO - 2015-12-21 02:40:28,736 INFO : Initialising browser for dromaeo_css test... 02:40:28 INFO - 2015-12-21 02:40:28,746 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtYYyJ/profile http://localhost:53880/getInfo.html 02:40:33 INFO - 2015-12-21 02:40:33,368 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:40:33 INFO - 2015-12-21 02:40:33,371 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:40:33 INFO - 2015-12-21 02:40:33,371 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:40:33 INFO - 2015-12-21 02:40:33,371 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:40:33 INFO - 2015-12-21 02:40:33,371 DEBUG : BROWSER_OUTPUT: __metrics 02:40:33 INFO - 2015-12-21 02:40:33,488 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:40:33 INFO - 2015-12-21 02:40:33,564 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:40:34 INFO - 2015-12-21 02:40:34,865 INFO : Browser initialized. 02:40:34 INFO - 2015-12-21 02:40:34,865 INFO : Running cycle 1/1 for dromaeo_css test... 02:40:34 INFO - 2015-12-21 02:40:34,865 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtYYyJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:40:46 INFO - 2015-12-21 02:40:46,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 149905408 02:40:46 INFO - 2015-12-21 02:40:46,834 DEBUG : BROWSER_OUTPUT: 02:41:38 INFO - 2015-12-21 02:41:38,076 DEBUG : BROWSER_OUTPUT: 1450694498074 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:43:50 INFO - 2015-12-21 02:43:50,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53880/tests/dromaeo/cssquery-ext.html) 02:43:51 INFO - 2015-12-21 02:43:51,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 235560960 02:43:51 INFO - 2015-12-21 02:43:51,077 DEBUG : BROWSER_OUTPUT: 02:46:53 INFO - 2015-12-21 02:46:53,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/dromaeo/cssquery-ext.html (next: http://localhost:53880/tests/dromaeo/cssquery-jquery.html) 02:46:54 INFO - 2015-12-21 02:46:54,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 232542208 02:46:54 INFO - 2015-12-21 02:46:54,010 DEBUG : BROWSER_OUTPUT: 02:49:56 INFO - 2015-12-21 02:49:56,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53880/tests/dromaeo/cssquery-mootools.html) 02:49:56 INFO - 2015-12-21 02:49:56,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 215502848 02:49:56 INFO - 2015-12-21 02:49:56,731 DEBUG : BROWSER_OUTPUT: 02:52:58 INFO - 2015-12-21 02:52:58,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53880/tests/dromaeo/cssquery-prototype.html) 02:52:59 INFO - 2015-12-21 02:52:59,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 211685376 02:52:59 INFO - 2015-12-21 02:52:59,244 DEBUG : BROWSER_OUTPUT: 02:56:02 INFO - 2015-12-21 02:56:02,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53880/tests/dromaeo/cssquery-yui.html) 02:56:02 INFO - 2015-12-21 02:56:02,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 211615744 02:56:02 INFO - 2015-12-21 02:56:02,783 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/dromaeo/cssquery-yui.html (next: http://localhost:53880/tests/dromaeo/cssquery-dojo.html) 02:59:05 INFO - 2015-12-21 02:59:05,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 241598464 02:59:05 INFO - 2015-12-21 02:59:05,474 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,474 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:59:05 INFO - 2015-12-21 02:59:05,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:59:05 INFO - 2015-12-21 02:59:05,475 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:59:05 INFO - 2015-12-21 02:59:05,475 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:59:05 INFO - 2015-12-21 02:59:05,475 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2545.8981640734373;2613.7386261373863;2625.645537852389;2629.526685196665;2635.051381502659;4312.892177695559;4425.446819147606;4428.357888106223;4481.417415735954;4489.371487991683;4437.356583295428;4453.1539007588535;4468.664850136237;4500.662450316223;4555.908881822362;4113.424120623115;4124.97937510312;4183.979080104603;4302.505211900624;4310.4611923509565;4240.745555266694;4317.740935543861;4317.978410107945;4318.265894797876;4356.15055064261;3987.102901847076;4090.0797320602924;4118.320477121301;4172.749635021908;4178.728382655148;4182.205380977604;4190.413342132104;4192.769397683126;4203.201391735561;4232.280512312914;3999.200159968018;4167.291560434734;4169.291220492523;4190.078182799779;4223.366495025771;4333.39332493448;4349.9130017399475;4357.477102747659;4462.3752674625575;4478.0596074824325;4829.227323628238;4843.5398637129765;4843.878903027417;4861.951380486221;4890.290907818382;4863.416390033183;4864.829730959399;4864.951350486485;4873.731944743037;4903.53416425439;4294.24850651138;4383.07955329378;4387.232234359039;4465.4864690561;4560.566746159109;4945.109880221595;4994.925076123861;5004.749762511859;5005.724685142352;5045.924311135336;4752.097101550694;4801.351817504662;4817.445993710698;4821.445533763662;4861.6353773467135;4653.302004699322;4780.450248221499;4787.497312782108;4801.567858892647;4870.245112007645;4712.986707857827;4811.903761924742;4818.036392721469;4851.272309153655;4869.391326084239;4691.882702932386;4698.859034228979;4706.623470122382;4707.6233901287815;4740.644451666139;3867.497225360685;3982.26328129297;3989.4215338775716;3999.5200575931076;4024.0744628735556;3490.808005559719;3512.297540491912;3533.4169861972487;3565.144365352349;3602.603713591503;4179.540250572434;4182.811773470201;4186.183694179666;4187.036981494273;4230.725002874803;4794.352762377034;4830.565249127595;4855.951440485621;4884;4889.706617602955;4046.4132700758223;4106.67146628269;4154.376843473503;4166.250074986471;4221.282381995068;4242.957570424318;4256.3189889617515;4261.893452663709;4314.7626880521875;4317.266064768997;4525.9773701130625;4537.636989040935;4538.909221815611;4559.430071241095;4566.908661826745;4672.7196368216655;4763.4522029967;4776.307435421914;4788.066327066189;4816.277558366273;4608.193566125981;4617.8152873884665;4628.652851036253;4634.976825115988;4651.6975246930915;4764.047190561971;4787.138315103315;4800.73595952226;4836.637252206169;4845.781939812647;4631.976840115778;4760.59534939534;4762.047590481849;4885.071836351082;4887.095887260868;4664.183767840682;4764.857054288377;4765.428148622187;4795.592374648194;4812.8796780080775;4740.19416699155;4756.072565849626;4756.143894098957;4761.785719642694;4797.760111994457;4350.412694286231;4459;4664.55686709762;4667.393238878924;4707.788149533348;4613.861584152481;4650.279206722963;4731.361266229015;4732.219183834766;4775.379200703886;4618.168729628699;4656.348111264493;4663.883402914954;4680.204365257846;4724.244120940633 02:59:05 INFO - 2015-12-21 02:59:05,475 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.501930771959;561.3740679142754;563.5322682173796;585.5198737035627;587.7854583077178;35409.82295088524;35767.46348804764;35906.28187436253;36006.63993360069;36080.81959590205;38907;39817.99999999993;39835.40246896299;39850.80074599623;39893.8005309973;6957.930420695779;7095.574265544058;7796.142424333319;7972.521648701097;7972.800679982989;9985.900140998607;10201.132903703194;10211.183105351554;10217.438040907748;10247.538860751283;9702.417854928692;9787;9788.314817962746;9790.951045244763;9794.16749576287;7035.437165026811;7263.309985551364;9904.653337133203;9960.701178964642;10229.488525573692;9729;9861.50692465381;9862.950685246527;9867.16129129025;9869.21046316293;36058;36482.08794780125;36527.4520882187;36558.26883462343;36600.26799464023;2722.8366298022183;2846.1034774046316;2904.941901161986;2932.0470846974604;3288.490284005983;28053.719462805315;28195.436091278265;28336.716632833613;28339.291517712016;28545.28636784097;3397.3375191837604;3450.6204317525053;3464.2551851351827;3534.222471056389;3577.069961809948;205968;206951;207469.96265018728;207472;207504;45021.32468012982;51331.7433412838;51666.48333516692;51674.48325516697;51712.22431663453;39797;40063.59936400599;61383.38616613777;62670.37329626645;62763.372366275755;13566;13652.385642646104;13724.519641812689;13788;13790.931045344909;10686.0916822071;10699.090577300862;10701.090407315465;10712.678619641423;10832.891671083189;17752.11239438023;17755.556111097067;17799.555011124565;17867.553311167067;17886.195121219316;7303.59830209333;7517;7555.962220188974;7622.352100071556;7629.809254768564;873.5064688451005;911.5670056723136;940.0505489455699;956.2827879090682;1022.539857064324;24110.758892411202;24335.756642433702;24394.512109757707;24620.5075898481;25778.226653200432;940.5673390240567;945.191860958884;997.8453339732353;1080.6541906589973;1106.3859557945418;12609.621711348675;12676.873231267753;12748.872511274954;12756.681082973;12779.105462617528;266682;270184;270878;270916;271666;42841;42853.571464284956;42966;43116.35325470121;43199.13601727948;1205.7046023724245;1219.7987332090283;1225.871283515236;1231.0889941443447;1244.875512448748;21707.131714731233;24214.394640134138;24850.50298994046;25249.747502525475;25277.87361063183;38341.616583833806;38619.613803862725;38767;38799.224015518965;38815.6118438812;203793;205364;205536;205703;205733;27099.45801083928;27135.45729085447;27624.171274861787;27660.72339276662;27903.441931160858;37217.25565488621;37576;37926.62073379341;38255.23489530249;38378.808105959295;32087.839560802047;32534.186645334055;32574.674253257162;32903.51934163016;33104.50343244901;32145.55345009527;32893;33089.172770680925;33185;33220.66779332176;32190.19524511906;32537.34925301528;32907.341853163285;32927.83536082304;32961.67038329586;27941.64700235985;28560.42879142447;29245.561316580694;29355;30009.699903000692;21136;21187.576248475252;21277.255296064563;21396.893015534824;21705.34883953484 02:59:05 INFO - 2015-12-21 02:59:05,475 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.7228674909456;324.9788763730358;326.8725197173101;333.4930905024363;336.659973426839;12346.197497162679;12797.48810047597;14938.402463901444;15717.292721827516;15961.600959976007;9744.366616169962;9983.20134389249;9993.950030249838;14476.2761861907;14868.10791352517;4489.079738653568;4612.423447069116;4618.284165954283;4621.214393553088;4621.37611422457;3512.4380099184136;3616.7649102808364;3620.6560376764164;3625.963740362602;4811.326414302001;3614.367485690007;5152.407473140581;5336.706481143536;5355.571554275649;5359.839204823861;5162.22566615007;5290.021346050954;5300.893982120375;5302.257683924254;5309.920351194735;5086.720230387327;5097.617678674077;5102.387713474407;5102.795888164506;5103.387593488768;11900.702482438008;14080.225587592678;16408.343666253335;18998.52503687405;19038.143283552272;1717.2358300556257;1727.974080388795;1765.3556451895095;1873.157079314314;1899.211827091769;8923.910760892373;8942.552872356422;9020.413673111227;10946.781064378667;12508.483372589644;1616.264599607176;1657.1962598139892;1730.524105870883;1733.3586572967956;1819.0722731406945;46543.30185047227;47663;50545;51380;53473;9462.195713364303;9601.951990240144;9629.470379129076;9638;9659.517024148765;12081.395930203631;12082.45628946682;12112.333821639895;12115.212511186744;12123.636290911287;6743.35938085881;6798.150231221098;6800.6939687714175;6832.043513908056;6921.6193109379465;6405.327440618668;6624;6629.469642428594;6813.4208592270215;6921.411680007256;4002.4996875390575;4059.4519739835337;4168.353905144708;4171.624553790173;4221.662267018693;1609.4849648112727;1639.9672006559802;1650.8703772134054;1711.6063305439818;1732.774739283885;842.3808500751942;845.5814371885833;863.9136086391436;915.56053094515;950.5864948747317;15264.313105910262;15858.841411585967;16456.177191140396;16648;16923.746143807606;736.1203361982487;833.1418638802044;863.9222469977607;883.2492381475822;937.9062093790703;9051.732757413967;9282.814343713088;9322.25421966241;9477.573509192103;9547.236221102296;519827;528847;536951;543358;548490;67147.32852671508;67834.66082669554;69432.65283673549;69443.65278173678;69801.3019869805;1082.4154956323655;1085.7177133945231;1089.3082892363407;1092.4919912240687;1097.6981330134117;14423.42306307736;14523.553323768632;14561.854381456049;14641.48754793577;14818.555443336718;32412.83793581017;32607.18482037873;32900.1774955628;33419.66580334165;33454.665453346126;41893.581064190184;41917.371239430824;42208;42751.3587296197;42914.78542607267;8813.89826271716;8954.417962832395;9039.096090390909;9058.773530661523;9072.95463522678;10421.218408619536;15246;15517.84482155164;16048.759268611213;16102.677946440772;8960.596773145095;9280.58237379306;9288.256939444964;14172.078814877;14471.855281447051;9102.726918192464;9215.216706580015;9380.20268277204;9394.06059394055;9891.35706179096;7440.813979650552;7668.769936901902;9375.156235938799;9620.95189524048;9682;12926.418311175832;13360.465581376637;13481.59555213345;13486.797698034341;13736.381862815997;14136.717265654836;14153.443121256447;14168.504102356368;14463.855361446671;14755.852441475878 02:59:05 INFO - 2015-12-21 02:59:05,476 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1409.267181065845;1651.364224773462;1675.22939447854;1705.5054034330044;1714.6056407026392;5860.326062502808;7130.429565634749;7235.023271858297;7248.96375518123;7262.455315851313;7160.892586611192;7318.158411782647;7340.229275926017;7355.37479314259;7361.742339018136;2047.7747447780732;2071.2854065347433;2082.115101082034;2083.3749875037506;2084.937451876446;2074.439901226668;2083.3020937985793;2090.289301637443;2117.481217101812;2120.8939553022365;2028.8174064334207;2069.2343832781894;2091.4039498742864;2096.056774451495;2096.9895150524226;2039.3677959832426;2059.4439501334555;2059.8970051497513;2066.4317312738967;2066.4627196928755;2042.652749032668;2069.793020697918;2075.0973326602975;2082.1567265257595;2086.2072412483312;6935.306469353075;6960.095187625627;6963.547369420971;7008.299170083002;7021.052157958712;4170.70805043647;4252.2345977724;4253.893652658678;4261.87214383569;4264.680148988808;2760.806743527954;2784.484870299001;2813.6623605167306;2815.3524689321366;2831.66020077592;895.3346774998563;1744.9825501744947;1776.191832716111;1785.526835388623;1785.7946336171376;9521;9606.615735370646;9609.231261499064;9643.3731807433;9645.469499177543;3718.2749363873786;3719.5536535615897;3782.508273924372;3825.540935087807;3842.1355195080882;7596.430267729942;7610.39116870649;7613.276738709814;7613.961930190314;7630.580318082448;4002.8198731057173;4014.437978682987;4015.638592526687;4039.313316736162;4041.8787436376956;3196.5045417960255;3281.6718328166994;3705.6850167735506;3726.2547490502006;3738.383166777451;3137.780355375102;3174.1429813950103;3184.4268031754045;3223.62928263248;3231.4829627259523;949.7388218240039;978.5205249427729;979.2361957673027;979.5396163803001;984.4290311619244;1189.0962868220215;1189.5420263198557;1190.6011486152236;1204.0969273045216;1217.9025677945742;6646;6677.799666010027;6705.362990515893;6726.831829204309;6816.4546836252985;421.8228344095487;422.02091148535715;428.14157613984383;428.82846861255746;430.2599528810441;4880.463149053601;4910.90178196434;4924.162892308244;4941.50584941503;4953.975230123826;7773.611319434006;7843.058832940083;8461.196186362286;8749.606267717842;8753.868691969625;7785.649645765954;7866;7963.203679632106;7965.243301886311;8023.117457079717;6542.672866356758;6622.602643841288;6692.933070669231;6710.530262881552;6716.093327400738;6575.243846957661;6592.505562082959;6632.701528431328;6641.435477984425;6644;7299.744508942162;7596.582187979714;7605.315521603082;7665.808354791175;7701.691932322644;7610.429217808797;7856.37149028065;7859.449838511478;7874.488158269694;7992.640331185227;5012.423571289349;5439.755211015435;6381.840453988688;6495.512836537184;6505.024246362894;6710.060591517094;6777.220619628609;6780.32196780318;6826.658667066726;6835.384815366641;6340.9048864268;6366.108744775827;6438;6452.193475815523;6567.9671601641685;6354.968225158845;6403.391677790602;6403.871922561616;6496.837579060561;6505.967470162619;6493.642849643315;6540.247871494839;6540.771073012422;6541.215054193337;6547.934520654732;5863.091220860773;6053.757849685963;6090;6095.481884039907;6098.32918378969;6124.938750612437;6154.230721159855;6157.507399408126;6158.538109641705;6161.44546990773 02:59:05 INFO - 2015-12-21 02:59:05,476 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.68804910819085;303.2418952618454;305.4212267752609;309.4019389851417;310.3111093372713;5154.896902061956;5270.130428479301;5309.123994540906;5315.176147697113;5332.680039197651;5196.350456192976;5227.947720522803;5228;5239.056969745454;5239.816606418776;3858.3440815061367;4119.970007498126;4122.196171746511;4125.195586860564;4131.256373852705;3990;3999.520057593093;4126.731762435432;4131.73143745657;4138.97930510347;4066.8169932353117;4078.4290199372113;4079.9796001019954;4091.1385319679625;4099.262132816092;3808.257389808988;3917.0599056226583;3949.111449923773;4076.1236334188143;4087.427760113572;3597.2985267872778;3606.296772129436;3608.8736894208578;3616.8372423241017;3619.5475565554307;4991.276264941599;5032.0690672225755;5033.245013248005;5033.345665063518;5041.571466425358;4670.299455081765;4677.64917631179;4680.578747912704;4681.602063824579;4682.391289132425;5366.9463305366835;5474.618540934706;5492.093804522249;5493.2034854946205;5500.339959204881;3912.9804350978347;3932.9803350983348;3942.586028467027;3943.0536671198993;3947.782871942042;5769.567282453832;5773.855653608652;5781.306243250837;5783.855403614902;5784.13238014297;4053;4057.3711074783455;4059.715819892638;4059.782065380374;4068.4100805383055;3716.895641006971;3821.8471261149243;4124.298869192245;4128.958710412858;4132.235536425771;4379.386885835986;4527.637788976874;4531.77341132942;4534.433195850519;4535.206338890681;5356.866078348073;5380.542653874386;5408.4050754416985;5521.66869987794;5526.088195447786;1357.9388927498287;1377.5316392426623;1378.8138601288697;1381.0056759133408;1381.205806661174;928.8467402878449;943.9575219115156;946.5030858799048;952.7046615549202;956.206348730552;4806.543378379049;4820.060088282751;4831.057943701015;4842.370491836039;4843.588294994965;5636;5639.125935480007;5656.43435656431;5664.5751568631695;5670.744816483269;4816;4824.179889418807;4827.8551643450755;4833.637477189225;4834.057358815067;2832.3344014156655;2911.3595009097967;3010.232390740391;3048.1008102609785;3050.0392376401364;5349.491798279158;5433.1850222466155;5449.836504904859;5453.372862120827;5453.400125986138;5877.471027607536;5886.117082437583;5896.6756828374855;5898.764049437975;5919.792807251725;5410.8917821643345;5426.158945363475;5428.647137936022;5434.375046869582;5437.673739575638;5539.25220095282;5694.487496125369;5696.515796157208;5735.11105778605;5739.196512488172;5555.055640541199;5560.944390556043;5584.357798853021;5607.719614019201;5624.465675760796;5436.483534064258;5442.319710036246;5446.673199608036;5447.591430642638;5452;3926.2147570485445;3928.2339943710704;3930.1157239620857;3932.05630648648;3936.31114554946;5555.2222688822785;5754.424557544212;5761.596688231783;5774.076147816497;5781.971090144522;5545.584081193846;5555.916661250004;5556.611037227355;5557.027520184032;5564.276644036249;5546.362168350692;5554.389017208023;5556.083246264321;5561;5562.332520097614;5302.9469705304;5403.729813509387;5424.945750542444;5427.864303392446;5430.728463576885;5572.331320241597;5579.553635709052;5580.693061881636;5587.0502014656795;5589.5248903842;5231.895362092813;5304.681719096867;5363.5863861261805;5453;5463.289772329572 02:59:05 INFO - 2015-12-21 02:59:05,477 DEBUG : BROWSER_OUTPUT: |5;yui.html;665.9866802663946;692.612137203166;786.8701664225404;788.6845261895241;801.9198080191982;10401.479926003698;10816.621418250363;10827.07969822565;10847.186461015435;10853.891461085397;10848.132149428047;11202.215844890861;11564.132690048258;11679.474423650934;11849.822252666196;783.9412044096701;799.604195923016;799.8320352725934;800.2237829305565;800.4396922154486;793.416838623614;794.3565711773454;802.4864086984335;805.0942689474341;805.7582725182422;830.2776584371575;836.1095433363448;836.4437648963462;836.9330453563731;837.2757564706516;824.7814329202766;825.2160447574798;826.7726375246855;829.6888666749969;829.8340331933607;614.5237440983229;614.7172300741664;615.1449485215554;615.1818081950994;615.2033117113349;9670.081342272473;9815.312928095036;9828.508574571242;9838.06538378853;9840.606375744961;9431.90568094324;9580.01249219238;9782.461964591945;9827.459489728133;9955.701328960144;8507.532085735282;8523.190296921783;8526.658933642648;8533.530655813927;8724;3000.084974082904;3061.1734831595345;3062.9432845668207;3096.28785379364;3122.7189552940117;34361.31277374439;34591.82704086489;37240.81379593112;37322.44016339757;38612.22775544501;9093.772655683528;9099.81800363989;9179.908200917906;9412.105849944244;9575.856362154573;17081.572960675832;17670.646587068186;17679.20443580042;17686.557836054202;17688.115594220493;5387.9461205388225;5938.524918006549;6669.599824010575;6701.765438209639;6848.965755171292;3608.9458658120147;3613.33153366628;3690.1881586051027;3693.4829123922673;3773.1510410158044;2645.4576811753545;2684.2886635041727;2685.181019788944;2771.5011297966157;2839.432113577293;492.2419474010056;500.46200334640406;501.21309544016276;501.6964736334538;501.89460213354874;453.05764010857337;527.3566249175999;555.2321676442929;571.6684323092596;588.4027711872453;7318.085239345082;7333.376662983599;7373.668184931691;7385.778426647209;7398;501.5235526250077;572.842468321215;584.1383958660941;588.5585810642018;593.2110293309887;3698.778073315556;3711.1464363196615;3758.173201895633;3816.809159542012;3938.448617193595;43706.78146609246;46666.83196548588;47353.76323118362;49236.50763492319;49841.50158498441;44585.55414445879;44604.55395446069;44675.32987005197;44722.77638611851;44797.104057919314;34463;37827.243455130745;37851.43222851659;37868.810655946545;38427.615723842966;7388.704451821867;7705.807354816175;7882.251186137537;8062.1534738853925;8118.391120665856;29833.85083074571;30767.53848692316;30827.383452331276;31550.684493154775;32467.67532324741;33820.830895846346;37508.81245593754;42942.141157176055;42983;43588;9234.492102934402;9643.469609171563;9650.613975440903;10112.342697724624;10128.594856205964;10813.24307298513;10819.459027048773;11054.723631909266;11151.776964460503;11638.260556730018;9730.756731081496;9924.851127233242;9952.800943980936;10267.332623379456;10834.241603088023;10120.949395252977;10406.907274736044;10627.256092073481;10686.561544825474;10937.726556836144;9837.458939758382;9863.224619568546;9866.457344846101;9943.453110079015;10059.748506287402;8590.1839325264;8715.9105111861;8823.338249631175;8883;8954.328425367994;8607.75292084142;8738.91261087381;8755.518446485505;8938.10618938101;8979.078746520461 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,842 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: __startTimestamp1450695545469__endTimestamp 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,478 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4458.09 Median:4608.19 stddev:462.72 (10.0%) stddev-sans-first:439.16 02:59:05 INFO - 2015-12-21 02:59:05,479 DEBUG : BROWSER_OUTPUT: Values: 2545.9 2613.7 2625.6 2629.5 2635.1 4312.9 4425.4 4428.4 4481.4 4489.4 4437.4 4453.2 4468.7 4500.7 4555.9 4113.4 4125.0 4184.0 4302.5 4310.5 4240.7 4317.7 4318.0 4318.3 4356.2 3987.1 4090.1 4118.3 4172.7 4178.7 4182.2 4190.4 4192.8 4203.2 4232.3 3999.2 4167.3 4169.3 4190.1 4223.4 4333.4 4349.9 4357.5 4462.4 4478.1 4829.2 4843.5 4843.9 4862.0 4890.3 4863.4 4864.8 4865.0 4873.7 4903.5 4294.2 4383.1 4387.2 4465.5 4560.6 4945.1 4994.9 5004.7 5005.7 5045.9 4752.1 4801.4 4817.4 4821.4 4861.6 4653.3 4780.5 4787.5 4801.6 4870.2 4713.0 4811.9 4818.0 4851.3 4869.4 4691.9 4698.9 4706.6 4707.6 4740.6 3867.5 3982.3 3989.4 3999.5 4024.1 3490.8 3512.3 3533.4 3565.1 3602.6 4179.5 4182.8 4186.2 4187.0 4230.7 4794.4 4830.6 4856.0 4884.0 4889.7 4046.4 4106.7 4154.4 4166.3 4221.3 4243.0 4256.3 4261.9 4314.8 4317.3 4526.0 4537.6 4538.9 4559.4 4566.9 4672.7 4763.5 4776.3 4788.1 4816.3 4608.2 4617.8 4628.7 4635.0 4651.7 4764.0 4787.1 4800.7 4836.6 4845.8 4632.0 4760.6 4762.0 4885.1 4887.1 4664.2 4764.9 4765.4 4795.6 4812.9 4740.2 4756.1 4756.1 4761.8 4797.8 4350.4 4459.0 4664.6 4667.4 4707.8 4613.9 4650.3 4731.4 4732.2 4775.4 4618.2 4656.3 4663.9 4680.2 4724.2 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38601.02 Median:32905.43 stddev:59637.21 (181.2%) stddev-sans-first:59736.09 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: Values: 556.5 561.4 563.5 585.5 587.8 35409.8 35767.5 35906.3 36006.6 36080.8 38907.0 39818.0 39835.4 39850.8 39893.8 6957.9 7095.6 7796.1 7972.5 7972.8 9985.9 10201.1 10211.2 10217.4 10247.5 9702.4 9787.0 9788.3 9791.0 9794.2 7035.4 7263.3 9904.7 9960.7 10229.5 9729.0 9861.5 9863.0 9867.2 9869.2 36058.0 36482.1 36527.5 36558.3 36600.3 2722.8 2846.1 2904.9 2932.0 3288.5 28053.7 28195.4 28336.7 28339.3 28545.3 3397.3 3450.6 3464.3 3534.2 3577.1 205968.0 206951.0 207470.0 207472.0 207504.0 45021.3 51331.7 51666.5 51674.5 51712.2 39797.0 40063.6 61383.4 62670.4 62763.4 13566.0 13652.4 13724.5 13788.0 13790.9 10686.1 10699.1 10701.1 10712.7 10832.9 17752.1 17755.6 17799.6 17867.6 17886.2 7303.6 7517.0 7556.0 7622.4 7629.8 873.5 911.6 940.1 956.3 1022.5 24110.8 24335.8 24394.5 24620.5 25778.2 940.6 945.2 997.8 1080.7 1106.4 12609.6 12676.9 12748.9 12756.7 12779.1 266682.0 270184.0 270878.0 270916.0 271666.0 42841.0 42853.6 42966.0 43116.4 43199.1 1205.7 1219.8 1225.9 1231.1 1244.9 21707.1 24214.4 24850.5 25249.7 25277.9 38341.6 38619.6 38767.0 38799.2 38815.6 203793.0 205364.0 205536.0 205703.0 205733.0 27099.5 27135.5 27624.2 27660.7 27903.4 37217.3 37576.0 37926.6 38255.2 38378.8 32087.8 32534.2 32574.7 32903.5 33104.5 32145.6 32893.0 33089.2 33185.0 33220.7 32190.2 32537.3 32907.3 32927.8 32961.7 27941.6 28560.4 29245.6 29355.0 30009.7 21136.0 21187.6 21277.3 21396.9 21705.3 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27058.84 Median:23701.93 stddev:87380.90 (368.7%) stddev-sans-first:87602.95 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: Values: 316.7 325.0 326.9 333.5 336.7 12346.2 12797.5 14938.4 15717.3 15961.6 9744.4 9983.2 9994.0 14476.3 14868.1 4489.1 4612.4 4618.3 4621.2 4621.4 3512.4 3616.8 3620.7 3626.0 4811.3 3614.4 5152.4 5336.7 5355.6 5359.8 5162.2 5290.0 5300.9 5302.3 5309.9 5086.7 5097.6 5102.4 5102.8 5103.4 11900.7 14080.2 16408.3 18998.5 19038.1 1717.2 1728.0 1765.4 1873.2 1899.2 8923.9 8942.6 9020.4 10946.8 12508.5 1616.3 1657.2 1730.5 1733.4 1819.1 46543.3 47663.0 50545.0 51380.0 53473.0 9462.2 9602.0 9629.5 9638.0 9659.5 12081.4 12082.5 12112.3 12115.2 12123.6 6743.4 6798.2 6800.7 6832.0 6921.6 6405.3 6624.0 6629.5 6813.4 6921.4 4002.5 4059.5 4168.4 4171.6 4221.7 1609.5 1640.0 1650.9 1711.6 1732.8 842.4 845.6 863.9 915.6 950.6 15264.3 15858.8 16456.2 16648.0 16923.7 736.1 833.1 863.9 883.2 937.9 9051.7 9282.8 9322.3 9477.6 9547.2 519827.0 528847.0 536951.0 543358.0 548490.0 67147.3 67834.7 69432.7 69443.7 69801.3 1082.4 1085.7 1089.3 1092.5 1097.7 14423.4 14523.6 14561.9 14641.5 14818.6 32412.8 32607.2 32900.2 33419.7 33454.7 41893.6 41917.4 42208.0 42751.4 42914.8 8813.9 8954.4 9039.1 9058.8 9073.0 10421.2 15246.0 15517.8 16048.8 16102.7 8960.6 9280.6 9288.3 14172.1 14471.9 9102.7 9215.2 9380.2 9394.1 9891.4 7440.8 7668.8 9375.2 9621.0 9682.0 12926.4 13360.5 13481.6 13486.8 13736.4 14136.7 14153.4 14168.5 14463.9 14755.9 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,480 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4920.02 Median:6159.99 stddev:2523.93 (41.0%) stddev-sans-first:2517.22 02:59:05 INFO - 2015-12-21 02:59:05,481 DEBUG : BROWSER_OUTPUT: Values: 1409.3 1651.4 1675.2 1705.5 1714.6 5860.3 7130.4 7235.0 7249.0 7262.5 7160.9 7318.2 7340.2 7355.4 7361.7 2047.8 2071.3 2082.1 2083.4 2084.9 2074.4 2083.3 2090.3 2117.5 2120.9 2028.8 2069.2 2091.4 2096.1 2097.0 2039.4 2059.4 2059.9 2066.4 2066.5 2042.7 2069.8 2075.1 2082.2 2086.2 6935.3 6960.1 6963.5 7008.3 7021.1 4170.7 4252.2 4253.9 4261.9 4264.7 2760.8 2784.5 2813.7 2815.4 2831.7 895.3 1745.0 1776.2 1785.5 1785.8 9521.0 9606.6 9609.2 9643.4 9645.5 3718.3 3719.6 3782.5 3825.5 3842.1 7596.4 7610.4 7613.3 7614.0 7630.6 4002.8 4014.4 4015.6 4039.3 4041.9 3196.5 3281.7 3705.7 3726.3 3738.4 3137.8 3174.1 3184.4 3223.6 3231.5 949.7 978.5 979.2 979.5 984.4 1189.1 1189.5 1190.6 1204.1 1217.9 6646.0 6677.8 6705.4 6726.8 6816.5 421.8 422.0 428.1 428.8 430.3 4880.5 4910.9 4924.2 4941.5 4954.0 7773.6 7843.1 8461.2 8749.6 8753.9 7785.6 7866.0 7963.2 7965.2 8023.1 6542.7 6622.6 6692.9 6710.5 6716.1 6575.2 6592.5 6632.7 6641.4 6644.0 7299.7 7596.6 7605.3 7665.8 7701.7 7610.4 7856.4 7859.4 7874.5 7992.6 5012.4 5439.8 6381.8 6495.5 6505.0 6710.1 6777.2 6780.3 6826.7 6835.4 6340.9 6366.1 6438.0 6452.2 6568.0 6355.0 6403.4 6403.9 6496.8 6506.0 6493.6 6540.2 6540.8 6541.2 6547.9 5863.1 6053.8 6090.0 6095.5 6098.3 6124.9 6154.2 6157.5 6158.5 6161.4 02:59:05 INFO - 2015-12-21 02:59:05,481 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,482 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4573.93 Median:5239.44 stddev:1347.31 (25.7%) stddev-sans-first:1312.27 02:59:05 INFO - 2015-12-21 02:59:05,482 DEBUG : BROWSER_OUTPUT: Values: 295.7 303.2 305.4 309.4 310.3 5154.9 5270.1 5309.1 5315.2 5332.7 5196.4 5227.9 5228.0 5239.1 5239.8 3858.3 4120.0 4122.2 4125.2 4131.3 3990.0 3999.5 4126.7 4131.7 4139.0 4066.8 4078.4 4080.0 4091.1 4099.3 3808.3 3917.1 3949.1 4076.1 4087.4 3597.3 3606.3 3608.9 3616.8 3619.5 4991.3 5032.1 5033.2 5033.3 5041.6 4670.3 4677.6 4680.6 4681.6 4682.4 5366.9 5474.6 5492.1 5493.2 5500.3 3913.0 3933.0 3942.6 3943.1 3947.8 5769.6 5773.9 5781.3 5783.9 5784.1 4053.0 4057.4 4059.7 4059.8 4068.4 3716.9 3821.8 4124.3 4129.0 4132.2 4379.4 4527.6 4531.8 4534.4 4535.2 5356.9 5380.5 5408.4 5521.7 5526.1 1357.9 1377.5 1378.8 1381.0 1381.2 928.8 944.0 946.5 952.7 956.2 4806.5 4820.1 4831.1 4842.4 4843.6 5636.0 5639.1 5656.4 5664.6 5670.7 4816.0 4824.2 4827.9 4833.6 4834.1 2832.3 2911.4 3010.2 3048.1 3050.0 5349.5 5433.2 5449.8 5453.4 5453.4 5877.5 5886.1 5896.7 5898.8 5919.8 5410.9 5426.2 5428.6 5434.4 5437.7 5539.3 5694.5 5696.5 5735.1 5739.2 5555.1 5560.9 5584.4 5607.7 5624.5 5436.5 5442.3 5446.7 5447.6 5452.0 3926.2 3928.2 3930.1 3932.1 3936.3 5555.2 5754.4 5761.6 5774.1 5782.0 5545.6 5555.9 5556.6 5557.0 5564.3 5546.4 5554.4 5556.1 5561.0 5562.3 5302.9 5403.7 5424.9 5427.9 5430.7 5572.3 5579.6 5580.7 5587.1 5589.5 5231.9 5304.7 5363.6 5453.0 5463.3 02:59:05 INFO - 2015-12-21 02:59:05,482 DEBUG : BROWSER_OUTPUT: 02:59:05 INFO - 2015-12-21 02:59:05,482 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11781.72 Median:572.26 stddev:13328.73 (2329.2%) stddev-sans-first:13339.98 02:59:05 INFO - 2015-12-21 02:59:05,482 DEBUG : BROWSER_OUTPUT: Values: 666.0 692.6 786.9 788.7 801.9 10401.5 10816.6 10827.1 10847.2 10853.9 10848.1 11202.2 11564.1 11679.5 11849.8 783.9 799.6 799.8 800.2 800.4 793.4 794.4 802.5 805.1 805.8 830.3 836.1 836.4 836.9 837.3 824.8 825.2 826.8 829.7 829.8 614.5 614.7 615.1 615.2 615.2 9670.1 9815.3 9828.5 9838.1 9840.6 9431.9 9580.0 9782.5 9827.5 9955.7 8507.5 8523.2 8526.7 8533.5 8724.0 3000.1 3061.2 3062.9 3096.3 3122.7 34361.3 34591.8 37240.8 37322.4 38612.2 9093.8 9099.8 9179.9 9412.1 9575.9 17081.6 17670.6 17679.2 17686.6 17688.1 5387.9 5938.5 6669.6 6701.8 6849.0 3608.9 3613.3 3690.2 3693.5 3773.2 2645.5 2684.3 2685.2 2771.5 2839.4 492.2 500.5 501.2 501.7 501.9 453.1 527.4 555.2 571.7 588.4 7318.1 7333.4 7373.7 7385.8 7398.0 501.5 572.8 584.1 588.6 593.2 3698.8 3711.1 3758.2 3816.8 3938.4 43706.8 46666.8 47353.8 49236.5 49841.5 44585.6 44604.6 44675.3 44722.8 44797.1 34463.0 37827.2 37851.4 37868.8 38427.6 7388.7 7705.8 7882.3 8062.2 8118.4 29833.9 30767.5 30827.4 31550.7 32467.7 33820.8 37508.8 42942.1 42983.0 43588.0 9234.5 9643.5 9650.6 10112.3 10128.6 10813.2 10819.5 11054.7 11151.8 11638.3 9730.8 9924.9 9952.8 10267.3 10834.2 10120.9 10406.9 10627.3 10686.6 10937.7 9837.5 9863.2 9866.5 9943.5 10059.7 8590.2 8715.9 8823.3 8883.0 8954.3 8607.8 8738.9 8755.5 8938.1 8979.1 02:59:05 INFO - 2015-12-21 02:59:05,482 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:59:05 INFO - 2015-12-21 02:59:05,482 DEBUG : BROWSER_OUTPUT: 02:59:06 INFO - 2015-12-21 02:59:06,254 INFO : Browser exited with error code: 0 02:59:06 INFO - 2015-12-21 02:59:06,272 INFO : Completed test dromaeo_css (00:18:37) 02:59:06 INFO - 2015-12-21 02:59:06,272 INFO : Starting test kraken 02:59:06 INFO - 2015-12-21 02:59:06,272 DEBUG : operating with platform_type : linux_ 02:59:06 INFO - 2015-12-21 02:59:06,272 INFO : Initialising browser for kraken test... 02:59:06 INFO - 2015-12-21 02:59:06,278 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDLY34D/profile http://localhost:53880/getInfo.html 02:59:11 INFO - 2015-12-21 02:59:11,065 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:59:11 INFO - 2015-12-21 02:59:11,080 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:59:11 INFO - 2015-12-21 02:59:11,081 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:59:11 INFO - 2015-12-21 02:59:11,081 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:59:11 INFO - 2015-12-21 02:59:11,081 DEBUG : BROWSER_OUTPUT: __metrics 02:59:11 INFO - 2015-12-21 02:59:11,182 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:59:11 INFO - 2015-12-21 02:59:11,242 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:59:12 INFO - 2015-12-21 02:59:12,149 INFO : Browser initialized. 02:59:12 INFO - 2015-12-21 02:59:12,150 INFO : Running cycle 1/1 for kraken test... 02:59:12 INFO - 2015-12-21 02:59:12,150 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDLY34D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:59:24 INFO - 2015-12-21 02:59:24,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 149794816 02:59:24 INFO - 2015-12-21 02:59:24,109 DEBUG : BROWSER_OUTPUT: 02:59:26 INFO - 2015-12-21 02:59:26,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53880/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:27 INFO - 2015-12-21 02:59:27,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 184582144 02:59:27 INFO - 2015-12-21 02:59:27,306 DEBUG : BROWSER_OUTPUT: 02:59:30 INFO - 2015-12-21 02:59:30,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53880/tests/kraken/driver.html?testName=audio-dft) 02:59:30 INFO - 2015-12-21 02:59:30,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 173015040 02:59:30 INFO - 2015-12-21 02:59:30,630 DEBUG : BROWSER_OUTPUT: 02:59:33 INFO - 2015-12-21 02:59:33,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53880/tests/kraken/driver.html?testName=audio-fft) 02:59:34 INFO - 2015-12-21 02:59:34,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 161652736 02:59:34 INFO - 2015-12-21 02:59:34,210 DEBUG : BROWSER_OUTPUT: 02:59:36 INFO - 2015-12-21 02:59:36,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53880/tests/kraken/driver.html?testName=audio-oscillator) 02:59:36 INFO - 2015-12-21 02:59:36,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 163766272 02:59:36 INFO - 2015-12-21 02:59:36,848 DEBUG : BROWSER_OUTPUT: 02:59:39 INFO - 2015-12-21 02:59:39,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:39 INFO - 2015-12-21 02:59:39,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 164605952 02:59:39 INFO - 2015-12-21 02:59:39,665 DEBUG : BROWSER_OUTPUT: 02:59:42 INFO - 2015-12-21 02:59:42,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53880/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:43 INFO - 2015-12-21 02:59:43,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 164556800 02:59:43 INFO - 2015-12-21 02:59:43,191 DEBUG : BROWSER_OUTPUT: 02:59:46 INFO - 2015-12-21 02:59:46,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53880/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:47 INFO - 2015-12-21 02:59:47,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 166940672 02:59:47 INFO - 2015-12-21 02:59:47,160 DEBUG : BROWSER_OUTPUT: 02:59:49 INFO - 2015-12-21 02:59:49,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53880/tests/kraken/driver.html?testName=json-parse-financial) 02:59:50 INFO - 2015-12-21 02:59:50,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 164286464 02:59:50 INFO - 2015-12-21 02:59:50,541 DEBUG : BROWSER_OUTPUT: 02:59:52 INFO - 2015-12-21 02:59:52,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:52 INFO - 2015-12-21 02:59:52,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 174600192 02:59:52 INFO - 2015-12-21 02:59:52,900 DEBUG : BROWSER_OUTPUT: 02:59:54 INFO - 2015-12-21 02:59:54,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:55 INFO - 2015-12-21 02:59:55,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 175472640 02:59:55 INFO - 2015-12-21 02:59:55,363 DEBUG : BROWSER_OUTPUT: 02:59:57 INFO - 2015-12-21 02:59:57,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:58 INFO - 2015-12-21 02:59:58,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 185991168 02:59:58 INFO - 2015-12-21 02:59:58,077 DEBUG : BROWSER_OUTPUT: 03:00:00 INFO - 2015-12-21 03:00:00,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:00:01 INFO - 2015-12-21 03:00:01,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 190287872 03:00:01 INFO - 2015-12-21 03:00:01,132 DEBUG : BROWSER_OUTPUT: 03:00:03 INFO - 2015-12-21 03:00:03,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:00:04 INFO - 2015-12-21 03:00:04,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 187785216 03:00:04 INFO - 2015-12-21 03:00:04,280 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53880/tests/kraken/driver.html?testName=ai-astar) 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 245919744 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;111;114;112;100;112;111;102 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;168;173;132;154;150;129;175;137 03:00:06 INFO - 2015-12-21 03:00:06,292 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;161;162;163;161;163;160;161;161 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;89;94;72;74;73;102;90;72 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;134;94;96;95;138;95;95;131 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;148;149;147;149;148;148;148;148 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;96;96;95;97 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;73;71;71;70;71;71;79;69;69 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;66;67;68;68;68;67;67;68 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;84;84;86;83;85;85;84;84 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;124;122;117;120;127;121;127;121;119 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;145;144;147;148;142;146;146;147;132 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;70;69;69;68;69;69;71;69 03:00:06 INFO - 2015-12-21 03:00:06,293 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: __startTimestamp1450695606288__endTimestamp 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.90 Median:111.50 stddev:4.79 (4.3%) stddev-sans-first:5.07 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 111.0 114.0 112.0 100.0 112.0 111.0 102.0 03:00:06 INFO - 2015-12-21 03:00:06,294 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:154.00 stddev:17.53 (11.4%) stddev-sans-first:18.55 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 168.0 173.0 132.0 154.0 150.0 129.0 175.0 137.0 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 161.0 162.0 163.0 161.0 163.0 160.0 161.0 161.0 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:73.50 stddev:11.34 (15.4%) stddev-sans-first:11.63 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 89.0 94.0 72.0 74.0 73.0 102.0 90.0 72.0 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:95.00 stddev:19.08 (20.1%) stddev-sans-first:19.75 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 134.0 94.0 96.0 95.0 138.0 95.0 95.0 131.0 03:00:06 INFO - 2015-12-21 03:00:06,295 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,296 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:00:06 INFO - 2015-12-21 03:00:06,296 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 03:00:06 INFO - 2015-12-21 03:00:06,296 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,296 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 03:00:06 INFO - 2015-12-21 03:00:06,296 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 148.0 149.0 147.0 149.0 148.0 148.0 148.0 148.0 03:00:06 INFO - 2015-12-21 03:00:06,296 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 97.0 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.50 Median:71.00 stddev:2.88 (4.1%) stddev-sans-first:3.05 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 71.0 70.0 71.0 71.0 79.0 69.0 69.0 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 66.0 67.0 68.0 68.0 68.0 67.0 67.0 68.0 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:1.10 (1.3%) stddev-sans-first:0.87 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 84.0 84.0 86.0 83.0 85.0 85.0 84.0 84.0 03:00:06 INFO - 2015-12-21 03:00:06,297 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.00 stddev:3.75 (3.0%) stddev-sans-first:3.43 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: Values: 128.0 124.0 122.0 117.0 120.0 127.0 121.0 127.0 121.0 119.0 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:146.00 stddev:5.61 (3.8%) stddev-sans-first:4.88 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: Values: 134.0 145.0 144.0 147.0 148.0 142.0 146.0 146.0 147.0 132.0 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 70.0 69.0 69.0 68.0 69.0 69.0 71.0 69.0 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:00:06 INFO - 2015-12-21 03:00:06,298 DEBUG : BROWSER_OUTPUT: 03:00:07 INFO - 2015-12-21 03:00:07,202 INFO : Browser exited with error code: 0 03:00:07 INFO - 2015-12-21 03:00:07,252 INFO : Completed test kraken (00:01:00) 03:00:07 INFO - 2015-12-21 03:00:07,252 INFO : Starting test v8_7 03:00:07 INFO - 2015-12-21 03:00:07,252 DEBUG : operating with platform_type : linux_ 03:00:07 INFO - 2015-12-21 03:00:07,253 INFO : Initialising browser for v8_7 test... 03:00:07 INFO - 2015-12-21 03:00:07,259 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXa4why/profile http://localhost:53880/getInfo.html 03:00:11 INFO - 2015-12-21 03:00:11,624 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 03:00:11 INFO - 2015-12-21 03:00:11,644 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:00:11 INFO - 2015-12-21 03:00:11,645 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:00:11 INFO - 2015-12-21 03:00:11,645 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:00:11 INFO - 2015-12-21 03:00:11,645 DEBUG : BROWSER_OUTPUT: __metrics 03:00:11 INFO - 2015-12-21 03:00:11,761 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:00:11 INFO - 2015-12-21 03:00:11,822 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:13 INFO - 2015-12-21 03:00:13,080 INFO : Browser initialized. 03:00:13 INFO - 2015-12-21 03:00:13,080 INFO : Running cycle 1/1 for v8_7 test... 03:00:13 INFO - 2015-12-21 03:00:13,080 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXa4why/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:00:24 INFO - 2015-12-21 03:00:24,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 149569536 03:00:24 INFO - 2015-12-21 03:00:24,968 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53880/tests/v8_7/run.html (next: http://localhost:53880/tests/v8_7/run.html) 03:00:46 INFO - 2015-12-21 03:00:46,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 448421888 03:00:46 INFO - 2015-12-21 03:00:46,551 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,552 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:00:46 INFO - 2015-12-21 03:00:46,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:00:46 INFO - 2015-12-21 03:00:46,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:00:46 INFO - 2015-12-21 03:00:46,552 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:00:46 INFO - 2015-12-21 03:00:46,553 DEBUG : BROWSER_OUTPUT: |0;Richards;166.05778811026238 03:00:46 INFO - 2015-12-21 03:00:46,553 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.8390633711206 03:00:46 INFO - 2015-12-21 03:00:46,553 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 03:00:46 INFO - 2015-12-21 03:00:46,553 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 03:00:46 INFO - 2015-12-21 03:00:46,553 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 03:00:46 INFO - 2015-12-21 03:00:46,553 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 03:00:46 INFO - 2015-12-21 03:00:46,553 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 03:00:46 INFO - 2015-12-21 03:00:46,554 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 03:00:46 INFO - 2015-12-21 03:00:46,554 DEBUG : BROWSER_OUTPUT: |8;Splay;611.9951040391677 03:00:46 INFO - 2015-12-21 03:00:46,554 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 03:00:46 INFO - 2015-12-21 03:00:46,554 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:00:46 INFO - 2015-12-21 03:00:46,554 DEBUG : BROWSER_OUTPUT: __startTimestamp1450695646551__endTimestamp 03:00:46 INFO - 2015-12-21 03:00:46,554 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,555 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:00:46 INFO - 2015-12-21 03:00:46,556 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:00:46 INFO - 2015-12-21 03:00:46,556 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,556 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,557 DEBUG : BROWSER_OUTPUT: Values: 166.1 03:00:46 INFO - 2015-12-21 03:00:46,557 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,557 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.84 Median:185.84 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,557 DEBUG : BROWSER_OUTPUT: Values: 185.8 03:00:46 INFO - 2015-12-21 03:00:46,557 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,557 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: Values: 278.4 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: Values: 5128.2 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: Values: 1966.6 03:00:46 INFO - 2015-12-21 03:00:46,558 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,559 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,559 DEBUG : BROWSER_OUTPUT: Values: 782.5 03:00:46 INFO - 2015-12-21 03:00:46,559 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,559 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,559 DEBUG : BROWSER_OUTPUT: Values: 12207.3 03:00:46 INFO - 2015-12-21 03:00:46,559 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,559 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: Values: 26526.3 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:612.00 Median:612.00 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: Values: 612.0 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: Values: 4830.9 03:00:46 INFO - 2015-12-21 03:00:46,560 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:00:46 INFO - 2015-12-21 03:00:46,561 DEBUG : BROWSER_OUTPUT: 03:00:47 INFO - 2015-12-21 03:00:47,458 INFO : Browser exited with error code: 0 03:00:47 INFO - 2015-12-21 03:00:47,476 INFO : Completed test v8_7 (00:00:40) 03:00:47 INFO - 2015-12-21 03:00:47,644 INFO : Completed test suite (00:20:18) 03:00:47 INFO - 2015-12-21 03:00:47,644 DEBUG : Working with test: dromaeo_css 03:00:47 INFO - 2015-12-21 03:00:47,645 DEBUG : Generating results file: dromaeo_css 03:00:47 INFO - 2015-12-21 03:00:47,646 DEBUG : Working with test: kraken 03:00:47 INFO - 2015-12-21 03:00:47,646 DEBUG : Generating results file: kraken 03:00:47 INFO - 2015-12-21 03:00:47,646 INFO : javascript benchmark 03:00:47 INFO - 2015-12-21 03:00:47,646 DEBUG : Working with test: v8_7 03:00:47 INFO - 2015-12-21 03:00:47,646 DEBUG : Generating results file: v8_7 03:00:47 INFO - 2015-12-21 03:00:47,647 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:47 INFO - 2015-12-21 03:00:47,702 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 03:00:47 INFO - 2015-12-21 03:00:47,702 DEBUG : process_Request line: dromaeo_css 6161.99 graph.html#tests=[[72,132,35]] 03:00:47 INFO - 2015-12-21 03:00:47,702 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:47 INFO - 2015-12-21 03:00:47,737 DEBUG : process_Request line: kraken 1520.10 graph.html#tests=[[232,132,35]] 03:00:47 INFO - 2015-12-21 03:00:47,737 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:47 INFO - 2015-12-21 03:00:47,846 DEBUG : process_Request line: v8_7 19869.58 graph.html#tests=[[230,132,35]] 03:00:47 INFO - 2015-12-21 03:00:47,847 INFO : javascript benchmark 03:00:47 INFO - 2015-12-21 03:00:47,851 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2545.8981640734373, 2613.7386261373863, 2625.645537852389, 2629.526685196665, 2635.051381502659, 4312.892177695559, 4425.446819147606, 4428.357888106223, 4481.417415735954, 4489.371487991683, 4437.356583295428, 4453.1539007588535, 4468.664850136237, 4500.662450316223, 4555.908881822362, 4113.424120623115, 4124.97937510312, 4183.979080104603, 4302.505211900624, 4310.4611923509565, 4240.745555266694, 4317.740935543861, 4317.978410107945, 4318.265894797876, 4356.15055064261, 3987.102901847076, 4090.0797320602924, 4118.320477121301, 4172.749635021908, 4178.728382655148, 4182.205380977604, 4190.413342132104, 4192.769397683126, 4203.201391735561, 4232.280512312914, 3999.200159968018, 4167.291560434734, 4169.291220492523, 4190.078182799779, 4223.366495025771, 4333.39332493448, 4349.9130017399475, 4357.477102747659, 4462.3752674625575, 4478.0596074824325, 4829.227323628238, 4843.5398637129765, 4843.878903027417, 4861.951380486221, 4890.290907818382, 4863.416390033183, 4864.829730959399, 4864.951350486485, 4873.731944743037, 4903.53416425439, 4294.24850651138, 4383.07955329378, 4387.232234359039, 4465.4864690561, 4560.566746159109, 4945.109880221595, 4994.925076123861, 5004.749762511859, 5005.724685142352, 5045.924311135336, 4752.097101550694, 4801.351817504662, 4817.445993710698, 4821.445533763662, 4861.6353773467135, 4653.302004699322, 4780.450248221499, 4787.497312782108, 4801.567858892647, 4870.245112007645, 4712.986707857827, 4811.903761924742, 4818.036392721469, 4851.272309153655, 4869.391326084239, 4691.882702932386, 4698.859034228979, 4706.623470122382, 4707.6233901287815, 4740.644451666139, 3867.497225360685, 3982.26328129297, 3989.4215338775716, 3999.5200575931076, 4024.0744628735556, 3490.808005559719, 3512.297540491912, 3533.4169861972487, 3565.144365352349, 3602.603713591503, 4179.540250572434, 4182.811773470201, 4186.183694179666, 4187.036981494273, 4230.725002874803, 4794.352762377034, 4830.565249127595, 4855.951440485621, 4884.0, 4889.706617602955, 4046.4132700758223, 4106.67146628269, 4154.376843473503, 4166.250074986471, 4221.282381995068, 4242.957570424318, 4256.3189889617515, 4261.893452663709, 4314.7626880521875, 4317.266064768997, 4525.9773701130625, 4537.636989040935, 4538.909221815611, 4559.430071241095, 4566.908661826745, 4672.7196368216655, 4763.4522029967, 4776.307435421914, 4788.066327066189, 4816.277558366273, 4608.193566125981, 4617.8152873884665, 4628.652851036253, 4634.976825115988, 4651.6975246930915, 4764.047190561971, 4787.138315103315, 4800.73595952226, 4836.637252206169, 4845.781939812647, 4631.976840115778, 4760.59534939534, 4762.047590481849, 4885.071836351082, 4887.095887260868, 4664.183767840682, 4764.857054288377, 4765.428148622187, 4795.592374648194, 4812.8796780080775, 4740.19416699155, 4756.072565849626, 4756.143894098957, 4761.785719642694, 4797.760111994457, 4350.412694286231, 4459.0, 4664.55686709762, 4667.393238878924, 4707.788149533348, 4613.861584152481, 4650.279206722963, 4731.361266229015, 4732.219183834766, 4775.379200703886, 4618.168729628699, 4656.348111264493, 4663.883402914954, 4680.204365257846, 4724.244120940633], "unit": "score", "name": "dojo.html", "value": 4429.653407247413}, {"lowerIsBetter": false, "replicates": [556.501930771959, 561.3740679142754, 563.5322682173796, 585.5198737035627, 587.7854583077178, 35409.82295088524, 35767.46348804764, 35906.28187436253, 36006.63993360069, 36080.81959590205, 38907.0, 39817.99999999993, 39835.40246896299, 39850.80074599623, 39893.8005309973, 6957.930420695779, 7095.574265544058, 7796.142424333319, 7972.521648701097, 7972.800679982989, 9985.900140998607, 10201.132903703194, 10211.183105351554, 10217.438040907748, 10247.538860751283, 9702.417854928692, 9787.0, 9788.314817962746, 9790.951045244763, 9794.16749576287, 7035.437165026811, 7263.309985551364, 9904.653337133203, 9960.701178964642, 10229.488525573692, 9729.0, 9861.50692465381, 9862.950685246527, 9867.16129129025, 9869.21046316293, 36058.0, 36482.08794780125, 36527.4520882187, 36558.26883462343, 36600.26799464023, 2722.8366298022183, 2846.1034774046316, 2904.941901161986, 2932.0470846974604, 3288.490284005983, 28053.719462805315, 28195.436091278265, 28336.716632833613, 28339.291517712016, 28545.28636784097, 3397.3375191837604, 3450.6204317525053, 3464.2551851351827, 3534.222471056389, 3577.069961809948, 205968.0, 206951.0, 207469.96265018728, 207472.0, 207504.0, 45021.32468012982, 51331.7433412838, 51666.48333516692, 51674.48325516697, 51712.22431663453, 39797.0, 40063.59936400599, 61383.38616613777, 62670.37329626645, 62763.372366275755, 13566.0, 13652.385642646104, 13724.519641812689, 13788.0, 13790.931045344909, 10686.0916822071, 10699.090577300862, 10701.090407315465, 10712.678619641423, 10832.891671083189, 17752.11239438023, 17755.556111097067, 17799.555011124565, 17867.553311167067, 17886.195121219316, 7303.59830209333, 7517.0, 7555.962220188974, 7622.352100071556, 7629.809254768564, 873.5064688451005, 911.5670056723136, 940.0505489455699, 956.2827879090682, 1022.539857064324, 24110.758892411202, 24335.756642433702, 24394.512109757707, 24620.5075898481, 25778.226653200432, 940.5673390240567, 945.191860958884, 997.8453339732353, 1080.6541906589973, 1106.3859557945418, 12609.621711348675, 12676.873231267753, 12748.872511274954, 12756.681082973, 12779.105462617528, 266682.0, 270184.0, 270878.0, 270916.0, 271666.0, 42841.0, 42853.571464284956, 42966.0, 43116.35325470121, 43199.13601727948, 1205.7046023724245, 1219.7987332090283, 1225.871283515236, 1231.0889941443447, 1244.875512448748, 21707.131714731233, 24214.394640134138, 24850.50298994046, 25249.747502525475, 25277.87361063183, 38341.616583833806, 38619.613803862725, 38767.0, 38799.224015518965, 38815.6118438812, 203793.0, 205364.0, 205536.0, 205703.0, 205733.0, 27099.45801083928, 27135.45729085447, 27624.171274861787, 27660.72339276662, 27903.441931160858, 37217.25565488621, 37576.0, 37926.62073379341, 38255.23489530249, 38378.808105959295, 32087.839560802047, 32534.186645334055, 32574.674253257162, 32903.51934163016, 33104.50343244901, 32145.55345009527, 32893.0, 33089.172770680925, 33185.0, 33220.66779332176, 32190.19524511906, 32537.34925301528, 32907.341853163285, 32927.83536082304, 32961.67038329586, 27941.64700235985, 28560.42879142447, 29245.561316580694, 29355.0, 30009.699903000692, 21136.0, 21187.576248475252, 21277.255296064563, 21396.893015534824, 21705.34883953484], "unit": "score", "name": "ext.html", "value": 16744.659906890018}, {"lowerIsBetter": false, "replicates": [316.7228674909456, 324.9788763730358, 326.8725197173101, 333.4930905024363, 336.659973426839, 12346.197497162679, 12797.48810047597, 14938.402463901444, 15717.292721827516, 15961.600959976007, 9744.366616169962, 9983.20134389249, 9993.950030249838, 14476.2761861907, 14868.10791352517, 4489.079738653568, 4612.423447069116, 4618.284165954283, 4621.214393553088, 4621.37611422457, 3512.4380099184136, 3616.7649102808364, 3620.6560376764164, 3625.963740362602, 4811.326414302001, 3614.367485690007, 5152.407473140581, 5336.706481143536, 5355.571554275649, 5359.839204823861, 5162.22566615007, 5290.021346050954, 5300.893982120375, 5302.257683924254, 5309.920351194735, 5086.720230387327, 5097.617678674077, 5102.387713474407, 5102.795888164506, 5103.387593488768, 11900.702482438008, 14080.225587592678, 16408.343666253335, 18998.52503687405, 19038.143283552272, 1717.2358300556257, 1727.974080388795, 1765.3556451895095, 1873.157079314314, 1899.211827091769, 8923.910760892373, 8942.552872356422, 9020.413673111227, 10946.781064378667, 12508.483372589644, 1616.264599607176, 1657.1962598139892, 1730.524105870883, 1733.3586572967956, 1819.0722731406945, 46543.30185047227, 47663.0, 50545.0, 51380.0, 53473.0, 9462.195713364303, 9601.951990240144, 9629.470379129076, 9638.0, 9659.517024148765, 12081.395930203631, 12082.45628946682, 12112.333821639895, 12115.212511186744, 12123.636290911287, 6743.35938085881, 6798.150231221098, 6800.6939687714175, 6832.043513908056, 6921.6193109379465, 6405.327440618668, 6624.0, 6629.469642428594, 6813.4208592270215, 6921.411680007256, 4002.4996875390575, 4059.4519739835337, 4168.353905144708, 4171.624553790173, 4221.662267018693, 1609.4849648112727, 1639.9672006559802, 1650.8703772134054, 1711.6063305439818, 1732.774739283885, 842.3808500751942, 845.5814371885833, 863.9136086391436, 915.56053094515, 950.5864948747317, 15264.313105910262, 15858.841411585967, 16456.177191140396, 16648.0, 16923.746143807606, 736.1203361982487, 833.1418638802044, 863.9222469977607, 883.2492381475822, 937.9062093790703, 9051.732757413967, 9282.814343713088, 9322.25421966241, 9477.573509192103, 9547.236221102296, 519827.0, 528847.0, 536951.0, 543358.0, 548490.0, 67147.32852671508, 67834.66082669554, 69432.65283673549, 69443.65278173678, 69801.3019869805, 1082.4154956323655, 1085.7177133945231, 1089.3082892363407, 1092.4919912240687, 1097.6981330134117, 14423.42306307736, 14523.553323768632, 14561.854381456049, 14641.48754793577, 14818.555443336718, 32412.83793581017, 32607.18482037873, 32900.1774955628, 33419.66580334165, 33454.665453346126, 41893.581064190184, 41917.371239430824, 42208.0, 42751.3587296197, 42914.78542607267, 8813.89826271716, 8954.417962832395, 9039.096090390909, 9058.773530661523, 9072.95463522678, 10421.218408619536, 15246.0, 15517.84482155164, 16048.759268611213, 16102.677946440772, 8960.596773145095, 9280.58237379306, 9288.256939444964, 14172.078814877, 14471.855281447051, 9102.726918192464, 9215.216706580015, 9380.20268277204, 9394.06059394055, 9891.35706179096, 7440.813979650552, 7668.769936901902, 9375.156235938799, 9620.95189524048, 9682.0, 12926.418311175832, 13360.465581376637, 13481.59555213345, 13486.797698034341, 13736.381862815997, 14136.717265654836, 14153.443121256447, 14168.504102356368, 14463.855361446671, 14755.852441475878], "unit": "score", "name": "jquery.html", "value": 7950.341254616556}, {"lowerIsBetter": false, "replicates": [1409.267181065845, 1651.364224773462, 1675.22939447854, 1705.5054034330044, 1714.6056407026392, 5860.326062502808, 7130.429565634749, 7235.023271858297, 7248.96375518123, 7262.455315851313, 7160.892586611192, 7318.158411782647, 7340.229275926017, 7355.37479314259, 7361.742339018136, 2047.7747447780732, 2071.2854065347433, 2082.115101082034, 2083.3749875037506, 2084.937451876446, 2074.439901226668, 2083.3020937985793, 2090.289301637443, 2117.481217101812, 2120.8939553022365, 2028.8174064334207, 2069.2343832781894, 2091.4039498742864, 2096.056774451495, 2096.9895150524226, 2039.3677959832426, 2059.4439501334555, 2059.8970051497513, 2066.4317312738967, 2066.4627196928755, 2042.652749032668, 2069.793020697918, 2075.0973326602975, 2082.1567265257595, 2086.2072412483312, 6935.306469353075, 6960.095187625627, 6963.547369420971, 7008.299170083002, 7021.052157958712, 4170.70805043647, 4252.2345977724, 4253.893652658678, 4261.87214383569, 4264.680148988808, 2760.806743527954, 2784.484870299001, 2813.6623605167306, 2815.3524689321366, 2831.66020077592, 895.3346774998563, 1744.9825501744947, 1776.191832716111, 1785.526835388623, 1785.7946336171376, 9521.0, 9606.615735370646, 9609.231261499064, 9643.3731807433, 9645.469499177543, 3718.2749363873786, 3719.5536535615897, 3782.508273924372, 3825.540935087807, 3842.1355195080882, 7596.430267729942, 7610.39116870649, 7613.276738709814, 7613.961930190314, 7630.580318082448, 4002.8198731057173, 4014.437978682987, 4015.638592526687, 4039.313316736162, 4041.8787436376956, 3196.5045417960255, 3281.6718328166994, 3705.6850167735506, 3726.2547490502006, 3738.383166777451, 3137.780355375102, 3174.1429813950103, 3184.4268031754045, 3223.62928263248, 3231.4829627259523, 949.7388218240039, 978.5205249427729, 979.2361957673027, 979.5396163803001, 984.4290311619244, 1189.0962868220215, 1189.5420263198557, 1190.6011486152236, 1204.0969273045216, 1217.9025677945742, 6646.0, 6677.799666010027, 6705.362990515893, 6726.831829204309, 6816.4546836252985, 421.8228344095487, 422.02091148535715, 428.14157613984383, 428.82846861255746, 430.2599528810441, 4880.463149053601, 4910.90178196434, 4924.162892308244, 4941.50584941503, 4953.975230123826, 7773.611319434006, 7843.058832940083, 8461.196186362286, 8749.606267717842, 8753.868691969625, 7785.649645765954, 7866.0, 7963.203679632106, 7965.243301886311, 8023.117457079717, 6542.672866356758, 6622.602643841288, 6692.933070669231, 6710.530262881552, 6716.093327400738, 6575.243846957661, 6592.505562082959, 6632.701528431328, 6641.435477984425, 6644.0, 7299.744508942162, 7596.582187979714, 7605.315521603082, 7665.808354791175, 7701.691932322644, 7610.429217808797, 7856.37149028065, 7859.449838511478, 7874.488158269694, 7992.640331185227, 5012.423571289349, 5439.755211015435, 6381.840453988688, 6495.512836537184, 6505.024246362894, 6710.060591517094, 6777.220619628609, 6780.32196780318, 6826.658667066726, 6835.384815366641, 6340.9048864268, 6366.108744775827, 6438.0, 6452.193475815523, 6567.9671601641685, 6354.968225158845, 6403.391677790602, 6403.871922561616, 6496.837579060561, 6505.967470162619, 6493.642849643315, 6540.247871494839, 6540.771073012422, 6541.215054193337, 6547.934520654732, 5863.091220860773, 6053.757849685963, 6090.0, 6095.481884039907, 6098.32918378969, 6124.938750612437, 6154.230721159855, 6157.507399408126, 6158.538109641705, 6161.44546990773], "unit": "score", "name": "mootools.html", "value": 4028.7121631515665}, {"lowerIsBetter": false, "replicates": [295.68804910819085, 303.2418952618454, 305.4212267752609, 309.4019389851417, 310.3111093372713, 5154.896902061956, 5270.130428479301, 5309.123994540906, 5315.176147697113, 5332.680039197651, 5196.350456192976, 5227.947720522803, 5228.0, 5239.056969745454, 5239.816606418776, 3858.3440815061367, 4119.970007498126, 4122.196171746511, 4125.195586860564, 4131.256373852705, 3990.0, 3999.520057593093, 4126.731762435432, 4131.73143745657, 4138.97930510347, 4066.8169932353117, 4078.4290199372113, 4079.9796001019954, 4091.1385319679625, 4099.262132816092, 3808.257389808988, 3917.0599056226583, 3949.111449923773, 4076.1236334188143, 4087.427760113572, 3597.2985267872778, 3606.296772129436, 3608.8736894208578, 3616.8372423241017, 3619.5475565554307, 4991.276264941599, 5032.0690672225755, 5033.245013248005, 5033.345665063518, 5041.571466425358, 4670.299455081765, 4677.64917631179, 4680.578747912704, 4681.602063824579, 4682.391289132425, 5366.9463305366835, 5474.618540934706, 5492.093804522249, 5493.2034854946205, 5500.339959204881, 3912.9804350978347, 3932.9803350983348, 3942.586028467027, 3943.0536671198993, 3947.782871942042, 5769.567282453832, 5773.855653608652, 5781.306243250837, 5783.855403614902, 5784.13238014297, 4053.0, 4057.3711074783455, 4059.715819892638, 4059.782065380374, 4068.4100805383055, 3716.895641006971, 3821.8471261149243, 4124.298869192245, 4128.958710412858, 4132.235536425771, 4379.386885835986, 4527.637788976874, 4531.77341132942, 4534.433195850519, 4535.206338890681, 5356.866078348073, 5380.542653874386, 5408.4050754416985, 5521.66869987794, 5526.088195447786, 1357.9388927498287, 1377.5316392426623, 1378.8138601288697, 1381.0056759133408, 1381.205806661174, 928.8467402878449, 943.9575219115156, 946.5030858799048, 952.7046615549202, 956.206348730552, 4806.543378379049, 4820.060088282751, 4831.057943701015, 4842.370491836039, 4843.588294994965, 5636.0, 5639.125935480007, 5656.43435656431, 5664.5751568631695, 5670.744816483269, 4816.0, 4824.179889418807, 4827.8551643450755, 4833.637477189225, 4834.057358815067, 2832.3344014156655, 2911.3595009097967, 3010.232390740391, 3048.1008102609785, 3050.0392376401364, 5349.491798279158, 5433.1850222466155, 5449.836504904859, 5453.372862120827, 5453.400125986138, 5877.471027607536, 5886.117082437583, 5896.6756828374855, 5898.764049437975, 5919.792807251725, 5410.8917821643345, 5426.158945363475, 5428.647137936022, 5434.375046869582, 5437.673739575638, 5539.25220095282, 5694.487496125369, 5696.515796157208, 5735.11105778605, 5739.196512488172, 5555.055640541199, 5560.944390556043, 5584.357798853021, 5607.719614019201, 5624.465675760796, 5436.483534064258, 5442.319710036246, 5446.673199608036, 5447.591430642638, 5452.0, 3926.2147570485445, 3928.2339943710704, 3930.1157239620857, 3932.05630648648, 3936.31114554946, 5555.2222688822785, 5754.424557544212, 5761.596688231783, 5774.076147816497, 5781.971090144522, 5545.584081193846, 5555.916661250004, 5556.611037227355, 5557.027520184032, 5564.276644036249, 5546.362168350692, 5554.389017208023, 5556.083246264321, 5561.0, 5562.332520097614, 5302.9469705304, 5403.729813509387, 5424.945750542444, 5427.864303392446, 5430.728463576885, 5572.331320241597, 5579.553635709052, 5580.693061881636, 5587.0502014656795, 5589.5248903842, 5231.895362092813, 5304.681719096867, 5363.5863861261805, 5453.0, 5463.289772329572], "unit": "score", "name": "prototype.html", "value": 4139.746400552794}, {"lowerIsBetter": false, "replicates": [665.9866802663946, 692.612137203166, 786.8701664225404, 788.6845261895241, 801.9198080191982, 10401.479926003698, 10816.621418250363, 10827.07969822565, 10847.186461015435, 10853.891461085397, 10848.132149428047, 11202.215844890861, 11564.132690048258, 11679.474423650934, 11849.822252666196, 783.9412044096701, 799.604195923016, 799.8320352725934, 800.2237829305565, 800.4396922154486, 793.416838623614, 794.3565711773454, 802.4864086984335, 805.0942689474341, 805.7582725182422, 830.2776584371575, 836.1095433363448, 836.4437648963462, 836.9330453563731, 837.2757564706516, 824.7814329202766, 825.2160447574798, 826.7726375246855, 829.6888666749969, 829.8340331933607, 614.5237440983229, 614.7172300741664, 615.1449485215554, 615.1818081950994, 615.2033117113349, 9670.081342272473, 9815.312928095036, 9828.508574571242, 9838.06538378853, 9840.606375744961, 9431.90568094324, 9580.01249219238, 9782.461964591945, 9827.459489728133, 9955.701328960144, 8507.532085735282, 8523.190296921783, 8526.658933642648, 8533.530655813927, 8724.0, 3000.084974082904, 3061.1734831595345, 3062.9432845668207, 3096.28785379364, 3122.7189552940117, 34361.31277374439, 34591.82704086489, 37240.81379593112, 37322.44016339757, 38612.22775544501, 9093.772655683528, 9099.81800363989, 9179.908200917906, 9412.105849944244, 9575.856362154573, 17081.572960675832, 17670.646587068186, 17679.20443580042, 17686.557836054202, 17688.115594220493, 5387.9461205388225, 5938.524918006549, 6669.599824010575, 6701.765438209639, 6848.965755171292, 3608.9458658120147, 3613.33153366628, 3690.1881586051027, 3693.4829123922673, 3773.1510410158044, 2645.4576811753545, 2684.2886635041727, 2685.181019788944, 2771.5011297966157, 2839.432113577293, 492.2419474010056, 500.46200334640406, 501.21309544016276, 501.6964736334538, 501.89460213354874, 453.05764010857337, 527.3566249175999, 555.2321676442929, 571.6684323092596, 588.4027711872453, 7318.085239345082, 7333.376662983599, 7373.668184931691, 7385.778426647209, 7398.0, 501.5235526250077, 572.842468321215, 584.1383958660941, 588.5585810642018, 593.2110293309887, 3698.778073315556, 3711.1464363196615, 3758.173201895633, 3816.809159542012, 3938.448617193595, 43706.78146609246, 46666.83196548588, 47353.76323118362, 49236.50763492319, 49841.50158498441, 44585.55414445879, 44604.55395446069, 44675.32987005197, 44722.77638611851, 44797.104057919314, 34463.0, 37827.243455130745, 37851.43222851659, 37868.810655946545, 38427.615723842966, 7388.704451821867, 7705.807354816175, 7882.251186137537, 8062.1534738853925, 8118.391120665856, 29833.85083074571, 30767.53848692316, 30827.383452331276, 31550.684493154775, 32467.67532324741, 33820.830895846346, 37508.81245593754, 42942.141157176055, 42983.0, 43588.0, 9234.492102934402, 9643.469609171563, 9650.613975440903, 10112.342697724624, 10128.594856205964, 10813.24307298513, 10819.459027048773, 11054.723631909266, 11151.776964460503, 11638.260556730018, 9730.756731081496, 9924.851127233242, 9952.800943980936, 10267.332623379456, 10834.241603088023, 10120.949395252977, 10406.907274736044, 10627.256092073481, 10686.561544825474, 10937.726556836144, 9837.458939758382, 9863.224619568546, 9866.457344846101, 9943.453110079015, 10059.748506287402, 8590.1839325264, 8715.9105111861, 8823.338249631175, 8883.0, 8954.328425367994, 8607.75292084142, 8738.91261087381, 8755.518446485505, 8938.10618938101, 8979.078746520461], "unit": "score", "name": "yui.html", "value": 5565.574046432481}], "name": "dromaeo_css", "value": 6161.99546132151}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 114.0, 112.0, 100.0, 112.0, 111.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 168.0, 173.0, 132.0, 154.0, 150.0, 129.0, 175.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 162.0, 163.0, 161.0, 163.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 89.0, 94.0, 72.0, 74.0, 73.0, 102.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 134.0, 94.0, 96.0, 95.0, 138.0, 95.0, 95.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 148.0, 149.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 71.0, 70.0, 71.0, 71.0, 79.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 84.0, 86.0, 83.0, 85.0, 85.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 122.0, 117.0, 120.0, 127.0, 121.0, 127.0, 121.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [134.0, 145.0, 144.0, 147.0, 148.0, 142.0, 146.0, 146.0, 147.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1520.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [185.8390633711206], "unit": "score", "name": "DeltaBlue", "value": 355.78095800000017}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [611.9951040391677], "unit": "score", "name": "Splay", "value": 133.15629400000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19869.580584232037}]} 03:00:47 INFO - RETURN: dromaeo_css: 6161.99 03:00:47 INFO - RETURN: kraken: 1520.10 03:00:47 INFO - RETURN: v8_7: 19869.58 03:00:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19869.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6161.99"}}} 03:00:47 INFO - Return code: 0 03:00:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:00:47 INFO - # TBPL SUCCESS # 03:00:47 INFO - Running post-action listener: _resource_record_post_action 03:00:47 INFO - Running post-run listener: _resource_record_post_run 03:00:49 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545665024; Read time: 56; Write time: 656296 03:00:49 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 227221504; Read time: 56; Write time: 354632 03:00:49 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 318443520; Read time: 0; Write time: 301664 03:00:49 INFO - Running post-run listener: _upload_blobber_files 03:00:49 INFO - Blob upload gear active. 03:00:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:00:49 INFO - Copying logs to upload dir... 03:00:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.654752 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 03:00:48.430974) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:48.434899) ========= 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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009899 build_url: 'https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:48.486363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:48.486685) ========= 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=0cff312cb257a7829adc5a5d000001df-1450694318.473793-1468040700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:48.536354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 03:00:48.536687) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 03:00:48.537278) ========= ========= Total master_lag: 0.22 =========