builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1450703519.75 results: success (0) buildid: 20151221044428 builduid: c2a59b5c1b614d82a82309b045b9b3ca revision: fd7f6a9dcfad66d79b0e28d964c49529588aecf4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:11:59.750244) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:11:59.750760) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:11:59.751104) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004885 basedir: '/builds/slave/test' ========= master_lag: 0.26 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.013830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.014185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.049340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.049791) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.036672 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.096958) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.097341) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.097794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.098140) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 05:12:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-12-21 05:12:00 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.273260 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.384548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.384931) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.169948 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:00.567366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 05:12:00.567753) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fd7f6a9dcfad66d79b0e28d964c49529588aecf4 --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 fd7f6a9dcfad66d79b0e28d964c49529588aecf4 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 05:12:00,847 truncating revision to first 12 chars 2015-12-21 05:12:00,847 Setting DEBUG logging. 2015-12-21 05:12:00,847 attempt 1/10 2015-12-21 05:12:00,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fd7f6a9dcfad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 05:12:01,772 unpacking tar archive at: fx-team-fd7f6a9dcfad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.212827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 05:12:01.794664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:01.795051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:01.803743) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:01.804024) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:12:01.804445) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-21 05:12:01.804757) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:12:02 INFO - MultiFileLogger online at 20151221 05:12:02 in /builds/slave/test 05:12:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:12:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:02 INFO - {'append_to_log': False, 05:12:02 INFO - 'base_work_dir': '/builds/slave/test', 05:12:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:12:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:02 INFO - 'branch': 'Fx-Team-Non-PGO', 05:12:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:02 INFO - 'config_files': ('talos/linux_config.py',), 05:12:02 INFO - 'default_actions': ('clobber', 05:12:02 INFO - 'read-buildbot-config', 05:12:02 INFO - 'download-and-extract', 05:12:02 INFO - 'populate-webroot', 05:12:02 INFO - 'create-virtualenv', 05:12:02 INFO - 'install', 05:12:02 INFO - 'run-tests'), 05:12:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:02 INFO - 'download_minidump_stackwalk': True, 05:12:02 INFO - 'download_symbols': 'ondemand', 05:12:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:02 INFO - 'installer_path': 'installer.exe', 05:12:02 INFO - 'log_level': 'info', 05:12:02 INFO - 'log_name': 'talos', 05:12:02 INFO - 'log_to_console': True, 05:12:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:12:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:12:02 INFO - 'opt_config_files': (), 05:12:02 INFO - 'pip_index': False, 05:12:02 INFO - 'sps_profile': False, 05:12:02 INFO - 'sps_profile_interval': 0, 05:12:02 INFO - 'suite': 'dromaeojs', 05:12:02 INFO - 'system_bits': '64', 05:12:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:02 INFO - 'title': 'talos-linux64-ix-037', 05:12:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:02 INFO - 'use_talos_json': True, 05:12:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:02 INFO - 'work_dir': 'build'} 05:12:02 INFO - ##### 05:12:02 INFO - ##### Running clobber step. 05:12:02 INFO - ##### 05:12:02 INFO - Running pre-action listener: _resource_record_pre_action 05:12:02 INFO - Running main action method: clobber 05:12:02 INFO - rmtree: /builds/slave/test/build 05:12:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:04 INFO - Running post-action listener: _resource_record_post_action 05:12:04 INFO - ##### 05:12:04 INFO - ##### Running read-buildbot-config step. 05:12:04 INFO - ##### 05:12:04 INFO - Running pre-action listener: _resource_record_pre_action 05:12:04 INFO - Running main action method: read_buildbot_config 05:12:04 INFO - Using buildbot properties: 05:12:04 INFO - { 05:12:04 INFO - "project": "", 05:12:04 INFO - "product": "firefox", 05:12:04 INFO - "script_repo_revision": "production", 05:12:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:12:04 INFO - "repository": "", 05:12:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:12:04 INFO - "buildid": "20151221044428", 05:12:04 INFO - "pgo_build": "False", 05:12:04 INFO - "basedir": "/builds/slave/test", 05:12:04 INFO - "buildnumber": 1036, 05:12:04 INFO - "slavename": "talos-linux64-ix-037", 05:12:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:12:04 INFO - "platform": "ubuntu64_hw", 05:12:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:12:04 INFO - "branch": "fx-team", 05:12:04 INFO - "repo_path": "integration/fx-team", 05:12:04 INFO - "revision": "fd7f6a9dcfad66d79b0e28d964c49529588aecf4", 05:12:04 INFO - "stage_platform": "linux64", 05:12:04 INFO - "builduid": "c2a59b5c1b614d82a82309b045b9b3ca", 05:12:04 INFO - "slavebuilddir": "test" 05:12:04 INFO - } 05:12:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:12:04 INFO - Running post-action listener: _resource_record_post_action 05:12:04 INFO - ##### 05:12:04 INFO - ##### Running download-and-extract step. 05:12:04 INFO - ##### 05:12:04 INFO - Running pre-action listener: _resource_record_pre_action 05:12:04 INFO - Running main action method: download_and_extract 05:12:04 INFO - mkdir: /builds/slave/test/build/tests 05:12: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')]} 05:12:04 INFO - https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/test_packages.json 05:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/test_packages.json 05:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:12:04 INFO - Downloaded 1302 bytes. 05:12:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:12:04 INFO - Using the following test package requirements: 05:12:04 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:04 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:12:04 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:04 INFO - u'jsshell-linux-x86_64.zip'], 05:12:04 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:12:04 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:04 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:12:04 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:12:04 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:12:04 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:04 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:12:04 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:12: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')]} 05:12:04 INFO - https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:05 INFO - Downloaded 21926753 bytes. 05:12:05 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 05:12:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:05 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 05:12:07 INFO - Return code: 0 05:12:07 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 05:12: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')]} 05:12:07 INFO - https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:08 INFO - Downloaded 21926753 bytes. 05:12:08 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 05:12:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:12:08 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 05:12:09 INFO - Return code: 0 05:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:09 INFO - https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:12:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:10 INFO - Downloaded 11132277 bytes. 05:12:10 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 05:12:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:10 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 05:12:10 INFO - Return code: 0 05:12: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')]} 05:12:10 INFO - https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:12:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:12:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:12:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/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 05:12:12 INFO - Downloaded 53386181 bytes. 05:12:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:12:12 INFO - mkdir: /builds/slave/test/properties 05:12:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:12:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:12:12 INFO - Contents: 05:12:12 INFO - build_url:https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:12:12 INFO - Running post-action listener: _resource_record_post_action 05:12:12 INFO - Running post-action listener: set_extra_try_arguments 05:12:12 INFO - ##### 05:12:12 INFO - ##### Running populate-webroot step. 05:12:12 INFO - ##### 05:12:12 INFO - Running pre-action listener: _resource_record_pre_action 05:12:12 INFO - Running main action method: populate_webroot 05:12:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:12:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:12:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:12:12 INFO - '--tppagecycles', 05:12:12 INFO - '7'], 05:12:12 INFO - 'tests': ['tsvgm']}}, 05:12:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:12:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:12:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:12:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:12:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'tests': ['damp', 'tps']}, 05:12:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['damp', 'tps']}, 05:12:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:12:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:12:12 INFO - 'other': {'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore']}, 05:12:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore']}, 05:12:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore']}, 05:12:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore']}, 05:12:12 INFO - 'other_l64': {'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore']}, 05:12:12 INFO - 'other_nol64': {'tests': ['a11yr', 05:12:12 INFO - 'ts_paint', 05:12:12 INFO - 'tpaint', 05:12:12 INFO - 'sessionrestore', 05:12:12 INFO - 'sessionrestore_no_auto_restore']}, 05:12:12 INFO - 'svgr': {'tests': ['tsvgx', 05:12:12 INFO - 'tsvgr_opacity', 05:12:12 INFO - 'tart', 05:12:12 INFO - 'tscrollx', 05:12:12 INFO - 'cart']}, 05:12:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tsvgx', 05:12:12 INFO - 'tsvgr_opacity', 05:12:12 INFO - 'tart', 05:12:12 INFO - 'tscrollx', 05:12:12 INFO - 'cart']}, 05:12:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'tests': ['tp5o']}, 05:12:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s'], 05:12:12 INFO - 'tests': ['tp5o']}, 05:12:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--xperf_path', 05:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:12 INFO - 'tests': ['tp5n']}, 05:12:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:12 INFO - 'talos_options': ['--e10s', 05:12:12 INFO - '--xperf_path', 05:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:12 INFO - 'tests': ['tp5n']}}, 05:12:12 INFO - 'talos.zip': {'path': '', 05:12:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:12:12 INFO - Running post-action listener: _resource_record_post_action 05:12:12 INFO - ##### 05:12:12 INFO - ##### Running create-virtualenv step. 05:12:12 INFO - ##### 05:12:12 INFO - Running pre-action listener: _resource_record_pre_action 05:12:12 INFO - Running main action method: create_virtualenv 05:12:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:12:12 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 05:12:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:12:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:12:12 INFO - Using real prefix '/usr' 05:12:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:12:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:12:14 INFO - Installing pip.................done. 05:12:14 INFO - Return code: 0 05:12:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:14 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:14 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 05:12:14 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 05:12:14 INFO - Using env: {'DISPLAY': ':0', 05:12:14 INFO - 'HOME': '/home/cltbld', 05:12:14 INFO - 'LANG': 'en_US.UTF-8', 05:12:14 INFO - 'LANGUAGE': 'en_US:en', 05:12:14 INFO - 'LOGNAME': 'cltbld', 05:12:14 INFO - 'MAIL': '/var/mail/cltbld', 05:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:14 INFO - 'MOZ_NO_REMOTE': '1', 05:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:14 INFO - 'NO_EM_RESTART': '1', 05:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:14 INFO - 'PWD': '/builds/slave/test', 05:12:14 INFO - 'SHELL': '/bin/bash', 05:12:14 INFO - 'SHLVL': '1', 05:12:14 INFO - 'TERM': 'linux', 05:12:14 INFO - 'TMOUT': '86400', 05:12:14 INFO - 'USER': 'cltbld', 05:12:14 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:14 INFO - '_': '/tools/buildbot/bin/python'} 05:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:15 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 05:12:15 INFO - Cleaning up... 05:12:15 INFO - Return code: 0 05:12:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:15 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 05:12:15 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 05:12:15 INFO - Using env: {'DISPLAY': ':0', 05:12:15 INFO - 'HOME': '/home/cltbld', 05:12:15 INFO - 'LANG': 'en_US.UTF-8', 05:12:15 INFO - 'LANGUAGE': 'en_US:en', 05:12:15 INFO - 'LOGNAME': 'cltbld', 05:12:15 INFO - 'MAIL': '/var/mail/cltbld', 05:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:15 INFO - 'MOZ_NO_REMOTE': '1', 05:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:15 INFO - 'NO_EM_RESTART': '1', 05:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:15 INFO - 'PWD': '/builds/slave/test', 05:12:15 INFO - 'SHELL': '/bin/bash', 05:12:15 INFO - 'SHLVL': '1', 05:12:15 INFO - 'TERM': 'linux', 05:12:15 INFO - 'TMOUT': '86400', 05:12:15 INFO - 'USER': 'cltbld', 05:12:15 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:15 INFO - '_': '/tools/buildbot/bin/python'} 05:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:15 INFO - Downloading/unpacking psutil>=0.7.1 05:12:15 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 05:12:15 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 05:12:15 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 05:12:15 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 05:12:15 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 05:12:15 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 05:12:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:12:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:12:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:17 INFO - Installing collected packages: psutil 05:12:17 INFO - Running setup.py install for psutil 05:12:17 INFO - building 'psutil._psutil_linux' extension 05:12:17 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 05:12:18 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 05:12:18 INFO - building 'psutil._psutil_posix' extension 05:12:18 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 05:12:18 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 05:12:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:18 INFO - Successfully installed psutil 05:12:18 INFO - Cleaning up... 05:12:18 INFO - Return code: 0 05:12:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:12:18 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')]} 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:18 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')]} 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:18 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:18 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 05:12:18 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 05:12:18 INFO - Using env: {'DISPLAY': ':0', 05:12:18 INFO - 'HOME': '/home/cltbld', 05:12:18 INFO - 'LANG': 'en_US.UTF-8', 05:12:18 INFO - 'LANGUAGE': 'en_US:en', 05:12:18 INFO - 'LOGNAME': 'cltbld', 05:12:18 INFO - 'MAIL': '/var/mail/cltbld', 05:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:18 INFO - 'MOZ_NO_REMOTE': '1', 05:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:18 INFO - 'NO_EM_RESTART': '1', 05:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:18 INFO - 'PWD': '/builds/slave/test', 05:12:18 INFO - 'SHELL': '/bin/bash', 05:12:18 INFO - 'SHLVL': '1', 05:12:18 INFO - 'TERM': 'linux', 05:12:18 INFO - 'TMOUT': '86400', 05:12:18 INFO - 'USER': 'cltbld', 05:12:18 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:18 INFO - '_': '/tools/buildbot/bin/python'} 05:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:12:18 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 05:12:18 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 05:12:18 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 05:12:18 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 05:12:18 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 05:12:18 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 05:12:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:12:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:12:20 INFO - Installing collected packages: mozsystemmonitor 05:12:20 INFO - Running setup.py install for mozsystemmonitor 05:12:20 INFO - Successfully installed mozsystemmonitor 05:12:20 INFO - Cleaning up... 05:12:20 INFO - Return code: 0 05:12:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:20 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:20 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 05:12:20 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 05:12:20 INFO - Using env: {'DISPLAY': ':0', 05:12:20 INFO - 'HOME': '/home/cltbld', 05:12:20 INFO - 'LANG': 'en_US.UTF-8', 05:12:20 INFO - 'LANGUAGE': 'en_US:en', 05:12:20 INFO - 'LOGNAME': 'cltbld', 05:12:20 INFO - 'MAIL': '/var/mail/cltbld', 05:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:20 INFO - 'MOZ_NO_REMOTE': '1', 05:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:20 INFO - 'NO_EM_RESTART': '1', 05:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:20 INFO - 'PWD': '/builds/slave/test', 05:12:20 INFO - 'SHELL': '/bin/bash', 05:12:20 INFO - 'SHLVL': '1', 05:12:20 INFO - 'TERM': 'linux', 05:12:20 INFO - 'TMOUT': '86400', 05:12:20 INFO - 'USER': 'cltbld', 05:12:20 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:20 INFO - '_': '/tools/buildbot/bin/python'} 05:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:12:20 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 05:12:20 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 05:12:20 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 05:12:20 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 05:12:20 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 05:12:20 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 05:12:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:22 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 05:12:22 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 05:12:22 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 05:12:22 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 05:12:22 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 05:12:22 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 05:12:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:23 INFO - Downloading docopt-0.6.1.tar.gz 05:12:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:23 INFO - Running setup.py install for blobuploader 05:12:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:23 INFO - Running setup.py install for requests 05:12:23 INFO - Running setup.py install for docopt 05:12:23 INFO - Successfully installed blobuploader requests docopt 05:12:23 INFO - Cleaning up... 05:12:23 INFO - Return code: 0 05:12:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:23 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:23 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 05:12:23 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 05:12:23 INFO - Using env: {'DISPLAY': ':0', 05:12:23 INFO - 'HOME': '/home/cltbld', 05:12:23 INFO - 'LANG': 'en_US.UTF-8', 05:12:23 INFO - 'LANGUAGE': 'en_US:en', 05:12:23 INFO - 'LOGNAME': 'cltbld', 05:12:23 INFO - 'MAIL': '/var/mail/cltbld', 05:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:23 INFO - 'MOZ_NO_REMOTE': '1', 05:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:23 INFO - 'NO_EM_RESTART': '1', 05:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:23 INFO - 'PWD': '/builds/slave/test', 05:12:23 INFO - 'SHELL': '/bin/bash', 05:12:23 INFO - 'SHLVL': '1', 05:12:23 INFO - 'TERM': 'linux', 05:12:23 INFO - 'TMOUT': '86400', 05:12:23 INFO - 'USER': 'cltbld', 05:12:23 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:23 INFO - '_': '/tools/buildbot/bin/python'} 05:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:24 INFO - Running setup.py (path:/tmp/pip-72qQfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:24 INFO - Running setup.py (path:/tmp/pip-MMesW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:24 INFO - Running setup.py (path:/tmp/pip-lki07Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:24 INFO - Running setup.py (path:/tmp/pip-0nNhqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:24 INFO - Running setup.py (path:/tmp/pip-vPfpeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:24 INFO - Running setup.py (path:/tmp/pip-MgUSXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:24 INFO - Running setup.py (path:/tmp/pip-GPyb5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:24 INFO - Running setup.py (path:/tmp/pip-6kSaQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:24 INFO - Running setup.py (path:/tmp/pip-jvkhPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:24 INFO - Running setup.py (path:/tmp/pip-Bd3e55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:24 INFO - Running setup.py (path:/tmp/pip-KHFynd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:24 INFO - Running setup.py (path:/tmp/pip-RMZNXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:25 INFO - Running setup.py (path:/tmp/pip-LTp4l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:25 INFO - Running setup.py (path:/tmp/pip-Hlfuz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:25 INFO - Running setup.py (path:/tmp/pip-PYLNwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:25 INFO - Running setup.py (path:/tmp/pip-Wh3sg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:25 INFO - Running setup.py (path:/tmp/pip-N4AoaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:25 INFO - Running setup.py install for manifestparser 05:12:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:25 INFO - Running setup.py install for mozcrash 05:12:25 INFO - Running setup.py install for mozdebug 05:12:25 INFO - Running setup.py install for mozdevice 05:12:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:25 INFO - Running setup.py install for mozfile 05:12:25 INFO - Running setup.py install for mozhttpd 05:12:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Running setup.py install for mozinfo 05:12:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Running setup.py install for mozInstall 05:12:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Running setup.py install for mozleak 05:12:26 INFO - Running setup.py install for mozlog 05:12:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Running setup.py install for moznetwork 05:12:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Running setup.py install for mozprocess 05:12:26 INFO - Running setup.py install for mozprofile 05:12:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Running setup.py install for mozrunner 05:12:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:26 INFO - Running setup.py install for mozscreenshot 05:12:26 INFO - Running setup.py install for moztest 05:12:27 INFO - Running setup.py install for mozversion 05:12:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:27 INFO - Cleaning up... 05:12:27 INFO - Return code: 0 05:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:27 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:27 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 05:12:27 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 05:12:27 INFO - Using env: {'DISPLAY': ':0', 05:12:27 INFO - 'HOME': '/home/cltbld', 05:12:27 INFO - 'LANG': 'en_US.UTF-8', 05:12:27 INFO - 'LANGUAGE': 'en_US:en', 05:12:27 INFO - 'LOGNAME': 'cltbld', 05:12:27 INFO - 'MAIL': '/var/mail/cltbld', 05:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:27 INFO - 'MOZ_NO_REMOTE': '1', 05:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:27 INFO - 'NO_EM_RESTART': '1', 05:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:27 INFO - 'PWD': '/builds/slave/test', 05:12:27 INFO - 'SHELL': '/bin/bash', 05:12:27 INFO - 'SHLVL': '1', 05:12:27 INFO - 'TERM': 'linux', 05:12:27 INFO - 'TMOUT': '86400', 05:12:27 INFO - 'USER': 'cltbld', 05:12:27 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:27 INFO - '_': '/tools/buildbot/bin/python'} 05:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:27 INFO - Running setup.py (path:/tmp/pip-NdSBDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:27 INFO - Running setup.py (path:/tmp/pip-ARuTJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:27 INFO - Running setup.py (path:/tmp/pip-VfD0Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:27 INFO - Running setup.py (path:/tmp/pip-JkeL5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:27 INFO - Running setup.py (path:/tmp/pip-eCjdKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:27 INFO - Running setup.py (path:/tmp/pip-nKNxd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:27 INFO - Running setup.py (path:/tmp/pip-KLfNnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:27 INFO - Running setup.py (path:/tmp/pip-WyMYQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:27 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)) 05:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:27 INFO - Running setup.py (path:/tmp/pip-uaQDh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:28 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)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:28 INFO - Running setup.py (path:/tmp/pip-WCZYl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:28 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)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:28 INFO - Running setup.py (path:/tmp/pip-pFVe37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:28 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)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:28 INFO - Running setup.py (path:/tmp/pip-rBpBgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:28 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)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:28 INFO - Running setup.py (path:/tmp/pip-IPbhxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:28 INFO - Running setup.py (path:/tmp/pip-9K7QIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:28 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)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:28 INFO - Running setup.py (path:/tmp/pip-fX3pOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:28 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)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:28 INFO - Running setup.py (path:/tmp/pip-kOeIkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:28 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)) 05:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:28 INFO - Running setup.py (path:/tmp/pip-x2p7RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:28 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)) 05:12:28 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)) 05:12:28 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)) 05:12:28 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)) 05:12:28 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)) 05:12:28 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)) 05:12:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:30 INFO - Downloading blessings-1.5.1.tar.gz 05:12:30 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 05:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:30 INFO - Installing collected packages: blessings 05:12:30 INFO - Running setup.py install for blessings 05:12:30 INFO - Successfully installed blessings 05:12:30 INFO - Cleaning up... 05:12:30 INFO - Return code: 0 05:12:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:30 INFO - Reading from file tmpfile_stdout 05:12:30 INFO - Current package versions: 05:12:30 INFO - argparse == 1.2.1 05:12:30 INFO - blessings == 1.5.1 05:12:30 INFO - blobuploader == 1.2.4 05:12:30 INFO - docopt == 0.6.1 05:12:30 INFO - manifestparser == 1.1 05:12:30 INFO - mozInstall == 1.12 05:12:30 INFO - mozcrash == 0.16 05:12:30 INFO - mozdebug == 0.1 05:12:30 INFO - mozdevice == 0.47 05:12:30 INFO - mozfile == 1.2 05:12:30 INFO - mozhttpd == 0.7 05:12:30 INFO - mozinfo == 0.9 05:12:30 INFO - mozleak == 0.1 05:12:30 INFO - mozlog == 3.1 05:12:30 INFO - moznetwork == 0.27 05:12:30 INFO - mozprocess == 0.22 05:12:30 INFO - mozprofile == 0.28 05:12:30 INFO - mozrunner == 6.11 05:12:30 INFO - mozscreenshot == 0.1 05:12:30 INFO - mozsystemmonitor == 0.0 05:12:30 INFO - moztest == 0.7 05:12:30 INFO - mozversion == 1.4 05:12:30 INFO - psutil == 3.1.1 05:12:30 INFO - requests == 1.2.3 05:12:30 INFO - wsgiref == 0.1.2 05:12:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:30 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')]} 05:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:30 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')]} 05:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:30 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:30 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 05:12:30 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 05:12:30 INFO - Using env: {'DISPLAY': ':0', 05:12:30 INFO - 'HOME': '/home/cltbld', 05:12:30 INFO - 'LANG': 'en_US.UTF-8', 05:12:30 INFO - 'LANGUAGE': 'en_US:en', 05:12:30 INFO - 'LOGNAME': 'cltbld', 05:12:30 INFO - 'MAIL': '/var/mail/cltbld', 05:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:30 INFO - 'MOZ_NO_REMOTE': '1', 05:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:30 INFO - 'NO_EM_RESTART': '1', 05:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:30 INFO - 'PWD': '/builds/slave/test', 05:12:30 INFO - 'SHELL': '/bin/bash', 05:12:30 INFO - 'SHLVL': '1', 05:12:30 INFO - 'TERM': 'linux', 05:12:30 INFO - 'TMOUT': '86400', 05:12:30 INFO - 'USER': 'cltbld', 05:12:30 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:30 INFO - '_': '/tools/buildbot/bin/python'} 05:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:12:30 INFO - Cleaning up... 05:12:31 INFO - Return code: 0 05:12:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:31 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:31 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 05:12:31 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 05:12:31 INFO - Using env: {'DISPLAY': ':0', 05:12:31 INFO - 'HOME': '/home/cltbld', 05:12:31 INFO - 'LANG': 'en_US.UTF-8', 05:12:31 INFO - 'LANGUAGE': 'en_US:en', 05:12:31 INFO - 'LOGNAME': 'cltbld', 05:12:31 INFO - 'MAIL': '/var/mail/cltbld', 05:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:31 INFO - 'MOZ_NO_REMOTE': '1', 05:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:31 INFO - 'NO_EM_RESTART': '1', 05:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:31 INFO - 'PWD': '/builds/slave/test', 05:12:31 INFO - 'SHELL': '/bin/bash', 05:12:31 INFO - 'SHLVL': '1', 05:12:31 INFO - 'TERM': 'linux', 05:12:31 INFO - 'TMOUT': '86400', 05:12:31 INFO - 'USER': 'cltbld', 05:12:31 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:31 INFO - '_': '/tools/buildbot/bin/python'} 05:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:31 INFO - Downloading/unpacking jsonschema 05:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:32 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 05:12:32 INFO - Downloading/unpacking functools32 (from jsonschema) 05:12:32 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 05:12:32 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 05:12:32 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 05:12:32 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 05:12:32 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 05:12:32 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 05:12:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:33 INFO - warning: no files found matching '*.txt' 05:12:33 INFO - no previously-included directories found matching 'build' 05:12:33 INFO - no previously-included directories found matching 'dist' 05:12:33 INFO - no previously-included directories found matching '.git*' 05:12:33 INFO - Installing collected packages: jsonschema, functools32 05:12:33 INFO - Running setup.py install for functools32 05:12:33 INFO - warning: no files found matching '*.txt' 05:12:33 INFO - no previously-included directories found matching 'build' 05:12:33 INFO - no previously-included directories found matching 'dist' 05:12:33 INFO - no previously-included directories found matching '.git*' 05:12:33 INFO - Successfully installed jsonschema functools32 05:12:33 INFO - Cleaning up... 05:12:33 INFO - Return code: 0 05:12:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:33 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 0x7f27336fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', '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 05:12:33 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 05:12:33 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 05:12:33 INFO - Using env: {'DISPLAY': ':0', 05:12:33 INFO - 'HOME': '/home/cltbld', 05:12:33 INFO - 'LANG': 'en_US.UTF-8', 05:12:33 INFO - 'LANGUAGE': 'en_US:en', 05:12:33 INFO - 'LOGNAME': 'cltbld', 05:12:33 INFO - 'MAIL': '/var/mail/cltbld', 05:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:33 INFO - 'MOZ_NO_REMOTE': '1', 05:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:33 INFO - 'NO_EM_RESTART': '1', 05:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:33 INFO - 'PWD': '/builds/slave/test', 05:12:33 INFO - 'SHELL': '/bin/bash', 05:12:33 INFO - 'SHLVL': '1', 05:12:33 INFO - 'TERM': 'linux', 05:12:33 INFO - 'TMOUT': '86400', 05:12:33 INFO - 'USER': 'cltbld', 05:12:33 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:33 INFO - '_': '/tools/buildbot/bin/python'} 05:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:33 INFO - Downloading/unpacking flake8 05:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:12:35 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 05:12:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:12:35 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 05:12:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:35 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 05:12:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:12:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:35 INFO - no previously-included directories found matching 'docs/_build' 05:12:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:12:35 INFO - Running setup.py install for pep8 05:12:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:36 INFO - no previously-included directories found matching 'docs/_build' 05:12:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:12:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:12:36 INFO - Cleaning up... 05:12:36 INFO - Return code: 0 05:12:36 INFO - Running post-action listener: _resource_record_post_action 05:12:36 INFO - Running post-action listener: _start_resource_monitoring 05:12:36 INFO - Starting resource monitoring. 05:12:36 INFO - ##### 05:12:36 INFO - ##### Running install step. 05:12:36 INFO - ##### 05:12:36 INFO - Running pre-action listener: _resource_record_pre_action 05:12:36 INFO - Running main action method: install 05:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:36 INFO - Reading from file tmpfile_stdout 05:12:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:36 INFO - Reading from file tmpfile_stdout 05:12:36 INFO - Output received: 05:12:36 INFO - Usage: mozinstall [options] installer 05:12:36 INFO - Options: 05:12:36 INFO - -h, --help show this help message and exit 05:12:36 INFO - -d DEST, --destination=DEST 05:12:36 INFO - Directory to install application into. [default: 05:12:36 INFO - "/builds/slave/test"] 05:12:36 INFO - --app=APP Application being installed. [default: firefox] 05:12:36 INFO - mkdir: /builds/slave/test/build/application 05:12:36 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'] 05:12:36 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 05:12:51 INFO - Reading from file tmpfile_stdout 05:12:51 INFO - Output received: 05:12:51 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:51 INFO - Running post-action listener: _resource_record_post_action 05:12:51 INFO - ##### 05:12:51 INFO - ##### Running run-tests step. 05:12:51 INFO - ##### 05:12:51 INFO - Running pre-action listener: _resource_record_pre_action 05:12:51 INFO - Running main action method: run_tests 05:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:51 INFO - Python 2.7.3 05:12:51 INFO - Return code: 0 05:12:51 INFO - grabbing minidump binary from tooltool 05:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:51 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 0x283a3d0>, '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 0x27a5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:51 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 05:12:51 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 05:12:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:52 INFO - Return code: 0 05:12:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:12:53 INFO - Return code: 0 05:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:12:53 INFO - Using env: {'DISPLAY': ':0', 05:12:53 INFO - 'HOME': '/home/cltbld', 05:12:53 INFO - 'LANG': 'en_US.UTF-8', 05:12:53 INFO - 'LANGUAGE': 'en_US:en', 05:12:53 INFO - 'LOGNAME': 'cltbld', 05:12:53 INFO - 'MAIL': '/var/mail/cltbld', 05:12:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:53 INFO - 'MOZ_NO_REMOTE': '1', 05:12:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:53 INFO - 'NO_EM_RESTART': '1', 05:12:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:53 INFO - 'PWD': '/builds/slave/test', 05:12:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:53 INFO - 'SHELL': '/bin/bash', 05:12:53 INFO - 'SHLVL': '1', 05:12:53 INFO - 'TERM': 'linux', 05:12:53 INFO - 'TMOUT': '86400', 05:12:53 INFO - 'USER': 'cltbld', 05:12:53 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518', 05:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:53 INFO - '_': '/tools/buildbot/bin/python'} 05:12:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:12:53 INFO - mozversion application_buildid: 20151221044428 05:12:53 INFO - mozversion application_changeset: fd7f6a9dcfad66d79b0e28d964c49529588aecf4 05:12:53 INFO - mozversion application_display_name: Nightly 05:12:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:53 INFO - mozversion application_name: Firefox 05:12:53 INFO - mozversion application_remotingname: firefox 05:12:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:12:53 INFO - mozversion application_vendor: Mozilla 05:12:53 INFO - mozversion application_version: 46.0a1 05:12:53 INFO - mozversion platform_buildid: 20151221044428 05:12:53 INFO - mozversion platform_changeset: fd7f6a9dcfad66d79b0e28d964c49529588aecf4 05:12:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:12:53 INFO - mozversion platform_version: 46.0a1 05:12:53 INFO - using testdate: 1450703573 05:12:53 INFO - actual date: 1450703573 05:12:53 INFO - starting webserver on 'localhost:46803' 05:12:53 INFO - SUITE-START | Running 3 tests 05:12:53 INFO - TEST-START | dromaeo_css 05:12:53 INFO - operating with platform_type : linux_ 05:12:53 INFO - Initialising browser for dromaeo_css test... 05:12:53 INFO - TEST-INFO | started process 3406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGw_1hY/profile http://localhost:46803/getInfo.html) 05:12:59 INFO - PROCESS | 3406 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:12:59 INFO - PROCESS | 3406 | __metrics Screen width/height:1600/1200 05:12:59 INFO - PROCESS | 3406 | colorDepth:24 05:12:59 INFO - PROCESS | 3406 | Browser inner width/height: 1024/697 05:12:59 INFO - PROCESS | 3406 | __metrics 05:12:59 INFO - PROCESS | 3406 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:12:59 INFO - PROCESS | 3406 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:00 INFO - TEST-INFO | 3406: exit 0 05:13:00 INFO - Browser initialized. 05:13:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:13:00 INFO - TEST-INFO | started process 3500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGw_1hY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:12 INFO - PROCESS | 3500 | RSS: Main: 150114304 05:13:12 INFO - PROCESS | 3500 | 05:14:04 INFO - PROCESS | 3500 | 1450703644226 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] 05:16:16 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46803/tests/dromaeo/cssquery-ext.html) 05:16:17 INFO - PROCESS | 3500 | RSS: Main: 319803392 05:16:17 INFO - PROCESS | 3500 | 05:19:20 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-ext.html (next: http://localhost:46803/tests/dromaeo/cssquery-jquery.html) 05:19:21 INFO - PROCESS | 3500 | RSS: Main: 231563264 05:19:21 INFO - PROCESS | 3500 | 05:22:23 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46803/tests/dromaeo/cssquery-mootools.html) 05:22:23 INFO - PROCESS | 3500 | RSS: Main: 223580160 05:22:23 INFO - PROCESS | 3500 | 05:25:25 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46803/tests/dromaeo/cssquery-prototype.html) 05:25:26 INFO - PROCESS | 3500 | RSS: Main: 210243584 05:25:26 INFO - PROCESS | 3500 | 05:28:28 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46803/tests/dromaeo/cssquery-yui.html) 05:28:29 INFO - PROCESS | 3500 | RSS: Main: 212881408 05:28:29 INFO - PROCESS | 3500 | 05:31:31 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-yui.html (next: http://localhost:46803/tests/dromaeo/cssquery-dojo.html) 05:31:32 INFO - PROCESS | 3500 | RSS: Main: 253612032 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | __start_tp_report 05:31:32 INFO - PROCESS | 3500 | _x_x_mozilla_page_load 05:31:32 INFO - PROCESS | 3500 | _x_x_mozilla_page_load_details 05:31:32 INFO - PROCESS | 3500 | |i|pagename|runs| 05:31:32 INFO - PROCESS | 3500 | |0;dojo.html;2583.1217386088733;2673.9866300668496;2688.2472907585857;2700.9054683086097;2707.2149076767732;4454.777261136938;4575.88560285993;4614.930776038362;4674.929876051858;4684.554967278107;4567.931481027787;4601.79291931863;4654.767261636922;4655.348251244828;4742.122707299152;4149.502059752834;4306.2464068787995;4311.439512863323;4313.503947046082;4335.393044973691;4343.370211319372;4357.302831546953;4367.213901497729;4377.365282034119;4421.182081314967;4077.245709543729;4185.97907010463;4188.6649068074485;4191.538930717618;4295.656347492224;4279.550647182032;4279.87160385189;4281.935770963438;4293.420388247578;4319.956800432018;4243.957560424418;4252.468441444819;4254.574542545752;4302.784860756981;4304.418903448026;4428.114377124588;4543.727376357429;4547.067851090518;4568.680192386534;4722.645801564897;4942.0610084084265;4983.676061056056;4984.102861484931;4986.650934434591;5031.371078615173;5009.874753131165;5013.5989120870245;5016.072026675077;5018.64869459138;5021.723805190713;4489.236829738952;4547.204239258117;4601.677882548256;4607.193741095362;4650.37219975299;5081.923771143362;5108.61685373591;5109.131447653907;5109.156989096832;5112.590992720573;4876.756162191876;4890.290907818347;4926.187179115406;4931.753412329441;4935;4844.394450693663;4958.975205123951;4959.305697202394;4963.6525443218625;5118.436971933084;4929.383827021622;4943.085529177042;4953.306537084811;4961.627877909171;4987.1771157759285;4923.606111511071;4923.901521969612;4927.827526036572;4928.137575924199;4977.925331120036;3995.700322475826;4095.97952010244;4100.569440208735;4149.875503734893;4193.35003074524;3560.9851192410038;3617.4212126059706;3623.221007483404;3652.5069115669576;3653.725970552219;4314.115606300701;4327.632151267115;4350.390945267665;4392.363107349416;4396;4801.327814105958;4919.778609962489;4922.0648076866;4993.425756038029;5048.570871475892;4131.793410329532;4194.832206711759;4198.202341555156;4230.746155230696;4248.1078973415315;4415.624671902924;4450.643948484114;4452.8218871245435;4453.15390075891;4484.573965473275;4567.840125595588;4690.460597031385;4691.272852707836;4790.353302304214;4844.442889067803;4937.679050861826;5021.72380519075;5038.722870242172;5042.520960508746;5084.186530155157;4814.085323788469;4820.276958456259;4823.662343635911;4824.734639594715;4866.926996095132;4732.976335118303;4849.951500485091;4852.320675105418;4974.925376119433;5027.748612569284;4925.236588328815;4939.036887806843;4941.258811178352;4967.379077615298;4968.130577148912;4711.481737008995;4749.810007599795;4758.7858546364805;4759.6668233223345;4763.071201115749;4753.287006948985;4757.072370887644;4833.95166048335;4835.782389792397;4883.584895283941;4763.7618119094595;4799.3041009052795;4801.735904525284;4807.927881081717;4816.301636262652;4657.115148121846;4909.312696222603;4916.287138364989;4916.508349165055;4959.801607935787;4645.2103142465185;4664.463586687574;4671.43942726875;4778.092162489116;4814.085323788469 05:31:32 INFO - PROCESS | 3500 | |1;ext.html;518.8728761453443;525.2305372629099;525.8553897678138;545.8526197926558;552.6490678419202;26325.868370658143;34528.82735586321;35023.4746478803;35165.824170879176;35167.4724879127;39390.60609393905;40098.39852402209;40102.59897401025;40182.79908600453;40200.79899600498;7011.544249623784;7132.037174981363;7824.178461261557;7988.520688758693;7996.600169991506;9966.601335946554;10099.54552045156;10107.191424686007;10126.594936202542;10183.949080254588;9821;9911.653092141776;9913.405195688281;9918.454485003322;9927.900720992806;7131.500794944356;7309.488335816495;9833.852492212587;9949.950250248703;10203.6428724995;9738.269629777795;9914.958929312463;9916.851247231298;9921.355111917703;9922.603095876228;36998.07504812374;37383.252334953424;37504.43743343852;37544.43683344752;37590.62409375926;2693.6498255226893;2783.151138902634;2978.3596526746637;3292.1275861896615;3352.8491217895253;26078.34804129912;26289.868550657317;26339.473210535874;26347.57481527408;27065.1880443587;3262.8042317461027;3297.686719761619;3299.78551394161;3319.2531680371962;3341.248219150696;206521;209204;210466.9476652622;210539;210835;47961.760191198824;49088.50911490911;55472.72263638737;55869.44130558642;55907.72046139743;66250.66874665595;67971;67979.3202067973;68026;68083.3191668087;14300.85699143016;14629.414823407158;14739.484118055816;14742;14742.11547307165;10962.890371096188;11260.774784504429;11288.98399144081;11289.661310160709;11304.943475282735;18957.905210474135;19279;19318.13068411925;19394.515137121685;19412.417627471197;7485.737999170003;7792.766217013499;7813.1796161402235;7851.646675899484;7916.129225785159;790.5888937752452;807.6163822184416;940.5062342270363;946.068122898944;975.2149519636619;24827.62758558623;25156.74843251544;25654.615180772304;25776.48447031049;25821.612675809876;973.3770386952356;984.3995162950595;992.9751756206008;1045.3466583385384;1061.273027975839;13349.265790381429;15442.691146177014;15546.455874044354;16209.67580648404;16515.33938642465;305840.4707976446;312476;315107;315255;316968;45239.77380113144;45384;45511.317330240076;45610;45617.08765824665;1210.406900618708;1216.1061619709506;1226.3132645718426;1243.9315837629017;1362.9913863740958;25355.366115846515;27038.72961270362;28292.292692682848;30360.392792143593;30884.845575772877;42481.57518424776;42925.57074429341;42970;43165;43183.35224971691;236073;239553;240259;240452;240619;24074.759252407253;24470.143544976552;28102.43795124127;28148.577771333858;28260.85869570639;32566.674333256364;32860.83569582232;32878.1780455481;32956.1760955978;33238.00285991424;28573.571396429485;28701.99543016068;37281.62718372782;38247;38711;32036.718531258488;32970.340593188484;33142.5028624566;33372.833135835135;37229.81385093057;32705.836470817492;33313.333733325686;33461.66538334683;33546.329073418885;33771.66228337685;29382;30242;30644.693553064182;30739.385212296078;30901.69098308988;23249.18627848017;23465.178718745447;23557.411064723517;23630.645540316564;23855 05:31:32 INFO - PROCESS | 3500 | |2;jquery.html;299.9880004799808;304.9405365953639;307.11091390424707;315.87522928443263;318.5126756063223;12430.192037517554;12777.29724865132;15508;15775.447859324911;16012.279447424864;9797.314188006825;10063.04401081898;10066.39601623903;14690.192039437827;15173.393064277416;4312.784360781956;4516.345129956155;4525.9547404525865;4527.29826876833;4531.886702832423;3434.055634700465;3530.117470632342;3532.5231093802263;3534.0104770664257;4877.829275975341;3517.8416971236356;3531.470279458076;4940.135476291653;5099.235114732783;5115.641905066647;4941.604671626279;5092.465291144432;5095.235714642815;5223.843284701465;5224.895502089975;4926.3842019747535;5017.749112544395;5020.748962551857;5021.548060674557;5023.120953833101;17204.311827526883;17424.65150696979;17784.822151778448;17798;18818;1680.7899012623423;1714.1086634949881;1729.0922265810425;1789.7046987247088;1841.9355322563647;8229;8782.60478278479;8949.105089491064;10638.468076596217;12454.937725311316;1699.8780804668859;1707.8292170782822;1722.4488163787594;1723.6294196747633;1770.4157627982736;52988;54074.72962635201;54286;54637.9999999996;55812.72093639546;9325.720228393158;9447.866256049318;9493.24054075686;9518.381305215138;9520.8571871422;11778.587749428729;11949.641510754518;12021.819672704916;12035.578754743718;12040.096992725405;7177.7487787927175;7183.389411899942;7192.748253811092;7207.13514378278;7264.782056538313;6955.965220173968;6964.65176741171;6991.8601627967155;7014.333638304353;7029.0862187915245;3924.7841368724994;3971.146203566247;4002.199010445253;4014.5748259367506;4035.53591337;1526.3970731561194;1576.0535738363112;1627.983720162807;1649.7544354012884;1661.5846038490376;836.3810780022861;896.0949441064441;898.2679116520015;933.3000249812641;986.9161121304769;15018.174000429863;15474.148921809408;15714.449994250375;15753.921230394004;15813.1302778346;807.3460496997451;824.294365337968;853.9871901921476;882.7572417585216;898.4384759525296;8116.513009219466;8458.281046111026;8495.235428811437;8530.957345213234;8559.358048146414;321984.0214380717;326002;328764.49324274017;422091;487547;36618.26763464769;36624.81687591545;46616.533834661896;52500.47499525032;61188.38811611827;1032.6230925712061;1047.1884289675563;1064.4784055812595;1065.8134826405503;1069.4866464097277;13313.866861331262;14345;14411.639709007359;14476.927615361856;14736.189509577076;32209.838950805097;32235.516467252542;32768.836155819066;33106.83446582752;33746.32507349888;40797.79601101975;41166.382504263056;41832.58167418287;41894.790526047174;44542.55457445384;2420.52799704056;2452.5094981003513;2456.5946618807698;8197.672093116209;8537.676660117691;10284;10399.428031458343;15060.246987650793;15074.849251507345;16582.834171658127;13238.53665121716;13280.601581952556;13437.126586771828;13555.728885422433;13646.113002654796;12736.61790146297;12826.743465130832;12998.80501792455;13306.733865322833;13547.729045419233;12736.299503527025;12836.42236099359;12908.41912113976;13054.412551435018;13532.052756306965;8171.101178870201;8424.326053915795;8674.219320261207;8735.606897689491;8802.427842190236;11453.312801231952;13024.41390137465;13103.541376051793;13415.731685366432;13763.243021633505 05:31:32 INFO - PROCESS | 3500 | |3;mootools.html;1275.8213850061;1629.2912583026384;1698.2697440100756;1711.152979275258;1741.4340339389694;5929.080992446173;6996.720131194753;7235.240299768528;7238.7466438674655;7251.637418129086;6979.092717946673;7172.426205903528;7174.1032370953635;7174.282571742823;7176.138863336394;1774.7071733164012;1817.7727784026997;1818.2090790506106;2062.1648232465836;2104.326615483046;1819.7179437187192;1830.3685228596114;2077.6364136276165;2156.493224092337;2165.296278709418;2092.403664955488;2101.1175306371283;2103.978960210401;2106.062802053087;2110.9261175858846;2094;2111.1977448569523;2112.5458026524216;2114.164904862578;2115.8730476171477;2105.7788932162207;2108.5888251790907;2130.158587358;2172.9782702172934;2175.3908905506323;7137.179224389158;7175;7181.317774811385;7205.855882882313;7207.4594405419275;4275.572442755731;4330.545292744279;4336.262835318003;4346.804393802255;4347.847825326098;2759.530879750447;2776.972230277692;2797.776177905763;2880.510313246732;2887.422515496909;853.4836423963475;864.8270345930839;865.4374656473279;878.227160099115;882.5807741322884;9545.761355966088;9597;9598.568064437048;9605.471699056548;9620.518974051269;3929.057026313664;3980.383040628707;3990.780507072139;4016.9196616067516;4095.406166105898;8274.627641756135;8275.131111233355;8276.213759692819;8282.875756863652;8286.4613800104;4248.702590818675;4253.659707223414;4261.062566235423;4263.76549289792;4264.061906380592;3865.168988667394;3871.2064026874987;3879.515060617423;3881.4177873318663;3892.4355968384425;3417.470292104728;3451.741119416054;3474.3398754236614;3502.842372093262;3510.508528805969;961.5721004153224;976.2239019979133;1040.370575801629;1044.4621020174616;1054.6466933577185;754.1478129713389;763.171958425115;772.3705180278056;856.9271611913057;884.9292056635454;6675.833104172338;6721.7311307548125;6736.360045795642;6750;6753.1220941277315;1021.7598864266891;1024.2164743970868;1036.3937096798456;1049.186880167876;1055.8996895295088;5045.571126454292;5097.362829646294;5107.489251074937;5111.361079865017;5116.155834287375;8483.109273526314;8597.312215022783;8742.30061595071;8744.693935712347;8841.734747957571;8617.827643447095;8636.093210212963;8707.172818582225;8739.169778870997;8743.256823169975;6581.308962558863;6743.966280168666;6772.153480814898;6830.31696830313;6835.179778426621;6249.843753906189;6271.529635277281;6274.937250627435;6285.120083188266;6287.088372185916;7423.92576074254;7572.091349038151;7631.923680763343;7736.032995875516;7761.146273909978;7751.961240193763;7824.92175078242;7861.371090312876;7863.764087077397;8072.677092916452;6704.564203326768;6788.66056697173;6791.796246112624;6798.422134118655;6805;6023.247094113236;6347.39699728525;6435.935640643534;6440.452561532322;6690.765823196165;5681.801136960186;5800.883982320245;6006.489448396936;6334.271558770801;6376.52176086786;6188.783392581238;6232.688365581794;6237.251529816451;6273.937260627518;6296.401841825019;6294.496440284858;6335.049742538656;6337.904931426125;6339.461145802658;6344.429001389897;5355.169948657965;5632.436756324335;5638.548916086621;5638.956792993309;5653.349864765604;5718.79984200551;5745.683987380734;5755.8561035974435;5759.337676167294;5765.423457654201 05:31:32 INFO - PROCESS | 3500 | |4;prototype.html;287.45096864987875;288.96965818589047;294.929216987923;295.6998646373932;298.8535617547401;5270.525652691262;5304.92042619361;5346.652467589604;5414.729263536827;5420.512153906157;5290.629655924087;5297.841064768063;5302.257683924254;5302.522772950434;5308.5487733542695;4086.080631857823;4090.141070375225;4104.302268614328;4106.404571337154;4108.650764685005;4102.528209255929;4105.363668631352;4107.54816970133;4112.547619761824;4113.609207125318;3977;4038.5557588665224;4055.1889622075555;4067.1865626874596;4071.145059537501;4056.1887622475624;4057.898552536181;4058.228936502055;4066.7559946403017;4073.40935564343;3544.043108360728;3547.7693949893433;3549.2014296783277;3553.093961039944;3560.3235385276716;5045.344105266328;5072.873178170538;5082.288479612857;5083.389993200803;5084.56781173597;4648.697834640738;4689.7655117244;4691.788869500847;4693.155232058228;4694.976525117387;5365;5555.138953462179;5559.499645031926;5559.527440167591;5562.610617256793;3799.5820459749407;3802.9429558556367;3805.3721136012523;3806.8667596633986;3806.904827379338;5556.583256255797;5700.7719691212305;5749.1663708762;5782.335031471351;5870.178175055496;3905.062784931596;3907.648311651965;3918.45141680165;3923.1761330120426;3934.370500719871;3969.503812023497;3973.264945985002;3974.503187101612;3975.542812576533;3976.8608098716404;4323.459567554056;4400.9559904401185;4422.756748378806;4551.795169217393;4591.449026116888;5517.393086760453;5527.198556209327;5530.834074977757;5537.36320323168;5544.390117087117;1343.2880573296168;1358.8844948179317;1359.64649191211;1360.5986234060779;1361.7889227169806;913.3378300732049;923.344425457919;928.9024652411534;942.4816351006918;945.7919257763281;4904.386951631046;4911.238757992517;4914.92627610579;4921.557059864629;4928.827491037868;5739.253896993448;5744.339400968858;5746.080627099644;5752.108423194411;5752.942470575241;4905.9754701226975;4908.141075311878;4910.337104490848;4914.803407863646;4915.090708218991;3009.45829750647;3066.4020515999164;3098.7830851840154;3101.116181888151;3108.207407111172;5513.972430137824;5516.310461192351;5528.226048353234;5532.640378375393;5533.750981205855;5979.5515336349945;5982.790602328898;5984.820455386345;5986.610870293417;5990.73041713124;5525.11598144295;5528.419515950848;5529.695866727288;5529.723513824292;5533.916991245134;5644.209810626434;5806.303243610625;5821.679807610622;5823.097419899922;5824.5631577631;5672.149177623224;5674.2623458950075;5680.77276908919;5682.886342273048;5689.118186681071;5511.641743286674;5512.889742205213;5521.751521181637;5524.088525393265;5527;3749.4000959846294;3883.5728069912852;3927.3716205407;3928.5285765707154;3931.980340098281;5542.060278902352;5714.971425142848;5748.310202775694;5755.971220143872;5760.539156867357;5452.236686863763;5538.6399884007415;5564.4713752193475;5587.161925711176;5587.357453892854;5514.696691681996;5523.8895222096135;5562.471565201299;5593.972030139823;5594.244776955059;5392.056390131633;5441.047816632153;5476.479734425223;5490.066688662857;5508.228847961369;5525.0883604204855;5567.081431563909;5570.108782594765;5630.831075067755;5637.3235211774845;5432.402435731988;5442.727863606883;5447.836564903059;5452.100403433389;5453.454654534515 05:31:32 INFO - PROCESS | 3500 | |5;yui.html;617.7343742190859;650.7657243392377;739.7115125101208;777.3819813248467;786.382689588673;10445.37327760334;10499.475026248696;10504.527296271666;10556.841647375286;13784.931075344633;12180.81728774069;12200.93899530501;12224.51101955923;12304.630861074182;12310.692232694164;631.0408179567055;637.2480473041809;789.6920201121567;798.2974982015818;805.4361946637348;798.4730078148423;807.9798005049862;809.4697972827807;814.6782021101661;814.8736945773414;853.2747164909808;862.4178679391385;863.0334025890979;863.3783675753479;863.5725315968605;660.682872221334;669.0866966590618;831.3930830493773;844.0926004545139;851.2083762101244;631.728356806573;632.3170975346615;632.6615260835431;633.1547384242042;634.175571756719;12171.33057681827;12195.573154939624;12219.083568732292;12223.633291001284;12229.755404891941;10396.48017599117;10457.26799124054;10467.581296748122;10727.141828653688;11043.061339786127;9023.729288121367;9326.533673316375;9443.858342124873;9677.37097088687;9714.659986900495;3139.3250451153112;3198.1524895902603;3200.0559834848777;3244.643089260203;3250.0574833298315;38396;39136.60863391358;39319.803400983095;39373.212535749124;39395.40906886399;8550.315974722007;8571.142885711504;8990.730278091667;9018.659637509627;9426.717198484057;15688.215589220494;15733.213339332988;15762.054276743433;15801.920990394974;15812.841871581368;6263.655498947511;6272.153259310026;6536.411722944958;6593.428433725312;6731.091302674175;3713.8700145494777;3752.2870654575545;3778.0554861284677;3792.9241415172096;3793.7534060285993;2634.1702363755358;2663.2542887991394;2668.21287720123;2670.225634565993;2671.1051797648006;478.98216290382936;479.50371365637096;487.0648355158105;487.90485855257884;489.20504180706354;403.48555591620334;440.5308346610849;443.9378487011821;452.3373258176787;533.7384681506034;6911.965440172767;6981.2669669684965;7286.125664920138;7387.593682347415;7733.0524339895;553.8200084972319;554.5812911251979;567.8523583868224;580.1298052920619;591.7071049830275;3112.9533057004164;3176.6346870110233;3202.295494991098;3253.4957081652383;3278.606567211902;47854.760726196146;48687.51312486901;48779.51220487821;48813.511864881606;48875.266870996966;42804.143917122106;43551.78224108859;43864.12271754547;44401.55598443974;44590.55409445929;39878.60121398749;40264.59735402667;40555.1888962225;40903.590964090574;41148;6830.726770929107;6991.650417479004;7105.75129870452;7394.338118022243;7505.286997735207;30840.228994275323;31180.844095780285;31280.843595781877;32946;32991.50512742359;37269;39002.6099738999;39198.60801392064;39301;39654.2069158621;9075.818483630159;9121.635134594542;9128.634854606007;9355.48544830041;9413.85879211826;9799.804003919739;9950.900490995287;9992.400455972665;10023.54894029785;10142.137918277029;9037.728868133967;9239.953800230956;9255.86116208244;9279.257659387098;9370.718878433658;8453.95773021131;8487.193716596914;8685.131486851264;8820.25027872638;9131.5434228287;8416.579171041301;8707.91292087071;8862.379633425857;8868.423552469068;8890;8105.594720264081;8112.959435202786;8124.918750812416;8151.673933042849;8332.708355207538;7455.039577052787;7613.619319033915;7972.242636949481;8017.238362355567;8504.957475212585 05:31:32 INFO - PROCESS | 3500 | __end_tp_report 05:31:32 INFO - PROCESS | 3500 | __start_cc_report 05:31:32 INFO - PROCESS | 3500 | _x_x_mozilla_cycle_collect,1527 05:31:32 INFO - PROCESS | 3500 | __end_cc_report 05:31:32 INFO - PROCESS | 3500 | __startTimestamp1450704692174__endTimestamp 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | ------- Summary: start ------- 05:31:32 INFO - PROCESS | 3500 | Number of tests: 6 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | [#0] dojo.html Cycles:165 Average:4586.95 Median:4732.98 stddev:481.26 (10.2%) stddev-sans-first:456.34 05:31:32 INFO - PROCESS | 3500 | Values: 2583.1 2674.0 2688.2 2700.9 2707.2 4454.8 4575.9 4614.9 4674.9 4684.6 4567.9 4601.8 4654.8 4655.3 4742.1 4149.5 4306.2 4311.4 4313.5 4335.4 4343.4 4357.3 4367.2 4377.4 4421.2 4077.2 4186.0 4188.7 4191.5 4295.7 4279.6 4279.9 4281.9 4293.4 4320.0 4244.0 4252.5 4254.6 4302.8 4304.4 4428.1 4543.7 4547.1 4568.7 4722.6 4942.1 4983.7 4984.1 4986.7 5031.4 5009.9 5013.6 5016.1 5018.6 5021.7 4489.2 4547.2 4601.7 4607.2 4650.4 5081.9 5108.6 5109.1 5109.2 5112.6 4876.8 4890.3 4926.2 4931.8 4935.0 4844.4 4959.0 4959.3 4963.7 5118.4 4929.4 4943.1 4953.3 4961.6 4987.2 4923.6 4923.9 4927.8 4928.1 4977.9 3995.7 4096.0 4100.6 4149.9 4193.4 3561.0 3617.4 3623.2 3652.5 3653.7 4314.1 4327.6 4350.4 4392.4 4396.0 4801.3 4919.8 4922.1 4993.4 5048.6 4131.8 4194.8 4198.2 4230.7 4248.1 4415.6 4450.6 4452.8 4453.2 4484.6 4567.8 4690.5 4691.3 4790.4 4844.4 4937.7 5021.7 5038.7 5042.5 5084.2 4814.1 4820.3 4823.7 4824.7 4866.9 4733.0 4850.0 4852.3 4974.9 5027.7 4925.2 4939.0 4941.3 4967.4 4968.1 4711.5 4749.8 4758.8 4759.7 4763.1 4753.3 4757.1 4834.0 4835.8 4883.6 4763.8 4799.3 4801.7 4807.9 4816.3 4657.1 4909.3 4916.3 4916.5 4959.8 4645.2 4664.5 4671.4 4778.1 4814.1 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | [#1] ext.html Cycles:180 Average:41705.76 Median:18126.93 stddev:67357.05 (371.6%) stddev-sans-first:67475.01 05:31:32 INFO - PROCESS | 3500 | Values: 518.9 525.2 525.9 545.9 552.6 26325.9 34528.8 35023.5 35165.8 35167.5 39390.6 40098.4 40102.6 40182.8 40200.8 7011.5 7132.0 7824.2 7988.5 7996.6 9966.6 10099.5 10107.2 10126.6 10183.9 9821.0 9911.7 9913.4 9918.5 9927.9 7131.5 7309.5 9833.9 9950.0 10203.6 9738.3 9915.0 9916.9 9921.4 9922.6 36998.1 37383.3 37504.4 37544.4 37590.6 2693.6 2783.2 2978.4 3292.1 3352.8 26078.3 26289.9 26339.5 26347.6 27065.2 3262.8 3297.7 3299.8 3319.3 3341.2 206521.0 209204.0 210466.9 210539.0 210835.0 47961.8 49088.5 55472.7 55869.4 55907.7 66250.7 67971.0 67979.3 68026.0 68083.3 14300.9 14629.4 14739.5 14742.0 14742.1 10962.9 11260.8 11289.0 11289.7 11304.9 18957.9 19279.0 19318.1 19394.5 19412.4 7485.7 7792.8 7813.2 7851.6 7916.1 790.6 807.6 940.5 946.1 975.2 24827.6 25156.7 25654.6 25776.5 25821.6 973.4 984.4 993.0 1045.3 1061.3 13349.3 15442.7 15546.5 16209.7 16515.3 305840.5 312476.0 315107.0 315255.0 316968.0 45239.8 45384.0 45511.3 45610.0 45617.1 1210.4 1216.1 1226.3 1243.9 1363.0 25355.4 27038.7 28292.3 30360.4 30884.8 42481.6 42925.6 42970.0 43165.0 43183.4 236073.0 239553.0 240259.0 240452.0 240619.0 24074.8 24470.1 28102.4 28148.6 28260.9 32566.7 32860.8 32878.2 32956.2 33238.0 28573.6 28702.0 37281.6 38247.0 38711.0 32036.7 32970.3 33142.5 33372.8 37229.8 32705.8 33313.3 33461.7 33546.3 33771.7 29382.0 30242.0 30644.7 30739.4 30901.7 23249.2 23465.2 23557.4 23630.6 23855.0 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | [#2] jquery.html Cycles:180 Average:22097.51 Median:33426.58 stddev:62539.20 (187.1%) stddev-sans-first:62693.23 05:31:32 INFO - PROCESS | 3500 | Values: 300.0 304.9 307.1 315.9 318.5 12430.2 12777.3 15508.0 15775.4 16012.3 9797.3 10063.0 10066.4 14690.2 15173.4 4312.8 4516.3 4526.0 4527.3 4531.9 3434.1 3530.1 3532.5 3534.0 4877.8 3517.8 3531.5 4940.1 5099.2 5115.6 4941.6 5092.5 5095.2 5223.8 5224.9 4926.4 5017.7 5020.7 5021.5 5023.1 17204.3 17424.7 17784.8 17798.0 18818.0 1680.8 1714.1 1729.1 1789.7 1841.9 8229.0 8782.6 8949.1 10638.5 12454.9 1699.9 1707.8 1722.4 1723.6 1770.4 52988.0 54074.7 54286.0 54638.0 55812.7 9325.7 9447.9 9493.2 9518.4 9520.9 11778.6 11949.6 12021.8 12035.6 12040.1 7177.7 7183.4 7192.7 7207.1 7264.8 6956.0 6964.7 6991.9 7014.3 7029.1 3924.8 3971.1 4002.2 4014.6 4035.5 1526.4 1576.1 1628.0 1649.8 1661.6 836.4 896.1 898.3 933.3 986.9 15018.2 15474.1 15714.4 15753.9 15813.1 807.3 824.3 854.0 882.8 898.4 8116.5 8458.3 8495.2 8531.0 8559.4 321984.0 326002.0 328764.5 422091.0 487547.0 36618.3 36624.8 46616.5 52500.5 61188.4 1032.6 1047.2 1064.5 1065.8 1069.5 13313.9 14345.0 14411.6 14476.9 14736.2 32209.8 32235.5 32768.8 33106.8 33746.3 40797.8 41166.4 41832.6 41894.8 44542.6 2420.5 2452.5 2456.6 8197.7 8537.7 10284.0 10399.4 15060.2 15074.8 16582.8 13238.5 13280.6 13437.1 13555.7 13646.1 12736.6 12826.7 12998.8 13306.7 13547.7 12736.3 12836.4 12908.4 13054.4 13532.1 8171.1 8424.3 8674.2 8735.6 8802.4 11453.3 13024.4 13103.5 13415.7 13763.2 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | [#3] mootools.html Cycles:180 Average:4953.52 Median:6243.55 stddev:2574.10 (41.2%) stddev-sans-first:2566.48 05:31:32 INFO - PROCESS | 3500 | Values: 1275.8 1629.3 1698.3 1711.2 1741.4 5929.1 6996.7 7235.2 7238.7 7251.6 6979.1 7172.4 7174.1 7174.3 7176.1 1774.7 1817.8 1818.2 2062.2 2104.3 1819.7 1830.4 2077.6 2156.5 2165.3 2092.4 2101.1 2104.0 2106.1 2110.9 2094.0 2111.2 2112.5 2114.2 2115.9 2105.8 2108.6 2130.2 2173.0 2175.4 7137.2 7175.0 7181.3 7205.9 7207.5 4275.6 4330.5 4336.3 4346.8 4347.8 2759.5 2777.0 2797.8 2880.5 2887.4 853.5 864.8 865.4 878.2 882.6 9545.8 9597.0 9598.6 9605.5 9620.5 3929.1 3980.4 3990.8 4016.9 4095.4 8274.6 8275.1 8276.2 8282.9 8286.5 4248.7 4253.7 4261.1 4263.8 4264.1 3865.2 3871.2 3879.5 3881.4 3892.4 3417.5 3451.7 3474.3 3502.8 3510.5 961.6 976.2 1040.4 1044.5 1054.6 754.1 763.2 772.4 856.9 884.9 6675.8 6721.7 6736.4 6750.0 6753.1 1021.8 1024.2 1036.4 1049.2 1055.9 5045.6 5097.4 5107.5 5111.4 5116.2 8483.1 8597.3 8742.3 8744.7 8841.7 8617.8 8636.1 8707.2 8739.2 8743.3 6581.3 6744.0 6772.2 6830.3 6835.2 6249.8 6271.5 6274.9 6285.1 6287.1 7423.9 7572.1 7631.9 7736.0 7761.1 7752.0 7824.9 7861.4 7863.8 8072.7 6704.6 6788.7 6791.8 6798.4 6805.0 6023.2 6347.4 6435.9 6440.5 6690.8 5681.8 5800.9 6006.5 6334.3 6376.5 6188.8 6232.7 6237.3 6273.9 6296.4 6294.5 6335.0 6337.9 6339.5 6344.4 5355.2 5632.4 5638.5 5639.0 5653.3 5718.8 5745.7 5755.9 5759.3 5765.4 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | [#4] prototype.html Cycles:180 Average:4601.37 Median:5306.73 stddev:1372.43 (25.9%) stddev-sans-first:1337.54 05:31:32 INFO - PROCESS | 3500 | Values: 287.5 289.0 294.9 295.7 298.9 5270.5 5304.9 5346.7 5414.7 5420.5 5290.6 5297.8 5302.3 5302.5 5308.5 4086.1 4090.1 4104.3 4106.4 4108.7 4102.5 4105.4 4107.5 4112.5 4113.6 3977.0 4038.6 4055.2 4067.2 4071.1 4056.2 4057.9 4058.2 4066.8 4073.4 3544.0 3547.8 3549.2 3553.1 3560.3 5045.3 5072.9 5082.3 5083.4 5084.6 4648.7 4689.8 4691.8 4693.2 4695.0 5365.0 5555.1 5559.5 5559.5 5562.6 3799.6 3802.9 3805.4 3806.9 3806.9 5556.6 5700.8 5749.2 5782.3 5870.2 3905.1 3907.6 3918.5 3923.2 3934.4 3969.5 3973.3 3974.5 3975.5 3976.9 4323.5 4401.0 4422.8 4551.8 4591.4 5517.4 5527.2 5530.8 5537.4 5544.4 1343.3 1358.9 1359.6 1360.6 1361.8 913.3 923.3 928.9 942.5 945.8 4904.4 4911.2 4914.9 4921.6 4928.8 5739.3 5744.3 5746.1 5752.1 5752.9 4906.0 4908.1 4910.3 4914.8 4915.1 3009.5 3066.4 3098.8 3101.1 3108.2 5514.0 5516.3 5528.2 5532.6 5533.8 5979.6 5982.8 5984.8 5986.6 5990.7 5525.1 5528.4 5529.7 5529.7 5533.9 5644.2 5806.3 5821.7 5823.1 5824.6 5672.1 5674.3 5680.8 5682.9 5689.1 5511.6 5512.9 5521.8 5524.1 5527.0 3749.4 3883.6 3927.4 3928.5 3932.0 5542.1 5715.0 5748.3 5756.0 5760.5 5452.2 5538.6 5564.5 5587.2 5587.4 5514.7 5523.9 5562.5 5594.0 5594.2 5392.1 5441.0 5476.5 5490.1 5508.2 5525.1 5567.1 5570.1 5630.8 5637.3 5432.4 5442.7 5447.8 5452.1 5453.5 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - PROCESS | 3500 | [#5] yui.html Cycles:180 Average:11803.97 Median:585.92 stddev:13651.08 (2329.9%) stddev-sans-first:13663.53 05:31:32 INFO - PROCESS | 3500 | Values: 617.7 650.8 739.7 777.4 786.4 10445.4 10499.5 10504.5 10556.8 13784.9 12180.8 12200.9 12224.5 12304.6 12310.7 631.0 637.2 789.7 798.3 805.4 798.5 808.0 809.5 814.7 814.9 853.3 862.4 863.0 863.4 863.6 660.7 669.1 831.4 844.1 851.2 631.7 632.3 632.7 633.2 634.2 12171.3 12195.6 12219.1 12223.6 12229.8 10396.5 10457.3 10467.6 10727.1 11043.1 9023.7 9326.5 9443.9 9677.4 9714.7 3139.3 3198.2 3200.1 3244.6 3250.1 38396.0 39136.6 39319.8 39373.2 39395.4 8550.3 8571.1 8990.7 9018.7 9426.7 15688.2 15733.2 15762.1 15801.9 15812.8 6263.7 6272.2 6536.4 6593.4 6731.1 3713.9 3752.3 3778.1 3792.9 3793.8 2634.2 2663.3 2668.2 2670.2 2671.1 479.0 479.5 487.1 487.9 489.2 403.5 440.5 443.9 452.3 533.7 6912.0 6981.3 7286.1 7387.6 7733.1 553.8 554.6 567.9 580.1 591.7 3113.0 3176.6 3202.3 3253.5 3278.6 47854.8 48687.5 48779.5 48813.5 48875.3 42804.1 43551.8 43864.1 44401.6 44590.6 39878.6 40264.6 40555.2 40903.6 41148.0 6830.7 6991.7 7105.8 7394.3 7505.3 30840.2 31180.8 31280.8 32946.0 32991.5 37269.0 39002.6 39198.6 39301.0 39654.2 9075.8 9121.6 9128.6 9355.5 9413.9 9799.8 9950.9 9992.4 10023.5 10142.1 9037.7 9240.0 9255.9 9279.3 9370.7 8454.0 8487.2 8685.1 8820.3 9131.5 8416.6 8707.9 8862.4 8868.4 8890.0 8105.6 8113.0 8124.9 8151.7 8332.7 7455.0 7613.6 7972.2 8017.2 8505.0 05:31:32 INFO - PROCESS | 3500 | -------- Summary: end -------- 05:31:32 INFO - PROCESS | 3500 | 05:31:32 INFO - TEST-INFO | 3500: exit 0 05:31:32 INFO - TEST-OK | dromaeo_css | took 1119677ms 05:31:32 INFO - TEST-START | kraken 05:31:32 INFO - operating with platform_type : linux_ 05:31:32 INFO - Initialising browser for kraken test... 05:31:32 INFO - TEST-INFO | started process 3720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZMUiXA/profile http://localhost:46803/getInfo.html) 05:31:37 INFO - PROCESS | 3720 | __metrics Screen width/height:1600/1200 05:31:37 INFO - PROCESS | 3720 | colorDepth:24 05:31:37 INFO - PROCESS | 3720 | Browser inner width/height: 1024/697 05:31:37 INFO - PROCESS | 3720 | __metrics 05:31:37 INFO - PROCESS | 3720 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:31:37 INFO - PROCESS | 3720 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:38 INFO - TEST-INFO | 3720: exit 0 05:31:38 INFO - Browser initialized. 05:31:38 INFO - Running cycle 1/1 for kraken test... 05:31:38 INFO - TEST-INFO | started process 3803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZMUiXA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:50 INFO - PROCESS | 3803 | RSS: Main: 149983232 05:31:50 INFO - PROCESS | 3803 | 05:31:53 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:53 INFO - PROCESS | 3803 | RSS: Main: 184193024 05:31:53 INFO - PROCESS | 3803 | 05:31:56 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-dft) 05:31:56 INFO - PROCESS | 3803 | RSS: Main: 173805568 05:31:56 INFO - PROCESS | 3803 | 05:31:59 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-fft) 05:32:00 INFO - PROCESS | 3803 | RSS: Main: 160907264 05:32:00 INFO - PROCESS | 3803 | 05:32:02 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-oscillator) 05:32:03 INFO - PROCESS | 3803 | RSS: Main: 162529280 05:32:03 INFO - PROCESS | 3803 | 05:32:05 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:32:05 INFO - PROCESS | 3803 | RSS: Main: 165818368 05:32:05 INFO - PROCESS | 3803 | 05:32:08 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46803/tests/kraken/driver.html?testName=imaging-darkroom) 05:32:09 INFO - PROCESS | 3803 | RSS: Main: 163983360 05:32:09 INFO - PROCESS | 3803 | 05:32:12 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46803/tests/kraken/driver.html?testName=imaging-desaturate) 05:32:13 INFO - PROCESS | 3803 | RSS: Main: 165842944 05:32:13 INFO - PROCESS | 3803 | 05:32:16 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46803/tests/kraken/driver.html?testName=json-parse-financial) 05:32:16 INFO - PROCESS | 3803 | RSS: Main: 165023744 05:32:16 INFO - PROCESS | 3803 | 05:32:18 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:32:19 INFO - PROCESS | 3803 | RSS: Main: 176074752 05:32:19 INFO - PROCESS | 3803 | 05:32:20 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:32:21 INFO - PROCESS | 3803 | RSS: Main: 173719552 05:32:21 INFO - PROCESS | 3803 | 05:32:24 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:32:24 INFO - PROCESS | 3803 | RSS: Main: 190488576 05:32:24 INFO - PROCESS | 3803 | 05:32:27 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:27 INFO - PROCESS | 3803 | RSS: Main: 194535424 05:32:27 INFO - PROCESS | 3803 | 05:32:30 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:30 INFO - PROCESS | 3803 | RSS: Main: 193122304 05:32:30 INFO - PROCESS | 3803 | 05:32:32 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46803/tests/kraken/driver.html?testName=ai-astar) 05:32:32 INFO - PROCESS | 3803 | RSS: Main: 251265024 05:32:32 INFO - PROCESS | 3803 | 05:32:32 INFO - PROCESS | 3803 | __start_tp_report 05:32:32 INFO - PROCESS | 3803 | _x_x_mozilla_page_load 05:32:32 INFO - PROCESS | 3803 | _x_x_mozilla_page_load_details 05:32:32 INFO - PROCESS | 3803 | |i|pagename|runs| 05:32:32 INFO - PROCESS | 3803 | |0;ai-astar;110;112;105;111;111;112;103;110;110;102 05:32:32 INFO - PROCESS | 3803 | |1;audio-beat-detection;163;133;152;163;134;155;153;132;164;128 05:32:32 INFO - PROCESS | 3803 | |2;audio-dft;161;161;161;160;164;160;161;162;162;162 05:32:32 INFO - PROCESS | 3803 | |3;audio-fft;72;72;85;91;72;73;72;99;88;71 05:32:32 INFO - PROCESS | 3803 | |4;audio-oscillator;95;95;128;95;95;95;132;94;95;132 05:32:32 INFO - PROCESS | 3803 | |5;imaging-gaussian-blur;110;110;109;110;109;109;110;109;110;110 05:32:32 INFO - PROCESS | 3803 | |6;imaging-darkroom;146;147;146;147;146;145;146;146;146;145 05:32:32 INFO - PROCESS | 3803 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;96;95 05:32:32 INFO - PROCESS | 3803 | |8;json-parse-financial;70;70;70;70;72;70;72;79;67;67 05:32:32 INFO - PROCESS | 3803 | |9;json-stringify-tinderbox;69;69;68;68;67;69;68;68;68;68 05:32:32 INFO - PROCESS | 3803 | |10;stanford-crypto-aes;82;84;82;81;83;81;82;82;84;83 05:32:32 INFO - PROCESS | 3803 | |11;stanford-crypto-ccm;136;123;128;134;124;121;123;119;130;119 05:32:32 INFO - PROCESS | 3803 | |12;stanford-crypto-pbkdf2;140;150;147;147;156;136;147;147;147;140 05:32:32 INFO - PROCESS | 3803 | |13;stanford-crypto-sha256-iterative;68;69;71;69;69;68;70;69;68;68 05:32:32 INFO - PROCESS | 3803 | __end_tp_report 05:32:32 INFO - PROCESS | 3803 | __start_cc_report 05:32:32 INFO - PROCESS | 3803 | _x_x_mozilla_cycle_collect,1005 05:32:32 INFO - PROCESS | 3803 | __end_cc_report 05:32:32 INFO - PROCESS | 3803 | __startTimestamp1450704752991__endTimestamp 05:32:32 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | ------- Summary: start ------- 05:32:33 INFO - PROCESS | 3803 | Number of tests: 14 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:3.78 (3.4%) stddev-sans-first:3.97 05:32:33 INFO - PROCESS | 3803 | Values: 110.0 112.0 105.0 111.0 111.0 112.0 103.0 110.0 110.0 102.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:154.00 stddev:14.42 (9.4%) stddev-sans-first:14.20 05:32:33 INFO - PROCESS | 3803 | Values: 163.0 133.0 152.0 163.0 134.0 155.0 153.0 132.0 164.0 128.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 05:32:33 INFO - PROCESS | 3803 | Values: 161.0 161.0 161.0 160.0 164.0 160.0 161.0 162.0 162.0 162.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#3] audio-fft Cycles:10 Average:79.50 Median:79.00 stddev:10.30 (13.0%) stddev-sans-first:10.56 05:32:33 INFO - PROCESS | 3803 | Values: 72.0 72.0 85.0 91.0 72.0 73.0 72.0 99.0 88.0 71.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:95.00 stddev:17.33 (18.2%) stddev-sans-first:17.96 05:32:33 INFO - PROCESS | 3803 | Values: 95.0 95.0 128.0 95.0 95.0 95.0 132.0 94.0 95.0 132.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:32:33 INFO - PROCESS | 3803 | Values: 110.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:32:33 INFO - PROCESS | 3803 | Values: 146.0 147.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 145.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:32:33 INFO - PROCESS | 3803 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.00 stddev:3.37 (4.8%) stddev-sans-first:3.56 05:32:33 INFO - PROCESS | 3803 | Values: 70.0 70.0 70.0 70.0 72.0 70.0 72.0 79.0 67.0 67.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 05:32:33 INFO - PROCESS | 3803 | Values: 69.0 69.0 68.0 68.0 67.0 69.0 68.0 68.0 68.0 68.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.07 (1.3%) stddev-sans-first:1.13 05:32:33 INFO - PROCESS | 3803 | Values: 82.0 84.0 82.0 81.0 83.0 81.0 82.0 82.0 84.0 83.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:126.00 stddev:6.04 (4.8%) stddev-sans-first:5.13 05:32:33 INFO - PROCESS | 3803 | Values: 136.0 123.0 128.0 134.0 124.0 121.0 123.0 119.0 130.0 119.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:147.00 stddev:5.70 (3.9%) stddev-sans-first:5.66 05:32:33 INFO - PROCESS | 3803 | Values: 140.0 150.0 147.0 147.0 156.0 136.0 147.0 147.0 147.0 140.0 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - PROCESS | 3803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 05:32:33 INFO - PROCESS | 3803 | Values: 68.0 69.0 71.0 69.0 69.0 68.0 70.0 69.0 68.0 68.0 05:32:33 INFO - PROCESS | 3803 | -------- Summary: end -------- 05:32:33 INFO - PROCESS | 3803 | 05:32:33 INFO - TEST-INFO | 3803: exit 0 05:32:33 INFO - TEST-OK | kraken | took 61000ms 05:32:33 INFO - TEST-START | v8_7 05:32:33 INFO - operating with platform_type : linux_ 05:32:33 INFO - Initialising browser for v8_7 test... 05:32:33 INFO - TEST-INFO | started process 4049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqWrqfc/profile http://localhost:46803/getInfo.html) 05:32:38 INFO - PROCESS | 4049 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:32:38 INFO - PROCESS | 4049 | __metrics Screen width/height:1600/1200 05:32:38 INFO - PROCESS | 4049 | colorDepth:24 05:32:38 INFO - PROCESS | 4049 | Browser inner width/height: 1024/697 05:32:38 INFO - PROCESS | 4049 | __metrics 05:32:38 INFO - PROCESS | 4049 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:32:38 INFO - PROCESS | 4049 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:39 INFO - TEST-INFO | 4049: exit 0 05:32:39 INFO - Browser initialized. 05:32:39 INFO - Running cycle 1/1 for v8_7 test... 05:32:39 INFO - TEST-INFO | started process 4128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqWrqfc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:51 INFO - PROCESS | 4128 | RSS: Main: 149340160 05:32:51 INFO - PROCESS | 4128 | 05:33:12 INFO - PROCESS | 4128 | Cycle 1(1): loaded http://localhost:46803/tests/v8_7/run.html (next: http://localhost:46803/tests/v8_7/run.html) 05:33:13 INFO - PROCESS | 4128 | RSS: Main: 450326528 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | __start_tp_report 05:33:13 INFO - PROCESS | 4128 | _x_x_mozilla_page_load 05:33:13 INFO - PROCESS | 4128 | _x_x_mozilla_page_load_details 05:33:13 INFO - PROCESS | 4128 | |i|pagename|runs| 05:33:13 INFO - PROCESS | 4128 | |0;Richards;165.48072149594572 05:33:13 INFO - PROCESS | 4128 | |1;DeltaBlue;187.58206715438004 05:33:13 INFO - PROCESS | 4128 | |2;Encrypt;278.473962684489 05:33:13 INFO - PROCESS | 4128 | |3;Decrypt;5117.34693877551 05:33:13 INFO - PROCESS | 4128 | |4;RayTrace;1992.03187250996 05:33:13 INFO - PROCESS | 4128 | |5;Earley;784.9293563579278 05:33:13 INFO - PROCESS | 4128 | |6;Boyer;11964.285714285714 05:33:13 INFO - PROCESS | 4128 | |7;RegExp;27972.222222222223 05:33:13 INFO - PROCESS | 4128 | |8;Splay;605.3268765133172 05:33:13 INFO - PROCESS | 4128 | |9;NavierStokes;4835.748792270531 05:33:13 INFO - PROCESS | 4128 | __end_tp_report 05:33:13 INFO - PROCESS | 4128 | __startTimestamp1450704793186__endTimestamp 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | ------- Summary: start ------- 05:33:13 INFO - PROCESS | 4128 | Number of tests: 10 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#0] Richards Cycles:1 Average:165.48 Median:165.48 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 165.5 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#1] DeltaBlue Cycles:1 Average:187.58 Median:187.58 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 187.6 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 278.5 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 5117.3 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 1992.0 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 784.9 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 11964.3 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#7] RegExp Cycles:1 Average:27972.22 Median:27972.22 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 27972.2 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#8] Splay Cycles:1 Average:605.33 Median:605.33 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 605.3 05:33:13 INFO - PROCESS | 4128 | 05:33:13 INFO - PROCESS | 4128 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:33:13 INFO - PROCESS | 4128 | Values: 4835.7 05:33:13 INFO - PROCESS | 4128 | -------- Summary: end -------- 05:33:13 INFO - PROCESS | 4128 | 05:33:14 INFO - TEST-INFO | 4128: exit 0 05:33:14 INFO - TEST-OK | v8_7 | took 40225ms 05:33:14 INFO - SUITE-END | took 1220s 05:33:14 INFO - Completed test suite (00:20:20) 05:33:14 INFO - Working with test: dromaeo_css 05:33:14 INFO - Generating results file: dromaeo_css 05:33:14 INFO - Working with test: kraken 05:33:14 INFO - Generating results file: kraken 05:33:14 INFO - javascript benchmark 05:33:14 INFO - Working with test: v8_7 05:33:14 INFO - Generating results file: v8_7 05:33:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:33:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:33:14 INFO - process_Request line: dromaeo_css 6174.52 graph.html#tests=[[72,132,35]] 05:33:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:33:14 INFO - process_Request line: kraken 1515.20 graph.html#tests=[[232,132,35]] 05:33:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:33:14 INFO - process_Request line: v8_7 19786.10 graph.html#tests=[[230,132,35]] 05:33:14 INFO - RETURN: dromaeo_css: 6174.52 05:33:14 INFO - RETURN: kraken: 1515.20 05:33:14 INFO - RETURN: v8_7: 19786.10 05:33:14 INFO - javascript benchmark 05:33:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2583.1217386088733, 2673.9866300668496, 2688.2472907585857, 2700.9054683086097, 2707.2149076767732, 4454.777261136938, 4575.88560285993, 4614.930776038362, 4674.929876051858, 4684.554967278107, 4567.931481027787, 4601.79291931863, 4654.767261636922, 4655.348251244828, 4742.122707299152, 4149.502059752834, 4306.2464068787995, 4311.439512863323, 4313.503947046082, 4335.393044973691, 4343.370211319372, 4357.302831546953, 4367.213901497729, 4377.365282034119, 4421.182081314967, 4077.245709543729, 4185.97907010463, 4188.6649068074485, 4191.538930717618, 4295.656347492224, 4279.550647182032, 4279.87160385189, 4281.935770963438, 4293.420388247578, 4319.956800432018, 4243.957560424418, 4252.468441444819, 4254.574542545752, 4302.784860756981, 4304.418903448026, 4428.114377124588, 4543.727376357429, 4547.067851090518, 4568.680192386534, 4722.645801564897, 4942.0610084084265, 4983.676061056056, 4984.102861484931, 4986.650934434591, 5031.371078615173, 5009.874753131165, 5013.5989120870245, 5016.072026675077, 5018.64869459138, 5021.723805190713, 4489.236829738952, 4547.204239258117, 4601.677882548256, 4607.193741095362, 4650.37219975299, 5081.923771143362, 5108.61685373591, 5109.131447653907, 5109.156989096832, 5112.590992720573, 4876.756162191876, 4890.290907818347, 4926.187179115406, 4931.753412329441, 4935.0, 4844.394450693663, 4958.975205123951, 4959.305697202394, 4963.6525443218625, 5118.436971933084, 4929.383827021622, 4943.085529177042, 4953.306537084811, 4961.627877909171, 4987.1771157759285, 4923.606111511071, 4923.901521969612, 4927.827526036572, 4928.137575924199, 4977.925331120036, 3995.700322475826, 4095.97952010244, 4100.569440208735, 4149.875503734893, 4193.35003074524, 3560.9851192410038, 3617.4212126059706, 3623.221007483404, 3652.5069115669576, 3653.725970552219, 4314.115606300701, 4327.632151267115, 4350.390945267665, 4392.363107349416, 4396.0, 4801.327814105958, 4919.778609962489, 4922.0648076866, 4993.425756038029, 5048.570871475892, 4131.793410329532, 4194.832206711759, 4198.202341555156, 4230.746155230696, 4248.1078973415315, 4415.624671902924, 4450.643948484114, 4452.8218871245435, 4453.15390075891, 4484.573965473275, 4567.840125595588, 4690.460597031385, 4691.272852707836, 4790.353302304214, 4844.442889067803, 4937.679050861826, 5021.72380519075, 5038.722870242172, 5042.520960508746, 5084.186530155157, 4814.085323788469, 4820.276958456259, 4823.662343635911, 4824.734639594715, 4866.926996095132, 4732.976335118303, 4849.951500485091, 4852.320675105418, 4974.925376119433, 5027.748612569284, 4925.236588328815, 4939.036887806843, 4941.258811178352, 4967.379077615298, 4968.130577148912, 4711.481737008995, 4749.810007599795, 4758.7858546364805, 4759.6668233223345, 4763.071201115749, 4753.287006948985, 4757.072370887644, 4833.95166048335, 4835.782389792397, 4883.584895283941, 4763.7618119094595, 4799.3041009052795, 4801.735904525284, 4807.927881081717, 4816.301636262652, 4657.115148121846, 4909.312696222603, 4916.287138364989, 4916.508349165055, 4959.801607935787, 4645.2103142465185, 4664.463586687574, 4671.43942726875, 4778.092162489116, 4814.085323788469], "unit": "score", "name": "dojo.html", "value": 4556.958507518865}, {"lowerIsBetter": false, "replicates": [518.8728761453443, 525.2305372629099, 525.8553897678138, 545.8526197926558, 552.6490678419202, 26325.868370658143, 34528.82735586321, 35023.4746478803, 35165.824170879176, 35167.4724879127, 39390.60609393905, 40098.39852402209, 40102.59897401025, 40182.79908600453, 40200.79899600498, 7011.544249623784, 7132.037174981363, 7824.178461261557, 7988.520688758693, 7996.600169991506, 9966.601335946554, 10099.54552045156, 10107.191424686007, 10126.594936202542, 10183.949080254588, 9821.0, 9911.653092141776, 9913.405195688281, 9918.454485003322, 9927.900720992806, 7131.500794944356, 7309.488335816495, 9833.852492212587, 9949.950250248703, 10203.6428724995, 9738.269629777795, 9914.958929312463, 9916.851247231298, 9921.355111917703, 9922.603095876228, 36998.07504812374, 37383.252334953424, 37504.43743343852, 37544.43683344752, 37590.62409375926, 2693.6498255226893, 2783.151138902634, 2978.3596526746637, 3292.1275861896615, 3352.8491217895253, 26078.34804129912, 26289.868550657317, 26339.473210535874, 26347.57481527408, 27065.1880443587, 3262.8042317461027, 3297.686719761619, 3299.78551394161, 3319.2531680371962, 3341.248219150696, 206521.0, 209204.0, 210466.9476652622, 210539.0, 210835.0, 47961.760191198824, 49088.50911490911, 55472.72263638737, 55869.44130558642, 55907.72046139743, 66250.66874665595, 67971.0, 67979.3202067973, 68026.0, 68083.3191668087, 14300.85699143016, 14629.414823407158, 14739.484118055816, 14742.0, 14742.11547307165, 10962.890371096188, 11260.774784504429, 11288.98399144081, 11289.661310160709, 11304.943475282735, 18957.905210474135, 19279.0, 19318.13068411925, 19394.515137121685, 19412.417627471197, 7485.737999170003, 7792.766217013499, 7813.1796161402235, 7851.646675899484, 7916.129225785159, 790.5888937752452, 807.6163822184416, 940.5062342270363, 946.068122898944, 975.2149519636619, 24827.62758558623, 25156.74843251544, 25654.615180772304, 25776.48447031049, 25821.612675809876, 973.3770386952356, 984.3995162950595, 992.9751756206008, 1045.3466583385384, 1061.273027975839, 13349.265790381429, 15442.691146177014, 15546.455874044354, 16209.67580648404, 16515.33938642465, 305840.4707976446, 312476.0, 315107.0, 315255.0, 316968.0, 45239.77380113144, 45384.0, 45511.317330240076, 45610.0, 45617.08765824665, 1210.406900618708, 1216.1061619709506, 1226.3132645718426, 1243.9315837629017, 1362.9913863740958, 25355.366115846515, 27038.72961270362, 28292.292692682848, 30360.392792143593, 30884.845575772877, 42481.57518424776, 42925.57074429341, 42970.0, 43165.0, 43183.35224971691, 236073.0, 239553.0, 240259.0, 240452.0, 240619.0, 24074.759252407253, 24470.143544976552, 28102.43795124127, 28148.577771333858, 28260.85869570639, 32566.674333256364, 32860.83569582232, 32878.1780455481, 32956.1760955978, 33238.00285991424, 28573.571396429485, 28701.99543016068, 37281.62718372782, 38247.0, 38711.0, 32036.718531258488, 32970.340593188484, 33142.5028624566, 33372.833135835135, 37229.81385093057, 32705.836470817492, 33313.333733325686, 33461.66538334683, 33546.329073418885, 33771.66228337685, 29382.0, 30242.0, 30644.693553064182, 30739.385212296078, 30901.69098308988, 23249.18627848017, 23465.178718745447, 23557.411064723517, 23630.645540316564, 23855.0], "unit": "score", "name": "ext.html", "value": 17316.85701812022}, {"lowerIsBetter": false, "replicates": [299.9880004799808, 304.9405365953639, 307.11091390424707, 315.87522928443263, 318.5126756063223, 12430.192037517554, 12777.29724865132, 15508.0, 15775.447859324911, 16012.279447424864, 9797.314188006825, 10063.04401081898, 10066.39601623903, 14690.192039437827, 15173.393064277416, 4312.784360781956, 4516.345129956155, 4525.9547404525865, 4527.29826876833, 4531.886702832423, 3434.055634700465, 3530.117470632342, 3532.5231093802263, 3534.0104770664257, 4877.829275975341, 3517.8416971236356, 3531.470279458076, 4940.135476291653, 5099.235114732783, 5115.641905066647, 4941.604671626279, 5092.465291144432, 5095.235714642815, 5223.843284701465, 5224.895502089975, 4926.3842019747535, 5017.749112544395, 5020.748962551857, 5021.548060674557, 5023.120953833101, 17204.311827526883, 17424.65150696979, 17784.822151778448, 17798.0, 18818.0, 1680.7899012623423, 1714.1086634949881, 1729.0922265810425, 1789.7046987247088, 1841.9355322563647, 8229.0, 8782.60478278479, 8949.105089491064, 10638.468076596217, 12454.937725311316, 1699.8780804668859, 1707.8292170782822, 1722.4488163787594, 1723.6294196747633, 1770.4157627982736, 52988.0, 54074.72962635201, 54286.0, 54637.9999999996, 55812.72093639546, 9325.720228393158, 9447.866256049318, 9493.24054075686, 9518.381305215138, 9520.8571871422, 11778.587749428729, 11949.641510754518, 12021.819672704916, 12035.578754743718, 12040.096992725405, 7177.7487787927175, 7183.389411899942, 7192.748253811092, 7207.13514378278, 7264.782056538313, 6955.965220173968, 6964.65176741171, 6991.8601627967155, 7014.333638304353, 7029.0862187915245, 3924.7841368724994, 3971.146203566247, 4002.199010445253, 4014.5748259367506, 4035.53591337, 1526.3970731561194, 1576.0535738363112, 1627.983720162807, 1649.7544354012884, 1661.5846038490376, 836.3810780022861, 896.0949441064441, 898.2679116520015, 933.3000249812641, 986.9161121304769, 15018.174000429863, 15474.148921809408, 15714.449994250375, 15753.921230394004, 15813.1302778346, 807.3460496997451, 824.294365337968, 853.9871901921476, 882.7572417585216, 898.4384759525296, 8116.513009219466, 8458.281046111026, 8495.235428811437, 8530.957345213234, 8559.358048146414, 321984.0214380717, 326002.0, 328764.49324274017, 422091.0, 487547.0, 36618.26763464769, 36624.81687591545, 46616.533834661896, 52500.47499525032, 61188.38811611827, 1032.6230925712061, 1047.1884289675563, 1064.4784055812595, 1065.8134826405503, 1069.4866464097277, 13313.866861331262, 14345.0, 14411.639709007359, 14476.927615361856, 14736.189509577076, 32209.838950805097, 32235.516467252542, 32768.836155819066, 33106.83446582752, 33746.32507349888, 40797.79601101975, 41166.382504263056, 41832.58167418287, 41894.790526047174, 44542.55457445384, 2420.52799704056, 2452.5094981003513, 2456.5946618807698, 8197.672093116209, 8537.676660117691, 10284.0, 10399.428031458343, 15060.246987650793, 15074.849251507345, 16582.834171658127, 13238.53665121716, 13280.601581952556, 13437.126586771828, 13555.728885422433, 13646.113002654796, 12736.61790146297, 12826.743465130832, 12998.80501792455, 13306.733865322833, 13547.729045419233, 12736.299503527025, 12836.42236099359, 12908.41912113976, 13054.412551435018, 13532.052756306965, 8171.101178870201, 8424.326053915795, 8674.219320261207, 8735.606897689491, 8802.427842190236, 11453.312801231952, 13024.41390137465, 13103.541376051793, 13415.731685366432, 13763.243021633505], "unit": "score", "name": "jquery.html", "value": 7656.881785286886}, {"lowerIsBetter": false, "replicates": [1275.8213850061, 1629.2912583026384, 1698.2697440100756, 1711.152979275258, 1741.4340339389694, 5929.080992446173, 6996.720131194753, 7235.240299768528, 7238.7466438674655, 7251.637418129086, 6979.092717946673, 7172.426205903528, 7174.1032370953635, 7174.282571742823, 7176.138863336394, 1774.7071733164012, 1817.7727784026997, 1818.2090790506106, 2062.1648232465836, 2104.326615483046, 1819.7179437187192, 1830.3685228596114, 2077.6364136276165, 2156.493224092337, 2165.296278709418, 2092.403664955488, 2101.1175306371283, 2103.978960210401, 2106.062802053087, 2110.9261175858846, 2094.0, 2111.1977448569523, 2112.5458026524216, 2114.164904862578, 2115.8730476171477, 2105.7788932162207, 2108.5888251790907, 2130.158587358, 2172.9782702172934, 2175.3908905506323, 7137.179224389158, 7175.0, 7181.317774811385, 7205.855882882313, 7207.4594405419275, 4275.572442755731, 4330.545292744279, 4336.262835318003, 4346.804393802255, 4347.847825326098, 2759.530879750447, 2776.972230277692, 2797.776177905763, 2880.510313246732, 2887.422515496909, 853.4836423963475, 864.8270345930839, 865.4374656473279, 878.227160099115, 882.5807741322884, 9545.761355966088, 9597.0, 9598.568064437048, 9605.471699056548, 9620.518974051269, 3929.057026313664, 3980.383040628707, 3990.780507072139, 4016.9196616067516, 4095.406166105898, 8274.627641756135, 8275.131111233355, 8276.213759692819, 8282.875756863652, 8286.4613800104, 4248.702590818675, 4253.659707223414, 4261.062566235423, 4263.76549289792, 4264.061906380592, 3865.168988667394, 3871.2064026874987, 3879.515060617423, 3881.4177873318663, 3892.4355968384425, 3417.470292104728, 3451.741119416054, 3474.3398754236614, 3502.842372093262, 3510.508528805969, 961.5721004153224, 976.2239019979133, 1040.370575801629, 1044.4621020174616, 1054.6466933577185, 754.1478129713389, 763.171958425115, 772.3705180278056, 856.9271611913057, 884.9292056635454, 6675.833104172338, 6721.7311307548125, 6736.360045795642, 6750.0, 6753.1220941277315, 1021.7598864266891, 1024.2164743970868, 1036.3937096798456, 1049.186880167876, 1055.8996895295088, 5045.571126454292, 5097.362829646294, 5107.489251074937, 5111.361079865017, 5116.155834287375, 8483.109273526314, 8597.312215022783, 8742.30061595071, 8744.693935712347, 8841.734747957571, 8617.827643447095, 8636.093210212963, 8707.172818582225, 8739.169778870997, 8743.256823169975, 6581.308962558863, 6743.966280168666, 6772.153480814898, 6830.31696830313, 6835.179778426621, 6249.843753906189, 6271.529635277281, 6274.937250627435, 6285.120083188266, 6287.088372185916, 7423.92576074254, 7572.091349038151, 7631.923680763343, 7736.032995875516, 7761.146273909978, 7751.961240193763, 7824.92175078242, 7861.371090312876, 7863.764087077397, 8072.677092916452, 6704.564203326768, 6788.66056697173, 6791.796246112624, 6798.422134118655, 6805.0, 6023.247094113236, 6347.39699728525, 6435.935640643534, 6440.452561532322, 6690.765823196165, 5681.801136960186, 5800.883982320245, 6006.489448396936, 6334.271558770801, 6376.52176086786, 6188.783392581238, 6232.688365581794, 6237.251529816451, 6273.937260627518, 6296.401841825019, 6294.496440284858, 6335.049742538656, 6337.904931426125, 6339.461145802658, 6344.429001389897, 5355.169948657965, 5632.436756324335, 5638.548916086621, 5638.956792993309, 5653.349864765604, 5718.79984200551, 5745.683987380734, 5755.8561035974435, 5759.337676167294, 5765.423457654201], "unit": "score", "name": "mootools.html", "value": 4051.916912016748}, {"lowerIsBetter": false, "replicates": [287.45096864987875, 288.96965818589047, 294.929216987923, 295.6998646373932, 298.8535617547401, 5270.525652691262, 5304.92042619361, 5346.652467589604, 5414.729263536827, 5420.512153906157, 5290.629655924087, 5297.841064768063, 5302.257683924254, 5302.522772950434, 5308.5487733542695, 4086.080631857823, 4090.141070375225, 4104.302268614328, 4106.404571337154, 4108.650764685005, 4102.528209255929, 4105.363668631352, 4107.54816970133, 4112.547619761824, 4113.609207125318, 3977.0, 4038.5557588665224, 4055.1889622075555, 4067.1865626874596, 4071.145059537501, 4056.1887622475624, 4057.898552536181, 4058.228936502055, 4066.7559946403017, 4073.40935564343, 3544.043108360728, 3547.7693949893433, 3549.2014296783277, 3553.093961039944, 3560.3235385276716, 5045.344105266328, 5072.873178170538, 5082.288479612857, 5083.389993200803, 5084.56781173597, 4648.697834640738, 4689.7655117244, 4691.788869500847, 4693.155232058228, 4694.976525117387, 5365.0, 5555.138953462179, 5559.499645031926, 5559.527440167591, 5562.610617256793, 3799.5820459749407, 3802.9429558556367, 3805.3721136012523, 3806.8667596633986, 3806.904827379338, 5556.583256255797, 5700.7719691212305, 5749.1663708762, 5782.335031471351, 5870.178175055496, 3905.062784931596, 3907.648311651965, 3918.45141680165, 3923.1761330120426, 3934.370500719871, 3969.503812023497, 3973.264945985002, 3974.503187101612, 3975.542812576533, 3976.8608098716404, 4323.459567554056, 4400.9559904401185, 4422.756748378806, 4551.795169217393, 4591.449026116888, 5517.393086760453, 5527.198556209327, 5530.834074977757, 5537.36320323168, 5544.390117087117, 1343.2880573296168, 1358.8844948179317, 1359.64649191211, 1360.5986234060779, 1361.7889227169806, 913.3378300732049, 923.344425457919, 928.9024652411534, 942.4816351006918, 945.7919257763281, 4904.386951631046, 4911.238757992517, 4914.92627610579, 4921.557059864629, 4928.827491037868, 5739.253896993448, 5744.339400968858, 5746.080627099644, 5752.108423194411, 5752.942470575241, 4905.9754701226975, 4908.141075311878, 4910.337104490848, 4914.803407863646, 4915.090708218991, 3009.45829750647, 3066.4020515999164, 3098.7830851840154, 3101.116181888151, 3108.207407111172, 5513.972430137824, 5516.310461192351, 5528.226048353234, 5532.640378375393, 5533.750981205855, 5979.5515336349945, 5982.790602328898, 5984.820455386345, 5986.610870293417, 5990.73041713124, 5525.11598144295, 5528.419515950848, 5529.695866727288, 5529.723513824292, 5533.916991245134, 5644.209810626434, 5806.303243610625, 5821.679807610622, 5823.097419899922, 5824.5631577631, 5672.149177623224, 5674.2623458950075, 5680.77276908919, 5682.886342273048, 5689.118186681071, 5511.641743286674, 5512.889742205213, 5521.751521181637, 5524.088525393265, 5527.0, 3749.4000959846294, 3883.5728069912852, 3927.3716205407, 3928.5285765707154, 3931.980340098281, 5542.060278902352, 5714.971425142848, 5748.310202775694, 5755.971220143872, 5760.539156867357, 5452.236686863763, 5538.6399884007415, 5564.4713752193475, 5587.161925711176, 5587.357453892854, 5514.696691681996, 5523.8895222096135, 5562.471565201299, 5593.972030139823, 5594.244776955059, 5392.056390131633, 5441.047816632153, 5476.479734425223, 5490.066688662857, 5508.228847961369, 5525.0883604204855, 5567.081431563909, 5570.108782594765, 5630.831075067755, 5637.3235211774845, 5432.402435731988, 5442.727863606883, 5447.836564903059, 5452.100403433389, 5453.454654534515], "unit": "score", "name": "prototype.html", "value": 4153.056848566736}, {"lowerIsBetter": false, "replicates": [617.7343742190859, 650.7657243392377, 739.7115125101208, 777.3819813248467, 786.382689588673, 10445.37327760334, 10499.475026248696, 10504.527296271666, 10556.841647375286, 13784.931075344633, 12180.81728774069, 12200.93899530501, 12224.51101955923, 12304.630861074182, 12310.692232694164, 631.0408179567055, 637.2480473041809, 789.6920201121567, 798.2974982015818, 805.4361946637348, 798.4730078148423, 807.9798005049862, 809.4697972827807, 814.6782021101661, 814.8736945773414, 853.2747164909808, 862.4178679391385, 863.0334025890979, 863.3783675753479, 863.5725315968605, 660.682872221334, 669.0866966590618, 831.3930830493773, 844.0926004545139, 851.2083762101244, 631.728356806573, 632.3170975346615, 632.6615260835431, 633.1547384242042, 634.175571756719, 12171.33057681827, 12195.573154939624, 12219.083568732292, 12223.633291001284, 12229.755404891941, 10396.48017599117, 10457.26799124054, 10467.581296748122, 10727.141828653688, 11043.061339786127, 9023.729288121367, 9326.533673316375, 9443.858342124873, 9677.37097088687, 9714.659986900495, 3139.3250451153112, 3198.1524895902603, 3200.0559834848777, 3244.643089260203, 3250.0574833298315, 38396.0, 39136.60863391358, 39319.803400983095, 39373.212535749124, 39395.40906886399, 8550.315974722007, 8571.142885711504, 8990.730278091667, 9018.659637509627, 9426.717198484057, 15688.215589220494, 15733.213339332988, 15762.054276743433, 15801.920990394974, 15812.841871581368, 6263.655498947511, 6272.153259310026, 6536.411722944958, 6593.428433725312, 6731.091302674175, 3713.8700145494777, 3752.2870654575545, 3778.0554861284677, 3792.9241415172096, 3793.7534060285993, 2634.1702363755358, 2663.2542887991394, 2668.21287720123, 2670.225634565993, 2671.1051797648006, 478.98216290382936, 479.50371365637096, 487.0648355158105, 487.90485855257884, 489.20504180706354, 403.48555591620334, 440.5308346610849, 443.9378487011821, 452.3373258176787, 533.7384681506034, 6911.965440172767, 6981.2669669684965, 7286.125664920138, 7387.593682347415, 7733.0524339895, 553.8200084972319, 554.5812911251979, 567.8523583868224, 580.1298052920619, 591.7071049830275, 3112.9533057004164, 3176.6346870110233, 3202.295494991098, 3253.4957081652383, 3278.606567211902, 47854.760726196146, 48687.51312486901, 48779.51220487821, 48813.511864881606, 48875.266870996966, 42804.143917122106, 43551.78224108859, 43864.12271754547, 44401.55598443974, 44590.55409445929, 39878.60121398749, 40264.59735402667, 40555.1888962225, 40903.590964090574, 41148.0, 6830.726770929107, 6991.650417479004, 7105.75129870452, 7394.338118022243, 7505.286997735207, 30840.228994275323, 31180.844095780285, 31280.843595781877, 32946.0, 32991.50512742359, 37269.0, 39002.6099738999, 39198.60801392064, 39301.0, 39654.2069158621, 9075.818483630159, 9121.635134594542, 9128.634854606007, 9355.48544830041, 9413.85879211826, 9799.804003919739, 9950.900490995287, 9992.400455972665, 10023.54894029785, 10142.137918277029, 9037.728868133967, 9239.953800230956, 9255.86116208244, 9279.257659387098, 9370.718878433658, 8453.95773021131, 8487.193716596914, 8685.131486851264, 8820.25027872638, 9131.5434228287, 8416.579171041301, 8707.91292087071, 8862.379633425857, 8868.423552469068, 8890.0, 8105.594720264081, 8112.959435202786, 8124.918750812416, 8151.673933042849, 8332.708355207538, 7455.039577052787, 7613.619319033915, 7972.242636949481, 8017.238362355567, 8504.957475212585], "unit": "score", "name": "yui.html", "value": 5449.398024259789}], "name": "dromaeo_css", "value": 6174.520791673806}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 111.0, 112.0, 103.0, 110.0, 110.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [163.0, 133.0, 152.0, 163.0, 134.0, 155.0, 153.0, 132.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 164.0, 160.0, 161.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 85.0, 91.0, 72.0, 73.0, 72.0, 99.0, 88.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 95.0, 95.0, 95.0, 132.0, 94.0, 95.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 72.0, 70.0, 72.0, 79.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 81.0, 83.0, 81.0, 82.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [136.0, 123.0, 128.0, 134.0, 124.0, 121.0, 123.0, 119.0, 130.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 147.0, 147.0, 156.0, 136.0, 147.0, 147.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 69.0, 69.0, 68.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1515.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.48072149594572], "unit": "score", "name": "Richards", "value": 213.32998600000002}, {"lowerIsBetter": false, "replicates": [187.58206715438004], "unit": "score", "name": "DeltaBlue", "value": 352.47505799999993}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [27972.222222222223], "unit": "score", "name": "RegExp", "value": 32.56748758689176}, {"lowerIsBetter": false, "replicates": [605.3268765133172], "unit": "score", "name": "Splay", "value": 134.62313200000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19786.098872057428}]} 05:33:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19786.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1515.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6174.52"}}} 05:33:14 INFO - Return code: 0 05:33:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:33:14 INFO - # TBPL SUCCESS # 05:33:14 INFO - Running post-action listener: _resource_record_post_action 05:33:14 INFO - Running post-run listener: _resource_record_post_run 05:33:15 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 13225984; Write bytes: 446750720; Read time: 4144; Write time: 291132 05:33:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 8192; Write bytes: 65753088; Read time: 28; Write time: 41668 05:33:15 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 11321344; Write bytes: 363188224; Read time: 3892; Write time: 230912 05:33:15 INFO - Running post-run listener: _upload_blobber_files 05:33:15 INFO - Blob upload gear active. 05:33:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:33:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:33:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:33:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:33:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:33:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:16 INFO - (blobuploader) - INFO - Done attempting. 05:33:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:33:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:33:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:17 INFO - (blobuploader) - INFO - Done attempting. 05:33:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:33:17 INFO - Return code: 0 05:33:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:33:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:33:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7803ac86e45a1049f733fd4eace7ee39e5ba06cace9fc4baa1cf74689e7e99dda5c0e5b49a7340a541c5b5a0e5330f36325bf53e65f24c216e2d2d99953c92b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c9c97eddf8aec1baa29893d3882eb487b8f75fe013a10cc74c6d0701af8fb8b19a0817096ee995dce104c05cd143a0661c75a5944db7bcd01f76cd0d83bfe47"} 05:33:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:33:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:33:17 INFO - Contents: 05:33:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7803ac86e45a1049f733fd4eace7ee39e5ba06cace9fc4baa1cf74689e7e99dda5c0e5b49a7340a541c5b5a0e5330f36325bf53e65f24c216e2d2d99953c92b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c9c97eddf8aec1baa29893d3882eb487b8f75fe013a10cc74c6d0701af8fb8b19a0817096ee995dce104c05cd143a0661c75a5944db7bcd01f76cd0d83bfe47"} 05:33:17 INFO - Copying logs to upload dir... 05:33:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.723424 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-21 05:33:17.839684) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:33:17.842733) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7803ac86e45a1049f733fd4eace7ee39e5ba06cace9fc4baa1cf74689e7e99dda5c0e5b49a7340a541c5b5a0e5330f36325bf53e65f24c216e2d2d99953c92b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c9c97eddf8aec1baa29893d3882eb487b8f75fe013a10cc74c6d0701af8fb8b19a0817096ee995dce104c05cd143a0661c75a5944db7bcd01f76cd0d83bfe47"} build_url:https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/yFJPM1RyTFKHt5_Z8QK2ag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7803ac86e45a1049f733fd4eace7ee39e5ba06cace9fc4baa1cf74689e7e99dda5c0e5b49a7340a541c5b5a0e5330f36325bf53e65f24c216e2d2d99953c92b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c9c97eddf8aec1baa29893d3882eb487b8f75fe013a10cc74c6d0701af8fb8b19a0817096ee995dce104c05cd143a0661c75a5944db7bcd01f76cd0d83bfe47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:33:17.868743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:33:17.869097) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450703377.222578-1780792518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:33:17.952588) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:33:17.952931) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:33:17.953255) ========= ========= Total master_lag: 0.71 =========