builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1450694375.96 results: success (0) buildid: 20151221015828 builduid: 8a933936994c4903b214b308a96b8d10 revision: 3e3f7dd7190fe8e048994a7c90a494f19524f5eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:35.964510) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:35.964998) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:35.965308) ========= 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=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004877 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:35.986786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:35.987093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.002009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.002343) ========= 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=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.051266) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.051579) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.051953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.052228) ========= 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=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 02:39:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-12-21 02:39:36 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.264680) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.265010) ========= 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=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015577 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.314302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.314663) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e3f7dd7190fe8e048994a7c90a494f19524f5eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3e3f7dd7190fe8e048994a7c90a494f19524f5eb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 02:39:36,790 truncating revision to first 12 chars 2015-12-21 02:39:36,790 Setting DEBUG logging. 2015-12-21 02:39:36,790 attempt 1/10 2015-12-21 02:39:36,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e3f7dd7190f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 02:39:37,046 unpacking tar archive at: fx-team-3e3f7dd7190f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571498 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.901804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.902110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.909682) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.909936) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 02:39:36.910331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-21 02:39:36.910993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:39:37 INFO - MultiFileLogger online at 20151221 02:39:37 in /builds/slave/test 02:39:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:39:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:39:37 INFO - {'append_to_log': False, 02:39:37 INFO - 'base_work_dir': '/builds/slave/test', 02:39:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:39:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:39:37 INFO - 'branch': 'Fx-Team-Non-PGO', 02:39:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:39:37 INFO - 'config_files': ('talos/linux_config.py',), 02:39:37 INFO - 'default_actions': ('clobber', 02:39:37 INFO - 'read-buildbot-config', 02:39:37 INFO - 'download-and-extract', 02:39:37 INFO - 'populate-webroot', 02:39:37 INFO - 'create-virtualenv', 02:39:37 INFO - 'install', 02:39:37 INFO - 'run-tests'), 02:39:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:39:37 INFO - 'download_minidump_stackwalk': True, 02:39:37 INFO - 'download_symbols': 'ondemand', 02:39:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:39:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:39:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:39:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:39:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:39:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:39:37 INFO - 'installer_path': 'installer.exe', 02:39:37 INFO - 'log_level': 'info', 02:39:37 INFO - 'log_name': 'talos', 02:39:37 INFO - 'log_to_console': True, 02:39:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:39:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:39:37 INFO - 'opt_config_files': (), 02:39:37 INFO - 'pip_index': False, 02:39:37 INFO - 'sps_profile': False, 02:39:37 INFO - 'sps_profile_interval': 0, 02:39:37 INFO - 'suite': 'dromaeojs-e10s', 02:39:37 INFO - 'system_bits': '64', 02:39:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:39:37 INFO - 'title': 'talos-linux64-ix-028', 02:39:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:39:37 INFO - 'use_talos_json': True, 02:39:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:39:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:39:37 INFO - 'work_dir': 'build'} 02:39:37 INFO - ##### 02:39:37 INFO - ##### Running clobber step. 02:39:37 INFO - ##### 02:39:37 INFO - Running pre-action listener: _resource_record_pre_action 02:39:37 INFO - Running main action method: clobber 02:39:37 INFO - rmtree: /builds/slave/test/build 02:39:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:39:37 INFO - Running post-action listener: _resource_record_post_action 02:39:37 INFO - ##### 02:39:37 INFO - ##### Running read-buildbot-config step. 02:39:37 INFO - ##### 02:39:37 INFO - Running pre-action listener: _resource_record_pre_action 02:39:37 INFO - Running main action method: read_buildbot_config 02:39:37 INFO - Using buildbot properties: 02:39:37 INFO - { 02:39:37 INFO - "project": "", 02:39:37 INFO - "product": "firefox", 02:39:37 INFO - "script_repo_revision": "production", 02:39:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:39:37 INFO - "repository": "", 02:39:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:39:37 INFO - "buildid": "20151221015828", 02:39:37 INFO - "pgo_build": "False", 02:39:37 INFO - "basedir": "/builds/slave/test", 02:39:37 INFO - "buildnumber": 584, 02:39:37 INFO - "slavename": "talos-linux64-ix-028", 02:39:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:39:37 INFO - "platform": "ubuntu64_hw", 02:39:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:39:37 INFO - "branch": "fx-team", 02:39:37 INFO - "repo_path": "integration/fx-team", 02:39:37 INFO - "revision": "3e3f7dd7190fe8e048994a7c90a494f19524f5eb", 02:39:37 INFO - "stage_platform": "linux64", 02:39:37 INFO - "builduid": "8a933936994c4903b214b308a96b8d10", 02:39:37 INFO - "slavebuilddir": "test" 02:39:37 INFO - } 02:39:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:39:37 INFO - Running post-action listener: _resource_record_post_action 02:39:37 INFO - ##### 02:39:37 INFO - ##### Running download-and-extract step. 02:39:37 INFO - ##### 02:39:37 INFO - Running pre-action listener: _resource_record_pre_action 02:39:37 INFO - Running main action method: download_and_extract 02:39:37 INFO - mkdir: /builds/slave/test/build/tests 02:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:37 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:39:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json 02:39:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json 02:39:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:39:38 INFO - Downloaded 1302 bytes. 02:39:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:39:38 INFO - Using the following test package requirements: 02:39:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:39:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'jsshell-linux-x86_64.zip'], 02:39:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:39:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:39:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:39:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:39:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:39:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:38 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:39:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:39:42 INFO - Downloaded 21872076 bytes. 02:39:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:39:43 INFO - Return code: 0 02:39:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:43 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:39:45 INFO - Downloaded 21872076 bytes. 02:39: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:39:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39: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:39:46 INFO - Return code: 0 02:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:46 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:39:47 INFO - Downloaded 11132039 bytes. 02:39:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:39:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:39:47 INFO - Return code: 0 02:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:47 INFO - https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:39:50 INFO - Downloaded 53061442 bytes. 02:39:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:50 INFO - mkdir: /builds/slave/test/properties 02:39:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:50 INFO - Contents: 02:39:50 INFO - build_url:https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:50 INFO - Running post-action listener: _resource_record_post_action 02:39:50 INFO - Running post-action listener: set_extra_try_arguments 02:39:50 INFO - ##### 02:39:50 INFO - ##### Running populate-webroot step. 02:39:50 INFO - ##### 02:39:50 INFO - Running pre-action listener: _resource_record_pre_action 02:39:50 INFO - Running main action method: populate_webroot 02:39:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:50 INFO - '--tppagecycles', 02:39:50 INFO - '7'], 02:39:50 INFO - 'tests': ['tsvgm']}}, 02:39:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:39:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:39:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:39:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'tests': ['damp', 'tps']}, 02:39:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['damp', 'tps']}, 02:39:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:39:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:50 INFO - 'other': {'tests': ['a11yr', 02:39:50 INFO - 'ts_paint', 02:39:50 INFO - 'tpaint', 02:39:50 INFO - 'sessionrestore', 02:39:50 INFO - 'sessionrestore_no_auto_restore']}, 02:39:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['a11yr', 02:39:50 INFO - 'ts_paint', 02:39:50 INFO - 'tpaint', 02:39:50 INFO - 'sessionrestore', 02:39:50 INFO - 'sessionrestore_no_auto_restore']}, 02:39:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['a11yr', 02:39:50 INFO - 'ts_paint', 02:39:50 INFO - 'tpaint', 02:39:50 INFO - 'sessionrestore', 02:39:50 INFO - 'sessionrestore_no_auto_restore']}, 02:39:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['a11yr', 02:39:50 INFO - 'ts_paint', 02:39:50 INFO - 'tpaint', 02:39:50 INFO - 'sessionrestore', 02:39:50 INFO - 'sessionrestore_no_auto_restore']}, 02:39:50 INFO - 'other_l64': {'tests': ['a11yr', 02:39:50 INFO - 'ts_paint', 02:39:50 INFO - 'tpaint', 02:39:50 INFO - 'sessionrestore', 02:39:50 INFO - 'sessionrestore_no_auto_restore']}, 02:39:50 INFO - 'other_nol64': {'tests': ['a11yr', 02:39:50 INFO - 'ts_paint', 02:39:50 INFO - 'tpaint', 02:39:50 INFO - 'sessionrestore', 02:39:50 INFO - 'sessionrestore_no_auto_restore']}, 02:39:50 INFO - 'svgr': {'tests': ['tsvgx', 02:39:50 INFO - 'tsvgr_opacity', 02:39:50 INFO - 'tart', 02:39:50 INFO - 'tscrollx', 02:39:50 INFO - 'cart']}, 02:39:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['tsvgx', 02:39:50 INFO - 'tsvgr_opacity', 02:39:50 INFO - 'tart', 02:39:50 INFO - 'tscrollx', 02:39:50 INFO - 'cart']}, 02:39:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'tests': ['tp5o']}, 02:39:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'talos_options': ['--e10s'], 02:39:50 INFO - 'tests': ['tp5o']}, 02:39:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'talos_options': ['--xperf_path', 02:39:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:50 INFO - 'tests': ['tp5n']}, 02:39:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:50 INFO - 'talos_options': ['--e10s', 02:39:50 INFO - '--xperf_path', 02:39:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:50 INFO - 'tests': ['tp5n']}}, 02:39:50 INFO - 'talos.zip': {'path': '', 02:39:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:50 INFO - Running post-action listener: _resource_record_post_action 02:39:50 INFO - ##### 02:39:50 INFO - ##### Running create-virtualenv step. 02:39:50 INFO - ##### 02:39:50 INFO - Running pre-action listener: _resource_record_pre_action 02:39:50 INFO - Running main action method: create_virtualenv 02:39:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39: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:39:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:50 INFO - Using real prefix '/usr' 02:39:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:52 INFO - Installing pip.................done. 02:39:52 INFO - Return code: 0 02:39:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:52 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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:39:52 INFO - Using env: {'DISPLAY': ':0', 02:39:52 INFO - 'HOME': '/home/cltbld', 02:39:52 INFO - 'LANG': 'en_US.UTF-8', 02:39:52 INFO - 'LANGUAGE': 'en_US:en', 02:39:52 INFO - 'LOGNAME': 'cltbld', 02:39:52 INFO - 'MAIL': '/var/mail/cltbld', 02:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:52 INFO - 'MOZ_NO_REMOTE': '1', 02:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:52 INFO - 'NO_EM_RESTART': '1', 02:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:52 INFO - 'PWD': '/builds/slave/test', 02:39:52 INFO - 'SHELL': '/bin/bash', 02:39:52 INFO - 'SHLVL': '1', 02:39:52 INFO - 'TERM': 'linux', 02:39:52 INFO - 'TMOUT': '86400', 02:39:52 INFO - 'USER': 'cltbld', 02:39:52 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:52 INFO - '_': '/tools/buildbot/bin/python'} 02:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:39:52 INFO - Cleaning up... 02:39:52 INFO - Return code: 0 02:39:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:52 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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39: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:39: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:39:53 INFO - Using env: {'DISPLAY': ':0', 02:39:53 INFO - 'HOME': '/home/cltbld', 02:39:53 INFO - 'LANG': 'en_US.UTF-8', 02:39:53 INFO - 'LANGUAGE': 'en_US:en', 02:39:53 INFO - 'LOGNAME': 'cltbld', 02:39:53 INFO - 'MAIL': '/var/mail/cltbld', 02:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:53 INFO - 'MOZ_NO_REMOTE': '1', 02:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:53 INFO - 'NO_EM_RESTART': '1', 02:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:53 INFO - 'PWD': '/builds/slave/test', 02:39:53 INFO - 'SHELL': '/bin/bash', 02:39:53 INFO - 'SHLVL': '1', 02:39:53 INFO - 'TERM': 'linux', 02:39:53 INFO - 'TMOUT': '86400', 02:39:53 INFO - 'USER': 'cltbld', 02:39:53 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:53 INFO - '_': '/tools/buildbot/bin/python'} 02:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:53 INFO - Downloading/unpacking psutil>=0.7.1 02:39: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:39: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:39: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:39: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:39: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:39: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:39:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:39:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:54 INFO - Installing collected packages: psutil 02:39:54 INFO - Running setup.py install for psutil 02:39:55 INFO - building 'psutil._psutil_linux' extension 02:39: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:39: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:39:55 INFO - building 'psutil._psutil_posix' extension 02:39: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:39: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:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:55 INFO - Successfully installed psutil 02:39:55 INFO - Cleaning up... 02:39:55 INFO - Return code: 0 02:39:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:39: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:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39: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:39: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:39:55 INFO - Using env: {'DISPLAY': ':0', 02:39:55 INFO - 'HOME': '/home/cltbld', 02:39:55 INFO - 'LANG': 'en_US.UTF-8', 02:39:55 INFO - 'LANGUAGE': 'en_US:en', 02:39:55 INFO - 'LOGNAME': 'cltbld', 02:39:55 INFO - 'MAIL': '/var/mail/cltbld', 02:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:55 INFO - 'MOZ_NO_REMOTE': '1', 02:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:55 INFO - 'NO_EM_RESTART': '1', 02:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:55 INFO - 'PWD': '/builds/slave/test', 02:39:55 INFO - 'SHELL': '/bin/bash', 02:39:55 INFO - 'SHLVL': '1', 02:39:55 INFO - 'TERM': 'linux', 02:39:55 INFO - 'TMOUT': '86400', 02:39:55 INFO - 'USER': 'cltbld', 02:39:55 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:55 INFO - '_': '/tools/buildbot/bin/python'} 02:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:39: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:39: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:39: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:39: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:39: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:39: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:39:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:39:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39: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:39:57 INFO - Installing collected packages: mozsystemmonitor 02:39:57 INFO - Running setup.py install for mozsystemmonitor 02:39:57 INFO - Successfully installed mozsystemmonitor 02:39:57 INFO - Cleaning up... 02:39:57 INFO - Return code: 0 02:39:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39: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:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39: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:39: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:39:57 INFO - Using env: {'DISPLAY': ':0', 02:39:57 INFO - 'HOME': '/home/cltbld', 02:39:57 INFO - 'LANG': 'en_US.UTF-8', 02:39:57 INFO - 'LANGUAGE': 'en_US:en', 02:39:57 INFO - 'LOGNAME': 'cltbld', 02:39:57 INFO - 'MAIL': '/var/mail/cltbld', 02:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:57 INFO - 'MOZ_NO_REMOTE': '1', 02:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:57 INFO - 'NO_EM_RESTART': '1', 02:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:57 INFO - 'PWD': '/builds/slave/test', 02:39:57 INFO - 'SHELL': '/bin/bash', 02:39:57 INFO - 'SHLVL': '1', 02:39:57 INFO - 'TERM': 'linux', 02:39:57 INFO - 'TMOUT': '86400', 02:39:57 INFO - 'USER': 'cltbld', 02:39:57 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:57 INFO - '_': '/tools/buildbot/bin/python'} 02:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39: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:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:40:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:40: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:40: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:40: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:40: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:40: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:40: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:40:00 INFO - Downloading docopt-0.6.1.tar.gz 02:40: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:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:40:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:40:00 INFO - Running setup.py install for blobuploader 02:40:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:40:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:40:00 INFO - Running setup.py install for requests 02:40:00 INFO - Running setup.py install for docopt 02:40:00 INFO - Successfully installed blobuploader requests docopt 02:40:00 INFO - Cleaning up... 02:40:00 INFO - Return code: 0 02:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:00 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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:00 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:40:00 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:40:00 INFO - Using env: {'DISPLAY': ':0', 02:40:00 INFO - 'HOME': '/home/cltbld', 02:40:00 INFO - 'LANG': 'en_US.UTF-8', 02:40:00 INFO - 'LANGUAGE': 'en_US:en', 02:40:00 INFO - 'LOGNAME': 'cltbld', 02:40:00 INFO - 'MAIL': '/var/mail/cltbld', 02:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:00 INFO - 'MOZ_NO_REMOTE': '1', 02:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:00 INFO - 'NO_EM_RESTART': '1', 02:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:00 INFO - 'PWD': '/builds/slave/test', 02:40:00 INFO - 'SHELL': '/bin/bash', 02:40:00 INFO - 'SHLVL': '1', 02:40:00 INFO - 'TERM': 'linux', 02:40:00 INFO - 'TMOUT': '86400', 02:40:00 INFO - 'USER': 'cltbld', 02:40:00 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:00 INFO - '_': '/tools/buildbot/bin/python'} 02:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:01 INFO - Running setup.py (path:/tmp/pip-gpmdFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:01 INFO - Running setup.py (path:/tmp/pip-02udsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:01 INFO - Running setup.py (path:/tmp/pip-OPP8YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:01 INFO - Running setup.py (path:/tmp/pip-aChjLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:01 INFO - Running setup.py (path:/tmp/pip-s9hEVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:01 INFO - Running setup.py (path:/tmp/pip-hvGjou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:01 INFO - Running setup.py (path:/tmp/pip-TFOaPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:01 INFO - Running setup.py (path:/tmp/pip-AVxdpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:01 INFO - Running setup.py (path:/tmp/pip-UD7gjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:01 INFO - Running setup.py (path:/tmp/pip-6VAW7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:01 INFO - Running setup.py (path:/tmp/pip-573h_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:01 INFO - Running setup.py (path:/tmp/pip-fEQuUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:01 INFO - Running setup.py (path:/tmp/pip-0GpD7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:02 INFO - Running setup.py (path:/tmp/pip-hYbDSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:02 INFO - Running setup.py (path:/tmp/pip-6DYDc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:02 INFO - Running setup.py (path:/tmp/pip-q98bX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:02 INFO - Running setup.py (path:/tmp/pip-IqSJ_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:40:02 INFO - Running setup.py install for manifestparser 02:40:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for mozcrash 02:40:02 INFO - Running setup.py install for mozdebug 02:40:02 INFO - Running setup.py install for mozdevice 02:40:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for mozfile 02:40:02 INFO - Running setup.py install for mozhttpd 02:40:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for mozinfo 02:40:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:40:02 INFO - Running setup.py install for mozInstall 02:40:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Running setup.py install for mozleak 02:40:03 INFO - Running setup.py install for mozlog 02:40:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Running setup.py install for moznetwork 02:40:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Running setup.py install for mozprocess 02:40:03 INFO - Running setup.py install for mozprofile 02:40:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Running setup.py install for mozrunner 02:40:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Running setup.py install for mozscreenshot 02:40:03 INFO - Running setup.py install for moztest 02:40:03 INFO - Running setup.py install for mozversion 02:40:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:40:04 INFO - Cleaning up... 02:40:04 INFO - Return code: 0 02:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40: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:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40: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:40: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:40:04 INFO - Using env: {'DISPLAY': ':0', 02:40:04 INFO - 'HOME': '/home/cltbld', 02:40:04 INFO - 'LANG': 'en_US.UTF-8', 02:40:04 INFO - 'LANGUAGE': 'en_US:en', 02:40:04 INFO - 'LOGNAME': 'cltbld', 02:40:04 INFO - 'MAIL': '/var/mail/cltbld', 02:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:04 INFO - 'MOZ_NO_REMOTE': '1', 02:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:04 INFO - 'NO_EM_RESTART': '1', 02:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:04 INFO - 'PWD': '/builds/slave/test', 02:40:04 INFO - 'SHELL': '/bin/bash', 02:40:04 INFO - 'SHLVL': '1', 02:40:04 INFO - 'TERM': 'linux', 02:40:04 INFO - 'TMOUT': '86400', 02:40:04 INFO - 'USER': 'cltbld', 02:40:04 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:04 INFO - '_': '/tools/buildbot/bin/python'} 02:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:04 INFO - Running setup.py (path:/tmp/pip-CxLfD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40: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:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:04 INFO - Running setup.py (path:/tmp/pip-3mTVK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40: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:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:04 INFO - Running setup.py (path:/tmp/pip-UyDk5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40: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:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:04 INFO - Running setup.py (path:/tmp/pip-UuA0Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:04 INFO - Running setup.py (path:/tmp/pip-5LK5g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:04 INFO - Running setup.py (path:/tmp/pip-EwN5cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:04 INFO - Running setup.py (path:/tmp/pip-VyIpkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:04 INFO - Running setup.py (path:/tmp/pip-Swyqlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:04 INFO - Running setup.py (path:/tmp/pip-uQQ1LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:04 INFO - Running setup.py (path:/tmp/pip-AZiBvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:04 INFO - Running setup.py (path:/tmp/pip-I5VH0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40: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:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:05 INFO - Running setup.py (path:/tmp/pip-4MMqr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40: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:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:05 INFO - Running setup.py (path:/tmp/pip-4H5lBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40: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:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:05 INFO - Running setup.py (path:/tmp/pip-4r43pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40: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:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:05 INFO - Running setup.py (path:/tmp/pip-X7gDZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40: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:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:05 INFO - Running setup.py (path:/tmp/pip-qKR1zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40: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:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:05 INFO - Running setup.py (path:/tmp/pip-gLvtkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40: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:40: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:40: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:40: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:40: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:40: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:40:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40: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:40: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:40: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:40: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:40: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:40: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:40:07 INFO - Downloading blessings-1.5.1.tar.gz 02:40: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:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:40:07 INFO - Installing collected packages: blessings 02:40:07 INFO - Running setup.py install for blessings 02:40:07 INFO - Successfully installed blessings 02:40:07 INFO - Cleaning up... 02:40:07 INFO - Return code: 0 02:40:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:07 INFO - Reading from file tmpfile_stdout 02:40:07 INFO - Current package versions: 02:40:07 INFO - argparse == 1.2.1 02:40:07 INFO - blessings == 1.5.1 02:40:07 INFO - blobuploader == 1.2.4 02:40:07 INFO - docopt == 0.6.1 02:40:07 INFO - manifestparser == 1.1 02:40:07 INFO - mozInstall == 1.12 02:40:07 INFO - mozcrash == 0.16 02:40:07 INFO - mozdebug == 0.1 02:40:07 INFO - mozdevice == 0.47 02:40:07 INFO - mozfile == 1.2 02:40:07 INFO - mozhttpd == 0.7 02:40:07 INFO - mozinfo == 0.9 02:40:07 INFO - mozleak == 0.1 02:40:07 INFO - mozlog == 3.1 02:40:07 INFO - moznetwork == 0.27 02:40:07 INFO - mozprocess == 0.22 02:40:07 INFO - mozprofile == 0.27 02:40:07 INFO - mozrunner == 6.11 02:40:07 INFO - mozscreenshot == 0.1 02:40:07 INFO - mozsystemmonitor == 0.0 02:40:07 INFO - moztest == 0.7 02:40:07 INFO - mozversion == 1.4 02:40:07 INFO - psutil == 3.1.1 02:40:07 INFO - requests == 1.2.3 02:40:07 INFO - wsgiref == 0.1.2 02:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:07 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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:07 INFO - Using env: {'DISPLAY': ':0', 02:40:07 INFO - 'HOME': '/home/cltbld', 02:40:07 INFO - 'LANG': 'en_US.UTF-8', 02:40:07 INFO - 'LANGUAGE': 'en_US:en', 02:40:07 INFO - 'LOGNAME': 'cltbld', 02:40:07 INFO - 'MAIL': '/var/mail/cltbld', 02:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:07 INFO - 'MOZ_NO_REMOTE': '1', 02:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:07 INFO - 'NO_EM_RESTART': '1', 02:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:07 INFO - 'PWD': '/builds/slave/test', 02:40:07 INFO - 'SHELL': '/bin/bash', 02:40:07 INFO - 'SHLVL': '1', 02:40:07 INFO - 'TERM': 'linux', 02:40:07 INFO - 'TMOUT': '86400', 02:40:07 INFO - 'USER': 'cltbld', 02:40:07 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:07 INFO - '_': '/tools/buildbot/bin/python'} 02:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:07 INFO - Cleaning up... 02:40:07 INFO - Return code: 0 02:40:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:07 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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:40:07 INFO - Using env: {'DISPLAY': ':0', 02:40:07 INFO - 'HOME': '/home/cltbld', 02:40:07 INFO - 'LANG': 'en_US.UTF-8', 02:40:07 INFO - 'LANGUAGE': 'en_US:en', 02:40:07 INFO - 'LOGNAME': 'cltbld', 02:40:07 INFO - 'MAIL': '/var/mail/cltbld', 02:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:07 INFO - 'MOZ_NO_REMOTE': '1', 02:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:07 INFO - 'NO_EM_RESTART': '1', 02:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:07 INFO - 'PWD': '/builds/slave/test', 02:40:07 INFO - 'SHELL': '/bin/bash', 02:40:07 INFO - 'SHLVL': '1', 02:40:07 INFO - 'TERM': 'linux', 02:40:07 INFO - 'TMOUT': '86400', 02:40:07 INFO - 'USER': 'cltbld', 02:40:07 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:07 INFO - '_': '/tools/buildbot/bin/python'} 02:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:08 INFO - Downloading/unpacking jsonschema 02:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:40:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:40:09 INFO - Downloading/unpacking functools32 (from jsonschema) 02:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:09 INFO - Downloading functools32-3.2.3-2.tar.gz 02:40:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:40:09 INFO - warning: no files found matching '*.txt' 02:40:09 INFO - no previously-included directories found matching 'build' 02:40:09 INFO - no previously-included directories found matching 'dist' 02:40:09 INFO - no previously-included directories found matching '.git*' 02:40:09 INFO - Installing collected packages: jsonschema, functools32 02:40:10 INFO - Running setup.py install for functools32 02:40:10 INFO - warning: no files found matching '*.txt' 02:40:10 INFO - no previously-included directories found matching 'build' 02:40:10 INFO - no previously-included directories found matching 'dist' 02:40:10 INFO - no previously-included directories found matching '.git*' 02:40:10 INFO - Successfully installed jsonschema functools32 02:40:10 INFO - Cleaning up... 02:40:10 INFO - Return code: 0 02:40:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:40: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:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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 0x7f222e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, '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': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40: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:40: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:40:10 INFO - Using env: {'DISPLAY': ':0', 02:40:10 INFO - 'HOME': '/home/cltbld', 02:40:10 INFO - 'LANG': 'en_US.UTF-8', 02:40:10 INFO - 'LANGUAGE': 'en_US:en', 02:40:10 INFO - 'LOGNAME': 'cltbld', 02:40:10 INFO - 'MAIL': '/var/mail/cltbld', 02:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:10 INFO - 'MOZ_NO_REMOTE': '1', 02:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:10 INFO - 'NO_EM_RESTART': '1', 02:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:10 INFO - 'PWD': '/builds/slave/test', 02:40:10 INFO - 'SHELL': '/bin/bash', 02:40:10 INFO - 'SHLVL': '1', 02:40:10 INFO - 'TERM': 'linux', 02:40:10 INFO - 'TMOUT': '86400', 02:40:10 INFO - 'USER': 'cltbld', 02:40:10 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:10 INFO - '_': '/tools/buildbot/bin/python'} 02:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:10 INFO - Downloading/unpacking flake8 02:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:40: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:40:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:40: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:40: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:40: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:40: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:40: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:40: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:40:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:40: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:40:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:40: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:40: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:40: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:40: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:40: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:40: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:40: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:40:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:40: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:40: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:40: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:40: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:40: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:40: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:40:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:40:12 INFO - no previously-included directories found matching 'docs/_build' 02:40:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:40:12 INFO - Running setup.py install for pep8 02:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:40:12 INFO - no previously-included directories found matching 'docs/_build' 02:40:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:40:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:40:12 INFO - Cleaning up... 02:40:12 INFO - Return code: 0 02:40:12 INFO - Running post-action listener: _resource_record_post_action 02:40:12 INFO - Running post-action listener: _start_resource_monitoring 02:40:12 INFO - Starting resource monitoring. 02:40:12 INFO - ##### 02:40:12 INFO - ##### Running install step. 02:40:12 INFO - ##### 02:40:12 INFO - Running pre-action listener: _resource_record_pre_action 02:40:12 INFO - Running main action method: install 02:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:13 INFO - Reading from file tmpfile_stdout 02:40:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:40:13 INFO - Reading from file tmpfile_stdout 02:40:13 INFO - Output received: 02:40:13 INFO - Usage: mozinstall [options] installer 02:40:13 INFO - Options: 02:40:13 INFO - -h, --help show this help message and exit 02:40:13 INFO - -d DEST, --destination=DEST 02:40:13 INFO - Directory to install application into. [default: 02:40:13 INFO - "/builds/slave/test"] 02:40:13 INFO - --app=APP Application being installed. [default: firefox] 02:40:13 INFO - mkdir: /builds/slave/test/build/application 02:40: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:40: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:40:28 INFO - Reading from file tmpfile_stdout 02:40:28 INFO - Output received: 02:40:28 INFO - /builds/slave/test/build/application/firefox/firefox 02:40:28 INFO - Running post-action listener: _resource_record_post_action 02:40:28 INFO - ##### 02:40:28 INFO - ##### Running run-tests step. 02:40:28 INFO - ##### 02:40:28 INFO - Running pre-action listener: _resource_record_pre_action 02:40:28 INFO - Running main action method: run_tests 02:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:28 INFO - Python 2.7.3 02:40:28 INFO - Return code: 0 02:40:28 INFO - grabbing minidump binary from tooltool 02:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:28 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 0x29a90b0>, '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 0x29a9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:40:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:40:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:28 INFO - Return code: 0 02:40:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:40:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:40:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:40:29 INFO - Return code: 0 02:40:29 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test/build 02:40:29 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 02:40:29 INFO - Using env: {'DISPLAY': ':0', 02:40:29 INFO - 'HOME': '/home/cltbld', 02:40:29 INFO - 'LANG': 'en_US.UTF-8', 02:40:29 INFO - 'LANGUAGE': 'en_US:en', 02:40:29 INFO - 'LOGNAME': 'cltbld', 02:40:29 INFO - 'MAIL': '/var/mail/cltbld', 02:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:29 INFO - 'MOZ_NO_REMOTE': '1', 02:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:29 INFO - 'NO_EM_RESTART': '1', 02:40:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:29 INFO - 'PWD': '/builds/slave/test', 02:40:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:29 INFO - 'SHELL': '/bin/bash', 02:40:29 INFO - 'SHLVL': '1', 02:40:29 INFO - 'TERM': 'linux', 02:40:29 INFO - 'TMOUT': '86400', 02:40:29 INFO - 'USER': 'cltbld', 02:40:29 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758', 02:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:29 INFO - '_': '/tools/buildbot/bin/python'} 02:40:29 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 02:40:29 INFO - mozversion INFO | application_buildid: 20151221015828 02:40:29 INFO - mozversion INFO | application_changeset: 3e3f7dd7190fe8e048994a7c90a494f19524f5eb 02:40:29 INFO - mozversion INFO | application_display_name: Nightly 02:40:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:29 INFO - mozversion INFO | application_name: Firefox 02:40:29 INFO - mozversion INFO | application_remotingname: firefox 02:40:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:40:29 INFO - mozversion INFO | application_vendor: Mozilla 02:40:29 INFO - mozversion INFO | application_version: 46.0a1 02:40:29 INFO - mozversion INFO | platform_buildid: 20151221015828 02:40:29 INFO - mozversion INFO | platform_changeset: 3e3f7dd7190fe8e048994a7c90a494f19524f5eb 02:40:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:40:29 INFO - mozversion INFO | platform_version: 46.0a1 02:40:29 INFO - 2015-12-21 02:40:29,877 DEBUG : using testdate: 1450694429 02:40:29 INFO - 2015-12-21 02:40:29,878 DEBUG : actual date: 1450694429 02:40:29 INFO - 2015-12-21 02:40:29,886 INFO : starting webserver on 'localhost:49844' 02:40:29 INFO - 2015-12-21 02:40:29,887 INFO : Starting test suite talos-linux64-ix-028.e 02:40:29 INFO - 2015-12-21 02:40:29,887 INFO : Starting test dromaeo_css 02:40:29 INFO - 2015-12-21 02:40:29,887 DEBUG : operating with platform_type : linux_ 02:40:29 INFO - 2015-12-21 02:40:29,888 INFO : Initialising browser for dromaeo_css test... 02:40:29 INFO - 2015-12-21 02:40:29,897 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtfqd0/profile http://localhost:49844/getInfo.html 02:40:33 INFO - 2015-12-21 02:40:33,615 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:40:34 INFO - 2015-12-21 02:40:34,438 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:40:34 INFO - 2015-12-21 02:40:34,438 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:40:34 INFO - 2015-12-21 02:40:34,438 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:40:34 INFO - 2015-12-21 02:40:34,438 DEBUG : BROWSER_OUTPUT: __metrics 02:40:34 INFO - 2015-12-21 02:40:34,560 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:40:35 INFO - 2015-12-21 02:40:35,496 INFO : Browser initialized. 02:40:35 INFO - 2015-12-21 02:40:35,497 INFO : Running cycle 1/1 for dromaeo_css test... 02:40:35 INFO - 2015-12-21 02:40:35,497 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtfqd0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:40:47 INFO - 2015-12-21 02:40:47,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 150974464 02:40:47 INFO - 2015-12-21 02:40:47,452 DEBUG : BROWSER_OUTPUT: 02:41:37 INFO - 2015-12-21 02:41:37,072 DEBUG : BROWSER_OUTPUT: 1450694497071 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:43:48 INFO - 2015-12-21 02:43:48,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49844/tests/dromaeo/cssquery-ext.html) 02:43:50 INFO - 2015-12-21 02:43:50,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 153952256 02:43:50 INFO - 2015-12-21 02:43:50,035 DEBUG : BROWSER_OUTPUT: 02:46:52 INFO - 2015-12-21 02:46:52,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/dromaeo/cssquery-ext.html (next: http://localhost:49844/tests/dromaeo/cssquery-jquery.html) 02:46:52 INFO - 2015-12-21 02:46:52,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 152694784 02:46:52 INFO - 2015-12-21 02:46:52,771 DEBUG : BROWSER_OUTPUT: 02:49:54 INFO - 2015-12-21 02:49:54,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49844/tests/dromaeo/cssquery-mootools.html) 02:49:55 INFO - 2015-12-21 02:49:55,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 155111424 02:49:55 INFO - 2015-12-21 02:49:55,115 DEBUG : BROWSER_OUTPUT: 02:52:56 INFO - 2015-12-21 02:52:56,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49844/tests/dromaeo/cssquery-prototype.html) 02:52:57 INFO - 2015-12-21 02:52:57,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 152584192 02:52:57 INFO - 2015-12-21 02:52:57,429 DEBUG : BROWSER_OUTPUT: 02:56:00 INFO - 2015-12-21 02:56:00,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49844/tests/dromaeo/cssquery-yui.html) 02:56:00 INFO - 2015-12-21 02:56:00,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 151789568 02:56:00 INFO - 2015-12-21 02:56:00,633 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/dromaeo/cssquery-yui.html (next: http://localhost:49844/tests/dromaeo/cssquery-dojo.html) 02:59:03 INFO - 2015-12-21 02:59:03,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 155516928 02:59:03 INFO - 2015-12-21 02:59:03,458 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,459 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:59:03 INFO - 2015-12-21 02:59:03,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:59:03 INFO - 2015-12-21 02:59:03,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:59:03 INFO - 2015-12-21 02:59:03,460 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:59:03 INFO - 2015-12-21 02:59:03,462 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2633.1968749531393;2649.509840679473;2682.611021401897;2701.6082668013137;2703.9999999999995;4391.231534481469;4467.463904331476;4539.477960034597;4560.361549383089;4564.338170965208;4514.210013247685;4514.367988481607;4520.141173177094;4651.279051746977;4655.394798676176;4178.8328466861285;4267.466566679165;4330.740155590659;4331.177076355482;4370.71590346628;4289.056407590325;4301.892452688677;4301.956980430187;4333.826646934134;4379.540148284416;4096.3855421686685;4215.620594146541;4313.245182093121;4347.456567929009;4373.300271956487;4131.566185550504;4208.494980602347;4212.789360531961;4230.323148296288;4233.089885674564;4256.361545768129;4282.957170428287;4296.5273819879785;4328.4156638853665;4340.327249276367;4284.957150428487;4431.047324825178;4434.866953991385;4561.6806823522365;4590.770461476913;4737.360456338385;4779.80880764769;4780.378550788375;4794.400699912511;4865.41615006198;4928.063667903087;4976.502349765031;5014.824481143142;5024.723640199788;5038.168702164176;4383.254846676073;4619.769011549409;4641.605463535638;4645.117427688729;4706.811727530929;4827.493113223061;4909.7790599423115;4920.040592084581;4944.53026962438;4965.404151501771;4837.516248375205;4881.341018962466;4894.363732714724;4901.264810278487;4941.901161976741;4707.599854012447;4798.04039192163;4956.628252881048;4966.801327946914;4983.401991761012;4768.237082066922;4780.569748722632;4813.7593120343845;4832.202686556749;4862;4882.414110306715;4889.4377146627885;4889.535494128123;4914.0908931847725;4934.136526107916;3946.625070618287;4040.676745860383;4066.268071747055;4132.876013719593;4167.83328666856;3584.731145164123;3606.549181352331;3643.125649844071;3646.927061458809;3666.834992425347;4264.445622069111;4268.167707297047;4297.183535128315;4303;4319.524852266311;4715.292706094045;4865.440474345495;4894.583960363409;4951.579115775127;5027.597792176617;4248;4272.551382104896;4281.400603915455;4305.16049370376;4309.461317335333;4345.760983145958;4353.73877567347;4357.302831547001;4360.193364227628;4367.192069467159;4402.911941761083;4524.547545245581;4610.377599024089;4683.718976861399;4753.453352864465;4949.33184020167;4952;4966.975165124151;4978.900421991612;5022.221555658879;4663.650226232979;4683.906321873612;4695.389599352063;4699.154152252628;4742.478327384054;4584.266517357207;4694.389729335165;4763.618910487222;4856.587190088882;4890.388701412324;4911.656184067224;4927.630427717864;4929.112759703288;4934.18585933317;4969.503049695001;4572.588467037983;4796.592289655278;4797.832075877328;4798.424189097331;4842.757862106951;4658.743769092733;4806.158922188533;4889.339939108318;4897.216445368724;4922.015596880709;4674.6260299176665;4682.906341873211;4687.695299805502;4709.882252943704;4717.811287548459;4507.09858028389;4683.953160468488;4802.063597598435;4809.105904984061;4862.756862156949;4713.128071306819;4775.06886157196;4789.7605119743175;4794.161021821097;4843.24929635907 02:59:03 INFO - 2015-12-21 02:59:03,463 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.1289994059237;560.2548610348236;560.5347561523936;563.4365634365635;567.2653913182428;35258.647413525854;35895.82052089736;35991.460128098064;36042;36054.45918311224;39974;40367.798161009225;40597.797011014976;40623;40689;7764.417668674843;7900.881486777703;7960.442769006172;7979.880301795478;7987.440879138463;7758.573278469682;7921.485103468285;7924.08872979609;7928.365730741527;7931.722389716361;7916.881246781303;7932.960335198316;7985.441019128663;8003.359731221517;8035.799105022363;7874.251946065115;7938.563379014152;7952.244536768998;7974.12284648694;7978.481398709066;7817.765467035998;7877.921220787834;7949.483283586548;7962.442629015971;7967.681292748283;37080.62919370799;37552;37681.62318376836;37729;37849.243015139546;2959.0531030070388;2962.481565725989;2969.659133474841;3065.877364905401;3420.9144771380666;27838;27930.581041284397;28215.294617634518;28585.428291434262;28942.69757860901;3424.6232914379398;3447.345004449172;3495.860165593373;3526.7531272810916;3543.450765131409;203335;203628;203716;204484;205471;50662.746686266335;51831;52517.2122418164;52898.471015290124;53013.469865301624;64499;65122.674386628714;65463.34536654668;65876.6706166466;65930;13476.730465390834;13667;13696.589102326947;13763.243021633907;13853.930730346283;9901.752456188653;9963.202943764481;9964.750881228027;9967.80064398708;9968.950155249322;18889.244430222912;19130.904345478182;19144.425667230007;19182;19257.903710481638;6982.1272340957385;7210.206877243604;7337.3029562191505;7414.369778568775;7475.551466912003;849.0617867256716;938.648006997376;957.8515330123703;992.6426486464867;1023.9948800255951;25911.222663319753;26136.8693156533;26546;26814.463710725675;26976.460470790473;935.1957316707626;944.3531181140941;946.6639343033262;970.1995853420956;1027.6916924922493;12345.580258270415;12399.13206075566;12448.75102497945;12467.812982805266;12530.749385012248;197543;202718;202900;203312;203740;40463.19073618511;40927.795361023;40963.180736385104;41079.794601026806;41207.38188927169;1224.7489264700714;1232.617888454582;1232.8643849176583;1254.912156149079;1265.5507294910174;23400.76599234054;25751.227463176136;28338;28390.716092838808;28748;40572.79713601413;40768.79615601903;40791.388129177496;40894;40971.38542921799;190802;191260;191917;192082;192602.03698981417;28473.43053138967;28530.57204141981;28975.5653665191;29047.419051618428;29139.12582622525;33487.66512334943;33556;33570;34303.31393372069;34375.48436773501;31845;32503.349933000736;32572.185695357806;32910.83544582358;33031.33937321192;31447.371052579278;32250;32304.35391292114;32490;32509.187270317485;32511.349773003934;32523.674763252064;33099.50350744789;33609.49585756167;33629.495557566166;25630.743692562835;27252.45495090127;27465.862670686518;28689;29466;22934.197303094978;23030.884845575663;23082.42293942598;23162.420939475975;23285.3014409568 02:59:03 INFO - 2015-12-21 02:59:03,466 DEBUG : BROWSER_OUTPUT: |2;jquery.html;308.8656434451014;310.23062804245455;317.76802933858283;318.4554411955556;327.08742608123345;15021.39914403424;16038.59903502413;16363.509094727162;16596.419125330616;17243.655126897454;14667.413303467849;14676.55970320892;14714.484993025246;14756.557303280892;15009;4452.287633978564;4713;4715.528447155291;4715.952840471603;4720.433547974248;3788.677962373202;3804.0489877530617;3805.828737706796;3806.9340584636207;3816.8473261069526;3521.330947120039;3796.411556208778;3802.5627052888995;4415.646748260147;5309.920351194716;5221.6083793715625;5263.44733802949;5297.046531624325;5322.467753224685;5332.733363331838;4739.834105806281;4905.754712264373;4929.556339929423;5081.847544573632;5114.846554603368;11047.392393418359;11123.777524449466;11276.041536469409;11304.321740695585;11355.489002994886;1807.5268656045282;1836.0452564666432;1856.8700190986635;1869.2616416515536;1879.3234435603308;8782.429142105742;9437.386569872937;10165.948382622495;11854.644360669194;12170;1682.6382327799581;1683.6885176242433;1729.4119999200332;1788.2578729827237;1833.7157740550235;50905.490945090445;53125.73437132828;53318.73340633311;53796;55240.17139742867;9367.344285900057;9441.150296473214;9578.521073946275;9632.662856800118;9687.51562421876;11880.762384752257;11982;12026.037916966796;12034.879651203375;12036.157468977088;6565.737370505126;6601.768938087144;6652.83367915806;6701.463882889358;6748;6310.148130002391;6341.017142342944;6347.365263473708;6380.393862583047;6396.0725694774;4161.396597493407;4167.437395951508;4193.448424083048;4207.852725154666;4253.829846806155;1639.1312604319492;1673.2888522377941;1704.880658353928;1754.4210410564483;1757.1565648488797;377.98488060477274;381.8873432337467;408.2202992284722;817.1338381315825;871.6600525794945;9251.953740231256;9620.326577139673;9796.902030979742;9871.851922221173;10190.643327483502;394.43398722832825;400.91580768038455;409.68249606555156;411.93409054551125;433.3002201444707;5418.02475554404;5470;5525.944740552623;5532.778688852401;8930.374873758905;510212;512977;518637;522968;529763;68301.65849170822;71280;71653.2834671657;73566;73574;1042.4006196436928;1063.8670166229222;1068.0707784227773;1073.6403304892792;1077.932846481977;14104.980080677367;14505.637359065686;14573.781393279321;14591;14968;32628.83685581557;32764.79762420878;32913.506297406035;33100.66899331072;33888.491672624434;39857.60142398539;40391;42535;42626.14747705091;43338.349924750524;8376.748697539084;8477.745667629733;8850.468971861708;8891.866622000805;8924.509151996703;10181.440020798927;10195.949020255148;10209.285350025724;10272.537735802056;13174;13208.73582528325;13221.669458263235;13361.331933403097;13362.732745345233;13466.93266533661;12881.291528965998;13051.934740326238;13137.934310328386;13382.799258011333;13790.655233618838;12580.119391642496;12913.806292905801;12963.675908102374;13816.516421925586;14622.268886555843;8685.739427817176;8936.553172341486;8962.865557016781;9009.729708108767;9118.270538356783;2450.938726531851;11958.940205298917;13695.520656776966;14176.078554893898;14198.533564577505 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1507.7889095526634;1602.4311369463837;1657.121725485493;1669.2988944643248;1692.9068901210428;5972.9402705972925;6133.417325354084;6743.393094621483;7276.490645654806;7312.341889229968;6705.262421133683;6916.170059592843;6916.96541517293;6956.895646565293;6959.269276725934;2048.0988365119338;2063.040686080972;2070.6272870883236;2081.906314215864;2085.103405535619;2042.3770749921268;2044.427560283123;2092.9686054709114;2128.4998025464;2154.526004279056;2063.370671945056;2074.3362124120285;2083.6978638097467;2093.2568938026934;2095.5075557244036;2045.5602045560202;2069.5757369739244;2075.107703687414;2076.563921576471;2079.5632917087355;2054.3323419888447;2060.103854823157;2100.537881666031;2103.8106570408736;2121.130336562002;7008.299170083002;7119.608421536814;7123.536970096979;7124.893126603105;7126.3942564882045;4011.117554138085;4084.326086195774;4093.9590604093873;4094.7747873866924;4113.938290925638;2676.9196924092307;2705.648265725463;2740.1231605886123;2801.523740964021;2809.8314101153996;879.4503435352905;886.9733907982771;896.1083721696888;899.7840518275567;928.7445952363087;9398.483083430408;9476.668316608886;9490.098440648197;9492.050794920522;9510.048995100435;3818.809059547067;3826.8660596878976;3848.6728628066367;3894.1432884765304;3918.529776426847;8134.064582572962;8210.507369557845;8212.548309843016;8212.712555060543;8219.630116644765;4181.958180418218;4190.28765109932;4192.895177620584;4204.51648060477;4204.789760512023;3708.8145592720257;3784.394496880486;3798.9430158547643;3798.9810050950123;3823.2926908522013;3316.088075779132;3317;3332.950005749916;3346.983265083708;3373.763836531419;985.8761012445817;996.1084829077935;1002.6440613582073;1008.909198172168;1013.4274135113637;1140.1164097824087;1155.8035134027236;1161.5818305410046;1176.8823117688162;1186.145974898072;6701.597904125768;6710.328967103348;6719.193696756421;6734.124563806674;6740.292269311652;400.8436709683226;403.81020920167475;407.6555310762401;411.56374243302196;411.7796978616426;4966.726830024311;4968.329275547755;5021.447640759514;5023.09584274834;5025.14572522672;8406.117357677478;8432.45189062709;8511.148885111439;8534.70128545498;8583.484990900566;8484.957575212084;8518.23335899772;8531.10423405546;8549.401541892132;8555.786105347415;6250.312465628777;6596.571222870498;6629.303923088103;6631.469482441393;6642.568233064835;6785.864282714417;6815.284395138638;6852.349026842442;6858.5199036067;6893.517453778188;7531.661075251517;7681.231876812274;7698.538087714755;7718.729844455417;7742.070951485858;7604.80987975305;7857.449978501679;7888.526688398714;7928.682852686059;7952.085510166405;5116.616253780907;5289.603279754111;6393.456556192589;6447.097406363207;6500.674966251574;6413.743450261937;6537.640429776408;6574.309697481695;6575.473962083118;6586.736530538725;6119.877602448015;6267.2479302484;6314.589551679126;6370.968145159244;6380.521460890544;6137.386261374006;6279.215098112736;6298.307186209605;6328.335524769833;6364.872702546016;6265.49876009909;6349.365063493614;6352.142460767737;6374.362563743589;6384.45732112757;5811.389804070681;5818.6217895836635;5821.039528477923;5826.94173058264;5831.970840145772;5931.377205393372;5950.583459157818;5977.551683623833;6035.577509574463;6048.0625503047095 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.4468526826931;293.6094993658435;299.0013355392987;303.7190598696206;304.16506689138316;5474.343078830541;5530.474604912537;5554.055810512213;5584.050711379065;5711.942880571193;5538.806141785039;5565.332160140779;5571.0807716726795;5610.214569960199;5611.298587676541;4184.644305234059;4267.9573204267945;4298.957010429887;4310.956890431087;4313.849015284466;4286.249906266391;4287.506936702288;4291.420658211148;4328.264195086843;4329.069250111225;4302.612764851163;4305.24658184818;4306.590873866993;4312.5903039211225;4312.827486900536;4286.871393858158;4299.376590394391;4304.3113101903855;4306.117245964601;4316.266234740102;3792.374258247386;3792.6017768134225;3799.810009499514;3801.4297855321925;3810.371288737355;5293.588975434384;5343.091674415358;5410.91883621746;5413.729313534308;5414.40441551429;4970.080535101018;4972.651914365996;4976.850694479172;4978.6017118630425;4980.12847751642;5822.883542329172;5862.560307976876;5870;5870.20752198452;5873.588848780587;4119.505659320871;4119.752814831089;4121.773302468363;4125.938110928339;4126.360414135814;5978.910316345258;6099.298580663236;6179.073139029181;6187.257529096492;6190.845228869314;4066.9186616267507;4072.9185416291507;4076.429299897957;4090.550039495653;4097.282975479279;4125.773082480432;4139.648129908931;4156.314208155621;4160.438340824011;4162.729422587522;4810.037992401533;4821.035792841446;4821.5178482151505;4826.638002149783;4832.9850731346105;5679.687617181012;5847.766089356378;5861.9706901465215;5866.677332746654;5878.823635290948;1512.4781950227155;1518.2560545332708;1530.5331873778382;1532.0271627516606;1537.8846586506056;1014.9543270552842;1033.1682995188794;1040.7398150462384;1043.186314674555;1044.185535282481;5092.567131793765;5099.056674515226;5125.692458452505;5130.30740849988;5131.1277082895995;5939.168516407706;6079.574429789961;6096.329403765582;6114.724837382329;6114.908276375858;5133.871653208625;5145.434002259748;5153.0466863630345;5166.457521960216;5168.483151684876;3268.5587445695;3320.236345640516;3321.8671253150087;3322.2857085726687;3327.4010678077693;5629.493345598916;5760.423957604206;5765.682887441147;5765.827025189251;5774.451427114417;6278.591891527036;6288.088227207029;6316.399942005502;6327.525435592349;6341.968290158519;5746.13807928814;5748.396418376094;5751.367349591542;5753.367129615739;5764.250647415809;6105.816825495064;6108.816735497942;6115.510759139347;6143.109249158758;6165.537584681257;5873.706314684334;5949.940500595112;5988;6000.5799594028;6000.969995149996;5696;5709.800156994652;5732.627379220337;5746.597738158289;5751.769929202952;4097.4263603095;4128.793560322032;4147.771872547039;4150.8339666413;4153.91692166161;5977.22296101504;6129.509639228761;6129.601575897553;6132.78535251264;6137.7851775187655;5882.058870580687;5887.470127688529;5887.911681324698;5889.322727886348;5892.145638882424;5864.794732184353;5865.824025279248;5883.852903677443;5892.558058145571;5894.882102358015;5583.944160558505;5714.5999780015;5761.107028410435;5773.8556536086935;5781.4507621775865;5949.524038076857;5962.791302304398;5969.76120955157;5972.8805423892145;5984.640921544721;5788.0739081746715;5793.768249269982;5802.622829516068;5812.854678633068;5816.47651711348 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.4600704418854;687.6871023684224;746.9775906722798;783.2363445640505;811.030818172284;10986.560537578498;11159.888401115986;11270.4364781761;11311.321320720752;11328.943355283212;11635.825462618046;11768;12797.872021279785;12948.74102517949;12962.351882405865;753.7361923326832;777.8910952466659;784.8548018616546;786.626352482569;801.8035581282594;761.603965937712;786.8819677048431;794.876794096913;796.4982061301372;800.2157885272436;826.4669288309037;832.6253186066264;833.9708110216144;836.8953880764905;838.8154605986673;821.2649678537736;822.9629666664985;825.3685930263354;825.7275099217273;828.825946551225;615.4061330815784;616.2389449030444;618.0790621973227;618.5979113576167;618.6411881108946;11300.378479183642;11433.771324573545;11469;11474.311541307465;11482.712932176679;10290.7427314317;10413.739656508573;10454.215933804995;10769.246152769309;11160.832587511193;8911.19799218067;9102.86345704815;9124.771880703036;9154.633814647406;9497.952510237474;3034.6965303469697;3130.280035591804;3159.0651867442302;3163.31988622445;3176.09481297829;39371.40942885859;39880.40179397311;40303.59696403057;40364.79817600922;40473.79763101195;9072.591733372014;9220.262379009662;9225.72322830316;9259.166674999147;9600.855987160197;14451.638709032148;14622.122672639676;14653.340599672827;14682.63293417673;14717.779233311509;6261.812145635638;6278.968605156945;6419.711112999927;6536.901946470807;6662.900056499157;3376.6623337666038;3467.1852114753015;3475.8088305142956;3486.459598762196;3530.947035794465;2492.0654754467073;2528.9114880979077;2530.949655892821;2531.632913227572;2538.352720056411;465.6763549333249;468.4425533614987;469.59614731331027;472.8581425572315;473.36096270035176;524.0574176001722;555.849920521457;559.720139930035;561.3740679142808;563.4647085269011;6669.199696036507;6678.799636010927;6878.518503704692;6921.411680007256;6971.128608923885;508.509288536564;517.3920643244173;533.8558589180977;538.2249560632677;544.3576579636067;3096.4735994880925;3118.204857761302;3153.81077135368;3165.034664427326;3197.4724170512072;48376;48646.75676621594;49028.509714903106;51404.20085297072;52529.474705253226;42596;43357.349639755426;43889.12221755547;43930.12139757187;44119.33820992688;40341.193176136316;40352.39471407873;40768;41583.58416415858;42054.789726051786;7414.22150674193;7514.924850751641;7643.159252482334;7766.728164514215;8132.6746930122135;31030.844845775628;31165;31295.530567041056;31316.06051818449;31364.215894602818;39780;40059;40428.59571404248;40441.39337909993;40659;9775.169110625677;9853.113219810251;9857.556409961426;9917.950410248191;9921.950390248003;10869.347839129678;10903.890961090288;10944.671659849899;11158.721031974266;11504.309741415542;10460.79078418412;10547.789044219226;10561.735956601147;10703.411312377582;10997.230193886351;10230.590776368861;10446.268761186948;10689.9465502672;10841.024307812335;10859.07697845692;10035.648752293635;10237.795244095225;10383.896161038292;10423.895761042595;10640.627578034731;9112.453252804587;9278.396904201205;9330.25588761313;9379.613757295116;9518;8729.650813967624;8757.255633271243;8823.294136469196;8826.955865220632;9241.445513269226 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:59:03 INFO - 2015-12-21 02:59:03,470 DEBUG : BROWSER_OUTPUT: __startTimestamp1450695543458__endTimestamp 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4535.63 Median:4674.63 stddev:457.53 (9.8%) stddev-sans-first:433.91 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: Values: 2633.2 2649.5 2682.6 2701.6 2704.0 4391.2 4467.5 4539.5 4560.4 4564.3 4514.2 4514.4 4520.1 4651.3 4655.4 4178.8 4267.5 4330.7 4331.2 4370.7 4289.1 4301.9 4302.0 4333.8 4379.5 4096.4 4215.6 4313.2 4347.5 4373.3 4131.6 4208.5 4212.8 4230.3 4233.1 4256.4 4283.0 4296.5 4328.4 4340.3 4285.0 4431.0 4434.9 4561.7 4590.8 4737.4 4779.8 4780.4 4794.4 4865.4 4928.1 4976.5 5014.8 5024.7 5038.2 4383.3 4619.8 4641.6 4645.1 4706.8 4827.5 4909.8 4920.0 4944.5 4965.4 4837.5 4881.3 4894.4 4901.3 4941.9 4707.6 4798.0 4956.6 4966.8 4983.4 4768.2 4780.6 4813.8 4832.2 4862.0 4882.4 4889.4 4889.5 4914.1 4934.1 3946.6 4040.7 4066.3 4132.9 4167.8 3584.7 3606.5 3643.1 3646.9 3666.8 4264.4 4268.2 4297.2 4303.0 4319.5 4715.3 4865.4 4894.6 4951.6 5027.6 4248.0 4272.6 4281.4 4305.2 4309.5 4345.8 4353.7 4357.3 4360.2 4367.2 4402.9 4524.5 4610.4 4683.7 4753.5 4949.3 4952.0 4967.0 4978.9 5022.2 4663.7 4683.9 4695.4 4699.2 4742.5 4584.3 4694.4 4763.6 4856.6 4890.4 4911.7 4927.6 4929.1 4934.2 4969.5 4572.6 4796.6 4797.8 4798.4 4842.8 4658.7 4806.2 4889.3 4897.2 4922.0 4674.6 4682.9 4687.7 4709.9 4717.8 4507.1 4684.0 4802.1 4809.1 4862.8 4713.1 4775.1 4789.8 4794.2 4843.2 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,471 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36570.34 Median:18863.97 stddev:51699.31 (274.1%) stddev-sans-first:51773.63 02:59:03 INFO - 2015-12-21 02:59:03,472 DEBUG : BROWSER_OUTPUT: Values: 560.1 560.3 560.5 563.4 567.3 35258.6 35895.8 35991.5 36042.0 36054.5 39974.0 40367.8 40597.8 40623.0 40689.0 7764.4 7900.9 7960.4 7979.9 7987.4 7758.6 7921.5 7924.1 7928.4 7931.7 7916.9 7933.0 7985.4 8003.4 8035.8 7874.3 7938.6 7952.2 7974.1 7978.5 7817.8 7877.9 7949.5 7962.4 7967.7 37080.6 37552.0 37681.6 37729.0 37849.2 2959.1 2962.5 2969.7 3065.9 3420.9 27838.0 27930.6 28215.3 28585.4 28942.7 3424.6 3447.3 3495.9 3526.8 3543.5 203335.0 203628.0 203716.0 204484.0 205471.0 50662.7 51831.0 52517.2 52898.5 53013.5 64499.0 65122.7 65463.3 65876.7 65930.0 13476.7 13667.0 13696.6 13763.2 13853.9 9901.8 9963.2 9964.8 9967.8 9969.0 18889.2 19130.9 19144.4 19182.0 19257.9 6982.1 7210.2 7337.3 7414.4 7475.6 849.1 938.6 957.9 992.6 1024.0 25911.2 26136.9 26546.0 26814.5 26976.5 935.2 944.4 946.7 970.2 1027.7 12345.6 12399.1 12448.8 12467.8 12530.7 197543.0 202718.0 202900.0 203312.0 203740.0 40463.2 40927.8 40963.2 41079.8 41207.4 1224.7 1232.6 1232.9 1254.9 1265.6 23400.8 25751.2 28338.0 28390.7 28748.0 40572.8 40768.8 40791.4 40894.0 40971.4 190802.0 191260.0 191917.0 192082.0 192602.0 28473.4 28530.6 28975.6 29047.4 29139.1 33487.7 33556.0 33570.0 34303.3 34375.5 31845.0 32503.3 32572.2 32910.8 33031.3 31447.4 32250.0 32304.4 32490.0 32509.2 32511.3 32523.7 33099.5 33609.5 33629.5 25630.7 27252.5 27465.9 28689.0 29466.0 22934.2 23030.9 23082.4 23162.4 23285.3 02:59:03 INFO - 2015-12-21 02:59:03,472 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,472 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26412.40 Median:3806.38 stddev:84810.00 (2228.1%) stddev-sans-first:85025.27 02:59:03 INFO - 2015-12-21 02:59:03,473 DEBUG : BROWSER_OUTPUT: Values: 308.9 310.2 317.8 318.5 327.1 15021.4 16038.6 16363.5 16596.4 17243.7 14667.4 14676.6 14714.5 14756.6 15009.0 4452.3 4713.0 4715.5 4716.0 4720.4 3788.7 3804.0 3805.8 3806.9 3816.8 3521.3 3796.4 3802.6 4415.6 5309.9 5221.6 5263.4 5297.0 5322.5 5332.7 4739.8 4905.8 4929.6 5081.8 5114.8 11047.4 11123.8 11276.0 11304.3 11355.5 1807.5 1836.0 1856.9 1869.3 1879.3 8782.4 9437.4 10165.9 11854.6 12170.0 1682.6 1683.7 1729.4 1788.3 1833.7 50905.5 53125.7 53318.7 53796.0 55240.2 9367.3 9441.2 9578.5 9632.7 9687.5 11880.8 11982.0 12026.0 12034.9 12036.2 6565.7 6601.8 6652.8 6701.5 6748.0 6310.1 6341.0 6347.4 6380.4 6396.1 4161.4 4167.4 4193.4 4207.9 4253.8 1639.1 1673.3 1704.9 1754.4 1757.2 378.0 381.9 408.2 817.1 871.7 9252.0 9620.3 9796.9 9871.9 10190.6 394.4 400.9 409.7 411.9 433.3 5418.0 5470.0 5525.9 5532.8 8930.4 510212.0 512977.0 518637.0 522968.0 529763.0 68301.7 71280.0 71653.3 73566.0 73574.0 1042.4 1063.9 1068.1 1073.6 1077.9 14105.0 14505.6 14573.8 14591.0 14968.0 32628.8 32764.8 32913.5 33100.7 33888.5 39857.6 40391.0 42535.0 42626.1 43338.3 8376.7 8477.7 8850.5 8891.9 8924.5 10181.4 10195.9 10209.3 10272.5 13174.0 13208.7 13221.7 13361.3 13362.7 13466.9 12881.3 13051.9 13137.9 13382.8 13790.7 12580.1 12913.8 12963.7 13816.5 14622.3 8685.7 8936.6 8962.9 9009.7 9118.3 2450.9 11958.9 13695.5 14176.1 14198.5 02:59:03 INFO - 2015-12-21 02:59:03,473 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,473 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4908.96 Median:6083.97 stddev:2562.12 (42.1%) stddev-sans-first:2556.56 02:59:03 INFO - 2015-12-21 02:59:03,474 DEBUG : BROWSER_OUTPUT: Values: 1507.8 1602.4 1657.1 1669.3 1692.9 5972.9 6133.4 6743.4 7276.5 7312.3 6705.3 6916.2 6917.0 6956.9 6959.3 2048.1 2063.0 2070.6 2081.9 2085.1 2042.4 2044.4 2093.0 2128.5 2154.5 2063.4 2074.3 2083.7 2093.3 2095.5 2045.6 2069.6 2075.1 2076.6 2079.6 2054.3 2060.1 2100.5 2103.8 2121.1 7008.3 7119.6 7123.5 7124.9 7126.4 4011.1 4084.3 4094.0 4094.8 4113.9 2676.9 2705.6 2740.1 2801.5 2809.8 879.5 887.0 896.1 899.8 928.7 9398.5 9476.7 9490.1 9492.1 9510.0 3818.8 3826.9 3848.7 3894.1 3918.5 8134.1 8210.5 8212.5 8212.7 8219.6 4182.0 4190.3 4192.9 4204.5 4204.8 3708.8 3784.4 3798.9 3799.0 3823.3 3316.1 3317.0 3333.0 3347.0 3373.8 985.9 996.1 1002.6 1008.9 1013.4 1140.1 1155.8 1161.6 1176.9 1186.1 6701.6 6710.3 6719.2 6734.1 6740.3 400.8 403.8 407.7 411.6 411.8 4966.7 4968.3 5021.4 5023.1 5025.1 8406.1 8432.5 8511.1 8534.7 8583.5 8485.0 8518.2 8531.1 8549.4 8555.8 6250.3 6596.6 6629.3 6631.5 6642.6 6785.9 6815.3 6852.3 6858.5 6893.5 7531.7 7681.2 7698.5 7718.7 7742.1 7604.8 7857.4 7888.5 7928.7 7952.1 5116.6 5289.6 6393.5 6447.1 6500.7 6413.7 6537.6 6574.3 6575.5 6586.7 6119.9 6267.2 6314.6 6371.0 6380.5 6137.4 6279.2 6298.3 6328.3 6364.9 6265.5 6349.4 6352.1 6374.4 6384.5 5811.4 5818.6 5821.0 5826.9 5832.0 5931.4 5950.6 5977.6 6035.6 6048.1 02:59:03 INFO - 2015-12-21 02:59:03,474 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,474 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4864.14 Median:5502.41 stddev:1435.46 (26.1%) stddev-sans-first:1397.89 02:59:03 INFO - 2015-12-21 02:59:03,474 DEBUG : BROWSER_OUTPUT: Values: 293.4 293.6 299.0 303.7 304.2 5474.3 5530.5 5554.1 5584.1 5711.9 5538.8 5565.3 5571.1 5610.2 5611.3 4184.6 4268.0 4299.0 4311.0 4313.8 4286.2 4287.5 4291.4 4328.3 4329.1 4302.6 4305.2 4306.6 4312.6 4312.8 4286.9 4299.4 4304.3 4306.1 4316.3 3792.4 3792.6 3799.8 3801.4 3810.4 5293.6 5343.1 5410.9 5413.7 5414.4 4970.1 4972.7 4976.9 4978.6 4980.1 5822.9 5862.6 5870.0 5870.2 5873.6 4119.5 4119.8 4121.8 4125.9 4126.4 5978.9 6099.3 6179.1 6187.3 6190.8 4066.9 4072.9 4076.4 4090.6 4097.3 4125.8 4139.6 4156.3 4160.4 4162.7 4810.0 4821.0 4821.5 4826.6 4833.0 5679.7 5847.8 5862.0 5866.7 5878.8 1512.5 1518.3 1530.5 1532.0 1537.9 1015.0 1033.2 1040.7 1043.2 1044.2 5092.6 5099.1 5125.7 5130.3 5131.1 5939.2 6079.6 6096.3 6114.7 6114.9 5133.9 5145.4 5153.0 5166.5 5168.5 3268.6 3320.2 3321.9 3322.3 3327.4 5629.5 5760.4 5765.7 5765.8 5774.5 6278.6 6288.1 6316.4 6327.5 6342.0 5746.1 5748.4 5751.4 5753.4 5764.3 6105.8 6108.8 6115.5 6143.1 6165.5 5873.7 5949.9 5988.0 6000.6 6001.0 5696.0 5709.8 5732.6 5746.6 5751.8 4097.4 4128.8 4147.8 4150.8 4153.9 5977.2 6129.5 6129.6 6132.8 6137.8 5882.1 5887.5 5887.9 5889.3 5892.1 5864.8 5865.8 5883.9 5892.6 5894.9 5583.9 5714.6 5761.1 5773.9 5781.5 5949.5 5962.8 5969.8 5972.9 5984.6 5788.1 5793.8 5802.6 5812.9 5816.5 02:59:03 INFO - 2015-12-21 02:59:03,474 DEBUG : BROWSER_OUTPUT: 02:59:03 INFO - 2015-12-21 02:59:03,474 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12084.22 Median:467.06 stddev:13831.27 (2961.4%) stddev-sans-first:13843.44 02:59:03 INFO - 2015-12-21 02:59:03,475 DEBUG : BROWSER_OUTPUT: Values: 654.5 687.7 747.0 783.2 811.0 10986.6 11159.9 11270.4 11311.3 11328.9 11635.8 11768.0 12797.9 12948.7 12962.4 753.7 777.9 784.9 786.6 801.8 761.6 786.9 794.9 796.5 800.2 826.5 832.6 834.0 836.9 838.8 821.3 823.0 825.4 825.7 828.8 615.4 616.2 618.1 618.6 618.6 11300.4 11433.8 11469.0 11474.3 11482.7 10290.7 10413.7 10454.2 10769.2 11160.8 8911.2 9102.9 9124.8 9154.6 9498.0 3034.7 3130.3 3159.1 3163.3 3176.1 39371.4 39880.4 40303.6 40364.8 40473.8 9072.6 9220.3 9225.7 9259.2 9600.9 14451.6 14622.1 14653.3 14682.6 14717.8 6261.8 6279.0 6419.7 6536.9 6662.9 3376.7 3467.2 3475.8 3486.5 3530.9 2492.1 2528.9 2530.9 2531.6 2538.4 465.7 468.4 469.6 472.9 473.4 524.1 555.8 559.7 561.4 563.5 6669.2 6678.8 6878.5 6921.4 6971.1 508.5 517.4 533.9 538.2 544.4 3096.5 3118.2 3153.8 3165.0 3197.5 48376.0 48646.8 49028.5 51404.2 52529.5 42596.0 43357.3 43889.1 43930.1 44119.3 40341.2 40352.4 40768.0 41583.6 42054.8 7414.2 7514.9 7643.2 7766.7 8132.7 31030.8 31165.0 31295.5 31316.1 31364.2 39780.0 40059.0 40428.6 40441.4 40659.0 9775.2 9853.1 9857.6 9918.0 9922.0 10869.3 10903.9 10944.7 11158.7 11504.3 10460.8 10547.8 10561.7 10703.4 10997.2 10230.6 10446.3 10689.9 10841.0 10859.1 10035.6 10237.8 10383.9 10423.9 10640.6 9112.5 9278.4 9330.3 9379.6 9518.0 8729.7 8757.3 8823.3 8827.0 9241.4 02:59:03 INFO - 2015-12-21 02:59:03,475 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:59:03 INFO - 2015-12-21 02:59:03,475 DEBUG : BROWSER_OUTPUT: 02:59:04 INFO - 2015-12-21 02:59:04,204 INFO : Browser exited with error code: 0 02:59:04 INFO - 2015-12-21 02:59:04,228 INFO : Completed test dromaeo_css (00:18:34) 02:59:04 INFO - 2015-12-21 02:59:04,228 INFO : Starting test kraken 02:59:04 INFO - 2015-12-21 02:59:04,228 DEBUG : operating with platform_type : linux_ 02:59:04 INFO - 2015-12-21 02:59:04,228 INFO : Initialising browser for kraken test... 02:59:04 INFO - 2015-12-21 02:59:04,234 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNe7IM/profile http://localhost:49844/getInfo.html 02:59:08 INFO - 2015-12-21 02:59:08,015 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:59:08 INFO - 2015-12-21 02:59:08,784 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:59:08 INFO - 2015-12-21 02:59:08,785 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:59:08 INFO - 2015-12-21 02:59:08,785 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:59:08 INFO - 2015-12-21 02:59:08,785 DEBUG : BROWSER_OUTPUT: __metrics 02:59:08 INFO - 2015-12-21 02:59:08,921 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:59:09 INFO - 2015-12-21 02:59:09,876 INFO : Browser initialized. 02:59:09 INFO - 2015-12-21 02:59:09,877 INFO : Running cycle 1/1 for kraken test... 02:59:09 INFO - 2015-12-21 02:59:09,877 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNe7IM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:59:21 INFO - 2015-12-21 02:59:21,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 150835200 02:59:21 INFO - 2015-12-21 02:59:21,785 DEBUG : BROWSER_OUTPUT: 02:59:24 INFO - 2015-12-21 02:59:24,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49844/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:24 INFO - 2015-12-21 02:59:24,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 152350720 02:59:24 INFO - 2015-12-21 02:59:24,937 DEBUG : BROWSER_OUTPUT: 02:59:27 INFO - 2015-12-21 02:59:27,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49844/tests/kraken/driver.html?testName=audio-dft) 02:59:28 INFO - 2015-12-21 02:59:28,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 151683072 02:59:28 INFO - 2015-12-21 02:59:28,285 DEBUG : BROWSER_OUTPUT: 02:59:31 INFO - 2015-12-21 02:59:31,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49844/tests/kraken/driver.html?testName=audio-fft) 02:59:31 INFO - 2015-12-21 02:59:31,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 146354176 02:59:31 INFO - 2015-12-21 02:59:31,769 DEBUG : BROWSER_OUTPUT: 02:59:33 INFO - 2015-12-21 02:59:33,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49844/tests/kraken/driver.html?testName=audio-oscillator) 02:59:34 INFO - 2015-12-21 02:59:34,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 146231296 02:59:34 INFO - 2015-12-21 02:59:34,429 DEBUG : BROWSER_OUTPUT: 02:59:36 INFO - 2015-12-21 02:59:36,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:37 INFO - 2015-12-21 02:59:37,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 146767872 02:59:37 INFO - 2015-12-21 02:59:37,265 DEBUG : BROWSER_OUTPUT: 02:59:40 INFO - 2015-12-21 02:59:40,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49844/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:40 INFO - 2015-12-21 02:59:40,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 147963904 02:59:40 INFO - 2015-12-21 02:59:40,924 DEBUG : BROWSER_OUTPUT: 02:59:44 INFO - 2015-12-21 02:59:44,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49844/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:44 INFO - 2015-12-21 02:59:44,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 148819968 02:59:44 INFO - 2015-12-21 02:59:44,959 DEBUG : BROWSER_OUTPUT: 02:59:47 INFO - 2015-12-21 02:59:47,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49844/tests/kraken/driver.html?testName=json-parse-financial) 02:59:48 INFO - 2015-12-21 02:59:48,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 149090304 02:59:48 INFO - 2015-12-21 02:59:48,431 DEBUG : BROWSER_OUTPUT: 02:59:50 INFO - 2015-12-21 02:59:50,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:50 INFO - 2015-12-21 02:59:50,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 148676608 02:59:50 INFO - 2015-12-21 02:59:50,784 DEBUG : BROWSER_OUTPUT: 02:59:52 INFO - 2015-12-21 02:59:52,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:53 INFO - 2015-12-21 02:59:53,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 147693568 02:59:53 INFO - 2015-12-21 02:59:53,281 DEBUG : BROWSER_OUTPUT: 02:59:55 INFO - 2015-12-21 02:59:55,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:56 INFO - 2015-12-21 02:59:56,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 148041728 02:59:56 INFO - 2015-12-21 02:59:56,031 DEBUG : BROWSER_OUTPUT: 02:59:58 INFO - 2015-12-21 02:59:58,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:59 INFO - 2015-12-21 02:59:59,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 148987904 02:59:59 INFO - 2015-12-21 02:59:59,204 DEBUG : BROWSER_OUTPUT: 03:00:01 INFO - 2015-12-21 03:00:01,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:00:02 INFO - 2015-12-21 03:00:02,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 149278720 03:00:02 INFO - 2015-12-21 03:00:02,385 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49844/tests/kraken/driver.html?testName=ai-astar) 03:00:04 INFO - 2015-12-21 03:00:04,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 148164608 03:00:04 INFO - 2015-12-21 03:00:04,380 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,383 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:00:04 INFO - 2015-12-21 03:00:04,383 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;105;112;112;114;123;113;112;112;113 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;154;168;132;168;151;137;181;131 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;164;161;161;161;164;168;164;161 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;72;74;74;135;72;73;75 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;133;94;94;102;135;94;93;129 03:00:04 INFO - 2015-12-21 03:00:04,384 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;112;110;110;110;110;111;110 03:00:04 INFO - 2015-12-21 03:00:04,385 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;148;149;147;148;147;147 03:00:04 INFO - 2015-12-21 03:00:04,385 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;95;96;95;96;96;95 03:00:04 INFO - 2015-12-21 03:00:04,385 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;73;75;73;72;72;75;72 03:00:04 INFO - 2015-12-21 03:00:04,385 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;67;68;68;68;67;68;67;68 03:00:04 INFO - 2015-12-21 03:00:04,385 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;84;85;94;83;84;84;85;85 03:00:04 INFO - 2015-12-21 03:00:04,385 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;124;133;120;126;125;122;126;121;127 03:00:04 INFO - 2015-12-21 03:00:04,385 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;146;146;145;145;136;148;142;159;132 03:00:04 INFO - 2015-12-21 03:00:04,386 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;71;69;69;69;67;71;68;70 03:00:04 INFO - 2015-12-21 03:00:04,386 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:00:04 INFO - 2015-12-21 03:00:04,386 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:00:04 INFO - 2015-12-21 03:00:04,386 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,775 03:00:04 INFO - 2015-12-21 03:00:04,386 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:00:04 INFO - 2015-12-21 03:00:04,386 DEBUG : BROWSER_OUTPUT: __startTimestamp1450695604382__endTimestamp 03:00:04 INFO - 2015-12-21 03:00:04,386 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:4.33 (3.8%) stddev-sans-first:4.59 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: Values: 113.0 105.0 112.0 112.0 114.0 123.0 113.0 112.0 112.0 113.0 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.50 Median:153.50 stddev:17.91 (11.7%) stddev-sans-first:18.97 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 154.0 168.0 132.0 168.0 151.0 137.0 181.0 131.0 03:00:04 INFO - 2015-12-21 03:00:04,394 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:2.31 (1.4%) stddev-sans-first:2.44 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 164.0 161.0 161.0 161.0 164.0 168.0 164.0 161.0 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:73.00 stddev:19.63 (26.9%) stddev-sans-first:20.65 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 72.0 74.0 74.0 135.0 72.0 73.0 75.0 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.00 stddev:18.20 (19.4%) stddev-sans-first:18.84 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 133.0 94.0 94.0 102.0 135.0 94.0 93.0 129.0 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 112.0 110.0 110.0 110.0 110.0 111.0 110.0 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 148.0 149.0 147.0 148.0 147.0 147.0 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,395 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:73.00 stddev:1.15 (1.6%) stddev-sans-first:1.22 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 75.0 73.0 72.0 72.0 75.0 72.0 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 68.0 68.0 68.0 67.0 68.0 67.0 68.0 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:3.19 (3.8%) stddev-sans-first:3.38 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 84.0 85.0 94.0 83.0 84.0 84.0 85.0 85.0 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:3.68 (2.9%) stddev-sans-first:3.89 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 133.0 120.0 126.0 125.0 122.0 126.0 121.0 127.0 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,396 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:145.50 stddev:7.20 (5.0%) stddev-sans-first:7.60 03:00:04 INFO - 2015-12-21 03:00:04,397 DEBUG : BROWSER_OUTPUT: Values: 142.0 146.0 146.0 145.0 145.0 136.0 148.0 142.0 159.0 132.0 03:00:04 INFO - 2015-12-21 03:00:04,397 DEBUG : BROWSER_OUTPUT: 03:00:04 INFO - 2015-12-21 03:00:04,397 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 03:00:04 INFO - 2015-12-21 03:00:04,397 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 69.0 69.0 69.0 67.0 71.0 68.0 70.0 03:00:04 INFO - 2015-12-21 03:00:04,397 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:00:04 INFO - 2015-12-21 03:00:04,397 DEBUG : BROWSER_OUTPUT: 03:00:05 INFO - 2015-12-21 03:00:05,312 INFO : Browser exited with error code: 0 03:00:05 INFO - 2015-12-21 03:00:05,366 INFO : Completed test kraken (00:01:01) 03:00:05 INFO - 2015-12-21 03:00:05,366 INFO : Starting test v8_7 03:00:05 INFO - 2015-12-21 03:00:05,366 DEBUG : operating with platform_type : linux_ 03:00:05 INFO - 2015-12-21 03:00:05,366 INFO : Initialising browser for v8_7 test... 03:00:05 INFO - 2015-12-21 03:00:05,373 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpijS9Uh/profile http://localhost:49844/getInfo.html 03:00:09 INFO - 2015-12-21 03:00:09,181 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 03:00:10 INFO - 2015-12-21 03:00:10,065 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:00:10 INFO - 2015-12-21 03:00:10,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:00:10 INFO - 2015-12-21 03:00:10,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:00:10 INFO - 2015-12-21 03:00:10,066 DEBUG : BROWSER_OUTPUT: __metrics 03:00:10 INFO - 2015-12-21 03:00:10,194 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:00:11 INFO - 2015-12-21 03:00:11,115 INFO : Browser initialized. 03:00:11 INFO - 2015-12-21 03:00:11,116 INFO : Running cycle 1/1 for v8_7 test... 03:00:11 INFO - 2015-12-21 03:00:11,116 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpijS9Uh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:00:23 INFO - 2015-12-21 03:00:23,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 150376448 03:00:23 INFO - 2015-12-21 03:00:23,147 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49844/tests/v8_7/run.html (next: http://localhost:49844/tests/v8_7/run.html) 03:00:44 INFO - 2015-12-21 03:00:44,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 146010112 03:00:44 INFO - 2015-12-21 03:00:44,850 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,851 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:00:44 INFO - 2015-12-21 03:00:44,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:00:44 INFO - 2015-12-21 03:00:44,852 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:00:44 INFO - 2015-12-21 03:00:44,852 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:00:44 INFO - 2015-12-21 03:00:44,852 DEBUG : BROWSER_OUTPUT: |0;Richards;165.89250165892503 03:00:44 INFO - 2015-12-21 03:00:44,852 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.76688286913392 03:00:44 INFO - 2015-12-21 03:00:44,852 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.54648903691367 03:00:44 INFO - 2015-12-21 03:00:44,852 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 03:00:44 INFO - 2015-12-21 03:00:44,852 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1068.3030949839915 03:00:44 INFO - 2015-12-21 03:00:44,853 DEBUG : BROWSER_OUTPUT: |5;Earley;696.8641114982578 03:00:44 INFO - 2015-12-21 03:00:44,854 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 03:00:44 INFO - 2015-12-21 03:00:44,854 DEBUG : BROWSER_OUTPUT: |7;RegExp;26631.57894736842 03:00:44 INFO - 2015-12-21 03:00:44,854 DEBUG : BROWSER_OUTPUT: |8;Splay;635.3240152477764 03:00:44 INFO - 2015-12-21 03:00:44,854 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 03:00:44 INFO - 2015-12-21 03:00:44,855 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:00:44 INFO - 2015-12-21 03:00:44,855 DEBUG : BROWSER_OUTPUT: __startTimestamp1450695644851__endTimestamp 03:00:44 INFO - 2015-12-21 03:00:44,855 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,855 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:00:44 INFO - 2015-12-21 03:00:44,855 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: Values: 165.9 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.77 Median:190.77 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: Values: 190.8 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,856 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.55 Median:277.55 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: Values: 277.5 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: Values: 5175.3 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1068.30 Median:1068.30 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: Values: 1068.3 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:696.86 Median:696.86 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,857 DEBUG : BROWSER_OUTPUT: Values: 696.9 03:00:44 INFO - 2015-12-21 03:00:44,858 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,858 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: Values: 12108.4 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26631.58 Median:26631.58 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: Values: 26631.6 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:635.32 Median:635.32 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: Values: 635.3 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: Values: 4845.4 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:00:44 INFO - 2015-12-21 03:00:44,859 DEBUG : BROWSER_OUTPUT: 03:00:45 INFO - 2015-12-21 03:00:45,804 INFO : Browser exited with error code: 0 03:00:45 INFO - 2015-12-21 03:00:45,819 INFO : Completed test v8_7 (00:00:40) 03:00:45 INFO - 2015-12-21 03:00:45,845 INFO : Completed test suite (00:20:15) 03:00:45 INFO - 2015-12-21 03:00:45,846 DEBUG : Working with test: dromaeo_css 03:00:45 INFO - 2015-12-21 03:00:45,846 DEBUG : Generating results file: dromaeo_css 03:00:45 INFO - 2015-12-21 03:00:45,847 DEBUG : Working with test: kraken 03:00:45 INFO - 2015-12-21 03:00:45,847 DEBUG : Generating results file: kraken 03:00:45 INFO - 2015-12-21 03:00:45,847 INFO : javascript benchmark 03:00:45 INFO - 2015-12-21 03:00:45,847 DEBUG : Working with test: v8_7 03:00:45 INFO - 2015-12-21 03:00:45,848 DEBUG : Generating results file: v8_7 03:00:45 INFO - 2015-12-21 03:00:45,848 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:45 INFO - 2015-12-21 03:00:45,985 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:00:45 INFO - 2015-12-21 03:00:45,985 DEBUG : process_Request line: dromaeo_css 6143.66 graph.html#tests=[[72,132,43]] 03:00:45 INFO - 2015-12-21 03:00:45,985 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:46 INFO - 2015-12-21 03:00:46,019 DEBUG : process_Request line: kraken 1529.30 graph.html#tests=[[232,132,43]] 03:00:46 INFO - 2015-12-21 03:00:46,019 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:46 INFO - 2015-12-21 03:00:46,144 DEBUG : process_Request line: v8_7 21227.30 graph.html#tests=[[230,132,43]] 03:00:46 INFO - 2015-12-21 03:00:46,145 INFO : javascript benchmark 03:00:46 INFO - 2015-12-21 03:00:46,149 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2633.1968749531393, 2649.509840679473, 2682.611021401897, 2701.6082668013137, 2703.9999999999995, 4391.231534481469, 4467.463904331476, 4539.477960034597, 4560.361549383089, 4564.338170965208, 4514.210013247685, 4514.367988481607, 4520.141173177094, 4651.279051746977, 4655.394798676176, 4178.8328466861285, 4267.466566679165, 4330.740155590659, 4331.177076355482, 4370.71590346628, 4289.056407590325, 4301.892452688677, 4301.956980430187, 4333.826646934134, 4379.540148284416, 4096.3855421686685, 4215.620594146541, 4313.245182093121, 4347.456567929009, 4373.300271956487, 4131.566185550504, 4208.494980602347, 4212.789360531961, 4230.323148296288, 4233.089885674564, 4256.361545768129, 4282.957170428287, 4296.5273819879785, 4328.4156638853665, 4340.327249276367, 4284.957150428487, 4431.047324825178, 4434.866953991385, 4561.6806823522365, 4590.770461476913, 4737.360456338385, 4779.80880764769, 4780.378550788375, 4794.400699912511, 4865.41615006198, 4928.063667903087, 4976.502349765031, 5014.824481143142, 5024.723640199788, 5038.168702164176, 4383.254846676073, 4619.769011549409, 4641.605463535638, 4645.117427688729, 4706.811727530929, 4827.493113223061, 4909.7790599423115, 4920.040592084581, 4944.53026962438, 4965.404151501771, 4837.516248375205, 4881.341018962466, 4894.363732714724, 4901.264810278487, 4941.901161976741, 4707.599854012447, 4798.04039192163, 4956.628252881048, 4966.801327946914, 4983.401991761012, 4768.237082066922, 4780.569748722632, 4813.7593120343845, 4832.202686556749, 4862.0, 4882.414110306715, 4889.4377146627885, 4889.535494128123, 4914.0908931847725, 4934.136526107916, 3946.625070618287, 4040.676745860383, 4066.268071747055, 4132.876013719593, 4167.83328666856, 3584.731145164123, 3606.549181352331, 3643.125649844071, 3646.927061458809, 3666.834992425347, 4264.445622069111, 4268.167707297047, 4297.183535128315, 4303.0, 4319.524852266311, 4715.292706094045, 4865.440474345495, 4894.583960363409, 4951.579115775127, 5027.597792176617, 4248.0, 4272.551382104896, 4281.400603915455, 4305.16049370376, 4309.461317335333, 4345.760983145958, 4353.73877567347, 4357.302831547001, 4360.193364227628, 4367.192069467159, 4402.911941761083, 4524.547545245581, 4610.377599024089, 4683.718976861399, 4753.453352864465, 4949.33184020167, 4952.0, 4966.975165124151, 4978.900421991612, 5022.221555658879, 4663.650226232979, 4683.906321873612, 4695.389599352063, 4699.154152252628, 4742.478327384054, 4584.266517357207, 4694.389729335165, 4763.618910487222, 4856.587190088882, 4890.388701412324, 4911.656184067224, 4927.630427717864, 4929.112759703288, 4934.18585933317, 4969.503049695001, 4572.588467037983, 4796.592289655278, 4797.832075877328, 4798.424189097331, 4842.757862106951, 4658.743769092733, 4806.158922188533, 4889.339939108318, 4897.216445368724, 4922.015596880709, 4674.6260299176665, 4682.906341873211, 4687.695299805502, 4709.882252943704, 4717.811287548459, 4507.09858028389, 4683.953160468488, 4802.063597598435, 4809.105904984061, 4862.756862156949, 4713.128071306819, 4775.06886157196, 4789.7605119743175, 4794.161021821097, 4843.24929635907], "unit": "score", "name": "dojo.html", "value": 4508.400233567782}, {"lowerIsBetter": false, "replicates": [560.1289994059237, 560.2548610348236, 560.5347561523936, 563.4365634365635, 567.2653913182428, 35258.647413525854, 35895.82052089736, 35991.460128098064, 36042.0, 36054.45918311224, 39974.0, 40367.798161009225, 40597.797011014976, 40623.0, 40689.0, 7764.417668674843, 7900.881486777703, 7960.442769006172, 7979.880301795478, 7987.440879138463, 7758.573278469682, 7921.485103468285, 7924.08872979609, 7928.365730741527, 7931.722389716361, 7916.881246781303, 7932.960335198316, 7985.441019128663, 8003.359731221517, 8035.799105022363, 7874.251946065115, 7938.563379014152, 7952.244536768998, 7974.12284648694, 7978.481398709066, 7817.765467035998, 7877.921220787834, 7949.483283586548, 7962.442629015971, 7967.681292748283, 37080.62919370799, 37552.0, 37681.62318376836, 37729.0, 37849.243015139546, 2959.0531030070388, 2962.481565725989, 2969.659133474841, 3065.877364905401, 3420.9144771380666, 27838.0, 27930.581041284397, 28215.294617634518, 28585.428291434262, 28942.69757860901, 3424.6232914379398, 3447.345004449172, 3495.860165593373, 3526.7531272810916, 3543.450765131409, 203335.0, 203628.0, 203716.0, 204484.0, 205471.0, 50662.746686266335, 51831.0, 52517.2122418164, 52898.471015290124, 53013.469865301624, 64499.0, 65122.674386628714, 65463.34536654668, 65876.6706166466, 65930.0, 13476.730465390834, 13667.0, 13696.589102326947, 13763.243021633907, 13853.930730346283, 9901.752456188653, 9963.202943764481, 9964.750881228027, 9967.80064398708, 9968.950155249322, 18889.244430222912, 19130.904345478182, 19144.425667230007, 19182.0, 19257.903710481638, 6982.1272340957385, 7210.206877243604, 7337.3029562191505, 7414.369778568775, 7475.551466912003, 849.0617867256716, 938.648006997376, 957.8515330123703, 992.6426486464867, 1023.9948800255951, 25911.222663319753, 26136.8693156533, 26546.0, 26814.463710725675, 26976.460470790473, 935.1957316707626, 944.3531181140941, 946.6639343033262, 970.1995853420956, 1027.6916924922493, 12345.580258270415, 12399.13206075566, 12448.75102497945, 12467.812982805266, 12530.749385012248, 197543.0, 202718.0, 202900.0, 203312.0, 203740.0, 40463.19073618511, 40927.795361023, 40963.180736385104, 41079.794601026806, 41207.38188927169, 1224.7489264700714, 1232.617888454582, 1232.8643849176583, 1254.912156149079, 1265.5507294910174, 23400.76599234054, 25751.227463176136, 28338.0, 28390.716092838808, 28748.0, 40572.79713601413, 40768.79615601903, 40791.388129177496, 40894.0, 40971.38542921799, 190802.0, 191260.0, 191917.0, 192082.0, 192602.03698981417, 28473.43053138967, 28530.57204141981, 28975.5653665191, 29047.419051618428, 29139.12582622525, 33487.66512334943, 33556.0, 33570.0, 34303.31393372069, 34375.48436773501, 31845.0, 32503.349933000736, 32572.185695357806, 32910.83544582358, 33031.33937321192, 31447.371052579278, 32250.0, 32304.35391292114, 32490.0, 32509.187270317485, 32511.349773003934, 32523.674763252064, 33099.50350744789, 33609.49585756167, 33629.495557566166, 25630.743692562835, 27252.45495090127, 27465.862670686518, 28689.0, 29466.0, 22934.197303094978, 23030.884845575663, 23082.42293942598, 23162.420939475975, 23285.3014409568], "unit": "score", "name": "ext.html", "value": 16405.69000384633}, {"lowerIsBetter": false, "replicates": [308.8656434451014, 310.23062804245455, 317.76802933858283, 318.4554411955556, 327.08742608123345, 15021.39914403424, 16038.59903502413, 16363.509094727162, 16596.419125330616, 17243.655126897454, 14667.413303467849, 14676.55970320892, 14714.484993025246, 14756.557303280892, 15009.0, 4452.287633978564, 4713.0, 4715.528447155291, 4715.952840471603, 4720.433547974248, 3788.677962373202, 3804.0489877530617, 3805.828737706796, 3806.9340584636207, 3816.8473261069526, 3521.330947120039, 3796.411556208778, 3802.5627052888995, 4415.646748260147, 5309.920351194716, 5221.6083793715625, 5263.44733802949, 5297.046531624325, 5322.467753224685, 5332.733363331838, 4739.834105806281, 4905.754712264373, 4929.556339929423, 5081.847544573632, 5114.846554603368, 11047.392393418359, 11123.777524449466, 11276.041536469409, 11304.321740695585, 11355.489002994886, 1807.5268656045282, 1836.0452564666432, 1856.8700190986635, 1869.2616416515536, 1879.3234435603308, 8782.429142105742, 9437.386569872937, 10165.948382622495, 11854.644360669194, 12170.0, 1682.6382327799581, 1683.6885176242433, 1729.4119999200332, 1788.2578729827237, 1833.7157740550235, 50905.490945090445, 53125.73437132828, 53318.73340633311, 53796.0, 55240.17139742867, 9367.344285900057, 9441.150296473214, 9578.521073946275, 9632.662856800118, 9687.51562421876, 11880.762384752257, 11982.0, 12026.037916966796, 12034.879651203375, 12036.157468977088, 6565.737370505126, 6601.768938087144, 6652.83367915806, 6701.463882889358, 6748.0, 6310.148130002391, 6341.017142342944, 6347.365263473708, 6380.393862583047, 6396.0725694774, 4161.396597493407, 4167.437395951508, 4193.448424083048, 4207.852725154666, 4253.829846806155, 1639.1312604319492, 1673.2888522377941, 1704.880658353928, 1754.4210410564483, 1757.1565648488797, 377.98488060477274, 381.8873432337467, 408.2202992284722, 817.1338381315825, 871.6600525794945, 9251.953740231256, 9620.326577139673, 9796.902030979742, 9871.851922221173, 10190.643327483502, 394.43398722832825, 400.91580768038455, 409.68249606555156, 411.93409054551125, 433.3002201444707, 5418.02475554404, 5470.0, 5525.944740552623, 5532.778688852401, 8930.374873758905, 510212.0, 512977.0, 518637.0, 522968.0, 529763.0, 68301.65849170822, 71280.0, 71653.2834671657, 73566.0, 73574.0, 1042.4006196436928, 1063.8670166229222, 1068.0707784227773, 1073.6403304892792, 1077.932846481977, 14104.980080677367, 14505.637359065686, 14573.781393279321, 14591.0, 14968.0, 32628.83685581557, 32764.79762420878, 32913.506297406035, 33100.66899331072, 33888.491672624434, 39857.60142398539, 40391.0, 42535.0, 42626.14747705091, 43338.349924750524, 8376.748697539084, 8477.745667629733, 8850.468971861708, 8891.866622000805, 8924.509151996703, 10181.440020798927, 10195.949020255148, 10209.285350025724, 10272.537735802056, 13174.0, 13208.73582528325, 13221.669458263235, 13361.331933403097, 13362.732745345233, 13466.93266533661, 12881.291528965998, 13051.934740326238, 13137.934310328386, 13382.799258011333, 13790.655233618838, 12580.119391642496, 12913.806292905801, 12963.675908102374, 13816.516421925586, 14622.268886555843, 8685.739427817176, 8936.553172341486, 8962.865557016781, 9009.729708108767, 9118.270538356783, 2450.938726531851, 11958.940205298917, 13695.520656776966, 14176.078554893898, 14198.533564577505], "unit": "score", "name": "jquery.html", "value": 7459.499868241149}, {"lowerIsBetter": false, "replicates": [1507.7889095526634, 1602.4311369463837, 1657.121725485493, 1669.2988944643248, 1692.9068901210428, 5972.9402705972925, 6133.417325354084, 6743.393094621483, 7276.490645654806, 7312.341889229968, 6705.262421133683, 6916.170059592843, 6916.96541517293, 6956.895646565293, 6959.269276725934, 2048.0988365119338, 2063.040686080972, 2070.6272870883236, 2081.906314215864, 2085.103405535619, 2042.3770749921268, 2044.427560283123, 2092.9686054709114, 2128.4998025464, 2154.526004279056, 2063.370671945056, 2074.3362124120285, 2083.6978638097467, 2093.2568938026934, 2095.5075557244036, 2045.5602045560202, 2069.5757369739244, 2075.107703687414, 2076.563921576471, 2079.5632917087355, 2054.3323419888447, 2060.103854823157, 2100.537881666031, 2103.8106570408736, 2121.130336562002, 7008.299170083002, 7119.608421536814, 7123.536970096979, 7124.893126603105, 7126.3942564882045, 4011.117554138085, 4084.326086195774, 4093.9590604093873, 4094.7747873866924, 4113.938290925638, 2676.9196924092307, 2705.648265725463, 2740.1231605886123, 2801.523740964021, 2809.8314101153996, 879.4503435352905, 886.9733907982771, 896.1083721696888, 899.7840518275567, 928.7445952363087, 9398.483083430408, 9476.668316608886, 9490.098440648197, 9492.050794920522, 9510.048995100435, 3818.809059547067, 3826.8660596878976, 3848.6728628066367, 3894.1432884765304, 3918.529776426847, 8134.064582572962, 8210.507369557845, 8212.548309843016, 8212.712555060543, 8219.630116644765, 4181.958180418218, 4190.28765109932, 4192.895177620584, 4204.51648060477, 4204.789760512023, 3708.8145592720257, 3784.394496880486, 3798.9430158547643, 3798.9810050950123, 3823.2926908522013, 3316.088075779132, 3317.0, 3332.950005749916, 3346.983265083708, 3373.763836531419, 985.8761012445817, 996.1084829077935, 1002.6440613582073, 1008.909198172168, 1013.4274135113637, 1140.1164097824087, 1155.8035134027236, 1161.5818305410046, 1176.8823117688162, 1186.145974898072, 6701.597904125768, 6710.328967103348, 6719.193696756421, 6734.124563806674, 6740.292269311652, 400.8436709683226, 403.81020920167475, 407.6555310762401, 411.56374243302196, 411.7796978616426, 4966.726830024311, 4968.329275547755, 5021.447640759514, 5023.09584274834, 5025.14572522672, 8406.117357677478, 8432.45189062709, 8511.148885111439, 8534.70128545498, 8583.484990900566, 8484.957575212084, 8518.23335899772, 8531.10423405546, 8549.401541892132, 8555.786105347415, 6250.312465628777, 6596.571222870498, 6629.303923088103, 6631.469482441393, 6642.568233064835, 6785.864282714417, 6815.284395138638, 6852.349026842442, 6858.5199036067, 6893.517453778188, 7531.661075251517, 7681.231876812274, 7698.538087714755, 7718.729844455417, 7742.070951485858, 7604.80987975305, 7857.449978501679, 7888.526688398714, 7928.682852686059, 7952.085510166405, 5116.616253780907, 5289.603279754111, 6393.456556192589, 6447.097406363207, 6500.674966251574, 6413.743450261937, 6537.640429776408, 6574.309697481695, 6575.473962083118, 6586.736530538725, 6119.877602448015, 6267.2479302484, 6314.589551679126, 6370.968145159244, 6380.521460890544, 6137.386261374006, 6279.215098112736, 6298.307186209605, 6328.335524769833, 6364.872702546016, 6265.49876009909, 6349.365063493614, 6352.142460767737, 6374.362563743589, 6384.45732112757, 5811.389804070681, 5818.6217895836635, 5821.039528477923, 5826.94173058264, 5831.970840145772, 5931.377205393372, 5950.583459157818, 5977.551683623833, 6035.577509574463, 6048.0625503047095], "unit": "score", "name": "mootools.html", "value": 3967.6944461198054}, {"lowerIsBetter": false, "replicates": [293.4468526826931, 293.6094993658435, 299.0013355392987, 303.7190598696206, 304.16506689138316, 5474.343078830541, 5530.474604912537, 5554.055810512213, 5584.050711379065, 5711.942880571193, 5538.806141785039, 5565.332160140779, 5571.0807716726795, 5610.214569960199, 5611.298587676541, 4184.644305234059, 4267.9573204267945, 4298.957010429887, 4310.956890431087, 4313.849015284466, 4286.249906266391, 4287.506936702288, 4291.420658211148, 4328.264195086843, 4329.069250111225, 4302.612764851163, 4305.24658184818, 4306.590873866993, 4312.5903039211225, 4312.827486900536, 4286.871393858158, 4299.376590394391, 4304.3113101903855, 4306.117245964601, 4316.266234740102, 3792.374258247386, 3792.6017768134225, 3799.810009499514, 3801.4297855321925, 3810.371288737355, 5293.588975434384, 5343.091674415358, 5410.91883621746, 5413.729313534308, 5414.40441551429, 4970.080535101018, 4972.651914365996, 4976.850694479172, 4978.6017118630425, 4980.12847751642, 5822.883542329172, 5862.560307976876, 5870.0, 5870.20752198452, 5873.588848780587, 4119.505659320871, 4119.752814831089, 4121.773302468363, 4125.938110928339, 4126.360414135814, 5978.910316345258, 6099.298580663236, 6179.073139029181, 6187.257529096492, 6190.845228869314, 4066.9186616267507, 4072.9185416291507, 4076.429299897957, 4090.550039495653, 4097.282975479279, 4125.773082480432, 4139.648129908931, 4156.314208155621, 4160.438340824011, 4162.729422587522, 4810.037992401533, 4821.035792841446, 4821.5178482151505, 4826.638002149783, 4832.9850731346105, 5679.687617181012, 5847.766089356378, 5861.9706901465215, 5866.677332746654, 5878.823635290948, 1512.4781950227155, 1518.2560545332708, 1530.5331873778382, 1532.0271627516606, 1537.8846586506056, 1014.9543270552842, 1033.1682995188794, 1040.7398150462384, 1043.186314674555, 1044.185535282481, 5092.567131793765, 5099.056674515226, 5125.692458452505, 5130.30740849988, 5131.1277082895995, 5939.168516407706, 6079.574429789961, 6096.329403765582, 6114.724837382329, 6114.908276375858, 5133.871653208625, 5145.434002259748, 5153.0466863630345, 5166.457521960216, 5168.483151684876, 3268.5587445695, 3320.236345640516, 3321.8671253150087, 3322.2857085726687, 3327.4010678077693, 5629.493345598916, 5760.423957604206, 5765.682887441147, 5765.827025189251, 5774.451427114417, 6278.591891527036, 6288.088227207029, 6316.399942005502, 6327.525435592349, 6341.968290158519, 5746.13807928814, 5748.396418376094, 5751.367349591542, 5753.367129615739, 5764.250647415809, 6105.816825495064, 6108.816735497942, 6115.510759139347, 6143.109249158758, 6165.537584681257, 5873.706314684334, 5949.940500595112, 5988.0, 6000.5799594028, 6000.969995149996, 5696.0, 5709.800156994652, 5732.627379220337, 5746.597738158289, 5751.769929202952, 4097.4263603095, 4128.793560322032, 4147.771872547039, 4150.8339666413, 4153.91692166161, 5977.22296101504, 6129.509639228761, 6129.601575897553, 6132.78535251264, 6137.7851775187655, 5882.058870580687, 5887.470127688529, 5887.911681324698, 5889.322727886348, 5892.145638882424, 5864.794732184353, 5865.824025279248, 5883.852903677443, 5892.558058145571, 5894.882102358015, 5583.944160558505, 5714.5999780015, 5761.107028410435, 5773.8556536086935, 5781.4507621775865, 5949.524038076857, 5962.791302304398, 5969.76120955157, 5972.8805423892145, 5984.640921544721, 5788.0739081746715, 5793.768249269982, 5802.622829516068, 5812.854678633068, 5816.47651711348], "unit": "score", "name": "prototype.html", "value": 4398.128994213564}, {"lowerIsBetter": false, "replicates": [654.4600704418854, 687.6871023684224, 746.9775906722798, 783.2363445640505, 811.030818172284, 10986.560537578498, 11159.888401115986, 11270.4364781761, 11311.321320720752, 11328.943355283212, 11635.825462618046, 11768.0, 12797.872021279785, 12948.74102517949, 12962.351882405865, 753.7361923326832, 777.8910952466659, 784.8548018616546, 786.626352482569, 801.8035581282594, 761.603965937712, 786.8819677048431, 794.876794096913, 796.4982061301372, 800.2157885272436, 826.4669288309037, 832.6253186066264, 833.9708110216144, 836.8953880764905, 838.8154605986673, 821.2649678537736, 822.9629666664985, 825.3685930263354, 825.7275099217273, 828.825946551225, 615.4061330815784, 616.2389449030444, 618.0790621973227, 618.5979113576167, 618.6411881108946, 11300.378479183642, 11433.771324573545, 11469.0, 11474.311541307465, 11482.712932176679, 10290.7427314317, 10413.739656508573, 10454.215933804995, 10769.246152769309, 11160.832587511193, 8911.19799218067, 9102.86345704815, 9124.771880703036, 9154.633814647406, 9497.952510237474, 3034.6965303469697, 3130.280035591804, 3159.0651867442302, 3163.31988622445, 3176.09481297829, 39371.40942885859, 39880.40179397311, 40303.59696403057, 40364.79817600922, 40473.79763101195, 9072.591733372014, 9220.262379009662, 9225.72322830316, 9259.166674999147, 9600.855987160197, 14451.638709032148, 14622.122672639676, 14653.340599672827, 14682.63293417673, 14717.779233311509, 6261.812145635638, 6278.968605156945, 6419.711112999927, 6536.901946470807, 6662.900056499157, 3376.6623337666038, 3467.1852114753015, 3475.8088305142956, 3486.459598762196, 3530.947035794465, 2492.0654754467073, 2528.9114880979077, 2530.949655892821, 2531.632913227572, 2538.352720056411, 465.6763549333249, 468.4425533614987, 469.59614731331027, 472.8581425572315, 473.36096270035176, 524.0574176001722, 555.849920521457, 559.720139930035, 561.3740679142808, 563.4647085269011, 6669.199696036507, 6678.799636010927, 6878.518503704692, 6921.411680007256, 6971.128608923885, 508.509288536564, 517.3920643244173, 533.8558589180977, 538.2249560632677, 544.3576579636067, 3096.4735994880925, 3118.204857761302, 3153.81077135368, 3165.034664427326, 3197.4724170512072, 48376.0, 48646.75676621594, 49028.509714903106, 51404.20085297072, 52529.474705253226, 42596.0, 43357.349639755426, 43889.12221755547, 43930.12139757187, 44119.33820992688, 40341.193176136316, 40352.39471407873, 40768.0, 41583.58416415858, 42054.789726051786, 7414.22150674193, 7514.924850751641, 7643.159252482334, 7766.728164514215, 8132.6746930122135, 31030.844845775628, 31165.0, 31295.530567041056, 31316.06051818449, 31364.215894602818, 39780.0, 40059.0, 40428.59571404248, 40441.39337909993, 40659.0, 9775.169110625677, 9853.113219810251, 9857.556409961426, 9917.950410248191, 9921.950390248003, 10869.347839129678, 10903.890961090288, 10944.671659849899, 11158.721031974266, 11504.309741415542, 10460.79078418412, 10547.789044219226, 10561.735956601147, 10703.411312377582, 10997.230193886351, 10230.590776368861, 10446.268761186948, 10689.9465502672, 10841.024307812335, 10859.07697845692, 10035.648752293635, 10237.795244095225, 10383.896161038292, 10423.895761042595, 10640.627578034731, 9112.453252804587, 9278.396904201205, 9330.25588761313, 9379.613757295116, 9518.0, 8729.650813967624, 8757.255633271243, 8823.294136469196, 8826.955865220632, 9241.445513269226], "unit": "score", "name": "yui.html", "value": 5584.559688073717}], "name": "dromaeo_css", "value": 6143.66376425895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 112.0, 112.0, 114.0, 123.0, 113.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 154.0, 168.0, 132.0, 168.0, 151.0, 137.0, 181.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 164.0, 161.0, 161.0, 161.0, 164.0, 168.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 74.0, 74.0, 135.0, 72.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 94.0, 94.0, 102.0, 135.0, 94.0, 93.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 112.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 75.0, 73.0, 72.0, 72.0, 75.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 84.0, 85.0, 94.0, 83.0, 84.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [124.0, 124.0, 133.0, 120.0, 126.0, 125.0, 122.0, 126.0, 121.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [142.0, 146.0, 146.0, 145.0, 145.0, 136.0, 148.0, 142.0, 159.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 69.0, 69.0, 69.0, 67.0, 71.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1529.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [190.76688286913392], "unit": "score", "name": "DeltaBlue", "value": 346.59055600000005}, {"lowerIsBetter": false, "replicates": [277.54648903691367], "unit": "score", "name": "Encrypt", "value": 959.0501430000003}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1068.3030949839915], "unit": "score", "name": "RayTrace", "value": 692.677015984016}, {"lowerIsBetter": false, "replicates": [696.8641114982578], "unit": "score", "name": "Earley", "value": 956.374405}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [26631.57894736842], "unit": "score", "name": "RegExp", "value": 34.20694664031621}, {"lowerIsBetter": false, "replicates": [635.3240152477764], "unit": "score", "name": "Splay", "value": 128.26683399999996}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21227.303952933085}]} 03:00:46 INFO - RETURN: dromaeo_css: 6143.66 03:00:46 INFO - RETURN: kraken: 1529.30 03:00:46 INFO - RETURN: v8_7: 21227.30 03:00:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21227.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1529.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6143.66"}}} 03:00:46 INFO - Return code: 0 03:00:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:00:46 INFO - # TBPL SUCCESS # 03:00:46 INFO - Running post-action listener: _resource_record_post_action 03:00:46 INFO - Running post-run listener: _resource_record_post_run 03:00:47 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 90112; Write bytes: 552161280; Read time: 620; Write time: 511764 03:00:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 8192; Write bytes: 233857024; Read time: 312; Write time: 268444 03:00:47 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 81920; Write bytes: 318304256; Read time: 308; Write time: 243320 03:00:47 INFO - Running post-run listener: _upload_blobber_files 03:00:47 INFO - Blob upload gear active. 03:00:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:00:47 INFO - Copying logs to upload dir... 03:00:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.058553 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-21 03:00:46.988148) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:46.993121) ========= 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=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009914 build_url: 'https://queue.taskcluster.net/v1/task/i7rHb2BPT5mCmAHyRTPxaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:47.054139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:47.054620) ========= 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=b00de3c228505fac2445e70d000001bb-1450694374.750597-1241537758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 03:00:47.107781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 03:00:47.108217) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 03:00:47.108684) ========= ========= Total master_lag: 0.24 =========