builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1450694977.62 results: success (0) buildid: 20151221020630 builduid: 5ac8b7ed36a94c129907b817989210bb revision: ea9df316f1cc65509c92b3a2409d02e42a855682 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.620226) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.620898) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.621236) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006348 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.658869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.659212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.700742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.701239) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.757239) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.757539) ========= 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:49:37.757921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.758257) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 02:49:38-- 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% 61.1M=0s 2015-12-21 02:49:38 (61.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170927 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.945011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.945423) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015373 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.996252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:37.996651) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea9df316f1cc65509c92b3a2409d02e42a855682 --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 ea9df316f1cc65509c92b3a2409d02e42a855682 --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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 02:49:38,820 truncating revision to first 12 chars 2015-12-21 02:49:38,820 Setting DEBUG logging. 2015-12-21 02:49:38,820 attempt 1/10 2015-12-21 02:49:38,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea9df316f1cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 02:49:39,376 unpacking tar archive at: fx-team-ea9df316f1cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.829940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:38.848844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:38.849214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:38.860625) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 02:49:38.861088) ========= 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:49:38.861673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-21 02:49:38.862086) ========= /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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:49:39 INFO - MultiFileLogger online at 20151221 02:49:39 in /builds/slave/test 02:49:39 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:49:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:49:39 INFO - {'append_to_log': False, 02:49:39 INFO - 'base_work_dir': '/builds/slave/test', 02:49:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:49:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:49:39 INFO - 'branch': 'Fx-Team-Non-PGO', 02:49:39 INFO - 'buildbot_json_path': 'buildprops.json', 02:49:39 INFO - 'config_files': ('talos/linux_config.py',), 02:49:39 INFO - 'default_actions': ('clobber', 02:49:39 INFO - 'read-buildbot-config', 02:49:39 INFO - 'download-and-extract', 02:49:39 INFO - 'populate-webroot', 02:49:39 INFO - 'create-virtualenv', 02:49:39 INFO - 'install', 02:49:39 INFO - 'run-tests'), 02:49:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:49:39 INFO - 'download_minidump_stackwalk': True, 02:49:39 INFO - 'download_symbols': 'ondemand', 02:49:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:49:39 INFO - 'tooltool.py': '/tools/tooltool.py', 02:49:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:49:39 INFO - '/tools/misc-python/virtualenv.py')}, 02:49:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:49:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:49:39 INFO - 'installer_path': 'installer.exe', 02:49:39 INFO - 'log_level': 'info', 02:49:39 INFO - 'log_name': 'talos', 02:49:39 INFO - 'log_to_console': True, 02:49:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:49:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:49:39 INFO - 'opt_config_files': (), 02:49:39 INFO - 'pip_index': False, 02:49:39 INFO - 'sps_profile': False, 02:49:39 INFO - 'sps_profile_interval': 0, 02:49:39 INFO - 'suite': 'dromaeojs', 02:49:39 INFO - 'system_bits': '64', 02:49:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:49:39 INFO - 'title': 'talos-linux64-ix-057', 02:49:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:49:39 INFO - 'use_talos_json': True, 02:49:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:49:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:49:39 INFO - 'work_dir': 'build'} 02:49:39 INFO - ##### 02:49:39 INFO - ##### Running clobber step. 02:49:39 INFO - ##### 02:49:39 INFO - Running pre-action listener: _resource_record_pre_action 02:49:39 INFO - Running main action method: clobber 02:49:39 INFO - rmtree: /builds/slave/test/build 02:49:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:49:40 INFO - Running post-action listener: _resource_record_post_action 02:49:40 INFO - ##### 02:49:40 INFO - ##### Running read-buildbot-config step. 02:49:40 INFO - ##### 02:49:40 INFO - Running pre-action listener: _resource_record_pre_action 02:49:40 INFO - Running main action method: read_buildbot_config 02:49:40 INFO - Using buildbot properties: 02:49:40 INFO - { 02:49:40 INFO - "project": "", 02:49:40 INFO - "product": "firefox", 02:49:40 INFO - "script_repo_revision": "production", 02:49:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:49:40 INFO - "repository": "", 02:49:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:49:40 INFO - "buildid": "20151221020630", 02:49:40 INFO - "pgo_build": "False", 02:49:40 INFO - "basedir": "/builds/slave/test", 02:49:40 INFO - "buildnumber": 2233, 02:49:40 INFO - "slavename": "talos-linux64-ix-057", 02:49:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:49:40 INFO - "platform": "ubuntu64_hw", 02:49:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:49:40 INFO - "branch": "fx-team", 02:49:40 INFO - "repo_path": "integration/fx-team", 02:49:40 INFO - "revision": "ea9df316f1cc65509c92b3a2409d02e42a855682", 02:49:40 INFO - "stage_platform": "linux64", 02:49:40 INFO - "builduid": "5ac8b7ed36a94c129907b817989210bb", 02:49:40 INFO - "slavebuilddir": "test" 02:49:40 INFO - } 02:49:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:49:40 INFO - Running post-action listener: _resource_record_post_action 02:49:40 INFO - ##### 02:49:40 INFO - ##### Running download-and-extract step. 02:49:40 INFO - ##### 02:49:40 INFO - Running pre-action listener: _resource_record_pre_action 02:49:40 INFO - Running main action method: download_and_extract 02:49:40 INFO - mkdir: /builds/slave/test/build/tests 02:49:40 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:49:40 INFO - https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/test_packages.json 02:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/test_packages.json 02:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:49:41 INFO - Downloaded 1302 bytes. 02:49:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:49:41 INFO - Using the following test package requirements: 02:49:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:49:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:49:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:49:41 INFO - u'jsshell-linux-x86_64.zip'], 02:49:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:49:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:49:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:49:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:49:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:49:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:49:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:49:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:49: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:49:41 INFO - https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:49:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:49:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:49:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:43 INFO - Downloaded 21872076 bytes. 02:49:43 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:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:49:43 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:49:44 INFO - Return code: 0 02:49:44 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:49: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:49:44 INFO - https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:45 INFO - Downloaded 21872076 bytes. 02:49:45 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:49:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:49:45 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:49:46 INFO - Return code: 0 02:49: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:49:46 INFO - https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:49:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:49:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:49:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:48 INFO - Downloaded 11132039 bytes. 02:49:48 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:49:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:49:48 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:49:48 INFO - Return code: 0 02:49:48 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:49:48 INFO - https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/13scHWZuS1a4Dq5DRRRxeA/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:49:50 INFO - Downloaded 53066551 bytes. 02:49:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:49:50 INFO - mkdir: /builds/slave/test/properties 02:49:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:49:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:49:50 INFO - Contents: 02:49:50 INFO - build_url:https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:49:50 INFO - Running post-action listener: _resource_record_post_action 02:49:50 INFO - Running post-action listener: set_extra_try_arguments 02:49:50 INFO - ##### 02:49:50 INFO - ##### Running populate-webroot step. 02:49:50 INFO - ##### 02:49:50 INFO - Running pre-action listener: _resource_record_pre_action 02:49:50 INFO - Running main action method: populate_webroot 02:49:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:49:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:49:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:49:50 INFO - '--tppagecycles', 02:49:50 INFO - '7'], 02:49:50 INFO - 'tests': ['tsvgm']}}, 02:49:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:49:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:49:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:49:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:49:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'tests': ['damp', 'tps']}, 02:49:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['damp', 'tps']}, 02:49:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:49:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:49:50 INFO - 'other': {'tests': ['a11yr', 02:49:50 INFO - 'ts_paint', 02:49:50 INFO - 'tpaint', 02:49:50 INFO - 'sessionrestore', 02:49:50 INFO - 'sessionrestore_no_auto_restore']}, 02:49:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['a11yr', 02:49:50 INFO - 'ts_paint', 02:49:50 INFO - 'tpaint', 02:49:50 INFO - 'sessionrestore', 02:49:50 INFO - 'sessionrestore_no_auto_restore']}, 02:49:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['a11yr', 02:49:50 INFO - 'ts_paint', 02:49:50 INFO - 'tpaint', 02:49:50 INFO - 'sessionrestore', 02:49:50 INFO - 'sessionrestore_no_auto_restore']}, 02:49:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['a11yr', 02:49:50 INFO - 'ts_paint', 02:49:50 INFO - 'tpaint', 02:49:50 INFO - 'sessionrestore', 02:49:50 INFO - 'sessionrestore_no_auto_restore']}, 02:49:50 INFO - 'other_l64': {'tests': ['a11yr', 02:49:50 INFO - 'ts_paint', 02:49:50 INFO - 'tpaint', 02:49:50 INFO - 'sessionrestore', 02:49:50 INFO - 'sessionrestore_no_auto_restore']}, 02:49:50 INFO - 'other_nol64': {'tests': ['a11yr', 02:49:50 INFO - 'ts_paint', 02:49:50 INFO - 'tpaint', 02:49:50 INFO - 'sessionrestore', 02:49:50 INFO - 'sessionrestore_no_auto_restore']}, 02:49:50 INFO - 'svgr': {'tests': ['tsvgx', 02:49:50 INFO - 'tsvgr_opacity', 02:49:50 INFO - 'tart', 02:49:50 INFO - 'tscrollx', 02:49:50 INFO - 'cart']}, 02:49:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['tsvgx', 02:49:50 INFO - 'tsvgr_opacity', 02:49:50 INFO - 'tart', 02:49:50 INFO - 'tscrollx', 02:49:50 INFO - 'cart']}, 02:49:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'tests': ['tp5o']}, 02:49:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'talos_options': ['--e10s'], 02:49:50 INFO - 'tests': ['tp5o']}, 02:49:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'talos_options': ['--xperf_path', 02:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:50 INFO - 'tests': ['tp5n']}, 02:49:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:50 INFO - 'talos_options': ['--e10s', 02:49:50 INFO - '--xperf_path', 02:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:50 INFO - 'tests': ['tp5n']}}, 02:49:50 INFO - 'talos.zip': {'path': '', 02:49:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:49:50 INFO - Running post-action listener: _resource_record_post_action 02:49:50 INFO - ##### 02:49:50 INFO - ##### Running create-virtualenv step. 02:49:50 INFO - ##### 02:49:50 INFO - Running pre-action listener: _resource_record_pre_action 02:49:50 INFO - Running main action method: create_virtualenv 02:49:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:49:50 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:49:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:49:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:49:50 INFO - Using real prefix '/usr' 02:49:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:49:51 INFO - Installing distribute.............................................................................................................................................................................................done. 02:49:53 INFO - Installing pip.................done. 02:49:53 INFO - Return code: 0 02:49:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:49:53 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:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:53 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:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:53 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:49:53 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:49:53 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:49:53 INFO - Using env: {'DISPLAY': ':0', 02:49:53 INFO - 'HOME': '/home/cltbld', 02:49:53 INFO - 'LANG': 'en_US.UTF-8', 02:49:53 INFO - 'LANGUAGE': 'en_US:en', 02:49:53 INFO - 'LOGNAME': 'cltbld', 02:49:53 INFO - 'MAIL': '/var/mail/cltbld', 02:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:53 INFO - 'MOZ_NO_REMOTE': '1', 02:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:53 INFO - 'NO_EM_RESTART': '1', 02:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:53 INFO - 'PWD': '/builds/slave/test', 02:49:53 INFO - 'SHELL': '/bin/bash', 02:49:53 INFO - 'SHLVL': '1', 02:49:53 INFO - 'TERM': 'linux', 02:49:53 INFO - 'TMOUT': '86400', 02:49:53 INFO - 'USER': 'cltbld', 02:49:53 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:53 INFO - '_': '/tools/buildbot/bin/python'} 02:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:53 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:49:53 INFO - Cleaning up... 02:49:53 INFO - Return code: 0 02:49:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:49:53 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:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:53 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:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:53 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:49:53 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:49:53 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:49:53 INFO - Using env: {'DISPLAY': ':0', 02:49:53 INFO - 'HOME': '/home/cltbld', 02:49:53 INFO - 'LANG': 'en_US.UTF-8', 02:49:53 INFO - 'LANGUAGE': 'en_US:en', 02:49:53 INFO - 'LOGNAME': 'cltbld', 02:49:53 INFO - 'MAIL': '/var/mail/cltbld', 02:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:53 INFO - 'MOZ_NO_REMOTE': '1', 02:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:53 INFO - 'NO_EM_RESTART': '1', 02:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:53 INFO - 'PWD': '/builds/slave/test', 02:49:53 INFO - 'SHELL': '/bin/bash', 02:49:53 INFO - 'SHLVL': '1', 02:49:53 INFO - 'TERM': 'linux', 02:49:53 INFO - 'TMOUT': '86400', 02:49:53 INFO - 'USER': 'cltbld', 02:49:53 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:53 INFO - '_': '/tools/buildbot/bin/python'} 02:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:53 INFO - Downloading/unpacking psutil>=0.7.1 02:49:53 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:49:53 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:49:53 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:49:53 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:49:53 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:49:53 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:49:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:55 INFO - Installing collected packages: psutil 02:49:55 INFO - Running setup.py install for psutil 02:49:55 INFO - building 'psutil._psutil_linux' extension 02:49:55 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:49:55 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:49:55 INFO - building 'psutil._psutil_posix' extension 02:49:55 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:49:55 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:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:55 INFO - Successfully installed psutil 02:49:55 INFO - Cleaning up... 02:49:55 INFO - Return code: 0 02:49:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:55 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:49:55 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:49:55 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:49:55 INFO - Using env: {'DISPLAY': ':0', 02:49:55 INFO - 'HOME': '/home/cltbld', 02:49:55 INFO - 'LANG': 'en_US.UTF-8', 02:49:55 INFO - 'LANGUAGE': 'en_US:en', 02:49:55 INFO - 'LOGNAME': 'cltbld', 02:49:55 INFO - 'MAIL': '/var/mail/cltbld', 02:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:55 INFO - 'MOZ_NO_REMOTE': '1', 02:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:55 INFO - 'NO_EM_RESTART': '1', 02:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:55 INFO - 'PWD': '/builds/slave/test', 02:49:55 INFO - 'SHELL': '/bin/bash', 02:49:55 INFO - 'SHLVL': '1', 02:49:55 INFO - 'TERM': 'linux', 02:49:55 INFO - 'TMOUT': '86400', 02:49:55 INFO - 'USER': 'cltbld', 02:49:55 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:55 INFO - '_': '/tools/buildbot/bin/python'} 02:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:49:57 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:49:57 INFO - Installing collected packages: mozsystemmonitor 02:49:57 INFO - Running setup.py install for mozsystemmonitor 02:49:57 INFO - Successfully installed mozsystemmonitor 02:49:57 INFO - Cleaning up... 02:49:57 INFO - Return code: 0 02:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:57 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:49:57 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:49:57 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:49:57 INFO - Using env: {'DISPLAY': ':0', 02:49:57 INFO - 'HOME': '/home/cltbld', 02:49:57 INFO - 'LANG': 'en_US.UTF-8', 02:49:57 INFO - 'LANGUAGE': 'en_US:en', 02:49:57 INFO - 'LOGNAME': 'cltbld', 02:49:57 INFO - 'MAIL': '/var/mail/cltbld', 02:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:57 INFO - 'MOZ_NO_REMOTE': '1', 02:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:57 INFO - 'NO_EM_RESTART': '1', 02:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:57 INFO - 'PWD': '/builds/slave/test', 02:49:57 INFO - 'SHELL': '/bin/bash', 02:49:57 INFO - 'SHLVL': '1', 02:49:57 INFO - 'TERM': 'linux', 02:49:57 INFO - 'TMOUT': '86400', 02:49:57 INFO - 'USER': 'cltbld', 02:49:57 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:57 INFO - '_': '/tools/buildbot/bin/python'} 02:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:49: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:49: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:49: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:49: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:49: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:49: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:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:50:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:00 INFO - Downloading docopt-0.6.1.tar.gz 02:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:50:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:50:00 INFO - Running setup.py install for blobuploader 02:50:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:50:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:50:00 INFO - Running setup.py install for requests 02:50:01 INFO - Running setup.py install for docopt 02:50:01 INFO - Successfully installed blobuploader requests docopt 02:50:01 INFO - Cleaning up... 02:50:01 INFO - Return code: 0 02:50:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:01 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:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:01 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:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:01 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:50:01 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:50:01 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:50:01 INFO - Using env: {'DISPLAY': ':0', 02:50:01 INFO - 'HOME': '/home/cltbld', 02:50:01 INFO - 'LANG': 'en_US.UTF-8', 02:50:01 INFO - 'LANGUAGE': 'en_US:en', 02:50:01 INFO - 'LOGNAME': 'cltbld', 02:50:01 INFO - 'MAIL': '/var/mail/cltbld', 02:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:01 INFO - 'MOZ_NO_REMOTE': '1', 02:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:01 INFO - 'NO_EM_RESTART': '1', 02:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:01 INFO - 'PWD': '/builds/slave/test', 02:50:01 INFO - 'SHELL': '/bin/bash', 02:50:01 INFO - 'SHLVL': '1', 02:50:01 INFO - 'TERM': 'linux', 02:50:01 INFO - 'TMOUT': '86400', 02:50:01 INFO - 'USER': 'cltbld', 02:50:01 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:01 INFO - '_': '/tools/buildbot/bin/python'} 02:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:01 INFO - Running setup.py (path:/tmp/pip-DCa69i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:01 INFO - Running setup.py (path:/tmp/pip-lBSJXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:01 INFO - Running setup.py (path:/tmp/pip-9Xi1nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:01 INFO - Running setup.py (path:/tmp/pip-smuO8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:01 INFO - Running setup.py (path:/tmp/pip-Y4mmCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:01 INFO - Running setup.py (path:/tmp/pip-QTn1Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:01 INFO - Running setup.py (path:/tmp/pip-Xo7nSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:01 INFO - Running setup.py (path:/tmp/pip-N28JO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:02 INFO - Running setup.py (path:/tmp/pip-E6KY36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:02 INFO - Running setup.py (path:/tmp/pip-X6s4qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:02 INFO - Running setup.py (path:/tmp/pip-y7bT0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:02 INFO - Running setup.py (path:/tmp/pip-SRMIhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:02 INFO - Running setup.py (path:/tmp/pip-BRM9HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:02 INFO - Running setup.py (path:/tmp/pip-fbQazh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:02 INFO - Running setup.py (path:/tmp/pip-RIjg3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:02 INFO - Running setup.py (path:/tmp/pip-UC8Pdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:02 INFO - Running setup.py (path:/tmp/pip-I32Zth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:50:02 INFO - Running setup.py install for manifestparser 02:50:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:50:02 INFO - Running setup.py install for mozcrash 02:50:02 INFO - Running setup.py install for mozdebug 02:50:03 INFO - Running setup.py install for mozdevice 02:50:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Running setup.py install for mozfile 02:50:03 INFO - Running setup.py install for mozhttpd 02:50:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Running setup.py install for mozinfo 02:50:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Running setup.py install for mozInstall 02:50:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Running setup.py install for mozleak 02:50:03 INFO - Running setup.py install for mozlog 02:50:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Running setup.py install for moznetwork 02:50:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:50:03 INFO - Running setup.py install for mozprocess 02:50:03 INFO - Running setup.py install for mozprofile 02:50:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Running setup.py install for mozrunner 02:50:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Running setup.py install for mozscreenshot 02:50:04 INFO - Running setup.py install for moztest 02:50:04 INFO - Running setup.py install for mozversion 02:50:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:50:04 INFO - Cleaning up... 02:50:04 INFO - Return code: 0 02:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:04 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:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:04 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:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:04 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:50:04 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:50:04 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:50:04 INFO - Using env: {'DISPLAY': ':0', 02:50:04 INFO - 'HOME': '/home/cltbld', 02:50:04 INFO - 'LANG': 'en_US.UTF-8', 02:50:04 INFO - 'LANGUAGE': 'en_US:en', 02:50:04 INFO - 'LOGNAME': 'cltbld', 02:50:04 INFO - 'MAIL': '/var/mail/cltbld', 02:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:04 INFO - 'MOZ_NO_REMOTE': '1', 02:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:04 INFO - 'NO_EM_RESTART': '1', 02:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:04 INFO - 'PWD': '/builds/slave/test', 02:50:04 INFO - 'SHELL': '/bin/bash', 02:50:04 INFO - 'SHLVL': '1', 02:50:04 INFO - 'TERM': 'linux', 02:50:04 INFO - 'TMOUT': '86400', 02:50:04 INFO - 'USER': 'cltbld', 02:50:04 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:04 INFO - '_': '/tools/buildbot/bin/python'} 02:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:04 INFO - Running setup.py (path:/tmp/pip-Vdk6XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:04 INFO - Running setup.py (path:/tmp/pip-0ekQkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:04 INFO - Running setup.py (path:/tmp/pip-z257co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:04 INFO - Running setup.py (path:/tmp/pip-N4KaEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:05 INFO - Running setup.py (path:/tmp/pip-A8_ZjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:05 INFO - Running setup.py (path:/tmp/pip-BT8ZIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:05 INFO - Running setup.py (path:/tmp/pip-ao1h8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:05 INFO - Running setup.py (path:/tmp/pip-siYF1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:05 INFO - Running setup.py (path:/tmp/pip-ad5PB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:05 INFO - Running setup.py (path:/tmp/pip-1de9N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:05 INFO - Running setup.py (path:/tmp/pip-UOPLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:05 INFO - Running setup.py (path:/tmp/pip-ExnDmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:05 INFO - Running setup.py (path:/tmp/pip-nOcsBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:05 INFO - Running setup.py (path:/tmp/pip-hI8EIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:05 INFO - Running setup.py (path:/tmp/pip-iuoCsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:05 INFO - Running setup.py (path:/tmp/pip-EGJ6w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:05 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:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:05 INFO - Running setup.py (path:/tmp/pip-bYbfzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:05 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:50:05 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:50:05 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:50:05 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:50:05 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:50:05 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:50:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:07 INFO - Downloading blessings-1.5.1.tar.gz 02:50:07 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:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:50:07 INFO - Installing collected packages: blessings 02:50:07 INFO - Running setup.py install for blessings 02:50:07 INFO - Successfully installed blessings 02:50:07 INFO - Cleaning up... 02:50:07 INFO - Return code: 0 02:50:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:50:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:08 INFO - Reading from file tmpfile_stdout 02:50:08 INFO - Current package versions: 02:50:08 INFO - argparse == 1.2.1 02:50:08 INFO - blessings == 1.5.1 02:50:08 INFO - blobuploader == 1.2.4 02:50:08 INFO - docopt == 0.6.1 02:50:08 INFO - manifestparser == 1.1 02:50:08 INFO - mozInstall == 1.12 02:50:08 INFO - mozcrash == 0.16 02:50:08 INFO - mozdebug == 0.1 02:50:08 INFO - mozdevice == 0.47 02:50:08 INFO - mozfile == 1.2 02:50:08 INFO - mozhttpd == 0.7 02:50:08 INFO - mozinfo == 0.9 02:50:08 INFO - mozleak == 0.1 02:50:08 INFO - mozlog == 3.1 02:50:08 INFO - moznetwork == 0.27 02:50:08 INFO - mozprocess == 0.22 02:50:08 INFO - mozprofile == 0.27 02:50:08 INFO - mozrunner == 6.11 02:50:08 INFO - mozscreenshot == 0.1 02:50:08 INFO - mozsystemmonitor == 0.0 02:50:08 INFO - moztest == 0.7 02:50:08 INFO - mozversion == 1.4 02:50:08 INFO - psutil == 3.1.1 02:50:08 INFO - requests == 1.2.3 02:50:08 INFO - wsgiref == 0.1.2 02:50:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:08 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:50:08 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:50:08 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:50:08 INFO - Using env: {'DISPLAY': ':0', 02:50:08 INFO - 'HOME': '/home/cltbld', 02:50:08 INFO - 'LANG': 'en_US.UTF-8', 02:50:08 INFO - 'LANGUAGE': 'en_US:en', 02:50:08 INFO - 'LOGNAME': 'cltbld', 02:50:08 INFO - 'MAIL': '/var/mail/cltbld', 02:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:08 INFO - 'MOZ_NO_REMOTE': '1', 02:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:08 INFO - 'NO_EM_RESTART': '1', 02:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:08 INFO - 'PWD': '/builds/slave/test', 02:50:08 INFO - 'SHELL': '/bin/bash', 02:50:08 INFO - 'SHLVL': '1', 02:50:08 INFO - 'TERM': 'linux', 02:50:08 INFO - 'TMOUT': '86400', 02:50:08 INFO - 'USER': 'cltbld', 02:50:08 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:08 INFO - '_': '/tools/buildbot/bin/python'} 02:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 INFO - Cleaning up... 02:50:08 INFO - Return code: 0 02:50:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:08 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:50:08 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:50:08 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:50:08 INFO - Using env: {'DISPLAY': ':0', 02:50:08 INFO - 'HOME': '/home/cltbld', 02:50:08 INFO - 'LANG': 'en_US.UTF-8', 02:50:08 INFO - 'LANGUAGE': 'en_US:en', 02:50:08 INFO - 'LOGNAME': 'cltbld', 02:50:08 INFO - 'MAIL': '/var/mail/cltbld', 02:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:08 INFO - 'MOZ_NO_REMOTE': '1', 02:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:08 INFO - 'NO_EM_RESTART': '1', 02:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:08 INFO - 'PWD': '/builds/slave/test', 02:50:08 INFO - 'SHELL': '/bin/bash', 02:50:08 INFO - 'SHLVL': '1', 02:50:08 INFO - 'TERM': 'linux', 02:50:08 INFO - 'TMOUT': '86400', 02:50:08 INFO - 'USER': 'cltbld', 02:50:08 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:08 INFO - '_': '/tools/buildbot/bin/python'} 02:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:08 INFO - Downloading/unpacking jsonschema 02:50: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:50: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:50: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:50: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:50: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:50: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:50:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:50:10 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:50:10 INFO - Downloading/unpacking functools32 (from jsonschema) 02:50: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:50: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:50: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:50: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:50: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:50: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:50:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:50:10 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:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:50:10 INFO - warning: no files found matching '*.txt' 02:50:10 INFO - no previously-included directories found matching 'build' 02:50:10 INFO - no previously-included directories found matching 'dist' 02:50:10 INFO - no previously-included directories found matching '.git*' 02:50:10 INFO - Installing collected packages: jsonschema, functools32 02:50:10 INFO - Running setup.py install for functools32 02:50:10 INFO - warning: no files found matching '*.txt' 02:50:10 INFO - no previously-included directories found matching 'build' 02:50:10 INFO - no previously-included directories found matching 'dist' 02:50:10 INFO - no previously-included directories found matching '.git*' 02:50:10 INFO - Successfully installed jsonschema functools32 02:50:10 INFO - Cleaning up... 02:50:10 INFO - Return code: 0 02:50:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:50:10 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:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:10 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:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:10 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 0x7f4995075f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', '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:50:10 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:50:10 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:50:10 INFO - Using env: {'DISPLAY': ':0', 02:50:10 INFO - 'HOME': '/home/cltbld', 02:50:10 INFO - 'LANG': 'en_US.UTF-8', 02:50:10 INFO - 'LANGUAGE': 'en_US:en', 02:50:10 INFO - 'LOGNAME': 'cltbld', 02:50:10 INFO - 'MAIL': '/var/mail/cltbld', 02:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:10 INFO - 'MOZ_NO_REMOTE': '1', 02:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:10 INFO - 'NO_EM_RESTART': '1', 02:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:10 INFO - 'PWD': '/builds/slave/test', 02:50:10 INFO - 'SHELL': '/bin/bash', 02:50:10 INFO - 'SHLVL': '1', 02:50:10 INFO - 'TERM': 'linux', 02:50:10 INFO - 'TMOUT': '86400', 02:50:10 INFO - 'USER': 'cltbld', 02:50:10 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:10 INFO - '_': '/tools/buildbot/bin/python'} 02:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:10 INFO - Downloading/unpacking flake8 02:50: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:50: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:50: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:50: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:50: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:50: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:50:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:50:12 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:50:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:50:12 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:50:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:12 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:50:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:50:13 INFO - no previously-included directories found matching 'docs/_build' 02:50:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:50:13 INFO - Running setup.py install for pep8 02:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:50:13 INFO - no previously-included directories found matching 'docs/_build' 02:50:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:50:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:50:13 INFO - Cleaning up... 02:50:13 INFO - Return code: 0 02:50:13 INFO - Running post-action listener: _resource_record_post_action 02:50:13 INFO - Running post-action listener: _start_resource_monitoring 02:50:13 INFO - Starting resource monitoring. 02:50:13 INFO - ##### 02:50:13 INFO - ##### Running install step. 02:50:13 INFO - ##### 02:50:13 INFO - Running pre-action listener: _resource_record_pre_action 02:50:13 INFO - Running main action method: install 02:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:13 INFO - Reading from file tmpfile_stdout 02:50:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:50:13 INFO - Reading from file tmpfile_stdout 02:50:13 INFO - Output received: 02:50:13 INFO - Usage: mozinstall [options] installer 02:50:13 INFO - Options: 02:50:13 INFO - -h, --help show this help message and exit 02:50:13 INFO - -d DEST, --destination=DEST 02:50:13 INFO - Directory to install application into. [default: 02:50:13 INFO - "/builds/slave/test"] 02:50:13 INFO - --app=APP Application being installed. [default: firefox] 02:50:13 INFO - mkdir: /builds/slave/test/build/application 02:50:13 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:50:13 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:50:29 INFO - Reading from file tmpfile_stdout 02:50:29 INFO - Output received: 02:50:29 INFO - /builds/slave/test/build/application/firefox/firefox 02:50:29 INFO - Running post-action listener: _resource_record_post_action 02:50:29 INFO - ##### 02:50:29 INFO - ##### Running run-tests step. 02:50:29 INFO - ##### 02:50:29 INFO - Running pre-action listener: _resource_record_pre_action 02:50:29 INFO - Running main action method: run_tests 02:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:50:29 INFO - Python 2.7.3 02:50:29 INFO - Return code: 0 02:50:29 INFO - grabbing minidump binary from tooltool 02:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:29 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 0x2b020b0>, '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 0x2b02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b03440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:50:29 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:50:29 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:50:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:50:29 INFO - Return code: 0 02:50:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:50:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:50:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:50:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:50:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:50:30 INFO - Return code: 0 02:50:30 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/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] in /builds/slave/test/build 02:50:30 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/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost 02:50:30 INFO - Using env: {'DISPLAY': ':0', 02:50:30 INFO - 'HOME': '/home/cltbld', 02:50:30 INFO - 'LANG': 'en_US.UTF-8', 02:50:30 INFO - 'LANGUAGE': 'en_US:en', 02:50:30 INFO - 'LOGNAME': 'cltbld', 02:50:30 INFO - 'MAIL': '/var/mail/cltbld', 02:50:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:50:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:30 INFO - 'MOZ_NO_REMOTE': '1', 02:50:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:30 INFO - 'NO_EM_RESTART': '1', 02:50:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:30 INFO - 'PWD': '/builds/slave/test', 02:50:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:50:30 INFO - 'SHELL': '/bin/bash', 02:50:30 INFO - 'SHLVL': '1', 02:50:30 INFO - 'TERM': 'linux', 02:50:30 INFO - 'TMOUT': '86400', 02:50:30 INFO - 'USER': 'cltbld', 02:50:30 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528', 02:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:30 INFO - '_': '/tools/buildbot/bin/python'} 02:50:30 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/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] with output_timeout 3600 02:50:30 INFO - mozversion INFO | application_buildid: 20151221020630 02:50:30 INFO - mozversion INFO | application_changeset: ea9df316f1cc65509c92b3a2409d02e42a855682 02:50:30 INFO - mozversion INFO | application_display_name: Nightly 02:50:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:50:30 INFO - mozversion INFO | application_name: Firefox 02:50:30 INFO - mozversion INFO | application_remotingname: firefox 02:50:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:50:30 INFO - mozversion INFO | application_vendor: Mozilla 02:50:30 INFO - mozversion INFO | application_version: 46.0a1 02:50:30 INFO - mozversion INFO | platform_buildid: 20151221020630 02:50:30 INFO - mozversion INFO | platform_changeset: ea9df316f1cc65509c92b3a2409d02e42a855682 02:50:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:50:30 INFO - mozversion INFO | platform_version: 46.0a1 02:50:30 INFO - 2015-12-21 02:50:30,418 DEBUG : using testdate: 1450695030 02:50:30 INFO - 2015-12-21 02:50:30,418 DEBUG : actual date: 1450695030 02:50:30 INFO - 2015-12-21 02:50:30,516 INFO : starting webserver on 'localhost:37206' 02:50:30 INFO - 2015-12-21 02:50:30,517 INFO : Starting test suite talos-linux64-ix-057 02:50:30 INFO - 2015-12-21 02:50:30,518 INFO : Starting test dromaeo_css 02:50:30 INFO - 2015-12-21 02:50:30,518 DEBUG : operating with platform_type : linux_ 02:50:30 INFO - 2015-12-21 02:50:30,518 INFO : Initialising browser for dromaeo_css test... 02:50:30 INFO - 2015-12-21 02:50:30,532 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHaOxcX/profile http://localhost:37206/getInfo.html 02:50:34 INFO - 2015-12-21 02:50:34,664 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:50:34 INFO - 2015-12-21 02:50:34,679 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:50:34 INFO - 2015-12-21 02:50:34,680 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:50:34 INFO - 2015-12-21 02:50:34,680 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:50:34 INFO - 2015-12-21 02:50:34,680 DEBUG : BROWSER_OUTPUT: __metrics 02:50:34 INFO - 2015-12-21 02:50:34,816 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:50:34 INFO - 2015-12-21 02:50:34,872 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:50:36 INFO - 2015-12-21 02:50:36,002 INFO : Browser initialized. 02:50:36 INFO - 2015-12-21 02:50:36,002 INFO : Running cycle 1/1 for dromaeo_css test... 02:50:36 INFO - 2015-12-21 02:50:36,003 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHaOxcX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:50:47 INFO - 2015-12-21 02:50:47,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 150102016 02:50:47 INFO - 2015-12-21 02:50:47,954 DEBUG : BROWSER_OUTPUT: 02:51:39 INFO - 2015-12-21 02:51:39,159 DEBUG : BROWSER_OUTPUT: 1450695099155 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:53:51 INFO - 2015-12-21 02:53:51,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37206/tests/dromaeo/cssquery-ext.html) 02:53:52 INFO - 2015-12-21 02:53:52,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 252874752 02:53:52 INFO - 2015-12-21 02:53:52,150 DEBUG : BROWSER_OUTPUT: 02:56:54 INFO - 2015-12-21 02:56:54,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/dromaeo/cssquery-ext.html (next: http://localhost:37206/tests/dromaeo/cssquery-jquery.html) 02:56:55 INFO - 2015-12-21 02:56:55,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 226516992 02:56:55 INFO - 2015-12-21 02:56:55,204 DEBUG : BROWSER_OUTPUT: 02:59:57 INFO - 2015-12-21 02:59:57,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37206/tests/dromaeo/cssquery-mootools.html) 02:59:57 INFO - 2015-12-21 02:59:57,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 221786112 02:59:57 INFO - 2015-12-21 02:59:57,786 DEBUG : BROWSER_OUTPUT: 03:02:59 INFO - 2015-12-21 03:02:59,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37206/tests/dromaeo/cssquery-prototype.html) 03:03:00 INFO - 2015-12-21 03:03:00,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 210104320 03:03:00 INFO - 2015-12-21 03:03:00,239 DEBUG : BROWSER_OUTPUT: 03:06:02 INFO - 2015-12-21 03:06:02,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37206/tests/dromaeo/cssquery-yui.html) 03:06:03 INFO - 2015-12-21 03:06:03,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 215101440 03:06:03 INFO - 2015-12-21 03:06:03,541 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/dromaeo/cssquery-yui.html (next: http://localhost:37206/tests/dromaeo/cssquery-dojo.html) 03:09:06 INFO - 2015-12-21 03:09:06,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 256131072 03:09:06 INFO - 2015-12-21 03:09:06,296 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,297 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:09:06 INFO - 2015-12-21 03:09:06,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:09:06 INFO - 2015-12-21 03:09:06,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:09:06 INFO - 2015-12-21 03:09:06,298 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:09:06 INFO - 2015-12-21 03:09:06,299 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2532.164385752702;2641.656584643996;2644.246389778911;2656.760891519764;2658.720834312397;4261.87214383569;4367.4322338096;4485.686001979859;4500.054988452425;4502.549745025496;4467.575580319873;4482.932756008654;4501.774911254441;4522.41208642876;4582.450105987278;4152;4155.459790227282;4162.666986641061;4200.07598328368;4215.051613386979;4190;4260.914781704364;4260.998665313648;4263.424437700917;4288.849890253841;4015.1568170684045;4092.3656833190903;4112.444819949328;4202.810873510699;4208.410822484854;4157.355609880473;4164.500259968793;4166.354215096665;4172.77049762263;4198.160367926427;4136.937945930814;4139.606737359946;4144.067584793427;4144.730592511477;4184.581541845821;4218.6625069994325;4263.104748002923;4296.0548679290505;4391.165678521071;4499.797509112098;4781;4794.49657785931;4809.951900480985;4823.541763532458;4862.36789217403;4829.082474329866;4829.348038014893;4845.53967373099;4846.321514987904;4896.4124305083615;4277;4369.104333611602;4370.672199585044;4391.121775644884;4494.325851122358;4928.383952005999;4935.358403407606;4959.404871415381;4960.677555958851;4960.677555958923;4762.214234651313;4762.309465127537;4770.427548694179;4777.355057067321;4803.327534145223;4575.565321294472;4709.646776491777;4710;4733.952660473351;4877.585405240523;4743.857684269477;4759.309900064472;4768.928466073012;4772.976135119302;4814.638902082358;4738.976305118521;4746.311784791186;4746.596539294199;4748.3114948332295;4792;3867.5939026402384;3958.9208215835524;3964.147708242684;3964.266610677034;3968.7817170055346;3549.3256281306467;3568.2506673598314;3572.7499075065016;3578.3737845876867;3586.3544561979093;4172.603602657803;4174;4179.791010449465;4186.832526698959;4210.073783767566;4572.1312950539295;4670.766461676971;4675.485696573374;4698.882527936829;4815.783289751969;4126.42230087788;4142.212979533939;4157.438745769343;4186.665066794649;4188.476440444944;4230.344296634026;4238.533761286256;4247.49030116388;4266.530681625019;4282.914341713148;4332.285172946428;4419.933700994423;4508.211063063951;4515.729056256635;4520.118576877478;4696.74167920754;4783.043391321819;4852.8544143675745;4869.829555965524;4910.8281210157475;4571.931421028754;4572.017016341502;4573.794179261875;4584.679072464895;4616.422947131608;4570.702904311209;4692.671512994058;4780.95219047819;4783.306420569068;4829.73436460998;4714.127886341038;4752.667313288175;4798.856034318976;4825.420949486084;4859.781309841136;4686.039361930728;4693.178693728652;4695.600873925755;4696.1546921554445;4732.100900828831;4499.910001800011;4618.676692631483;4686.695364801277;4690.202665546797;4723.787429565747;4492.752898590609;4520.954790452185;4589.426321709786;4590.334401511829;4640.69835460694;4695.906081878412;4703.247480403119;4708.176069187947;4712.929306060343;4749.9287510688055;4365.694401391999;4464.15181115587;4624.1445332613575;4640.1879671058105;4660.184467718203 03:09:06 INFO - 2015-12-21 03:09:06,302 DEBUG : BROWSER_OUTPUT: |1;ext.html;519.2107995846316;539.6734975339922;557.8187089196011;564.7486868343589;566.8096996307754;24380.75619243807;34890.47664285038;35597.2880542389;35647.821760891224;35755.2848943021;38011;38394.23211535774;38582;38713;38738.8063059685;7000.439964802829;7108.466864985121;7822.061352637691;7965.800854978614;7989.880151797728;9917.454540000297;10207.897921020769;10210.897891021106;10222.591096356175;10226.590936362574;9689.951550242275;9785.168260697814;9785.510724463784;9789.902100979007;9793.510324483746;7187.209406965229;7374.668139933716;9796.951015244878;9879.06148915852;10047.196224302039;9717.12545870875;9815.165710914582;9857.35927164732;9865.457399843006;9868.309218354718;35602.465963010574;35938;35993.64006359929;36149.81925090358;36193;2750.931226719348;2797.9440411191867;2812.943741125166;2950.173951293641;3228.2252259457796;27550.724492755016;27585.448291034267;27830.443391132267;27897;28044.15867523957;3381.442062059757;3430.6569343065744;3442.277121804399;3500.9124771880906;3508.5263489428858;206555;207306;207417;207518;208078;44565.55434445679;52654;53015.46984530183;53040.73479632654;53048.204276935874;44200;44500.55499444964;44527.777361113636;44588.55411445909;55629.721851391296;13636;13747.175169489663;13843.653908652162;13844.377003034888;13857.930710346585;10449.582016719247;10635.840462393071;10661.307015043998;10680.57277708883;10684.358938463716;17492.300307987793;17635.29458821633;17651.205695743723;18161.636767264845;18439.81560184408;7219.458540609476;7278.199398066208;7381.409487241008;7493.512921660074;7494.362979146725;826.2027143806256;841.9957900210583;852.3224036890563;931.4318265857821;969.9127078562822;24749.505009900062;26223.868880655857;26393.208203753533;26436.8678156608;26468.60297095545;904.5341649050744;971.3491960386558;1017.9643712470177;1059.1262208677717;1103.3159441146381;13031.674208144872;13223.404946777418;13323.200607963554;13354.866451335361;13403.262820544964;255118;259235;260497;260696;260816;43042.35436468456;43119;43203.56796432058;43234;43362.132757344676;1021.9591216351263;1048.145761204631;1168.485866218861;1198.7782260281876;1206.5776978057609;22822.77177228273;23107.65338519957;23544.6468302979;23724.28827135189;23788.286351409486;32132.83933580317;32388.83805580957;32426.35147297088;32434.189145271557;35166.296674066885;148834.2558287245;241312;246665;247090;247997;24689.382765430288;25167.496650067264;25181;25186.74813251844;25187.87406063031;33818.29453643654;34219.315613688086;34332.82833585816;34722.30555388929;34795.130121746144;30510.389792204474;31591.84204078965;32578.185545361557;32882;33345.49981750227;29172.854135729187;30334.69665303319;31758.68241317557;31776.523352150198;31958.36083278368;30747.846260768554;31515.52726709147;31540.11128275029;31565.684343156274;31616.051518454482;27127;28450.715492844807;28811.711882880903;28998.56502152427;29066.564001540417;22798.316050517846;22925.42686432786;22968.310950671508;23017.76982230156;23199 03:09:06 INFO - 2015-12-21 03:09:06,304 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.9766767492436;311.6167114449227;317.9427703013457;318.56833989943624;320.4856205789709;15372.23219329776;15666;15919.442819501306;16284.674306513893;16314;14397.352119154637;14768.261586920664;15140;15157.242137893089;15162.938594298375;4829.251466022763;4966.826161084363;4967.652264341497;4968.503149685039;4970.453250142481;4807.831725889595;4917.041176970492;4953.826616068421;4955.6035517158725;4962.578180854632;3661.286049220403;3759.661630453272;3766.0961369271454;4932.556069953704;4934.950650493485;3764.096616811959;3766.0961369271313;5498;5662.065759149736;5700.059490184115;4611.4696809866955;4784.6889952153;4915.016996600659;4922.680025798311;4930.704157750511;8948.8657670135;10769.892301077045;10907.072898803612;10955;10978.835317470244;1778.8576913846862;1826.497713128887;1831.3407173417559;1903.8381737552324;2278.783515566035;8277.710280140227;8547;8612.698555550525;8955.238804701608;8976.820463590757;1711.212842092639;1738.4263193146232;1739.086979335846;1754.6052138268915;1774.1395423219728;50270.497295026944;52349.69125771848;52580;52786.73606631942;53921.46078539204;9603;9606.615735370508;9634.229261659051;9643.421394716339;9687;12076.698082548006;12084.818727719092;12099.697507562205;12100.455479503444;12118.39408029595;7210.134783825974;7227.9638601806655;7234.855302893912;7249.601271930094;7250.963745181346;6951.6871740771785;7020.508564400545;7024.438044956391;7098.290170982964;7125.821854453577;4077.4903137107863;4088.325426304686;4139.875803725893;4143.316352801754;4203.600657937491;1695.3727120965075;1726.1628110366462;1746.2840235503636;1747.8689098317677;1762.524118488001;353.8920629208116;356.2145469240319;365.6398447529182;842.4945032980163;842.7008412013647;9101.726948191565;9136.58885350161;9277.768055798659;9474.400830861146;9681.66114186;355.92347645256393;384.7922122054059;388.81531272645833;391.85305510433585;400.1816285695701;4782.904341913142;5254.474552544715;5277.419483856849;5384.623076384615;5396.757145928443;496525;497783;514708;525110;529390;70261.2973870265;74626.6268668664;75024.62487687527;75855.62072189603;76269;1060.6287799270194;1063.813832579311;1067.3649178738638;1090.1714696830306;1094.7208461842338;9377.906220937975;9670.323077384515;14261.286935653383;14420;14428.927855360656;32196.517052244704;33091.50362744609;33787.83106084454;34207.315853683285;36416.453753194255;48318.758406207744;49014.75492622514;50050.74974625104;50124.24813627725;50317;13755.38100785487;13998.230097344744;14161.858381416054;14320.856791432368;14336.498222562577;17403.129843508028;17571.385001524886;17572.472825815246;17723.556911077325;17889.73165402546;14493.173831103255;14531.418743250151;14538.200398978157;14951.327190276681;14988.550343489713;13810.171389716648;14582.635434113809;14629;14813.407463701331;15080.773788393402;14444.927775361477;14469.131852088909;14474.34865431037;14940.925295373454;15441.15073670959;11049.889501104886;13544.661383465493;13549.119307244997;13832.377543010387;13882.722345553235;11618.5352585899;12131.939340303596;14101.576952691436;14462.20457874785;15287.159206243763 03:09:06 INFO - 2015-12-21 03:09:06,304 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1423.9715205695893;1615.7334039883417;1675.0201132337586;1694.9237284322212;1736.7915850097982;5827.70861456927;6620.503462240333;6863.622500762456;6913.446924246061;6915.654217289128;6676.465882729382;6850.862982740342;6991.930080699191;7008.61452620107;7016.9649151754165;2029.8173164415164;2059.6292667319876;2066.927657531987;2067.2971189795467;2067.5968186203695;2056.629806634805;2090.560982193741;2093.5080256139872;2094.0262777808316;2094.9057292421876;2028.6449871272468;2036.1651722793658;2071.513194399315;2074.139232218635;2074.294739788472;1999.780024197337;2022.524706693933;2023.8684485508395;2024.1599736109497;2026;1999.090413861704;1999.5401057756796;2058.5059585699473;2061.4537147655883;2061.80412860778;6858.725650973955;6936;6940.6529673516125;6940.826479338057;6967.651617419108;3931.4889064421727;3993.6405723484736;3999.960000399988;4004.899877503057;4007.0583412897945;2689.946201075987;2692.6903406108354;2724.4006318609872;2759;2774.9722502774916;917.7200953709116;923.8845144356956;926.0970553710146;952.1383148250775;953.0421925964431;9059.365844390895;9066.410683305565;9077.818443631091;9087.954560227223;9102.68140615082;3660.377735784923;3684.613115622875;3721.702263818888;3734.3278209922473;3742.9812850936114;7906.248906353887;7914.089879663798;7917.722879699298;7920.326772224425;7927.4054445915635;4060.3503439450137;4069.6337329640473;4086.8773936781945;4091.4476545665952;4093.8771836844944;3144.3868445653334;3225.74194064479;3647.325244829715;3712.090537818252;3744.4196149596855;3330.3505816365578;3338.4324664806554;3370.292238629866;3372.224388390635;3390.4405773047665;1064.808334499782;1083.685731137977;1086.0768346905068;1093.4314156638663;1103.9558417663204;1128.774245150973;1149.2357582207737;1150.5570355413226;1153.6077733570626;1181.787278289916;6384.52116091295;6512.479001679854;6524.608523488606;6530.477561795045;6546.410823025951;427.80534856640156;428.97211681240617;429.7099457865928;430.62965849369516;430.9547497512716;5196.194589838581;5249.973750131225;5251.186066159751;5257.158854583248;5261.289725887033;8148.796280092926;8162.1837816219095;8272.958635206905;8319.126491718403;8374.665013399517;8159.224873636995;8191.0580283267;8234.876476852853;8251.381146414044;8260.215279548433;6330.461910737639;6449.355064493607;6467.2562655294305;6520.347965203442;6547.738090476328;6243.43809057187;6244.531660125418;6250.406211409909;6251.624902505864;6255.124282600531;7212.098487689039;7384.076990376203;7431.145418276751;7438.702451901863;7445.069366329209;7473.43949203801;7586.772396828104;7644.80887977805;7654.655540500802;7665.616719164131;5127.66670166438;5283.656562323436;6124.418180272867;6173.81478555644;6181.3200547938795;6408.551401401857;6641.169853768279;6694.29709880475;6701.463882889455;6704.094947182263;5942.078977758454;5977.432143946318;6154.630722156506;6156.1381406604005;6266.498680105489;6192.442680158807;6238.937610623836;6288.905666414916;6326.6836658165985;6366.9681651591445;6173.950428427088;6183.938160618336;6242.750289988349;6244.438000579969;6259.405356491126;5543.1408131739645;5582.9720851397105;5583.776648933997;5597.580181486486;5608.439156084359;5900.675462849413;5932.6737029462065;5968.582199246011;5977.402259773988;5990.400959903975 03:09:06 INFO - 2015-12-21 03:09:06,305 DEBUG : BROWSER_OUTPUT: |4;prototype.html;283.70778098558486;286.7877770449868;292.78041468898317;293.30047835911347;294.85257371314344;5179.585633149349;5296.841094767158;5374.086405311096;5382.219578161169;5391.973040134794;5260.526552610264;5316.494932981361;5316.9734151329285;5325.680459172443;5332.386775520817;4094.3858421236905;4098;4100.077482566414;4103.5280942691525;4107.835686572534;3861.7489863158944;3923.3526468132723;3937.3503371943593;3987.9202415951663;4018.1762738638654;3953.4267531207956;3975;3977.6618987385964;3983.760974341534;3989.1423343981037;3796.2027974125467;3914.628110329543;3969.24584328978;3980.6019398060253;3990.7206495545324;3470.16715988161;3507.298540291926;3511.578610566723;3511.877084302037;3528.7177025838128;5062;5102.285680004802;5104.310918026056;5112.41207261166;5115.769790359443;4640.373549570832;4640.582347588733;4649.232876575395;4649.95350046502;4650.162970665279;5420.91868621971;5530.806421775219;5539.695316757577;5548.44515548446;5548.500634942834;3918.7060970427333;3919.941200881989;3919.941200881989;3921.2353591049755;3927.4894263745814;5745.195672605839;5832.95006898758;5842.649441033552;5848.532117430638;5851.590388672837;3968.900777480528;3997.040710229524;3999.1201935574127;4004.5594984551676;4008.6392224699916;4053.250148722496;4053.3717273822604;4056.878293651136;4057.9391309129796;4059.878203653895;4521.344405061248;4641.094986477672;4647.09381670571;4647.697899636512;4653.488116307203;5556.444355564411;5564.332280126329;5586.972065139648;5588.0779671354585;5590.357108932525;1418.2979425184599;1447.7176950494763;1448.7247422989599;1449.6013596261112;1449.811524501808;969.5443141723379;974.0940924939874;978.3885071830106;1001.759577701361;1004.3772860826334;4894.926576101361;4914.70511769295;4915.975420122948;4916.631252655993;4917.950820491821;5782.335031471351;5784.59507834456;5791.536677065825;5796.1305804129715;5797.217375654317;4905.460399356068;4919.975400123048;4920.434150072716;4922.803087876445;4925.088858561177;3006.4738670732972;3055.495843185894;3099.767517436201;3122.469180239365;3127.6246850377647;5387.568994480433;5425.647332923348;5515.145152501288;5518.144687573433;5521;5949.137375080589;5969.880602388015;5972.193753843176;5980.611260268069;5985.042393217064;5487.64330318528;5501.202325662756;5502.944970550323;5505.174223866452;5507.862303442446;5641.323041235078;5770.2498675171955;5842.766289348378;5844.240248767633;5876.500497457764;5709.54323654115;5710.65736055838;5715.771369145187;5725.141228815711;5726.112452569859;5504.724763761876;5505.807296744595;5513.421090785409;5519.227308176939;5526.447355264602;3796.2027974125745;3920.5099362579676;3958;3958.663513601261;3960.7821569812786;5721.170430287501;5793.304803423616;5794.565407594363;5800.622959507618;5804.042333015005;5590.748416321194;5593.888122237451;5598.86002849932;5601.04782187021;5605.299337582802;5593.468620481048;5595.132754423071;5601.831945041656;5603.271574695264;5606.579506536945;5351.491608297206;5463.562914966714;5466.4260252674485;5473.0695781718;5477.233187353694;5605.747741351731;5615.943840561542;5618.550515958632;5621.80323688669;5630.155476678531;5473.917891231715;5483.4516548344845;5494.9725251375085;5496.6701997880255;5509.090999984957 03:09:06 INFO - 2015-12-21 03:09:06,306 DEBUG : BROWSER_OUTPUT: |5;yui.html;649.5193556767994;655;704.8977898204761;793.4485532554875;800.7757827808214;10705.678829635113;10972.561097556088;10993.0655894249;10999.780004399907;11023.61417350393;10497.842532362021;10537.947310263457;10540.314879532825;10550.155987520999;10756;631.4632562322013;639.066962235135;793.317746737805;795.1769918134718;809.1301850510695;801.6512816924627;801.8676918308502;808.5431731071955;808.6159074439623;808.8220591469867;845.0282175498165;851.5103815306193;852.1776485691306;852.26705033671;852.5311078906608;648.3581254558001;657.5955787190867;816.4121832280748;829.2412442615;830.6469750356135;616.2266355723539;616.4390404731718;616.6824085595922;617.3517806303364;617.4813156948185;11031.61389351377;11186.16103792219;11191.720206994809;11216.607418740386;11347.148963827745;10441.47792610374;10722;10828.620998265102;10916.727081822939;10927.344359338465;9368.67209647659;9441.952790236073;9471.573779179953;9567.37812042215;9633.940266570671;3175.25381535339;3182.2839861031084;3193.8243396613175;3215.4051500472488;3242.513622956552;38531.229375412615;38545;38591.80704096489;39358.21283574341;39495.40756888649;7816.335611473089;7867.763967080997;8314.376421768391;8319.209675080858;8329;14696.338664759898;14718.33767480466;14745.41018359275;14759.040662356912;14767.335469903881;6280.968595157086;6378.776742814072;6434.067060276234;6467.288598254188;6700.128983232246;3301.653326400741;3407.5399821023843;3459.2043829919257;3542.468629705513;3576.9821150894077;2547.2485616743106;2584.3926677230834;2584.987075064613;2585.3536615846037;2588.327034970921;441.77027945468177;450.2705616900642;452.2853890852445;456.3428662725664;460.4957571459247;468.94607120180933;476.51395576511766;511.836212412032;546.5217934307481;570.4523657289049;7081.92918070823;7092.148942126978;7262.636868156676;7265.382442492447;7496.887546686804;463.33974086925997;505.2396143803552;529.5315682281043;550.1610044681812;561.7472137538124;3394.8642054318043;3595.658412450813;3705.6850167736043;3756;3995.260876737813;44271;47464.7626761864;47479.05041899212;47498.762506187246;47782.76108619435;40461.59538404637;41734.791326043174;41944.79027604842;41983.790081049396;42993;38260;38765.41851872224;38779.80610096988;39031.414528782094;39272.80363598164;6998.6150761708595;7667.118281397487;7796;7811.531308121531;7983.481073730189;28946.7105328944;29557.704422956354;29599.556006660347;29703.55444668375;29830.70169298366;35025.474617880245;36705.08237294089;39190.60809391984;39395.606043939195;39719.205615886945;9824.852627210455;9835.704928852147;9949.552270147717;10047.296689231976;10290.639827605997;10210.438425886647;10355.275130741076;10599.8940010602;10836.295640783324;11051.17116216271;10170.186385089322;10206.081452669296;10258.43578603184;10386.272960892666;10621;10191.541380638037;10244.129249013618;10343.896561034293;10392.272540922062;10397.58409663605;9555.617775289189;9564.426134431957;9598.95200523993;9798.902010979798;9982.750431239278;8624.870626940727;8799.164079412702;8822.161894620001;8864.936207655122;9255.25957923378;8166.836663266583;8170.142135075732;8221.260086592236;8396;8836.911630883866 03:09:06 INFO - 2015-12-21 03:09:06,307 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:09:06 INFO - 2015-12-21 03:09:06,307 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:09:06 INFO - 2015-12-21 03:09:06,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 03:09:06 INFO - 2015-12-21 03:09:06,307 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:09:06 INFO - 2015-12-21 03:09:06,307 DEBUG : BROWSER_OUTPUT: __startTimestamp1450696146296__endTimestamp 03:09:06 INFO - 2015-12-21 03:09:06,307 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,308 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:09:06 INFO - 2015-12-21 03:09:06,308 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:09:06 INFO - 2015-12-21 03:09:06,308 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,308 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4428.88 Median:4520.95 stddev:447.19 (9.9%) stddev-sans-first:423.09 03:09:06 INFO - 2015-12-21 03:09:06,308 DEBUG : BROWSER_OUTPUT: Values: 2532.2 2641.7 2644.2 2656.8 2658.7 4261.9 4367.4 4485.7 4500.1 4502.5 4467.6 4482.9 4501.8 4522.4 4582.5 4152.0 4155.5 4162.7 4200.1 4215.1 4190.0 4260.9 4261.0 4263.4 4288.8 4015.2 4092.4 4112.4 4202.8 4208.4 4157.4 4164.5 4166.4 4172.8 4198.2 4136.9 4139.6 4144.1 4144.7 4184.6 4218.7 4263.1 4296.1 4391.2 4499.8 4781.0 4794.5 4810.0 4823.5 4862.4 4829.1 4829.3 4845.5 4846.3 4896.4 4277.0 4369.1 4370.7 4391.1 4494.3 4928.4 4935.4 4959.4 4960.7 4960.7 4762.2 4762.3 4770.4 4777.4 4803.3 4575.6 4709.6 4710.0 4734.0 4877.6 4743.9 4759.3 4768.9 4773.0 4814.6 4739.0 4746.3 4746.6 4748.3 4792.0 3867.6 3958.9 3964.1 3964.3 3968.8 3549.3 3568.3 3572.7 3578.4 3586.4 4172.6 4174.0 4179.8 4186.8 4210.1 4572.1 4670.8 4675.5 4698.9 4815.8 4126.4 4142.2 4157.4 4186.7 4188.5 4230.3 4238.5 4247.5 4266.5 4282.9 4332.3 4419.9 4508.2 4515.7 4520.1 4696.7 4783.0 4852.9 4869.8 4910.8 4571.9 4572.0 4573.8 4584.7 4616.4 4570.7 4692.7 4781.0 4783.3 4829.7 4714.1 4752.7 4798.9 4825.4 4859.8 4686.0 4693.2 4695.6 4696.2 4732.1 4499.9 4618.7 4686.7 4690.2 4723.8 4492.8 4521.0 4589.4 4590.3 4640.7 4695.9 4703.2 4708.2 4712.9 4749.9 4365.7 4464.2 4624.1 4640.2 4660.2 03:09:06 INFO - 2015-12-21 03:09:06,308 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,309 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38238.62 Median:31603.95 stddev:60603.13 (191.8%) stddev-sans-first:60706.96 03:09:06 INFO - 2015-12-21 03:09:06,309 DEBUG : BROWSER_OUTPUT: Values: 519.2 539.7 557.8 564.7 566.8 24380.8 34890.5 35597.3 35647.8 35755.3 38011.0 38394.2 38582.0 38713.0 38738.8 7000.4 7108.5 7822.1 7965.8 7989.9 9917.5 10207.9 10210.9 10222.6 10226.6 9690.0 9785.2 9785.5 9789.9 9793.5 7187.2 7374.7 9797.0 9879.1 10047.2 9717.1 9815.2 9857.4 9865.5 9868.3 35602.5 35938.0 35993.6 36149.8 36193.0 2750.9 2797.9 2812.9 2950.2 3228.2 27550.7 27585.4 27830.4 27897.0 28044.2 3381.4 3430.7 3442.3 3500.9 3508.5 206555.0 207306.0 207417.0 207518.0 208078.0 44565.6 52654.0 53015.5 53040.7 53048.2 44200.0 44500.6 44527.8 44588.6 55629.7 13636.0 13747.2 13843.7 13844.4 13857.9 10449.6 10635.8 10661.3 10680.6 10684.4 17492.3 17635.3 17651.2 18161.6 18439.8 7219.5 7278.2 7381.4 7493.5 7494.4 826.2 842.0 852.3 931.4 969.9 24749.5 26223.9 26393.2 26436.9 26468.6 904.5 971.3 1018.0 1059.1 1103.3 13031.7 13223.4 13323.2 13354.9 13403.3 255118.0 259235.0 260497.0 260696.0 260816.0 43042.4 43119.0 43203.6 43234.0 43362.1 1022.0 1048.1 1168.5 1198.8 1206.6 22822.8 23107.7 23544.6 23724.3 23788.3 32132.8 32388.8 32426.4 32434.2 35166.3 148834.3 241312.0 246665.0 247090.0 247997.0 24689.4 25167.5 25181.0 25186.7 25187.9 33818.3 34219.3 34332.8 34722.3 34795.1 30510.4 31591.8 32578.2 32882.0 33345.5 29172.9 30334.7 31758.7 31776.5 31958.4 30747.8 31515.5 31540.1 31565.7 31616.1 27127.0 28450.7 28811.7 28998.6 29066.6 22798.3 22925.4 22968.3 23017.8 23199.0 03:09:06 INFO - 2015-12-21 03:09:06,309 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,309 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27059.28 Median:2013.46 stddev:83820.27 (4163.0%) stddev-sans-first:84031.35 03:09:06 INFO - 2015-12-21 03:09:06,310 DEBUG : BROWSER_OUTPUT: Values: 311.0 311.6 317.9 318.6 320.5 15372.2 15666.0 15919.4 16284.7 16314.0 14397.4 14768.3 15140.0 15157.2 15162.9 4829.3 4966.8 4967.7 4968.5 4970.5 4807.8 4917.0 4953.8 4955.6 4962.6 3661.3 3759.7 3766.1 4932.6 4935.0 3764.1 3766.1 5498.0 5662.1 5700.1 4611.5 4784.7 4915.0 4922.7 4930.7 8948.9 10769.9 10907.1 10955.0 10978.8 1778.9 1826.5 1831.3 1903.8 2278.8 8277.7 8547.0 8612.7 8955.2 8976.8 1711.2 1738.4 1739.1 1754.6 1774.1 50270.5 52349.7 52580.0 52786.7 53921.5 9603.0 9606.6 9634.2 9643.4 9687.0 12076.7 12084.8 12099.7 12100.5 12118.4 7210.1 7228.0 7234.9 7249.6 7251.0 6951.7 7020.5 7024.4 7098.3 7125.8 4077.5 4088.3 4139.9 4143.3 4203.6 1695.4 1726.2 1746.3 1747.9 1762.5 353.9 356.2 365.6 842.5 842.7 9101.7 9136.6 9277.8 9474.4 9681.7 355.9 384.8 388.8 391.9 400.2 4782.9 5254.5 5277.4 5384.6 5396.8 496525.0 497783.0 514708.0 525110.0 529390.0 70261.3 74626.6 75024.6 75855.6 76269.0 1060.6 1063.8 1067.4 1090.2 1094.7 9377.9 9670.3 14261.3 14420.0 14428.9 32196.5 33091.5 33787.8 34207.3 36416.5 48318.8 49014.8 50050.7 50124.2 50317.0 13755.4 13998.2 14161.9 14320.9 14336.5 17403.1 17571.4 17572.5 17723.6 17889.7 14493.2 14531.4 14538.2 14951.3 14988.6 13810.2 14582.6 14629.0 14813.4 15080.8 14444.9 14469.1 14474.3 14940.9 15441.2 11049.9 13544.7 13549.1 13832.4 13882.7 11618.5 12131.9 14101.6 14462.2 15287.2 03:09:06 INFO - 2015-12-21 03:09:06,311 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,311 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4799.34 Median:5955.33 stddev:2471.00 (41.5%) stddev-sans-first:2464.91 03:09:06 INFO - 2015-12-21 03:09:06,312 DEBUG : BROWSER_OUTPUT: Values: 1424.0 1615.7 1675.0 1694.9 1736.8 5827.7 6620.5 6863.6 6913.4 6915.7 6676.5 6850.9 6991.9 7008.6 7017.0 2029.8 2059.6 2066.9 2067.3 2067.6 2056.6 2090.6 2093.5 2094.0 2094.9 2028.6 2036.2 2071.5 2074.1 2074.3 1999.8 2022.5 2023.9 2024.2 2026.0 1999.1 1999.5 2058.5 2061.5 2061.8 6858.7 6936.0 6940.7 6940.8 6967.7 3931.5 3993.6 4000.0 4004.9 4007.1 2689.9 2692.7 2724.4 2759.0 2775.0 917.7 923.9 926.1 952.1 953.0 9059.4 9066.4 9077.8 9088.0 9102.7 3660.4 3684.6 3721.7 3734.3 3743.0 7906.2 7914.1 7917.7 7920.3 7927.4 4060.4 4069.6 4086.9 4091.4 4093.9 3144.4 3225.7 3647.3 3712.1 3744.4 3330.4 3338.4 3370.3 3372.2 3390.4 1064.8 1083.7 1086.1 1093.4 1104.0 1128.8 1149.2 1150.6 1153.6 1181.8 6384.5 6512.5 6524.6 6530.5 6546.4 427.8 429.0 429.7 430.6 431.0 5196.2 5250.0 5251.2 5257.2 5261.3 8148.8 8162.2 8273.0 8319.1 8374.7 8159.2 8191.1 8234.9 8251.4 8260.2 6330.5 6449.4 6467.3 6520.3 6547.7 6243.4 6244.5 6250.4 6251.6 6255.1 7212.1 7384.1 7431.1 7438.7 7445.1 7473.4 7586.8 7644.8 7654.7 7665.6 5127.7 5283.7 6124.4 6173.8 6181.3 6408.6 6641.2 6694.3 6701.5 6704.1 5942.1 5977.4 6154.6 6156.1 6266.5 6192.4 6238.9 6288.9 6326.7 6367.0 6174.0 6183.9 6242.8 6244.4 6259.4 5543.1 5583.0 5583.8 5597.6 5608.4 5900.7 5932.7 5968.6 5977.4 5990.4 03:09:06 INFO - 2015-12-21 03:09:06,312 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,312 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4616.79 Median:5316.73 stddev:1371.54 (25.8%) stddev-sans-first:1336.27 03:09:06 INFO - 2015-12-21 03:09:06,314 DEBUG : BROWSER_OUTPUT: Values: 283.7 286.8 292.8 293.3 294.9 5179.6 5296.8 5374.1 5382.2 5392.0 5260.5 5316.5 5317.0 5325.7 5332.4 4094.4 4098.0 4100.1 4103.5 4107.8 3861.7 3923.4 3937.4 3987.9 4018.2 3953.4 3975.0 3977.7 3983.8 3989.1 3796.2 3914.6 3969.2 3980.6 3990.7 3470.2 3507.3 3511.6 3511.9 3528.7 5062.0 5102.3 5104.3 5112.4 5115.8 4640.4 4640.6 4649.2 4650.0 4650.2 5420.9 5530.8 5539.7 5548.4 5548.5 3918.7 3919.9 3919.9 3921.2 3927.5 5745.2 5833.0 5842.6 5848.5 5851.6 3968.9 3997.0 3999.1 4004.6 4008.6 4053.3 4053.4 4056.9 4057.9 4059.9 4521.3 4641.1 4647.1 4647.7 4653.5 5556.4 5564.3 5587.0 5588.1 5590.4 1418.3 1447.7 1448.7 1449.6 1449.8 969.5 974.1 978.4 1001.8 1004.4 4894.9 4914.7 4916.0 4916.6 4918.0 5782.3 5784.6 5791.5 5796.1 5797.2 4905.5 4920.0 4920.4 4922.8 4925.1 3006.5 3055.5 3099.8 3122.5 3127.6 5387.6 5425.6 5515.1 5518.1 5521.0 5949.1 5969.9 5972.2 5980.6 5985.0 5487.6 5501.2 5502.9 5505.2 5507.9 5641.3 5770.2 5842.8 5844.2 5876.5 5709.5 5710.7 5715.8 5725.1 5726.1 5504.7 5505.8 5513.4 5519.2 5526.4 3796.2 3920.5 3958.0 3958.7 3960.8 5721.2 5793.3 5794.6 5800.6 5804.0 5590.7 5593.9 5598.9 5601.0 5605.3 5593.5 5595.1 5601.8 5603.3 5606.6 5351.5 5463.6 5466.4 5473.1 5477.2 5605.7 5615.9 5618.6 5621.8 5630.2 5473.9 5483.5 5495.0 5496.7 5509.1 03:09:06 INFO - 2015-12-21 03:09:06,314 DEBUG : BROWSER_OUTPUT: 03:09:06 INFO - 2015-12-21 03:09:06,314 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11617.84 Median:454.31 stddev:13103.73 (2884.3%) stddev-sans-first:13114.60 03:09:06 INFO - 2015-12-21 03:09:06,314 DEBUG : BROWSER_OUTPUT: Values: 649.5 655.0 704.9 793.4 800.8 10705.7 10972.6 10993.1 10999.8 11023.6 10497.8 10537.9 10540.3 10550.2 10756.0 631.5 639.1 793.3 795.2 809.1 801.7 801.9 808.5 808.6 808.8 845.0 851.5 852.2 852.3 852.5 648.4 657.6 816.4 829.2 830.6 616.2 616.4 616.7 617.4 617.5 11031.6 11186.2 11191.7 11216.6 11347.1 10441.5 10722.0 10828.6 10916.7 10927.3 9368.7 9442.0 9471.6 9567.4 9633.9 3175.3 3182.3 3193.8 3215.4 3242.5 38531.2 38545.0 38591.8 39358.2 39495.4 7816.3 7867.8 8314.4 8319.2 8329.0 14696.3 14718.3 14745.4 14759.0 14767.3 6281.0 6378.8 6434.1 6467.3 6700.1 3301.7 3407.5 3459.2 3542.5 3577.0 2547.2 2584.4 2585.0 2585.4 2588.3 441.8 450.3 452.3 456.3 460.5 468.9 476.5 511.8 546.5 570.5 7081.9 7092.1 7262.6 7265.4 7496.9 463.3 505.2 529.5 550.2 561.7 3394.9 3595.7 3705.7 3756.0 3995.3 44271.0 47464.8 47479.1 47498.8 47782.8 40461.6 41734.8 41944.8 41983.8 42993.0 38260.0 38765.4 38779.8 39031.4 39272.8 6998.6 7667.1 7796.0 7811.5 7983.5 28946.7 29557.7 29599.6 29703.6 29830.7 35025.5 36705.1 39190.6 39395.6 39719.2 9824.9 9835.7 9949.6 10047.3 10290.6 10210.4 10355.3 10599.9 10836.3 11051.2 10170.2 10206.1 10258.4 10386.3 10621.0 10191.5 10244.1 10343.9 10392.3 10397.6 9555.6 9564.4 9599.0 9798.9 9982.8 8624.9 8799.2 8822.2 8864.9 9255.3 8166.8 8170.1 8221.3 8396.0 8836.9 03:09:06 INFO - 2015-12-21 03:09:06,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:09:06 INFO - 2015-12-21 03:09:06,314 DEBUG : BROWSER_OUTPUT: 03:09:07 INFO - 2015-12-21 03:09:07,067 INFO : Browser exited with error code: 0 03:09:07 INFO - 2015-12-21 03:09:07,088 INFO : Completed test dromaeo_css (00:18:36) 03:09:07 INFO - 2015-12-21 03:09:07,088 INFO : Starting test kraken 03:09:07 INFO - 2015-12-21 03:09:07,088 DEBUG : operating with platform_type : linux_ 03:09:07 INFO - 2015-12-21 03:09:07,088 INFO : Initialising browser for kraken test... 03:09:07 INFO - 2015-12-21 03:09:07,094 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVNetQ0/profile http://localhost:37206/getInfo.html 03:09:11 INFO - 2015-12-21 03:09:11,097 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 03:09:11 INFO - 2015-12-21 03:09:11,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:09:11 INFO - 2015-12-21 03:09:11,105 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:09:11 INFO - 2015-12-21 03:09:11,105 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:09:11 INFO - 2015-12-21 03:09:11,105 DEBUG : BROWSER_OUTPUT: __metrics 03:09:11 INFO - 2015-12-21 03:09:11,227 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:09:11 INFO - 2015-12-21 03:09:11,303 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:09:12 INFO - 2015-12-21 03:09:12,413 INFO : Browser initialized. 03:09:12 INFO - 2015-12-21 03:09:12,414 INFO : Running cycle 1/1 for kraken test... 03:09:12 INFO - 2015-12-21 03:09:12,414 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVNetQ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:09:24 INFO - 2015-12-21 03:09:24,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 150265856 03:09:24 INFO - 2015-12-21 03:09:24,349 DEBUG : BROWSER_OUTPUT: 03:09:26 INFO - 2015-12-21 03:09:26,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37206/tests/kraken/driver.html?testName=audio-beat-detection) 03:09:27 INFO - 2015-12-21 03:09:27,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 187785216 03:09:27 INFO - 2015-12-21 03:09:27,526 DEBUG : BROWSER_OUTPUT: 03:09:30 INFO - 2015-12-21 03:09:30,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37206/tests/kraken/driver.html?testName=audio-dft) 03:09:30 INFO - 2015-12-21 03:09:30,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 176599040 03:09:30 INFO - 2015-12-21 03:09:30,798 DEBUG : BROWSER_OUTPUT: 03:09:33 INFO - 2015-12-21 03:09:33,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37206/tests/kraken/driver.html?testName=audio-fft) 03:09:34 INFO - 2015-12-21 03:09:34,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 161484800 03:09:34 INFO - 2015-12-21 03:09:34,331 DEBUG : BROWSER_OUTPUT: 03:09:36 INFO - 2015-12-21 03:09:36,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37206/tests/kraken/driver.html?testName=audio-oscillator) 03:09:36 INFO - 2015-12-21 03:09:36,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 164007936 03:09:36 INFO - 2015-12-21 03:09:36,937 DEBUG : BROWSER_OUTPUT: 03:09:39 INFO - 2015-12-21 03:09:39,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37206/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:09:39 INFO - 2015-12-21 03:09:39,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 165920768 03:09:39 INFO - 2015-12-21 03:09:39,761 DEBUG : BROWSER_OUTPUT: 03:09:42 INFO - 2015-12-21 03:09:42,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37206/tests/kraken/driver.html?testName=imaging-darkroom) 03:09:43 INFO - 2015-12-21 03:09:43,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 164724736 03:09:43 INFO - 2015-12-21 03:09:43,320 DEBUG : BROWSER_OUTPUT: 03:09:46 INFO - 2015-12-21 03:09:46,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37206/tests/kraken/driver.html?testName=imaging-desaturate) 03:09:47 INFO - 2015-12-21 03:09:47,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 165351424 03:09:47 INFO - 2015-12-21 03:09:47,340 DEBUG : BROWSER_OUTPUT: 03:09:50 INFO - 2015-12-21 03:09:50,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37206/tests/kraken/driver.html?testName=json-parse-financial) 03:09:50 INFO - 2015-12-21 03:09:50,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 166785024 03:09:50 INFO - 2015-12-21 03:09:50,769 DEBUG : BROWSER_OUTPUT: 03:09:52 INFO - 2015-12-21 03:09:52,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37206/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:09:53 INFO - 2015-12-21 03:09:53,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 176615424 03:09:53 INFO - 2015-12-21 03:09:53,086 DEBUG : BROWSER_OUTPUT: 03:09:54 INFO - 2015-12-21 03:09:54,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:09:55 INFO - 2015-12-21 03:09:55,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 176140288 03:09:55 INFO - 2015-12-21 03:09:55,589 DEBUG : BROWSER_OUTPUT: 03:09:57 INFO - 2015-12-21 03:09:57,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:09:58 INFO - 2015-12-21 03:09:58,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 188436480 03:09:58 INFO - 2015-12-21 03:09:58,303 DEBUG : BROWSER_OUTPUT: 03:10:00 INFO - 2015-12-21 03:10:00,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:10:01 INFO - 2015-12-21 03:10:01,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 192667648 03:10:01 INFO - 2015-12-21 03:10:01,399 DEBUG : BROWSER_OUTPUT: 03:10:03 INFO - 2015-12-21 03:10:03,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:10:04 INFO - 2015-12-21 03:10:04,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 189693952 03:10:04 INFO - 2015-12-21 03:10:04,517 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37206/tests/kraken/driver.html?testName=ai-astar) 03:10:06 INFO - 2015-12-21 03:10:06,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 248045568 03:10:06 INFO - 2015-12-21 03:10:06,512 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,516 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:10:06 INFO - 2015-12-21 03:10:06,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:10:06 INFO - 2015-12-21 03:10:06,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:10:06 INFO - 2015-12-21 03:10:06,516 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:10:06 INFO - 2015-12-21 03:10:06,516 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;112;105;110;112;111;100;111;111;118 03:10:06 INFO - 2015-12-21 03:10:06,516 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;134;149;169;132;151;148;130;170;130 03:10:06 INFO - 2015-12-21 03:10:06,516 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;159;160;160;161;160;159;162;162;161 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;78;91;73;71;72;81;90;72 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;134;94;94;94;137;93;94;128 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;110;109;111 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;147;147;148;146;146;147 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;96;96;95;95 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;70;71;71;71;71;79;69;70 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;67;68;69;68;67;68;69 03:10:06 INFO - 2015-12-21 03:10:06,517 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;93;84;84;84;86;83;84;84 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;118;130;129;115;126;129;122;127;126 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;142;146;144;145;136;148;144;142;134 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;69;69;71;72;68;71;72;70 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,962 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:10:06 INFO - 2015-12-21 03:10:06,518 DEBUG : BROWSER_OUTPUT: __startTimestamp1450696206514__endTimestamp 03:10:06 INFO - 2015-12-21 03:10:06,519 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:4.81 (4.3%) stddev-sans-first:5.00 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: Values: 113.0 112.0 105.0 110.0 112.0 111.0 100.0 111.0 111.0 118.0 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:150.00 stddev:15.23 (10.2%) stddev-sans-first:15.79 03:10:06 INFO - 2015-12-21 03:10:06,522 DEBUG : BROWSER_OUTPUT: Values: 156.0 134.0 149.0 169.0 132.0 151.0 148.0 130.0 170.0 130.0 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: Values: 162.0 159.0 160.0 160.0 161.0 160.0 159.0 162.0 162.0 161.0 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.80 Median:78.00 stddev:7.48 (9.6%) stddev-sans-first:7.93 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 78.0 91.0 73.0 71.0 72.0 81.0 90.0 72.0 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.91 (20.1%) stddev-sans-first:19.57 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 134.0 94.0 94.0 94.0 137.0 93.0 94.0 128.0 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 111.0 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 03:10:06 INFO - 2015-12-21 03:10:06,523 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 147.0 147.0 148.0 146.0 146.0 147.0 03:10:06 INFO - 2015-12-21 03:10:06,524 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,524 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:10:06 INFO - 2015-12-21 03:10:06,524 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 03:10:06 INFO - 2015-12-21 03:10:06,524 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,524 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.00 stddev:2.79 (3.9%) stddev-sans-first:2.92 03:10:06 INFO - 2015-12-21 03:10:06,525 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 70.0 71.0 71.0 71.0 71.0 79.0 69.0 70.0 03:10:06 INFO - 2015-12-21 03:10:06,525 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,525 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 03:10:06 INFO - 2015-12-21 03:10:06,525 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 67.0 68.0 69.0 68.0 67.0 68.0 69.0 03:10:06 INFO - 2015-12-21 03:10:06,526 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,526 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:2.94 (3.5%) stddev-sans-first:3.12 03:10:06 INFO - 2015-12-21 03:10:06,526 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 93.0 84.0 84.0 84.0 86.0 83.0 84.0 84.0 03:10:06 INFO - 2015-12-21 03:10:06,526 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,526 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.50 stddev:4.95 (3.9%) stddev-sans-first:5.24 03:10:06 INFO - 2015-12-21 03:10:06,527 DEBUG : BROWSER_OUTPUT: Values: 125.0 118.0 130.0 129.0 115.0 126.0 129.0 122.0 127.0 126.0 03:10:06 INFO - 2015-12-21 03:10:06,527 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,527 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:144.00 stddev:5.23 (3.6%) stddev-sans-first:4.58 03:10:06 INFO - 2015-12-21 03:10:06,527 DEBUG : BROWSER_OUTPUT: Values: 133.0 142.0 146.0 144.0 145.0 136.0 148.0 144.0 142.0 134.0 03:10:06 INFO - 2015-12-21 03:10:06,528 DEBUG : BROWSER_OUTPUT: 03:10:06 INFO - 2015-12-21 03:10:06,528 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:71.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 03:10:06 INFO - 2015-12-21 03:10:06,528 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 69.0 69.0 71.0 72.0 68.0 71.0 72.0 70.0 03:10:06 INFO - 2015-12-21 03:10:06,528 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:10:06 INFO - 2015-12-21 03:10:06,528 DEBUG : BROWSER_OUTPUT: 03:10:07 INFO - 2015-12-21 03:10:07,467 INFO : Browser exited with error code: 0 03:10:07 INFO - 2015-12-21 03:10:07,517 INFO : Completed test kraken (00:01:00) 03:10:07 INFO - 2015-12-21 03:10:07,518 INFO : Starting test v8_7 03:10:07 INFO - 2015-12-21 03:10:07,518 DEBUG : operating with platform_type : linux_ 03:10:07 INFO - 2015-12-21 03:10:07,518 INFO : Initialising browser for v8_7 test... 03:10:07 INFO - 2015-12-21 03:10:07,524 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSeM6E/profile http://localhost:37206/getInfo.html 03:10:11 INFO - 2015-12-21 03:10:11,794 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 03:10:11 INFO - 2015-12-21 03:10:11,817 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:10:11 INFO - 2015-12-21 03:10:11,818 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:10:11 INFO - 2015-12-21 03:10:11,818 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:10:11 INFO - 2015-12-21 03:10:11,818 DEBUG : BROWSER_OUTPUT: __metrics 03:10:11 INFO - 2015-12-21 03:10:11,914 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:10:11 INFO - 2015-12-21 03:10:11,990 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:10:12 INFO - 2015-12-21 03:10:12,943 INFO : Browser initialized. 03:10:12 INFO - 2015-12-21 03:10:12,944 INFO : Running cycle 1/1 for v8_7 test... 03:10:12 INFO - 2015-12-21 03:10:12,944 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSeM6E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:10:24 INFO - 2015-12-21 03:10:24,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 150224896 03:10:24 INFO - 2015-12-21 03:10:24,819 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37206/tests/v8_7/run.html (next: http://localhost:37206/tests/v8_7/run.html) 03:10:46 INFO - 2015-12-21 03:10:46,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 448335872 03:10:46 INFO - 2015-12-21 03:10:46,503 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,504 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:10:46 INFO - 2015-12-21 03:10:46,504 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:10:46 INFO - 2015-12-21 03:10:46,504 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:10:46 INFO - 2015-12-21 03:10:46,505 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:10:46 INFO - 2015-12-21 03:10:46,505 DEBUG : BROWSER_OUTPUT: |0;Richards;166.14055490945339 03:10:46 INFO - 2015-12-21 03:10:46,505 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.93857965451056 03:10:46 INFO - 2015-12-21 03:10:46,505 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.2058906825262 03:10:46 INFO - 2015-12-21 03:10:46,505 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 03:10:46 INFO - 2015-12-21 03:10:46,505 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2014.0845070422536 03:10:46 INFO - 2015-12-21 03:10:46,505 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 03:10:46 INFO - 2015-12-21 03:10:46,506 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 03:10:46 INFO - 2015-12-21 03:10:46,506 DEBUG : BROWSER_OUTPUT: |7;RegExp;27486.486486486487 03:10:46 INFO - 2015-12-21 03:10:46,506 DEBUG : BROWSER_OUTPUT: |8;Splay;593.491124260355 03:10:46 INFO - 2015-12-21 03:10:46,506 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 03:10:46 INFO - 2015-12-21 03:10:46,506 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:10:46 INFO - 2015-12-21 03:10:46,506 DEBUG : BROWSER_OUTPUT: __startTimestamp1450696246503__endTimestamp 03:10:46 INFO - 2015-12-21 03:10:46,507 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,507 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:10:46 INFO - 2015-12-21 03:10:46,507 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:10:46 INFO - 2015-12-21 03:10:46,507 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,508 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,508 DEBUG : BROWSER_OUTPUT: Values: 166.1 03:10:46 INFO - 2015-12-21 03:10:46,508 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,508 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,508 DEBUG : BROWSER_OUTPUT: Values: 191.9 03:10:46 INFO - 2015-12-21 03:10:46,509 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,509 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.21 Median:283.21 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,509 DEBUG : BROWSER_OUTPUT: Values: 283.2 03:10:46 INFO - 2015-12-21 03:10:46,509 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,509 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,509 DEBUG : BROWSER_OUTPUT: Values: 5117.3 03:10:46 INFO - 2015-12-21 03:10:46,510 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,511 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,511 DEBUG : BROWSER_OUTPUT: Values: 2014.1 03:10:46 INFO - 2015-12-21 03:10:46,511 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,511 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,511 DEBUG : BROWSER_OUTPUT: Values: 796.8 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: Values: 12192.8 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27486.49 Median:27486.49 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: Values: 27486.5 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,512 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.49 Median:593.49 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,513 DEBUG : BROWSER_OUTPUT: Values: 593.5 03:10:46 INFO - 2015-12-21 03:10:46,513 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-21 03:10:46,513 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 03:10:46 INFO - 2015-12-21 03:10:46,513 DEBUG : BROWSER_OUTPUT: Values: 4830.9 03:10:46 INFO - 2015-12-21 03:10:46,513 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:10:46 INFO - 2015-12-21 03:10:46,513 DEBUG : BROWSER_OUTPUT: 03:10:47 INFO - 2015-12-21 03:10:47,439 INFO : Browser exited with error code: 0 03:10:47 INFO - 2015-12-21 03:10:47,453 INFO : Completed test v8_7 (00:00:39) 03:10:47 INFO - 2015-12-21 03:10:47,474 INFO : Completed test suite (00:20:16) 03:10:47 INFO - 2015-12-21 03:10:47,474 DEBUG : Working with test: dromaeo_css 03:10:47 INFO - 2015-12-21 03:10:47,474 DEBUG : Generating results file: dromaeo_css 03:10:47 INFO - 2015-12-21 03:10:47,475 DEBUG : Working with test: kraken 03:10:47 INFO - 2015-12-21 03:10:47,475 DEBUG : Generating results file: kraken 03:10:47 INFO - 2015-12-21 03:10:47,476 INFO : javascript benchmark 03:10:47 INFO - 2015-12-21 03:10:47,476 DEBUG : Working with test: v8_7 03:10:47 INFO - 2015-12-21 03:10:47,476 DEBUG : Generating results file: v8_7 03:10:47 INFO - 2015-12-21 03:10:47,476 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:10:47 INFO - 2015-12-21 03:10:47,644 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 03:10:47 INFO - 2015-12-21 03:10:47,644 DEBUG : process_Request line: dromaeo_css 6077.19 graph.html#tests=[[72,132,35]] 03:10:47 INFO - 2015-12-21 03:10:47,644 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:10:47 INFO - 2015-12-21 03:10:47,674 DEBUG : process_Request line: kraken 1513.60 graph.html#tests=[[232,132,35]] 03:10:47 INFO - 2015-12-21 03:10:47,674 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:10:47 INFO - 2015-12-21 03:10:47,796 DEBUG : process_Request line: v8_7 19685.62 graph.html#tests=[[230,132,35]] 03:10:47 INFO - 2015-12-21 03:10:47,797 INFO : javascript benchmark 03:10:47 INFO - 2015-12-21 03:10:47,801 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2532.164385752702, 2641.656584643996, 2644.246389778911, 2656.760891519764, 2658.720834312397, 4261.87214383569, 4367.4322338096, 4485.686001979859, 4500.054988452425, 4502.549745025496, 4467.575580319873, 4482.932756008654, 4501.774911254441, 4522.41208642876, 4582.450105987278, 4152.0, 4155.459790227282, 4162.666986641061, 4200.07598328368, 4215.051613386979, 4190.0, 4260.914781704364, 4260.998665313648, 4263.424437700917, 4288.849890253841, 4015.1568170684045, 4092.3656833190903, 4112.444819949328, 4202.810873510699, 4208.410822484854, 4157.355609880473, 4164.500259968793, 4166.354215096665, 4172.77049762263, 4198.160367926427, 4136.937945930814, 4139.606737359946, 4144.067584793427, 4144.730592511477, 4184.581541845821, 4218.6625069994325, 4263.104748002923, 4296.0548679290505, 4391.165678521071, 4499.797509112098, 4781.0, 4794.49657785931, 4809.951900480985, 4823.541763532458, 4862.36789217403, 4829.082474329866, 4829.348038014893, 4845.53967373099, 4846.321514987904, 4896.4124305083615, 4277.0, 4369.104333611602, 4370.672199585044, 4391.121775644884, 4494.325851122358, 4928.383952005999, 4935.358403407606, 4959.404871415381, 4960.677555958851, 4960.677555958923, 4762.214234651313, 4762.309465127537, 4770.427548694179, 4777.355057067321, 4803.327534145223, 4575.565321294472, 4709.646776491777, 4710.0, 4733.952660473351, 4877.585405240523, 4743.857684269477, 4759.309900064472, 4768.928466073012, 4772.976135119302, 4814.638902082358, 4738.976305118521, 4746.311784791186, 4746.596539294199, 4748.3114948332295, 4792.0, 3867.5939026402384, 3958.9208215835524, 3964.147708242684, 3964.266610677034, 3968.7817170055346, 3549.3256281306467, 3568.2506673598314, 3572.7499075065016, 3578.3737845876867, 3586.3544561979093, 4172.603602657803, 4174.0, 4179.791010449465, 4186.832526698959, 4210.073783767566, 4572.1312950539295, 4670.766461676971, 4675.485696573374, 4698.882527936829, 4815.783289751969, 4126.42230087788, 4142.212979533939, 4157.438745769343, 4186.665066794649, 4188.476440444944, 4230.344296634026, 4238.533761286256, 4247.49030116388, 4266.530681625019, 4282.914341713148, 4332.285172946428, 4419.933700994423, 4508.211063063951, 4515.729056256635, 4520.118576877478, 4696.74167920754, 4783.043391321819, 4852.8544143675745, 4869.829555965524, 4910.8281210157475, 4571.931421028754, 4572.017016341502, 4573.794179261875, 4584.679072464895, 4616.422947131608, 4570.702904311209, 4692.671512994058, 4780.95219047819, 4783.306420569068, 4829.73436460998, 4714.127886341038, 4752.667313288175, 4798.856034318976, 4825.420949486084, 4859.781309841136, 4686.039361930728, 4693.178693728652, 4695.600873925755, 4696.1546921554445, 4732.100900828831, 4499.910001800011, 4618.676692631483, 4686.695364801277, 4690.202665546797, 4723.787429565747, 4492.752898590609, 4520.954790452185, 4589.426321709786, 4590.334401511829, 4640.69835460694, 4695.906081878412, 4703.247480403119, 4708.176069187947, 4712.929306060343, 4749.9287510688055, 4365.694401391999, 4464.15181115587, 4624.1445332613575, 4640.1879671058105, 4660.184467718203], "unit": "score", "name": "dojo.html", "value": 4402.278929572903}, {"lowerIsBetter": false, "replicates": [519.2107995846316, 539.6734975339922, 557.8187089196011, 564.7486868343589, 566.8096996307754, 24380.75619243807, 34890.47664285038, 35597.2880542389, 35647.821760891224, 35755.2848943021, 38011.0, 38394.23211535774, 38582.0, 38713.0, 38738.8063059685, 7000.439964802829, 7108.466864985121, 7822.061352637691, 7965.800854978614, 7989.880151797728, 9917.454540000297, 10207.897921020769, 10210.897891021106, 10222.591096356175, 10226.590936362574, 9689.951550242275, 9785.168260697814, 9785.510724463784, 9789.902100979007, 9793.510324483746, 7187.209406965229, 7374.668139933716, 9796.951015244878, 9879.06148915852, 10047.196224302039, 9717.12545870875, 9815.165710914582, 9857.35927164732, 9865.457399843006, 9868.309218354718, 35602.465963010574, 35938.0, 35993.64006359929, 36149.81925090358, 36193.0, 2750.931226719348, 2797.9440411191867, 2812.943741125166, 2950.173951293641, 3228.2252259457796, 27550.724492755016, 27585.448291034267, 27830.443391132267, 27897.0, 28044.15867523957, 3381.442062059757, 3430.6569343065744, 3442.277121804399, 3500.9124771880906, 3508.5263489428858, 206555.0, 207306.0, 207417.0, 207518.0, 208078.0, 44565.55434445679, 52654.0, 53015.46984530183, 53040.73479632654, 53048.204276935874, 44200.0, 44500.55499444964, 44527.777361113636, 44588.55411445909, 55629.721851391296, 13636.0, 13747.175169489663, 13843.653908652162, 13844.377003034888, 13857.930710346585, 10449.582016719247, 10635.840462393071, 10661.307015043998, 10680.57277708883, 10684.358938463716, 17492.300307987793, 17635.29458821633, 17651.205695743723, 18161.636767264845, 18439.81560184408, 7219.458540609476, 7278.199398066208, 7381.409487241008, 7493.512921660074, 7494.362979146725, 826.2027143806256, 841.9957900210583, 852.3224036890563, 931.4318265857821, 969.9127078562822, 24749.505009900062, 26223.868880655857, 26393.208203753533, 26436.8678156608, 26468.60297095545, 904.5341649050744, 971.3491960386558, 1017.9643712470177, 1059.1262208677717, 1103.3159441146381, 13031.674208144872, 13223.404946777418, 13323.200607963554, 13354.866451335361, 13403.262820544964, 255118.0, 259235.0, 260497.0, 260696.0, 260816.0, 43042.35436468456, 43119.0, 43203.56796432058, 43234.0, 43362.132757344676, 1021.9591216351263, 1048.145761204631, 1168.485866218861, 1198.7782260281876, 1206.5776978057609, 22822.77177228273, 23107.65338519957, 23544.6468302979, 23724.28827135189, 23788.286351409486, 32132.83933580317, 32388.83805580957, 32426.35147297088, 32434.189145271557, 35166.296674066885, 148834.2558287245, 241312.0, 246665.0, 247090.0, 247997.0, 24689.382765430288, 25167.496650067264, 25181.0, 25186.74813251844, 25187.87406063031, 33818.29453643654, 34219.315613688086, 34332.82833585816, 34722.30555388929, 34795.130121746144, 30510.389792204474, 31591.84204078965, 32578.185545361557, 32882.0, 33345.49981750227, 29172.854135729187, 30334.69665303319, 31758.68241317557, 31776.523352150198, 31958.36083278368, 30747.846260768554, 31515.52726709147, 31540.11128275029, 31565.684343156274, 31616.051518454482, 27127.0, 28450.715492844807, 28811.711882880903, 28998.56502152427, 29066.564001540417, 22798.316050517846, 22925.42686432786, 22968.310950671508, 23017.76982230156, 23199.0], "unit": "score", "name": "ext.html", "value": 16394.202453734957}, {"lowerIsBetter": false, "replicates": [310.9766767492436, 311.6167114449227, 317.9427703013457, 318.56833989943624, 320.4856205789709, 15372.23219329776, 15666.0, 15919.442819501306, 16284.674306513893, 16314.0, 14397.352119154637, 14768.261586920664, 15140.0, 15157.242137893089, 15162.938594298375, 4829.251466022763, 4966.826161084363, 4967.652264341497, 4968.503149685039, 4970.453250142481, 4807.831725889595, 4917.041176970492, 4953.826616068421, 4955.6035517158725, 4962.578180854632, 3661.286049220403, 3759.661630453272, 3766.0961369271454, 4932.556069953704, 4934.950650493485, 3764.096616811959, 3766.0961369271313, 5498.0, 5662.065759149736, 5700.059490184115, 4611.4696809866955, 4784.6889952153, 4915.016996600659, 4922.680025798311, 4930.704157750511, 8948.8657670135, 10769.892301077045, 10907.072898803612, 10955.0, 10978.835317470244, 1778.8576913846862, 1826.497713128887, 1831.3407173417559, 1903.8381737552324, 2278.783515566035, 8277.710280140227, 8547.0, 8612.698555550525, 8955.238804701608, 8976.820463590757, 1711.212842092639, 1738.4263193146232, 1739.086979335846, 1754.6052138268915, 1774.1395423219728, 50270.497295026944, 52349.69125771848, 52580.0, 52786.73606631942, 53921.46078539204, 9603.0, 9606.615735370508, 9634.229261659051, 9643.421394716339, 9687.0, 12076.698082548006, 12084.818727719092, 12099.697507562205, 12100.455479503444, 12118.39408029595, 7210.134783825974, 7227.9638601806655, 7234.855302893912, 7249.601271930094, 7250.963745181346, 6951.6871740771785, 7020.508564400545, 7024.438044956391, 7098.290170982964, 7125.821854453577, 4077.4903137107863, 4088.325426304686, 4139.875803725893, 4143.316352801754, 4203.600657937491, 1695.3727120965075, 1726.1628110366462, 1746.2840235503636, 1747.8689098317677, 1762.524118488001, 353.8920629208116, 356.2145469240319, 365.6398447529182, 842.4945032980163, 842.7008412013647, 9101.726948191565, 9136.58885350161, 9277.768055798659, 9474.400830861146, 9681.66114186, 355.92347645256393, 384.7922122054059, 388.81531272645833, 391.85305510433585, 400.1816285695701, 4782.904341913142, 5254.474552544715, 5277.419483856849, 5384.623076384615, 5396.757145928443, 496525.0, 497783.0, 514708.0, 525110.0, 529390.0, 70261.2973870265, 74626.6268668664, 75024.62487687527, 75855.62072189603, 76269.0, 1060.6287799270194, 1063.813832579311, 1067.3649178738638, 1090.1714696830306, 1094.7208461842338, 9377.906220937975, 9670.323077384515, 14261.286935653383, 14420.0, 14428.927855360656, 32196.517052244704, 33091.50362744609, 33787.83106084454, 34207.315853683285, 36416.453753194255, 48318.758406207744, 49014.75492622514, 50050.74974625104, 50124.24813627725, 50317.0, 13755.38100785487, 13998.230097344744, 14161.858381416054, 14320.856791432368, 14336.498222562577, 17403.129843508028, 17571.385001524886, 17572.472825815246, 17723.556911077325, 17889.73165402546, 14493.173831103255, 14531.418743250151, 14538.200398978157, 14951.327190276681, 14988.550343489713, 13810.171389716648, 14582.635434113809, 14629.0, 14813.407463701331, 15080.773788393402, 14444.927775361477, 14469.131852088909, 14474.34865431037, 14940.925295373454, 15441.15073670959, 11049.889501104886, 13544.661383465493, 13549.119307244997, 13832.377543010387, 13882.722345553235, 11618.5352585899, 12131.939340303596, 14101.576952691436, 14462.20457874785, 15287.159206243763], "unit": "score", "name": "jquery.html", "value": 7837.274894798429}, {"lowerIsBetter": false, "replicates": [1423.9715205695893, 1615.7334039883417, 1675.0201132337586, 1694.9237284322212, 1736.7915850097982, 5827.70861456927, 6620.503462240333, 6863.622500762456, 6913.446924246061, 6915.654217289128, 6676.465882729382, 6850.862982740342, 6991.930080699191, 7008.61452620107, 7016.9649151754165, 2029.8173164415164, 2059.6292667319876, 2066.927657531987, 2067.2971189795467, 2067.5968186203695, 2056.629806634805, 2090.560982193741, 2093.5080256139872, 2094.0262777808316, 2094.9057292421876, 2028.6449871272468, 2036.1651722793658, 2071.513194399315, 2074.139232218635, 2074.294739788472, 1999.780024197337, 2022.524706693933, 2023.8684485508395, 2024.1599736109497, 2026.0, 1999.090413861704, 1999.5401057756796, 2058.5059585699473, 2061.4537147655883, 2061.80412860778, 6858.725650973955, 6936.0, 6940.6529673516125, 6940.826479338057, 6967.651617419108, 3931.4889064421727, 3993.6405723484736, 3999.960000399988, 4004.899877503057, 4007.0583412897945, 2689.946201075987, 2692.6903406108354, 2724.4006318609872, 2759.0, 2774.9722502774916, 917.7200953709116, 923.8845144356956, 926.0970553710146, 952.1383148250775, 953.0421925964431, 9059.365844390895, 9066.410683305565, 9077.818443631091, 9087.954560227223, 9102.68140615082, 3660.377735784923, 3684.613115622875, 3721.702263818888, 3734.3278209922473, 3742.9812850936114, 7906.248906353887, 7914.089879663798, 7917.722879699298, 7920.326772224425, 7927.4054445915635, 4060.3503439450137, 4069.6337329640473, 4086.8773936781945, 4091.4476545665952, 4093.8771836844944, 3144.3868445653334, 3225.74194064479, 3647.325244829715, 3712.090537818252, 3744.4196149596855, 3330.3505816365578, 3338.4324664806554, 3370.292238629866, 3372.224388390635, 3390.4405773047665, 1064.808334499782, 1083.685731137977, 1086.0768346905068, 1093.4314156638663, 1103.9558417663204, 1128.774245150973, 1149.2357582207737, 1150.5570355413226, 1153.6077733570626, 1181.787278289916, 6384.52116091295, 6512.479001679854, 6524.608523488606, 6530.477561795045, 6546.410823025951, 427.80534856640156, 428.97211681240617, 429.7099457865928, 430.62965849369516, 430.9547497512716, 5196.194589838581, 5249.973750131225, 5251.186066159751, 5257.158854583248, 5261.289725887033, 8148.796280092926, 8162.1837816219095, 8272.958635206905, 8319.126491718403, 8374.665013399517, 8159.224873636995, 8191.0580283267, 8234.876476852853, 8251.381146414044, 8260.215279548433, 6330.461910737639, 6449.355064493607, 6467.2562655294305, 6520.347965203442, 6547.738090476328, 6243.43809057187, 6244.531660125418, 6250.406211409909, 6251.624902505864, 6255.124282600531, 7212.098487689039, 7384.076990376203, 7431.145418276751, 7438.702451901863, 7445.069366329209, 7473.43949203801, 7586.772396828104, 7644.80887977805, 7654.655540500802, 7665.616719164131, 5127.66670166438, 5283.656562323436, 6124.418180272867, 6173.81478555644, 6181.3200547938795, 6408.551401401857, 6641.169853768279, 6694.29709880475, 6701.463882889455, 6704.094947182263, 5942.078977758454, 5977.432143946318, 6154.630722156506, 6156.1381406604005, 6266.498680105489, 6192.442680158807, 6238.937610623836, 6288.905666414916, 6326.6836658165985, 6366.9681651591445, 6173.950428427088, 6183.938160618336, 6242.750289988349, 6244.438000579969, 6259.405356491126, 5543.1408131739645, 5582.9720851397105, 5583.776648933997, 5597.580181486486, 5608.439156084359, 5900.675462849413, 5932.6737029462065, 5968.582199246011, 5977.402259773988, 5990.400959903975], "unit": "score", "name": "mootools.html", "value": 3910.740735204017}, {"lowerIsBetter": false, "replicates": [283.70778098558486, 286.7877770449868, 292.78041468898317, 293.30047835911347, 294.85257371314344, 5179.585633149349, 5296.841094767158, 5374.086405311096, 5382.219578161169, 5391.973040134794, 5260.526552610264, 5316.494932981361, 5316.9734151329285, 5325.680459172443, 5332.386775520817, 4094.3858421236905, 4098.0, 4100.077482566414, 4103.5280942691525, 4107.835686572534, 3861.7489863158944, 3923.3526468132723, 3937.3503371943593, 3987.9202415951663, 4018.1762738638654, 3953.4267531207956, 3975.0, 3977.6618987385964, 3983.760974341534, 3989.1423343981037, 3796.2027974125467, 3914.628110329543, 3969.24584328978, 3980.6019398060253, 3990.7206495545324, 3470.16715988161, 3507.298540291926, 3511.578610566723, 3511.877084302037, 3528.7177025838128, 5062.0, 5102.285680004802, 5104.310918026056, 5112.41207261166, 5115.769790359443, 4640.373549570832, 4640.582347588733, 4649.232876575395, 4649.95350046502, 4650.162970665279, 5420.91868621971, 5530.806421775219, 5539.695316757577, 5548.44515548446, 5548.500634942834, 3918.7060970427333, 3919.941200881989, 3919.941200881989, 3921.2353591049755, 3927.4894263745814, 5745.195672605839, 5832.95006898758, 5842.649441033552, 5848.532117430638, 5851.590388672837, 3968.900777480528, 3997.040710229524, 3999.1201935574127, 4004.5594984551676, 4008.6392224699916, 4053.250148722496, 4053.3717273822604, 4056.878293651136, 4057.9391309129796, 4059.878203653895, 4521.344405061248, 4641.094986477672, 4647.09381670571, 4647.697899636512, 4653.488116307203, 5556.444355564411, 5564.332280126329, 5586.972065139648, 5588.0779671354585, 5590.357108932525, 1418.2979425184599, 1447.7176950494763, 1448.7247422989599, 1449.6013596261112, 1449.811524501808, 969.5443141723379, 974.0940924939874, 978.3885071830106, 1001.759577701361, 1004.3772860826334, 4894.926576101361, 4914.70511769295, 4915.975420122948, 4916.631252655993, 4917.950820491821, 5782.335031471351, 5784.59507834456, 5791.536677065825, 5796.1305804129715, 5797.217375654317, 4905.460399356068, 4919.975400123048, 4920.434150072716, 4922.803087876445, 4925.088858561177, 3006.4738670732972, 3055.495843185894, 3099.767517436201, 3122.469180239365, 3127.6246850377647, 5387.568994480433, 5425.647332923348, 5515.145152501288, 5518.144687573433, 5521.0, 5949.137375080589, 5969.880602388015, 5972.193753843176, 5980.611260268069, 5985.042393217064, 5487.64330318528, 5501.202325662756, 5502.944970550323, 5505.174223866452, 5507.862303442446, 5641.323041235078, 5770.2498675171955, 5842.766289348378, 5844.240248767633, 5876.500497457764, 5709.54323654115, 5710.65736055838, 5715.771369145187, 5725.141228815711, 5726.112452569859, 5504.724763761876, 5505.807296744595, 5513.421090785409, 5519.227308176939, 5526.447355264602, 3796.2027974125745, 3920.5099362579676, 3958.0, 3958.663513601261, 3960.7821569812786, 5721.170430287501, 5793.304803423616, 5794.565407594363, 5800.622959507618, 5804.042333015005, 5590.748416321194, 5593.888122237451, 5598.86002849932, 5601.04782187021, 5605.299337582802, 5593.468620481048, 5595.132754423071, 5601.831945041656, 5603.271574695264, 5606.579506536945, 5351.491608297206, 5463.562914966714, 5466.4260252674485, 5473.0695781718, 5477.233187353694, 5605.747741351731, 5615.943840561542, 5618.550515958632, 5621.80323688669, 5630.155476678531, 5473.917891231715, 5483.4516548344845, 5494.9725251375085, 5496.6701997880255, 5509.090999984957], "unit": "score", "name": "prototype.html", "value": 4174.154614737959}, {"lowerIsBetter": false, "replicates": [649.5193556767994, 655.0, 704.8977898204761, 793.4485532554875, 800.7757827808214, 10705.678829635113, 10972.561097556088, 10993.0655894249, 10999.780004399907, 11023.61417350393, 10497.842532362021, 10537.947310263457, 10540.314879532825, 10550.155987520999, 10756.0, 631.4632562322013, 639.066962235135, 793.317746737805, 795.1769918134718, 809.1301850510695, 801.6512816924627, 801.8676918308502, 808.5431731071955, 808.6159074439623, 808.8220591469867, 845.0282175498165, 851.5103815306193, 852.1776485691306, 852.26705033671, 852.5311078906608, 648.3581254558001, 657.5955787190867, 816.4121832280748, 829.2412442615, 830.6469750356135, 616.2266355723539, 616.4390404731718, 616.6824085595922, 617.3517806303364, 617.4813156948185, 11031.61389351377, 11186.16103792219, 11191.720206994809, 11216.607418740386, 11347.148963827745, 10441.47792610374, 10722.0, 10828.620998265102, 10916.727081822939, 10927.344359338465, 9368.67209647659, 9441.952790236073, 9471.573779179953, 9567.37812042215, 9633.940266570671, 3175.25381535339, 3182.2839861031084, 3193.8243396613175, 3215.4051500472488, 3242.513622956552, 38531.229375412615, 38545.0, 38591.80704096489, 39358.21283574341, 39495.40756888649, 7816.335611473089, 7867.763967080997, 8314.376421768391, 8319.209675080858, 8329.0, 14696.338664759898, 14718.33767480466, 14745.41018359275, 14759.040662356912, 14767.335469903881, 6280.968595157086, 6378.776742814072, 6434.067060276234, 6467.288598254188, 6700.128983232246, 3301.653326400741, 3407.5399821023843, 3459.2043829919257, 3542.468629705513, 3576.9821150894077, 2547.2485616743106, 2584.3926677230834, 2584.987075064613, 2585.3536615846037, 2588.327034970921, 441.77027945468177, 450.2705616900642, 452.2853890852445, 456.3428662725664, 460.4957571459247, 468.94607120180933, 476.51395576511766, 511.836212412032, 546.5217934307481, 570.4523657289049, 7081.92918070823, 7092.148942126978, 7262.636868156676, 7265.382442492447, 7496.887546686804, 463.33974086925997, 505.2396143803552, 529.5315682281043, 550.1610044681812, 561.7472137538124, 3394.8642054318043, 3595.658412450813, 3705.6850167736043, 3756.0, 3995.260876737813, 44271.0, 47464.7626761864, 47479.05041899212, 47498.762506187246, 47782.76108619435, 40461.59538404637, 41734.791326043174, 41944.79027604842, 41983.790081049396, 42993.0, 38260.0, 38765.41851872224, 38779.80610096988, 39031.414528782094, 39272.80363598164, 6998.6150761708595, 7667.118281397487, 7796.0, 7811.531308121531, 7983.481073730189, 28946.7105328944, 29557.704422956354, 29599.556006660347, 29703.55444668375, 29830.70169298366, 35025.474617880245, 36705.08237294089, 39190.60809391984, 39395.606043939195, 39719.205615886945, 9824.852627210455, 9835.704928852147, 9949.552270147717, 10047.296689231976, 10290.639827605997, 10210.438425886647, 10355.275130741076, 10599.8940010602, 10836.295640783324, 11051.17116216271, 10170.186385089322, 10206.081452669296, 10258.43578603184, 10386.272960892666, 10621.0, 10191.541380638037, 10244.129249013618, 10343.896561034293, 10392.272540922062, 10397.58409663605, 9555.617775289189, 9564.426134431957, 9598.95200523993, 9798.902010979798, 9982.750431239278, 8624.870626940727, 8799.164079412702, 8822.161894620001, 8864.936207655122, 9255.25957923378, 8166.836663266583, 8170.142135075732, 8221.260086592236, 8396.0, 8836.911630883866], "unit": "score", "name": "yui.html", "value": 5455.215576697418}], "name": "dromaeo_css", "value": 6077.1946369732905}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 105.0, 110.0, 112.0, 111.0, 100.0, 111.0, 111.0, 118.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [156.0, 134.0, 149.0, 169.0, 132.0, 151.0, 148.0, 130.0, 170.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 160.0, 160.0, 161.0, 160.0, 159.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 78.0, 91.0, 73.0, 71.0, 72.0, 81.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 77.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 134.0, 94.0, 94.0, 94.0, 137.0, 93.0, 94.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 70.0, 71.0, 71.0, 71.0, 71.0, 79.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 93.0, 84.0, 84.0, 84.0, 86.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [125.0, 118.0, 130.0, 129.0, 115.0, 126.0, 129.0, 122.0, 127.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [133.0, 142.0, 146.0, 144.0, 145.0, 136.0, 148.0, 144.0, 142.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 69.0, 71.0, 72.0, 68.0, 71.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1513.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [283.2058906825262], "unit": "score", "name": "Encrypt", "value": 939.8851109999996}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [27486.486486486487], "unit": "score", "name": "RegExp", "value": 33.14301376597835}, {"lowerIsBetter": false, "replicates": [593.491124260355], "unit": "score", "name": "Splay", "value": 137.3078664007976}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19685.618449642294}]} 03:10:47 INFO - RETURN: dromaeo_css: 6077.19 03:10:47 INFO - RETURN: kraken: 1513.60 03:10:47 INFO - RETURN: v8_7: 19685.62 03:10:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19685.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1513.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6077.19"}}} 03:10:47 INFO - Return code: 0 03:10:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:10:47 INFO - # TBPL SUCCESS # 03:10:47 INFO - Running post-action listener: _resource_record_post_action 03:10:47 INFO - Running post-run listener: _resource_record_post_run 03:10:48 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553832448; Read time: 16; Write time: 689692 03:10:48 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234680320; Read time: 0; Write time: 396656 03:10:49 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319152128; Read time: 16; Write time: 293036 03:10:49 INFO - Running post-run listener: _upload_blobber_files 03:10:49 INFO - Blob upload gear active. 03:10:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:10:49 INFO - Copying logs to upload dir... 03:10:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.379135 ========= master_lag: 0.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-21 03:10:49.182979) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 03:10:49.189429) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009452 build_url: 'https://queue.taskcluster.net/v1/task/13scHWZuS1a4Dq5DRRRxeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 03:10:49.215557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 03:10:49.215912) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450694695.982384-786431528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 03:10:49.265309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 03:10:49.265685) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 03:10:49.269209) ========= ========= Total master_lag: 1.16 =========