builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1452524908.17 results: success (0) buildid: 20160111055931 builduid: 15b5b0eb16ed41c3ae665e65680fe3c9 revision: 15c5eb70ba7385270f1caa8a94746fd1320d4b8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.168161) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.168602) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.168889) ========= 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=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006327 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.190472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.190833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.216106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.216391) ========= 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=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.264895) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.265164) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.265490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.265774) ========= 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=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 07:08:28-- 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% 49.0M=0s 2016-01-11 07:08:28 (49.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.450121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.450594) ========= 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=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021994 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.501731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:28.502090) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 15c5eb70ba7385270f1caa8a94746fd1320d4b8a --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 15c5eb70ba7385270f1caa8a94746fd1320d4b8a --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=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 07:08:28,863 truncating revision to first 12 chars 2016-01-11 07:08:28,863 Setting DEBUG logging. 2016-01-11 07:08:28,863 attempt 1/10 2016-01-11 07:08:28,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/15c5eb70ba73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 07:08:29,132 unpacking tar archive at: fx-team-15c5eb70ba73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:29.111661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:29.111963) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:29.119391) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:29.119741) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 07:08:29.120163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-01-11 07:08:29.120445) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:29 INFO - MultiFileLogger online at 20160111 07:08:29 in /builds/slave/test 07:08:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:08:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:29 INFO - {'append_to_log': False, 07:08:29 INFO - 'base_work_dir': '/builds/slave/test', 07:08:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:08:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:29 INFO - 'branch': 'Fx-Team-Non-PGO', 07:08:29 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:29 INFO - 'config_files': ('talos/linux_config.py',), 07:08:29 INFO - 'default_actions': ('clobber', 07:08:29 INFO - 'read-buildbot-config', 07:08:29 INFO - 'download-and-extract', 07:08:29 INFO - 'populate-webroot', 07:08:29 INFO - 'create-virtualenv', 07:08:29 INFO - 'install', 07:08:29 INFO - 'run-tests'), 07:08:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:29 INFO - 'download_minidump_stackwalk': True, 07:08:29 INFO - 'download_symbols': 'ondemand', 07:08:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:29 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:29 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:29 INFO - 'installer_path': 'installer.exe', 07:08:29 INFO - 'log_level': 'info', 07:08:29 INFO - 'log_name': 'talos', 07:08:29 INFO - 'log_to_console': True, 07:08:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:29 INFO - 'opt_config_files': (), 07:08:29 INFO - 'pip_index': False, 07:08:29 INFO - 'sps_profile': False, 07:08:29 INFO - 'sps_profile_interval': 0, 07:08:29 INFO - 'suite': 'dromaeojs-e10s', 07:08:29 INFO - 'system_bits': '32', 07:08:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:29 INFO - 'title': 'talos-linux64-ix-020', 07:08:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:29 INFO - 'use_talos_json': True, 07:08:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:29 INFO - 'work_dir': 'build'} 07:08:29 INFO - ##### 07:08:29 INFO - ##### Running clobber step. 07:08:29 INFO - ##### 07:08:29 INFO - Running pre-action listener: _resource_record_pre_action 07:08:29 INFO - Running main action method: clobber 07:08:29 INFO - rmtree: /builds/slave/test/build 07:08:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:30 INFO - Running post-action listener: _resource_record_post_action 07:08:30 INFO - ##### 07:08:30 INFO - ##### Running read-buildbot-config step. 07:08:30 INFO - ##### 07:08:30 INFO - Running pre-action listener: _resource_record_pre_action 07:08:30 INFO - Running main action method: read_buildbot_config 07:08:30 INFO - Using buildbot properties: 07:08:30 INFO - { 07:08:30 INFO - "project": "", 07:08:30 INFO - "product": "firefox", 07:08:30 INFO - "script_repo_revision": "production", 07:08:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:08:30 INFO - "repository": "", 07:08:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:08:30 INFO - "buildid": "20160111055931", 07:08:30 INFO - "pgo_build": "False", 07:08:30 INFO - "basedir": "/builds/slave/test", 07:08:30 INFO - "buildnumber": 629, 07:08:30 INFO - "slavename": "talos-linux64-ix-020", 07:08:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:08:30 INFO - "platform": "ubuntu64_hw", 07:08:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:08:30 INFO - "branch": "fx-team", 07:08:30 INFO - "repo_path": "integration/fx-team", 07:08:30 INFO - "revision": "15c5eb70ba7385270f1caa8a94746fd1320d4b8a", 07:08:30 INFO - "stage_platform": "linux64", 07:08:30 INFO - "builduid": "15b5b0eb16ed41c3ae665e65680fe3c9", 07:08:30 INFO - "slavebuilddir": "test" 07:08:30 INFO - } 07:08:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:08:30 INFO - Running post-action listener: _resource_record_post_action 07:08:30 INFO - ##### 07:08:30 INFO - ##### Running download-and-extract step. 07:08:30 INFO - ##### 07:08:30 INFO - Running pre-action listener: _resource_record_pre_action 07:08:30 INFO - Running main action method: download_and_extract 07:08:30 INFO - mkdir: /builds/slave/test/build/tests 07:08: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')]} 07:08:30 INFO - https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/test_packages.json 07:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/test_packages.json 07:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:08:32 INFO - Downloaded 1302 bytes. 07:08:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:08:32 INFO - Using the following test package requirements: 07:08:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:32 INFO - u'jsshell-linux-x86_64.zip'], 07:08:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:32 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')]} 07:08:32 INFO - https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:08:35 INFO - Downloaded 22756965 bytes. 07:08:35 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 07:08:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:35 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 07:08:36 INFO - Return code: 0 07:08:36 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 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:08:46 INFO - Downloaded 22756965 bytes. 07:08:46 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 07:08:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:46 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 07:08:47 INFO - Return code: 0 07:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:47 INFO - https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:08:50 INFO - Downloaded 11132285 bytes. 07:08:50 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 07:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:50 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 07:08:50 INFO - Return code: 0 07:08:50 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')]} 07:08:50 INFO - https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FP6uQbiZSpSoOZ31CkAyyA/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 07:09:06 INFO - Downloaded 53739695 bytes. 07:09:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:09:06 INFO - mkdir: /builds/slave/test/properties 07:09:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:06 INFO - Contents: 07:09:06 INFO - build_url:https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:09:06 INFO - Running post-action listener: _resource_record_post_action 07:09:06 INFO - Running post-action listener: set_extra_try_arguments 07:09:06 INFO - ##### 07:09:06 INFO - ##### Running populate-webroot step. 07:09:06 INFO - ##### 07:09:06 INFO - Running pre-action listener: _resource_record_pre_action 07:09:06 INFO - Running main action method: populate_webroot 07:09:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:06 INFO - '--tppagecycles', 07:09:06 INFO - '7'], 07:09:06 INFO - 'tests': ['tsvgm']}}, 07:09:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:09:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:09:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:09:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'tests': ['damp', 'tps']}, 07:09:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['damp', 'tps']}, 07:09:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:09:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:06 INFO - 'other': {'tests': ['a11yr', 07:09:06 INFO - 'ts_paint', 07:09:06 INFO - 'tpaint', 07:09:06 INFO - 'sessionrestore', 07:09:06 INFO - 'sessionrestore_no_auto_restore']}, 07:09:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['a11yr', 07:09:06 INFO - 'ts_paint', 07:09:06 INFO - 'tpaint', 07:09:06 INFO - 'sessionrestore', 07:09:06 INFO - 'sessionrestore_no_auto_restore']}, 07:09:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['a11yr', 07:09:06 INFO - 'ts_paint', 07:09:06 INFO - 'tpaint', 07:09:06 INFO - 'sessionrestore', 07:09:06 INFO - 'sessionrestore_no_auto_restore']}, 07:09:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['a11yr', 07:09:06 INFO - 'ts_paint', 07:09:06 INFO - 'tpaint', 07:09:06 INFO - 'sessionrestore', 07:09:06 INFO - 'sessionrestore_no_auto_restore']}, 07:09:06 INFO - 'other_l64': {'tests': ['a11yr', 07:09:06 INFO - 'ts_paint', 07:09:06 INFO - 'tpaint', 07:09:06 INFO - 'sessionrestore', 07:09:06 INFO - 'sessionrestore_no_auto_restore']}, 07:09:06 INFO - 'other_nol64': {'tests': ['a11yr', 07:09:06 INFO - 'ts_paint', 07:09:06 INFO - 'tpaint', 07:09:06 INFO - 'sessionrestore', 07:09:06 INFO - 'sessionrestore_no_auto_restore']}, 07:09:06 INFO - 'svgr': {'tests': ['tsvgx', 07:09:06 INFO - 'tsvgr_opacity', 07:09:06 INFO - 'tart', 07:09:06 INFO - 'tscrollx', 07:09:06 INFO - 'cart']}, 07:09:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['tsvgx', 07:09:06 INFO - 'tsvgr_opacity', 07:09:06 INFO - 'tart', 07:09:06 INFO - 'tscrollx', 07:09:06 INFO - 'cart']}, 07:09:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'tests': ['tp5o']}, 07:09:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'talos_options': ['--e10s'], 07:09:06 INFO - 'tests': ['tp5o']}, 07:09:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'talos_options': ['--xperf_path', 07:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:06 INFO - 'tests': ['tp5n']}, 07:09:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:06 INFO - 'talos_options': ['--e10s', 07:09:06 INFO - '--xperf_path', 07:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:06 INFO - 'tests': ['tp5n']}}, 07:09:06 INFO - 'talos.zip': {'path': '', 07:09:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:06 INFO - Running post-action listener: _resource_record_post_action 07:09:06 INFO - ##### 07:09:06 INFO - ##### Running create-virtualenv step. 07:09:06 INFO - ##### 07:09:06 INFO - Running pre-action listener: _resource_record_pre_action 07:09:06 INFO - Running main action method: create_virtualenv 07:09:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:06 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 07:09:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:06 INFO - Using real prefix '/usr' 07:09:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:08 INFO - Installing pip.................done. 07:09:08 INFO - Return code: 0 07:09:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:09:08 INFO - Using env: {'DISPLAY': ':0', 07:09:08 INFO - 'HOME': '/home/cltbld', 07:09:08 INFO - 'LANG': 'en_US.UTF-8', 07:09:08 INFO - 'LANGUAGE': 'en_US:en', 07:09:08 INFO - 'LOGNAME': 'cltbld', 07:09:08 INFO - 'MAIL': '/var/mail/cltbld', 07:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:08 INFO - 'MOZ_NO_REMOTE': '1', 07:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:08 INFO - 'NO_EM_RESTART': '1', 07:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:08 INFO - 'PWD': '/builds/slave/test', 07:09:08 INFO - 'SHELL': '/bin/bash', 07:09:08 INFO - 'SHLVL': '1', 07:09:08 INFO - 'TERM': 'linux', 07:09:08 INFO - 'TMOUT': '86400', 07:09:08 INFO - 'USER': 'cltbld', 07:09:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:08 INFO - '_': '/tools/buildbot/bin/python'} 07:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:09 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 07:09:09 INFO - Cleaning up... 07:09:09 INFO - Return code: 0 07:09:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:09:09 INFO - Using env: {'DISPLAY': ':0', 07:09:09 INFO - 'HOME': '/home/cltbld', 07:09:09 INFO - 'LANG': 'en_US.UTF-8', 07:09:09 INFO - 'LANGUAGE': 'en_US:en', 07:09:09 INFO - 'LOGNAME': 'cltbld', 07:09:09 INFO - 'MAIL': '/var/mail/cltbld', 07:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:09 INFO - 'MOZ_NO_REMOTE': '1', 07:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:09 INFO - 'NO_EM_RESTART': '1', 07:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:09 INFO - 'PWD': '/builds/slave/test', 07:09:09 INFO - 'SHELL': '/bin/bash', 07:09:09 INFO - 'SHLVL': '1', 07:09:09 INFO - 'TERM': 'linux', 07:09:09 INFO - 'TMOUT': '86400', 07:09:09 INFO - 'USER': 'cltbld', 07:09:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:09 INFO - '_': '/tools/buildbot/bin/python'} 07:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:09 INFO - Downloading/unpacking psutil>=0.7.1 07:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:11 INFO - Installing collected packages: psutil 07:09:11 INFO - Running setup.py install for psutil 07:09:11 INFO - building 'psutil._psutil_linux' extension 07:09:11 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 07:09:11 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 07:09:11 INFO - building 'psutil._psutil_posix' extension 07:09:11 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 07:09:11 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 07:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:11 INFO - Successfully installed psutil 07:09:11 INFO - Cleaning up... 07:09:11 INFO - Return code: 0 07:09:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:09:11 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')]} 07:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:11 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')]} 07:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:11 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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:11 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 07:09:11 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 07:09:11 INFO - Using env: {'DISPLAY': ':0', 07:09:11 INFO - 'HOME': '/home/cltbld', 07:09:11 INFO - 'LANG': 'en_US.UTF-8', 07:09:11 INFO - 'LANGUAGE': 'en_US:en', 07:09:11 INFO - 'LOGNAME': 'cltbld', 07:09:11 INFO - 'MAIL': '/var/mail/cltbld', 07:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:11 INFO - 'MOZ_NO_REMOTE': '1', 07:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:11 INFO - 'NO_EM_RESTART': '1', 07:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:11 INFO - 'PWD': '/builds/slave/test', 07:09:11 INFO - 'SHELL': '/bin/bash', 07:09:11 INFO - 'SHLVL': '1', 07:09:11 INFO - 'TERM': 'linux', 07:09:11 INFO - 'TMOUT': '86400', 07:09:11 INFO - 'USER': 'cltbld', 07:09:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:11 INFO - '_': '/tools/buildbot/bin/python'} 07:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:09:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:09:13 INFO - Installing collected packages: mozsystemmonitor 07:09:13 INFO - Running setup.py install for mozsystemmonitor 07:09:13 INFO - Successfully installed mozsystemmonitor 07:09:13 INFO - Cleaning up... 07:09:13 INFO - Return code: 0 07:09:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:13 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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:13 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 07:09:13 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 07:09:13 INFO - Using env: {'DISPLAY': ':0', 07:09:13 INFO - 'HOME': '/home/cltbld', 07:09:13 INFO - 'LANG': 'en_US.UTF-8', 07:09:13 INFO - 'LANGUAGE': 'en_US:en', 07:09:13 INFO - 'LOGNAME': 'cltbld', 07:09:13 INFO - 'MAIL': '/var/mail/cltbld', 07:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:13 INFO - 'MOZ_NO_REMOTE': '1', 07:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:13 INFO - 'NO_EM_RESTART': '1', 07:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:13 INFO - 'PWD': '/builds/slave/test', 07:09:13 INFO - 'SHELL': '/bin/bash', 07:09:13 INFO - 'SHLVL': '1', 07:09:13 INFO - 'TERM': 'linux', 07:09:13 INFO - 'TMOUT': '86400', 07:09:13 INFO - 'USER': 'cltbld', 07:09:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:13 INFO - '_': '/tools/buildbot/bin/python'} 07:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:13 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:13 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 07:09:13 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 07:09:13 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 07:09:13 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 07:09:13 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 07:09:13 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 07:09:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:16 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 07:09:16 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 07:09:16 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 07:09:16 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 07:09:16 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 07:09:16 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 07:09:16 INFO - Downloading docopt-0.6.1.tar.gz 07:09:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:16 INFO - Running setup.py install for blobuploader 07:09:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:16 INFO - Running setup.py install for requests 07:09:16 INFO - Running setup.py install for docopt 07:09:17 INFO - Successfully installed blobuploader requests docopt 07:09:17 INFO - Cleaning up... 07:09:17 INFO - Return code: 0 07:09:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:17 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')]} 07:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:17 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')]} 07:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:17 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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:17 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 07:09:17 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 07:09:17 INFO - Using env: {'DISPLAY': ':0', 07:09:17 INFO - 'HOME': '/home/cltbld', 07:09:17 INFO - 'LANG': 'en_US.UTF-8', 07:09:17 INFO - 'LANGUAGE': 'en_US:en', 07:09:17 INFO - 'LOGNAME': 'cltbld', 07:09:17 INFO - 'MAIL': '/var/mail/cltbld', 07:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:17 INFO - 'MOZ_NO_REMOTE': '1', 07:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:17 INFO - 'NO_EM_RESTART': '1', 07:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:17 INFO - 'PWD': '/builds/slave/test', 07:09:17 INFO - 'SHELL': '/bin/bash', 07:09:17 INFO - 'SHLVL': '1', 07:09:17 INFO - 'TERM': 'linux', 07:09:17 INFO - 'TMOUT': '86400', 07:09:17 INFO - 'USER': 'cltbld', 07:09:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:17 INFO - '_': '/tools/buildbot/bin/python'} 07:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:17 INFO - Running setup.py (path:/tmp/pip-_mEue6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:17 INFO - Running setup.py (path:/tmp/pip-q3JdlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:17 INFO - Running setup.py (path:/tmp/pip-ax1Ep_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:17 INFO - Running setup.py (path:/tmp/pip-DBmRCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:17 INFO - Running setup.py (path:/tmp/pip-TGSY7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:17 INFO - Running setup.py (path:/tmp/pip-W968jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:17 INFO - Running setup.py (path:/tmp/pip-HNZfKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:17 INFO - Running setup.py (path:/tmp/pip-VR49lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:17 INFO - Running setup.py (path:/tmp/pip-8jdPTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:17 INFO - Running setup.py (path:/tmp/pip-ledkYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:17 INFO - Running setup.py (path:/tmp/pip-K1hb1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:18 INFO - Running setup.py (path:/tmp/pip-EWlJhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:18 INFO - Running setup.py (path:/tmp/pip-MWHq8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:18 INFO - Running setup.py (path:/tmp/pip-pglJ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:18 INFO - Running setup.py (path:/tmp/pip-J8KJwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:18 INFO - Running setup.py (path:/tmp/pip-nhkR_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:18 INFO - Running setup.py (path:/tmp/pip-8PPyMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:18 INFO - Running setup.py install for manifestparser 07:09:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Running setup.py install for mozcrash 07:09:18 INFO - Running setup.py install for mozdebug 07:09:18 INFO - Running setup.py install for mozdevice 07:09:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Running setup.py install for mozfile 07:09:18 INFO - Running setup.py install for mozhttpd 07:09:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozinfo 07:09:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozInstall 07:09:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozleak 07:09:19 INFO - Running setup.py install for mozlog 07:09:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for moznetwork 07:09:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozprocess 07:09:19 INFO - Running setup.py install for mozprofile 07:09:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozrunner 07:09:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozscreenshot 07:09:19 INFO - Running setup.py install for moztest 07:09:20 INFO - Running setup.py install for mozversion 07:09:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:20 INFO - Cleaning up... 07:09:20 INFO - Return code: 0 07:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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', '-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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:20 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 07:09:20 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 07:09:20 INFO - Using env: {'DISPLAY': ':0', 07:09:20 INFO - 'HOME': '/home/cltbld', 07:09:20 INFO - 'LANG': 'en_US.UTF-8', 07:09:20 INFO - 'LANGUAGE': 'en_US:en', 07:09:20 INFO - 'LOGNAME': 'cltbld', 07:09:20 INFO - 'MAIL': '/var/mail/cltbld', 07:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:20 INFO - 'MOZ_NO_REMOTE': '1', 07:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:20 INFO - 'NO_EM_RESTART': '1', 07:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:20 INFO - 'PWD': '/builds/slave/test', 07:09:20 INFO - 'SHELL': '/bin/bash', 07:09:20 INFO - 'SHLVL': '1', 07:09:20 INFO - 'TERM': 'linux', 07:09:20 INFO - 'TMOUT': '86400', 07:09:20 INFO - 'USER': 'cltbld', 07:09:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:20 INFO - '_': '/tools/buildbot/bin/python'} 07:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:20 INFO - Running setup.py (path:/tmp/pip-dIu3wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:20 INFO - Running setup.py (path:/tmp/pip-i8cDA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:20 INFO - Running setup.py (path:/tmp/pip-TlT5ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:20 INFO - Running setup.py (path:/tmp/pip-7bNkV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:20 INFO - Running setup.py (path:/tmp/pip-NZMu62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:20 INFO - Running setup.py (path:/tmp/pip-urCSur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:20 INFO - Running setup.py (path:/tmp/pip-xhrHoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:20 INFO - Running setup.py (path:/tmp/pip-d3mnvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:21 INFO - Running setup.py (path:/tmp/pip-K4_LIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:21 INFO - Running setup.py (path:/tmp/pip-i2AlFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:21 INFO - Running setup.py (path:/tmp/pip-M1gXvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:21 INFO - Running setup.py (path:/tmp/pip-0g67Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:21 INFO - Running setup.py (path:/tmp/pip-BnAbKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:21 INFO - Running setup.py (path:/tmp/pip-Ds865i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:22 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)) 07:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:22 INFO - Running setup.py (path:/tmp/pip-U2TBlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:22 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)) 07:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:22 INFO - Running setup.py (path:/tmp/pip-Z2N1hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:22 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)) 07:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:22 INFO - Running setup.py (path:/tmp/pip-NrKwoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:22 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)) 07:09:22 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)) 07:09:22 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)) 07:09:22 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)) 07:09:22 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)) 07:09:22 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)) 07:09:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:23 INFO - Downloading blessings-1.5.1.tar.gz 07:09:23 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 07:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:23 INFO - Installing collected packages: blessings 07:09:23 INFO - Running setup.py install for blessings 07:09:24 INFO - Successfully installed blessings 07:09:24 INFO - Cleaning up... 07:09:24 INFO - Return code: 0 07:09:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:24 INFO - Reading from file tmpfile_stdout 07:09:24 INFO - Current package versions: 07:09:24 INFO - argparse == 1.2.1 07:09:24 INFO - blessings == 1.5.1 07:09:24 INFO - blobuploader == 1.2.4 07:09:24 INFO - docopt == 0.6.1 07:09:24 INFO - manifestparser == 1.1 07:09:24 INFO - mozInstall == 1.12 07:09:24 INFO - mozcrash == 0.16 07:09:24 INFO - mozdebug == 0.1 07:09:24 INFO - mozdevice == 0.47 07:09:24 INFO - mozfile == 1.2 07:09:24 INFO - mozhttpd == 0.7 07:09:24 INFO - mozinfo == 0.9 07:09:24 INFO - mozleak == 0.1 07:09:24 INFO - mozlog == 3.1 07:09:24 INFO - moznetwork == 0.27 07:09:24 INFO - mozprocess == 0.22 07:09:24 INFO - mozprofile == 0.28 07:09:24 INFO - mozrunner == 6.11 07:09:24 INFO - mozscreenshot == 0.1 07:09:24 INFO - mozsystemmonitor == 0.0 07:09:24 INFO - moztest == 0.7 07:09:24 INFO - mozversion == 1.4 07:09:24 INFO - psutil == 3.1.1 07:09:24 INFO - requests == 1.2.3 07:09:24 INFO - wsgiref == 0.1.2 07:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:24 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')]} 07:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 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')]} 07:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:24 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 07:09:24 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 07:09:24 INFO - Using env: {'DISPLAY': ':0', 07:09:24 INFO - 'HOME': '/home/cltbld', 07:09:24 INFO - 'LANG': 'en_US.UTF-8', 07:09:24 INFO - 'LANGUAGE': 'en_US:en', 07:09:24 INFO - 'LOGNAME': 'cltbld', 07:09:24 INFO - 'MAIL': '/var/mail/cltbld', 07:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:24 INFO - 'MOZ_NO_REMOTE': '1', 07:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:24 INFO - 'NO_EM_RESTART': '1', 07:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:24 INFO - 'PWD': '/builds/slave/test', 07:09:24 INFO - 'SHELL': '/bin/bash', 07:09:24 INFO - 'SHLVL': '1', 07:09:24 INFO - 'TERM': 'linux', 07:09:24 INFO - 'TMOUT': '86400', 07:09:24 INFO - 'USER': 'cltbld', 07:09:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:24 INFO - '_': '/tools/buildbot/bin/python'} 07:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 INFO - Cleaning up... 07:09:24 INFO - Return code: 0 07:09:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:24 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')]} 07:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 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')]} 07:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:24 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 07:09:24 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 07:09:24 INFO - Using env: {'DISPLAY': ':0', 07:09:24 INFO - 'HOME': '/home/cltbld', 07:09:24 INFO - 'LANG': 'en_US.UTF-8', 07:09:24 INFO - 'LANGUAGE': 'en_US:en', 07:09:24 INFO - 'LOGNAME': 'cltbld', 07:09:24 INFO - 'MAIL': '/var/mail/cltbld', 07:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:24 INFO - 'MOZ_NO_REMOTE': '1', 07:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:24 INFO - 'NO_EM_RESTART': '1', 07:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:24 INFO - 'PWD': '/builds/slave/test', 07:09:24 INFO - 'SHELL': '/bin/bash', 07:09:24 INFO - 'SHLVL': '1', 07:09:24 INFO - 'TERM': 'linux', 07:09:24 INFO - 'TMOUT': '86400', 07:09:24 INFO - 'USER': 'cltbld', 07:09:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:24 INFO - '_': '/tools/buildbot/bin/python'} 07:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:24 INFO - Downloading/unpacking jsonschema 07:09:24 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 07:09:24 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 07:09:24 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 07:09:24 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 07:09:24 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 07:09:24 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 07:09:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:27 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 07:09:27 INFO - Downloading/unpacking functools32 (from jsonschema) 07:09:27 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 07:09:27 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 07:09:27 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 07:09:27 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 07:09:27 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 07:09:27 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 07:09:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:27 INFO - warning: no files found matching '*.txt' 07:09:27 INFO - no previously-included directories found matching 'build' 07:09:27 INFO - no previously-included directories found matching 'dist' 07:09:27 INFO - no previously-included directories found matching '.git*' 07:09:27 INFO - Installing collected packages: jsonschema, functools32 07:09:27 INFO - Running setup.py install for functools32 07:09:27 INFO - warning: no files found matching '*.txt' 07:09:27 INFO - no previously-included directories found matching 'build' 07:09:27 INFO - no previously-included directories found matching 'dist' 07:09:27 INFO - no previously-included directories found matching '.git*' 07:09:27 INFO - Successfully installed jsonschema functools32 07:09:27 INFO - Cleaning up... 07:09:27 INFO - Return code: 0 07:09:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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', '--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 0x7fc54a9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1858dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, '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': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', '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 07:09:27 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 07:09:27 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 07:09:27 INFO - Using env: {'DISPLAY': ':0', 07:09:27 INFO - 'HOME': '/home/cltbld', 07:09:27 INFO - 'LANG': 'en_US.UTF-8', 07:09:27 INFO - 'LANGUAGE': 'en_US:en', 07:09:27 INFO - 'LOGNAME': 'cltbld', 07:09:27 INFO - 'MAIL': '/var/mail/cltbld', 07:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:27 INFO - 'MOZ_NO_REMOTE': '1', 07:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:27 INFO - 'NO_EM_RESTART': '1', 07:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:27 INFO - 'PWD': '/builds/slave/test', 07:09:27 INFO - 'SHELL': '/bin/bash', 07:09:27 INFO - 'SHLVL': '1', 07:09:27 INFO - 'TERM': 'linux', 07:09:27 INFO - 'TMOUT': '86400', 07:09:27 INFO - 'USER': 'cltbld', 07:09:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:27 INFO - '_': '/tools/buildbot/bin/python'} 07:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:27 INFO - Downloading/unpacking flake8 07:09:27 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 07:09:27 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 07:09:27 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 07:09:27 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 07:09:27 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 07:09:27 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 07:09:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:29 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 07:09:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:09:29 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 07:09:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:29 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 07:09:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:30 INFO - no previously-included directories found matching 'docs/_build' 07:09:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:09:30 INFO - Running setup.py install for pep8 07:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:30 INFO - no previously-included directories found matching 'docs/_build' 07:09:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:09:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:09:30 INFO - Cleaning up... 07:09:30 INFO - Return code: 0 07:09:30 INFO - Running post-action listener: _resource_record_post_action 07:09:30 INFO - Running post-action listener: _start_resource_monitoring 07:09:30 INFO - Starting resource monitoring. 07:09:30 INFO - ##### 07:09:30 INFO - ##### Running install step. 07:09:30 INFO - ##### 07:09:30 INFO - Running pre-action listener: _resource_record_pre_action 07:09:30 INFO - Running main action method: install 07:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:30 INFO - Reading from file tmpfile_stdout 07:09:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:30 INFO - Reading from file tmpfile_stdout 07:09:30 INFO - Output received: 07:09:30 INFO - Usage: mozinstall [options] installer 07:09:30 INFO - Options: 07:09:30 INFO - -h, --help show this help message and exit 07:09:30 INFO - -d DEST, --destination=DEST 07:09:30 INFO - Directory to install application into. [default: 07:09:30 INFO - "/builds/slave/test"] 07:09:30 INFO - --app=APP Application being installed. [default: firefox] 07:09:30 INFO - mkdir: /builds/slave/test/build/application 07:09:30 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'] 07:09:30 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 07:09:46 INFO - Reading from file tmpfile_stdout 07:09:46 INFO - Output received: 07:09:46 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:46 INFO - Running post-action listener: _resource_record_post_action 07:09:46 INFO - ##### 07:09:46 INFO - ##### Running run-tests step. 07:09:46 INFO - ##### 07:09:46 INFO - Running pre-action listener: _resource_record_pre_action 07:09:46 INFO - Running main action method: run_tests 07:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:46 INFO - Python 2.7.3 07:09:46 INFO - Return code: 0 07:09:46 INFO - grabbing minidump binary from tooltool 07:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:46 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 0x18eb3d0>, '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 0x1856ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1857360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:46 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 07:09:46 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 07:09:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:46 INFO - Return code: 0 07:09:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:09:47 INFO - Return code: 0 07:09:47 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:09:47 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:09:47 INFO - Using env: {'DISPLAY': ':0', 07:09:47 INFO - 'HOME': '/home/cltbld', 07:09:47 INFO - 'LANG': 'en_US.UTF-8', 07:09:47 INFO - 'LANGUAGE': 'en_US:en', 07:09:47 INFO - 'LOGNAME': 'cltbld', 07:09:47 INFO - 'MAIL': '/var/mail/cltbld', 07:09:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:47 INFO - 'MOZ_NO_REMOTE': '1', 07:09:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:47 INFO - 'NO_EM_RESTART': '1', 07:09:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:47 INFO - 'PWD': '/builds/slave/test', 07:09:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:47 INFO - 'SHELL': '/bin/bash', 07:09:47 INFO - 'SHLVL': '1', 07:09:47 INFO - 'TERM': 'linux', 07:09:47 INFO - 'TMOUT': '86400', 07:09:47 INFO - 'USER': 'cltbld', 07:09:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424', 07:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:47 INFO - '_': '/tools/buildbot/bin/python'} 07:09:47 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:09:47 INFO - mozversion application_buildid: 20160111055931 07:09:47 INFO - mozversion application_changeset: 15c5eb70ba7385270f1caa8a94746fd1320d4b8a 07:09:47 INFO - mozversion application_display_name: Nightly 07:09:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:47 INFO - mozversion application_name: Firefox 07:09:47 INFO - mozversion application_remotingname: firefox 07:09:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:09:47 INFO - mozversion application_vendor: Mozilla 07:09:47 INFO - mozversion application_version: 46.0a1 07:09:47 INFO - mozversion platform_buildid: 20160111055931 07:09:47 INFO - mozversion platform_changeset: 15c5eb70ba7385270f1caa8a94746fd1320d4b8a 07:09:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:09:47 INFO - mozversion platform_version: 46.0a1 07:09:47 INFO - using testdate: 1452524987 07:09:47 INFO - actual date: 1452524987 07:09:47 INFO - starting webserver on 'localhost:46332' 07:09:47 INFO - SUITE-START | Running 3 tests 07:09:47 INFO - TEST-START | dromaeo_css 07:09:47 INFO - operating with platform_type : linux_ 07:09:47 INFO - Initialising browser for dromaeo_css test... 07:09:47 INFO - TEST-INFO | started process 1402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbDUCX/profile http://localhost:46332/getInfo.html) 07:09:52 INFO - PROCESS | 1402 | 07:09:52 INFO - PROCESS | 1402 | (process:1489): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:09:53 INFO - PROCESS | 1402 | __metrics Screen width/height:1600/1200 07:09:53 INFO - PROCESS | 1402 | colorDepth:24 07:09:53 INFO - PROCESS | 1402 | Browser inner width/height: 1024/697 07:09:53 INFO - PROCESS | 1402 | __metrics 07:09:53 INFO - PROCESS | 1402 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:54 INFO - TEST-INFO | 1402: exit 0 07:09:54 INFO - Browser initialized. 07:09:54 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:54 INFO - TEST-INFO | started process 1538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbDUCX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:55 INFO - PROCESS | 1538 | 07:09:55 INFO - PROCESS | 1538 | (process:1597): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:10:06 INFO - PROCESS | 1538 | RSS: Main: 150401024 07:10:06 INFO - PROCESS | 1538 | 07:10:56 INFO - PROCESS | 1538 | 1452525056007 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] 07:13:07 INFO - PROCESS | 1538 | Cycle 1(1): loaded http://localhost:46332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46332/tests/dromaeo/cssquery-ext.html) 07:13:08 INFO - PROCESS | 1538 | RSS: Main: 152260608 07:13:08 INFO - PROCESS | 1538 | 07:16:10 INFO - PROCESS | 1538 | Cycle 1(1): loaded http://localhost:46332/tests/dromaeo/cssquery-ext.html (next: http://localhost:46332/tests/dromaeo/cssquery-jquery.html) 07:16:11 INFO - PROCESS | 1538 | RSS: Main: 153546752 07:16:11 INFO - PROCESS | 1538 | 07:19:13 INFO - PROCESS | 1538 | Cycle 1(1): loaded http://localhost:46332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46332/tests/dromaeo/cssquery-mootools.html) 07:19:13 INFO - PROCESS | 1538 | RSS: Main: 150851584 07:19:13 INFO - PROCESS | 1538 | 07:22:15 INFO - PROCESS | 1538 | Cycle 1(1): loaded http://localhost:46332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46332/tests/dromaeo/cssquery-prototype.html) 07:22:16 INFO - PROCESS | 1538 | RSS: Main: 149590016 07:22:16 INFO - PROCESS | 1538 | 07:25:18 INFO - PROCESS | 1538 | Cycle 1(1): loaded http://localhost:46332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46332/tests/dromaeo/cssquery-yui.html) 07:25:19 INFO - PROCESS | 1538 | RSS: Main: 151220224 07:25:19 INFO - PROCESS | 1538 | 07:28:21 INFO - PROCESS | 1538 | Cycle 1(1): loaded http://localhost:46332/tests/dromaeo/cssquery-yui.html (next: http://localhost:46332/tests/dromaeo/cssquery-dojo.html) 07:28:22 INFO - PROCESS | 1538 | RSS: Main: 153567232 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | __start_tp_report 07:28:22 INFO - PROCESS | 1538 | _x_x_mozilla_page_load 07:28:22 INFO - PROCESS | 1538 | _x_x_mozilla_page_load_details 07:28:22 INFO - PROCESS | 1538 | |i|pagename|runs| 07:28:22 INFO - PROCESS | 1538 | |0;dojo.html;2645.153550863724;2686.7850571954245;2716.2258756254473;2734.056750421104;2735.124760076776;4525.34382514536;4552.749598772066;4601.585857272845;4622;4670.112678591069;4523.660725445597;4615.423072115986;4637.443506779183;4669.019505903764;4714.622830173586;4103.507579090513;4336.609705126538;4345.261305578044;4393.626541743955;4429.247028005247;4146.564610715876;4328.458942632171;4369.584889435499;4381.298992161255;4388.188185185751;4253.2769429197115;4279.87160385189;4345.760983145926;4383.364412160219;4386.71486353386;4298.247806633858;4309.073549186908;4310.762908040057;4320.546342634009;4345.782710864444;4174.70777045607;4284.592963668447;4292.5492823253735;4307.203167414038;4343.891402714958;4483.439570053743;4492;4539.296409056601;4613.961858581826;4622.95377046232;4995.750212489397;5000.024995125952;5004.524570165829;5049.798008079709;5058.570021548173;4893.902121957576;5070.011347787183;5080.212567052113;5085.974570127126;5125.103106956268;4591.586757191835;4591.678582499193;4698.1778188816825;4708.599769019604;4760.500147484534;5150.866809301948;5165.793368265227;5170.353705786777;5182.093133701587;5196.9740151299;4755.690880092783;4870.14772414826;4961.950380496221;4971.527704868032;5011.774470148852;4931.7040977541465;4939.925901111486;5013.997200559903;5041.168207245837;5049.82325618609;4930.654854160174;4942.308076869242;4949.876253093629;4950.975245123751;4997.900041999213;4772.117158325721;4898.926516102261;4920.3111564381015;4927.581155601814;4948.505149485023;4136.896577585524;4189.497260328719;4198.916021679549;4207.789610519461;4236.618704316565;3712.925741485155;3726.2174943261675;3731.2164445466215;3745.0824547985917;3766.322062028861;4195.412642230091;4368.322909948963;4379.5182529921685;4380.6933514653665;4428.3800267962515;4879.219324907997;4956.157453232959;5047.570956468741;5073.898522029539;5102.387713474407;4303.053328267776;4337.0458499130145;4354.085642015212;4363.52001279859;4391.165678521071;4363.80362883671;4462.174497717932;4485.416895803524;4488.708233964782;4518.819247230074;4653.255479123324;4716.9292460613115;4772.49888761675;4780.569748722632;4823.8552843415455;4986.227134794112;5019.7490125494305;5021.096202683552;5023.949760502494;5064.848054558369;4627.259638457831;4720.504347043511;4766.594839438548;4772.5227477252;4814.085323788469;4892.730899800403;4932.1122198004705;4955.72743499111;4960.206366981266;5000.12497812874;4956.653034287565;5007.198848184273;5010.098182327216;5015.699058056528;5060.569851562511;4706.458757242961;4779.06808172403;4859.343988561499;4860.100881336823;4898.461169271449;4806.158922188533;4814.855554333376;4821.831235906727;4840.83057093;4842.346283251857;4696.671233013656;4705.106029854317;4710.1757192490495;4715;4751.239801631722;4725.810967561397;4806.567408933212;4817.0365926815475;4824.469308376006;4852.8301509447;4790.496997815179;4792.616590672807;4808.591269742111;4810.350602668735;4846.39420072491 07:28:22 INFO - PROCESS | 1538 | |1;ext.html;482.52230292010915;484.6147312886257;489.5080444153625;511.52683767515083;512.1063743767127;25387;27174.184774456775;31611.20971975702;32430.18924526888;32518.837405812996;34725.47911781319;35078.82460587694;35112.64887351132;35321.11697207571;35359.2928141437;7520.8119797004965;7624.123225829017;7660.693572257103;7690.3078722914925;7696.384289256846;7410.851782964364;7555.697772089137;7587.241275872396;7591.696332146735;7604.353629941462;7761.417893657998;7770;7832.490888092284;7858.803529911741;7867.134615192324;7714.459987800856;7784.922150778476;7796.298333150044;7797.33722633574;7809.453338266324;7542.094948606147;7611.847763044708;7620.733274335372;7677.078750549914;7678.5392876427595;35426;35888;35903.82048089769;35931.28137437263;36121.27757444863;2729.9454010919867;2866.3693987322754;2870.7846911481515;3028.4094601552706;3356.9328613427597;27023.483132673733;27311.180664580093;27487.45025099507;27964.440711185664;28085.29786755327;3245.480723084319;3268.3299923515624;3293.4565796643765;3297;3320.352531256406;211551;211586;212223;212577;212790;48435.5156448431;48445.27332090022;48557;48610;48736;59641.403585963584;60647.696761516796;60665.69667151636;60722.392776071676;60800.69599651973;13588.456461741618;13636.318184090756;13766.93116534411;13863.098898571561;13865.4453821846;10898.18263630215;10976.451177441097;11016.17378696585;11018.50416731249;11032.50353734084;19452;19733.506662333555;19738.802611973984;19757.506062348268;19763.209471621263;7515.586642734702;7674.431389403954;7731.690732370642;7773.611319434119;7778.183290754502;777.2616014785863;824.74432925792;865.3899001204136;979.5249304087512;1015.669907280137;24434;24609.507809843704;24681.259562213163;24807.62788558173;24816.751832481805;904.5251243097294;905.9456432614064;925.8194652042787;953.1516949914582;970.9417434953925;13088.476460941647;13255.73488530224;13338.466461341632;13427.328633568282;13457.05800593949;304611;307274;308612;309329;310110;46891;47506.28740568894;47514.28728569005;47526.5247347529;47677.76161119172;1195.3485350484007;1202.1404695642657;1206.2943178240828;1221.2489319068886;1226.9018478521698;24289.635655465536;25107;25330;25495.23514294574;25557;36257;36560.45159322665;36578.634213657526;36580.63419365772;36582.63417365899;233911;235531;237066;237509;237630;28886.566701499072;38192.42711359276;38927.416088758124;38945.80527097346;39098;35222;37584.91014759878;37694.246115078095;38181.80909095548;38434;32311;32451.837740811145;33151.502727458625;33723.66276337205;34092.488612670335;33108.66891331152;33263;33510.32979340448;33932.151696207795;34006.48990265198;32736.181595460304;34977.475337869444;35611.46582801312;35711.46432803458;35916.4612530807;25330.873345633154;27198;28848.7115128846;29243.561346580245;29638.40723185481;23243.418914527272;23267.18564850222;23343.76656233416;23405;23691 07:28:22 INFO - PROCESS | 1538 | |2;jquery.html;338.32504154212353;340.54027063464326;342.91598558353206;343.1763766959298;343.50363724418224;14125.152490850543;14289.214093224868;14804;15388.38446462143;15783.447579334726;10340.482975851197;10414.375137491756;10439.947800261007;13250.33748312583;14857.257137143126;4426.535213802553;4433.423654924855;4579;4628.467726211495;4632;4523.909521809562;4600.240960241556;4606.677532572721;4609.746463944482;4610.285405762095;3449.379111759882;4574.176648203322;4584.312353147021;4597.448306203243;5140.794368225266;5059.443461219263;5087;5110.488951104897;5117.8464646060675;5117.948820511803;4817.56641902227;5026.095302845486;5048.873778155539;5053.545180933696;5058.215976523645;16414.6717065658;16606.75089873653;16822.66354672912;17960.101994900204;17990.370337038272;1747.6155245845894;1813.791413987382;1858.8141185881439;1946.707993800927;2232.8883555822144;8643.35174861888;8740.825183496294;8812.911870881273;8866.024737278894;8986.595603197871;1716.3134746101534;1716.7339062445342;1740.3125765322752;1823.9908800456046;1832.5327041604305;46496.76751616254;47636.28545571819;47674.52325476736;47933.52066479361;48014.759926200146;9350.205232555172;9430.905690943002;9536.427814331162;9575;9597.616095356247;12166.087543434101;12278.815817762741;12281.324527151093;12287.692807679701;12292.323922184365;6902.206246281641;6967.651617419108;6994.68523916425;7005.0893383859775;7010.544314619533;6543.051257567626;6553.115329430466;6578.539502234893;6599.901001484982;6642;4077.6533994610195;4094.815733292009;4119.402686610425;4127.669786417079;4151.543330233671;1608.308427376216;1631.4453085950597;1698.8131305556378;1758.648270345936;1767.7083281258706;747.8392145688595;861.6596444404425;865.6623916672503;904.9773755656066;988.7972965542046;13137.802932956014;13936;14044.508442204473;14421.495247666282;15340;853.2917678326974;860.1742327365799;886.9489654759132;901.4095767272447;948.1466679988066;8325.708600199085;8572.742817715478;8585.570721463902;8603.096674849176;8671.783205419788;420070;431340;431551;434906;442033;62516.68741656263;62684.37315626877;62822;63109.36890631127;63689.681551591944;1064.1380481809758;1089.7929393415225;1105.8783533811275;1115.1914861725184;1120.7366268926633;13006.219626822422;13966.58100256994;14208.928955355157;14265.358058887168;14359.138451692932;27242.72757272402;28132;30419.39161216719;30875.69124308728;31328.06015819529;34376.656233437345;34954.65045349514;36080.27839443249;36604.633953661185;37012.44481332728;5934.970325148347;6169.907451388143;6290.119383286252;6373.936260637334;6407.551471397144;7533.359664428585;8855;8981.685641002534;9177.403468774775;9414.717558473258;7508.399328053633;7832.960835195788;8132.105468398589;8201.671933122609;8208.753737387888;8269.875951860606;8308.916910831056;8321.459105158145;8539.615717292612;8664.176903194186;8054.677812887418;8078.919210807817;8142;8216.055153657167;8264.628091735765;6387.265464471459;6696.096027036482;6730.360615741497;6743.055972163803;6759.86480270382;7011.544249623758;8027.4380793346245;8101.149379315087;8162.306203972729;8230.876536852073 07:28:22 INFO - PROCESS | 1538 | |3;mootools.html;1367.4530187924827;1370.2600595678332;1482.2440555316784;1684.9578760530992;1693.0857337038;6178.28949670788;6263.686815659222;6958.652067396629;7143.2142464328945;7192.568445893244;6797.76207832726;6968.96515517423;7040.964795176017;7042.366187043165;7044.859102817941;2138.561594873051;2171.2400659769114;2172.348295511348;2173.1416090644184;2179.226374637005;2114.503091773432;2122.172352782416;2174.630312846812;2180.106156475845;2180.3349978256624;2114.978850211501;2119.5231073008604;2124.948150665423;2126.680997850327;2146.399008277677;2151.8170955468727;2152.8923553822324;2153.2894144932134;2162.740471143465;2167.111484291433;2137.700721898935;2184.322859913432;2186.158329043314;2187.8359123065834;2195.560887822426;7318.853622927511;7337.853242935112;7346.706131754723;7379.225181355988;7422.406207503441;4151.937720934158;4301.913961720779;4316.503602085769;4325.567443255649;4331.718438301532;2793.5949287353424;2828.717128287155;2848.458792829356;2851.543752999531;2865.3409715765283;834.6369329341755;863.1356270455848;867.5445391169624;868.2055918834259;894.2532984957568;9711.174550163245;9812.018798120202;9817.950910245403;9818.9509052455;9823.115919567274;3915.393114067267;3973.7417067890497;4025.2352053109817;4034.1931613676793;4066.573009833984;8412.957935210285;8452.74641760748;8471.110533394029;8476.576171191417;8490.660373585111;4301.376300436419;4320.481542214954;4323.502797178365;4330.9350359744;4334.089841133335;3351.9329613407594;3417.2823707021307;3791.33651610967;3918.9020274492796;3923.3918742594374;3515.4199557073307;3538.327717733622;3541.026217790128;3543.7342199335153;3574.8033858137533;1147.8507793986896;1149.747055647756;1160.0778028166258;1169.473736818435;1169.6783384569142;1179.5340840368178;1183.952641894332;1196.6888608961558;1206.2340413837276;1209.9516019359303;6285.308616052231;6334.651594162273;6359.268684101295;6376.1392212051705;6856.417204537571;438.8376300768736;446.32604766802365;448.0501337165231;448.3521311704621;449.0188937172289;5249.317588713519;5307.124324486494;5307.49578790022;5309.3894202166475;5316.069687804618;8130.30892374143;8279.8344033119;8377.120402357787;8730.825383492422;8767.430117042371;8346.20711032463;8366.832663346699;8372.330213582898;8383.203595658402;8452.943382077241;6719.697613607497;6791.252962174157;6867.244603093655;6875.5874647521305;6898.862022759517;6757.256701762901;6899.6205208712;6914.723411063703;6917.965410172917;6937.202221744564;7644.350230230492;7784.170719880936;7820.608969551614;7880.369570434466;7928.445008849556;7720;7939.563324017235;8012.839743204987;8052.235037671412;8080.959595201986;5526.336839579276;5629.6903670298525;6070.332263450929;6500.577462464925;6603.141591593062;6649.867002660017;6664.266930637723;6680.231773346128;6688.531802773759;6705.497087718343;6294.842628934313;6375.330590288138;6516.315786842503;6522.934770652233;6541;6189.412005859436;6252.874942501216;6266.968665156645;6324.588901721373;6342.587731797418;6443.516736244706;6444.065610486359;6493.512986526124;6517.8696426072165;6528.053432252392;5918.644881306963;5935.614185077956;5978.222831031938;5981.700914954322;5993.700314984146;6053.424924632153;6088.969555152373;6097.359777223505;6111.327753947151;6114.327423983447 07:28:22 INFO - PROCESS | 1538 | |4;prototype.html;320.8219438211792;321.0528939628096;324.2073131194231;329.93236386540747;332.4365200984331;5414.864628384293;5512.173174023898;5586.748596313166;5610.66336019838;5631.915521267179;5362.91955620666;5445.727713614313;5462.180672899067;5467.234587157801;5481.835544933659;4344.565543445662;4350.934735978963;4366.497852746935;4370.803313850868;4381.693281470299;4356.455443069616;4363.847265345714;4373.125374925012;4384.649228061763;4384.824607015716;4116.97941510292;4236.131593023423;4334.501532323791;4334.84828031019;4357.041450880801;4258.957410425903;4265.338872474771;4276.059266961263;4282.2506061439435;4282.850100246492;3744.157564547982;3746.456763769238;3749.8312575933874;3754.812259387047;3759.191773768653;5338.039152952467;5340.06548853949;5342.572594192494;5347.358317001946;5359.5444387227135;4833;4941.184704523749;4941.357623508957;4955.4548999610015;4962.379702537183;5825.271841019872;5828.795992140297;5830.7667693292215;5839.883202335929;5845.473907348359;4040;4056.4726585543985;4058.269511487931;4063.9187216255805;4068.877933661995;6062.151298818169;6170.629762214281;6177.25872895251;6177.7837775677635;6181.598196117238;4041.3533834586324;4052.77709725962;4198.433211516406;4199.391088292181;4212.978935105305;4112.239235741397;4120.340745480768;4122.134351786099;4123.958760412357;4140.23405669952;4775.737334446639;4812.037592481518;4816.759162041884;4825.831095911626;4826.927596085991;5853.180554722342;5853.590248682552;5855.238818953509;5863.091220860773;5872.236609240771;1466.5453709350136;1483.406637345049;1515.4165646226281;1519.8784097272192;1521.5739592914001;1006.1347241372414;1016.9288149829589;1017.8422344536609;1029.7374169586708;1031.7781676939344;5053.797848086109;5109.3613298337705;5110.207917772751;5115.079285728604;5115.411727651293;6015.127806468037;6030.668313242813;6033.155358249848;6045.879082418327;6060.393960603904;5041.117804384291;5095.668781529189;5100.923486147711;5105.5149760772665;5118.283440318359;3196.31279274957;3241.918952026218;3267.39553182662;3283.4089863824743;3290.9962461449486;5724.513416359656;5734.340550836624;5802.390748971382;5803.100519419497;5819.214406055213;6217.751289948352;6230.283517395557;6249;6254.249490061222;6269.373062693694;5644.6330988485615;5689.573282003867;5693.202951586781;5714.342850572154;5735.340435849931;6176;6179.134921110958;6179.876402472015;6188.535859810622;6197;5999.760009599567;6014.248218972629;6019.097135429721;6029.939700602938;6046.1535385045245;5767.826965191051;5768.480836724715;5781.161731548817;5799.4780469757925;5834.329052159056;4032.5967403259438;4183.728057676241;4206.915861682811;4220.409142720083;4222.387753775747;5929.318128415115;6129.938700612936;6147.108669243024;6156.815295541141;6169.951108311508;5862.443067908542;5872.882542349214;5905.379935106752;5929.902967950943;5931.169636251015;5917.763289468545;5920;5921;5926.970365148319;5940.881182376242;5664.631798933056;5784.1034639630925;5810.709464526842;5818.389069147678;5820.388859169726;5936.079907614327;5951.732172052181;5958.672273024852;5965.821025369246;5966.49284810796;5772.797952071657;5807.564432667482;5820.534357251495;5825.592208545361;5826.242588463472 07:28:22 INFO - PROCESS | 1538 | |5;yui.html;775.8681024225884;787.7164220880486;796.4783067091056;800.6957356204641;810.3274282345653;10423.530941107649;10478.10936070433;10549.41978191199;10584.576616935314;10610.469476526172;10706.19703522237;10738.463076846165;10738.624148154817;10742.355458672486;10752.870948550408;612.3386742318286;622.8349487385824;777.2732495117084;792.7661339904713;793.2028311546916;774.4346626962321;779.9727009554666;781.316348195329;781.7732857471326;782.6517199846071;823.2960818500186;825.6119623776815;828.1759649149105;828.4035494443991;828.4366630691128;811.1645005644195;818.8157664525494;819.4304958054155;822.3421262989614;823.2960818500216;585.5842351930135;587.7061469265367;588.6791698524314;605.6003037994902;616.2420223125581;11546.942265288704;11591.24656897299;11617.361045142514;11632.941835290854;11704.356260405675;11402.942985285103;11695.590654327143;12063.276203427822;12092.214006089576;12252.938735306356;9397.906020939772;9437.952810235973;9495.192908602778;9811.754706132333;10002.199824014062;3217.8551965161623;3246.107320486861;3275.2630658101975;3279.2293810954407;3282.113829266085;36590;36717;36822;36848;37573.62426375729;8603.397762156588;8695.347848911231;8736.15143595298;8768.824623507495;8821.955890220508;15550.611234718996;15596.376144954074;15665.921670391803;15674.68650626981;15715.371385144696;5974.074018527135;6091.116788065794;6120.969395153084;6354.555181137276;6467.773627923;3562.91092722684;3576.2668652926086;3612.7832330060282;3618.5295911531334;3636.07280143567;2656.6413534173025;2662.347724807396;2668.946621067568;2679.209633158223;2682.061278552491;475.60524764445427;480.5578867441962;489.5716248282753;492.450917227289;493.62977766674993;452.9026259354255;456.4978523623987;460.37389150755615;478.2305469761895;608.7004245934961;7092.680829362691;7203.243659415791;7271.709131634781;7327.45044121693;7559.055118110236;567.5204452237853;569.7179895951448;574.6724367110706;577.2034592262651;602.4397310501275;3416.7095796857548;3433.3991551478393;3456.6024907135497;3474.2530355973586;3518.20840310928;43378.56621433745;44052.55947440548;44102.55897441049;44291.11417771626;44351.33472997908;45400;45453.54546454559;45518.08963820705;46288;46776;36037.63962360395;36402;36988;37284.44073338902;37604.623953760114;7355.632218389166;7376.868953386121;7588.430867684835;7625.084989801259;7667.88498172539;28736.712632873405;29153.41693166167;29282.121536353945;29511;29767.55348669815;33284;33297.83351083229;36440.453393199656;36444.27111457703;36648.45027324645;9215.907840921505;9383.624655013997;9589.616415343588;9743.658971935949;10058.396496210251;10230.079292863678;10677.199210059121;10905.618303359344;10946.397948112612;11264.436778161224;9233.815323693623;9347.532623368941;9433.669821556212;9491.952540237255;10299.3820370778;9555.856662150212;9705.757356066155;9758;9875.209983201183;10059.446730429896;9644.324897257125;9873.703788886345;10002.24983126283;10084.142847858015;10113.342632728849;7782.766517004499;7900.723474678359;8340.623797073415;8824.823503530022;8932.821343573221;8449.197326253996;8551.35864810154;8638.17937295956;8719.65121395137;8822.867656985021 07:28:22 INFO - PROCESS | 1538 | __end_tp_report 07:28:22 INFO - PROCESS | 1538 | __start_cc_report 07:28:22 INFO - PROCESS | 1538 | _x_x_mozilla_cycle_collect,336 07:28:22 INFO - PROCESS | 1538 | __end_cc_report 07:28:22 INFO - PROCESS | 1538 | __startTimestamp1452526102127__endTimestamp 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | ------- Summary: start ------- 07:28:22 INFO - PROCESS | 1538 | Number of tests: 6 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | [#0] dojo.html Cycles:165 Average:4614.52 Median:4720.50 stddev:469.18 (9.9%) stddev-sans-first:444.46 07:28:22 INFO - PROCESS | 1538 | Values: 2645.2 2686.8 2716.2 2734.1 2735.1 4525.3 4552.7 4601.6 4622.0 4670.1 4523.7 4615.4 4637.4 4669.0 4714.6 4103.5 4336.6 4345.3 4393.6 4429.2 4146.6 4328.5 4369.6 4381.3 4388.2 4253.3 4279.9 4345.8 4383.4 4386.7 4298.2 4309.1 4310.8 4320.5 4345.8 4174.7 4284.6 4292.5 4307.2 4343.9 4483.4 4492.0 4539.3 4614.0 4623.0 4995.8 5000.0 5004.5 5049.8 5058.6 4893.9 5070.0 5080.2 5086.0 5125.1 4591.6 4591.7 4698.2 4708.6 4760.5 5150.9 5165.8 5170.4 5182.1 5197.0 4755.7 4870.1 4962.0 4971.5 5011.8 4931.7 4939.9 5014.0 5041.2 5049.8 4930.7 4942.3 4949.9 4951.0 4997.9 4772.1 4898.9 4920.3 4927.6 4948.5 4136.9 4189.5 4198.9 4207.8 4236.6 3712.9 3726.2 3731.2 3745.1 3766.3 4195.4 4368.3 4379.5 4380.7 4428.4 4879.2 4956.2 5047.6 5073.9 5102.4 4303.1 4337.0 4354.1 4363.5 4391.2 4363.8 4462.2 4485.4 4488.7 4518.8 4653.3 4716.9 4772.5 4780.6 4823.9 4986.2 5019.7 5021.1 5023.9 5064.8 4627.3 4720.5 4766.6 4772.5 4814.1 4892.7 4932.1 4955.7 4960.2 5000.1 4956.7 5007.2 5010.1 5015.7 5060.6 4706.5 4779.1 4859.3 4860.1 4898.5 4806.2 4814.9 4821.8 4840.8 4842.3 4696.7 4705.1 4710.2 4715.0 4751.2 4725.8 4806.6 4817.0 4824.5 4852.8 4790.5 4792.6 4808.6 4810.4 4846.4 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | [#1] ext.html Cycles:180 Average:40795.90 Median:33969.32 stddev:66776.62 (196.6%) stddev-sans-first:66895.34 07:28:22 INFO - PROCESS | 1538 | Values: 482.5 484.6 489.5 511.5 512.1 25387.0 27174.2 31611.2 32430.2 32518.8 34725.5 35078.8 35112.6 35321.1 35359.3 7520.8 7624.1 7660.7 7690.3 7696.4 7410.9 7555.7 7587.2 7591.7 7604.4 7761.4 7770.0 7832.5 7858.8 7867.1 7714.5 7784.9 7796.3 7797.3 7809.5 7542.1 7611.8 7620.7 7677.1 7678.5 35426.0 35888.0 35903.8 35931.3 36121.3 2729.9 2866.4 2870.8 3028.4 3356.9 27023.5 27311.2 27487.5 27964.4 28085.3 3245.5 3268.3 3293.5 3297.0 3320.4 211551.0 211586.0 212223.0 212577.0 212790.0 48435.5 48445.3 48557.0 48610.0 48736.0 59641.4 60647.7 60665.7 60722.4 60800.7 13588.5 13636.3 13766.9 13863.1 13865.4 10898.2 10976.5 11016.2 11018.5 11032.5 19452.0 19733.5 19738.8 19757.5 19763.2 7515.6 7674.4 7731.7 7773.6 7778.2 777.3 824.7 865.4 979.5 1015.7 24434.0 24609.5 24681.3 24807.6 24816.8 904.5 905.9 925.8 953.2 970.9 13088.5 13255.7 13338.5 13427.3 13457.1 304611.0 307274.0 308612.0 309329.0 310110.0 46891.0 47506.3 47514.3 47526.5 47677.8 1195.3 1202.1 1206.3 1221.2 1226.9 24289.6 25107.0 25330.0 25495.2 25557.0 36257.0 36560.5 36578.6 36580.6 36582.6 233911.0 235531.0 237066.0 237509.0 237630.0 28886.6 38192.4 38927.4 38945.8 39098.0 35222.0 37584.9 37694.2 38181.8 38434.0 32311.0 32451.8 33151.5 33723.7 34092.5 33108.7 33263.0 33510.3 33932.2 34006.5 32736.2 34977.5 35611.5 35711.5 35916.5 25330.9 27198.0 28848.7 29243.6 29638.4 23243.4 23267.2 23343.8 23405.0 23691.0 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | [#2] jquery.html Cycles:180 Average:22865.53 Median:47655.40 stddev:70578.45 (148.1%) stddev-sans-first:70756.17 07:28:22 INFO - PROCESS | 1538 | Values: 338.3 340.5 342.9 343.2 343.5 14125.2 14289.2 14804.0 15388.4 15783.4 10340.5 10414.4 10439.9 13250.3 14857.3 4426.5 4433.4 4579.0 4628.5 4632.0 4523.9 4600.2 4606.7 4609.7 4610.3 3449.4 4574.2 4584.3 4597.4 5140.8 5059.4 5087.0 5110.5 5117.8 5117.9 4817.6 5026.1 5048.9 5053.5 5058.2 16414.7 16606.8 16822.7 17960.1 17990.4 1747.6 1813.8 1858.8 1946.7 2232.9 8643.4 8740.8 8812.9 8866.0 8986.6 1716.3 1716.7 1740.3 1824.0 1832.5 46496.8 47636.3 47674.5 47933.5 48014.8 9350.2 9430.9 9536.4 9575.0 9597.6 12166.1 12278.8 12281.3 12287.7 12292.3 6902.2 6967.7 6994.7 7005.1 7010.5 6543.1 6553.1 6578.5 6599.9 6642.0 4077.7 4094.8 4119.4 4127.7 4151.5 1608.3 1631.4 1698.8 1758.6 1767.7 747.8 861.7 865.7 905.0 988.8 13137.8 13936.0 14044.5 14421.5 15340.0 853.3 860.2 886.9 901.4 948.1 8325.7 8572.7 8585.6 8603.1 8671.8 420070.0 431340.0 431551.0 434906.0 442033.0 62516.7 62684.4 62822.0 63109.4 63689.7 1064.1 1089.8 1105.9 1115.2 1120.7 13006.2 13966.6 14208.9 14265.4 14359.1 27242.7 28132.0 30419.4 30875.7 31328.1 34376.7 34954.7 36080.3 36604.6 37012.4 5935.0 6169.9 6290.1 6373.9 6407.6 7533.4 8855.0 8981.7 9177.4 9414.7 7508.4 7833.0 8132.1 8201.7 8208.8 8269.9 8308.9 8321.5 8539.6 8664.2 8054.7 8078.9 8142.0 8216.1 8264.6 6387.3 6696.1 6730.4 6743.1 6759.9 7011.5 8027.4 8101.1 8162.3 8230.9 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | [#3] mootools.html Cycles:180 Average:5001.81 Median:6104.34 stddev:2586.14 (42.4%) stddev-sans-first:2578.96 07:28:22 INFO - PROCESS | 1538 | Values: 1367.5 1370.3 1482.2 1685.0 1693.1 6178.3 6263.7 6958.7 7143.2 7192.6 6797.8 6969.0 7041.0 7042.4 7044.9 2138.6 2171.2 2172.3 2173.1 2179.2 2114.5 2122.2 2174.6 2180.1 2180.3 2115.0 2119.5 2124.9 2126.7 2146.4 2151.8 2152.9 2153.3 2162.7 2167.1 2137.7 2184.3 2186.2 2187.8 2195.6 7318.9 7337.9 7346.7 7379.2 7422.4 4151.9 4301.9 4316.5 4325.6 4331.7 2793.6 2828.7 2848.5 2851.5 2865.3 834.6 863.1 867.5 868.2 894.3 9711.2 9812.0 9818.0 9819.0 9823.1 3915.4 3973.7 4025.2 4034.2 4066.6 8413.0 8452.7 8471.1 8476.6 8490.7 4301.4 4320.5 4323.5 4330.9 4334.1 3351.9 3417.3 3791.3 3918.9 3923.4 3515.4 3538.3 3541.0 3543.7 3574.8 1147.9 1149.7 1160.1 1169.5 1169.7 1179.5 1184.0 1196.7 1206.2 1210.0 6285.3 6334.7 6359.3 6376.1 6856.4 438.8 446.3 448.1 448.4 449.0 5249.3 5307.1 5307.5 5309.4 5316.1 8130.3 8279.8 8377.1 8730.8 8767.4 8346.2 8366.8 8372.3 8383.2 8452.9 6719.7 6791.3 6867.2 6875.6 6898.9 6757.3 6899.6 6914.7 6918.0 6937.2 7644.4 7784.2 7820.6 7880.4 7928.4 7720.0 7939.6 8012.8 8052.2 8081.0 5526.3 5629.7 6070.3 6500.6 6603.1 6649.9 6664.3 6680.2 6688.5 6705.5 6294.8 6375.3 6516.3 6522.9 6541.0 6189.4 6252.9 6267.0 6324.6 6342.6 6443.5 6444.1 6493.5 6517.9 6528.1 5918.6 5935.6 5978.2 5981.7 5993.7 6053.4 6089.0 6097.4 6111.3 6114.3 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | [#4] prototype.html Cycles:180 Average:4860.60 Median:5388.89 stddev:1438.76 (26.7%) stddev-sans-first:1401.87 07:28:22 INFO - PROCESS | 1538 | Values: 320.8 321.1 324.2 329.9 332.4 5414.9 5512.2 5586.7 5610.7 5631.9 5362.9 5445.7 5462.2 5467.2 5481.8 4344.6 4350.9 4366.5 4370.8 4381.7 4356.5 4363.8 4373.1 4384.6 4384.8 4117.0 4236.1 4334.5 4334.8 4357.0 4259.0 4265.3 4276.1 4282.3 4282.9 3744.2 3746.5 3749.8 3754.8 3759.2 5338.0 5340.1 5342.6 5347.4 5359.5 4833.0 4941.2 4941.4 4955.5 4962.4 5825.3 5828.8 5830.8 5839.9 5845.5 4040.0 4056.5 4058.3 4063.9 4068.9 6062.2 6170.6 6177.3 6177.8 6181.6 4041.4 4052.8 4198.4 4199.4 4213.0 4112.2 4120.3 4122.1 4124.0 4140.2 4775.7 4812.0 4816.8 4825.8 4826.9 5853.2 5853.6 5855.2 5863.1 5872.2 1466.5 1483.4 1515.4 1519.9 1521.6 1006.1 1016.9 1017.8 1029.7 1031.8 5053.8 5109.4 5110.2 5115.1 5115.4 6015.1 6030.7 6033.2 6045.9 6060.4 5041.1 5095.7 5100.9 5105.5 5118.3 3196.3 3241.9 3267.4 3283.4 3291.0 5724.5 5734.3 5802.4 5803.1 5819.2 6217.8 6230.3 6249.0 6254.2 6269.4 5644.6 5689.6 5693.2 5714.3 5735.3 6176.0 6179.1 6179.9 6188.5 6197.0 5999.8 6014.2 6019.1 6029.9 6046.2 5767.8 5768.5 5781.2 5799.5 5834.3 4032.6 4183.7 4206.9 4220.4 4222.4 5929.3 6129.9 6147.1 6156.8 6170.0 5862.4 5872.9 5905.4 5929.9 5931.2 5917.8 5920.0 5921.0 5927.0 5940.9 5664.6 5784.1 5810.7 5818.4 5820.4 5936.1 5951.7 5958.7 5965.8 5966.5 5772.8 5807.6 5820.5 5825.6 5826.2 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - PROCESS | 1538 | [#5] yui.html Cycles:180 Average:11493.85 Median:476.92 stddev:12798.26 (2683.5%) stddev-sans-first:12808.85 07:28:22 INFO - PROCESS | 1538 | Values: 775.9 787.7 796.5 800.7 810.3 10423.5 10478.1 10549.4 10584.6 10610.5 10706.2 10738.5 10738.6 10742.4 10752.9 612.3 622.8 777.3 792.8 793.2 774.4 780.0 781.3 781.8 782.7 823.3 825.6 828.2 828.4 828.4 811.2 818.8 819.4 822.3 823.3 585.6 587.7 588.7 605.6 616.2 11546.9 11591.2 11617.4 11632.9 11704.4 11402.9 11695.6 12063.3 12092.2 12252.9 9397.9 9438.0 9495.2 9811.8 10002.2 3217.9 3246.1 3275.3 3279.2 3282.1 36590.0 36717.0 36822.0 36848.0 37573.6 8603.4 8695.3 8736.2 8768.8 8822.0 15550.6 15596.4 15665.9 15674.7 15715.4 5974.1 6091.1 6121.0 6354.6 6467.8 3562.9 3576.3 3612.8 3618.5 3636.1 2656.6 2662.3 2668.9 2679.2 2682.1 475.6 480.6 489.6 492.5 493.6 452.9 456.5 460.4 478.2 608.7 7092.7 7203.2 7271.7 7327.5 7559.1 567.5 569.7 574.7 577.2 602.4 3416.7 3433.4 3456.6 3474.3 3518.2 43378.6 44052.6 44102.6 44291.1 44351.3 45400.0 45453.5 45518.1 46288.0 46776.0 36037.6 36402.0 36988.0 37284.4 37604.6 7355.6 7376.9 7588.4 7625.1 7667.9 28736.7 29153.4 29282.1 29511.0 29767.6 33284.0 33297.8 36440.5 36444.3 36648.5 9215.9 9383.6 9589.6 9743.7 10058.4 10230.1 10677.2 10905.6 10946.4 11264.4 9233.8 9347.5 9433.7 9492.0 10299.4 9555.9 9705.8 9758.0 9875.2 10059.4 9644.3 9873.7 10002.2 10084.1 10113.3 7782.8 7900.7 8340.6 8824.8 8932.8 8449.2 8551.4 8638.2 8719.7 8822.9 07:28:22 INFO - PROCESS | 1538 | -------- Summary: end -------- 07:28:22 INFO - PROCESS | 1538 | 07:28:22 INFO - TEST-INFO | 1538: exit 0 07:28:22 INFO - TEST-OK | dromaeo_css | took 1115392ms 07:28:22 INFO - TEST-START | kraken 07:28:22 INFO - operating with platform_type : linux_ 07:28:22 INFO - Initialising browser for kraken test... 07:28:22 INFO - TEST-INFO | started process 1780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDHdC8/profile http://localhost:46332/getInfo.html) 07:28:27 INFO - PROCESS | 1780 | 07:28:27 INFO - PROCESS | 1780 | (process:1854): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:28 INFO - PROCESS | 1780 | __metrics Screen width/height:1600/1200 07:28:28 INFO - PROCESS | 1780 | colorDepth:24 07:28:28 INFO - PROCESS | 1780 | Browser inner width/height: 1024/697 07:28:28 INFO - PROCESS | 1780 | __metrics 07:28:28 INFO - PROCESS | 1780 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:28:28 INFO - PROCESS | 1780 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 07:28:29 INFO - TEST-INFO | 1780: exit 0 07:28:29 INFO - Browser initialized. 07:28:29 INFO - Running cycle 1/1 for kraken test... 07:28:29 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDHdC8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:31 INFO - PROCESS | 1903 | 07:28:31 INFO - PROCESS | 1903 | (process:1960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:41 INFO - PROCESS | 1903 | RSS: Main: 150421504 07:28:41 INFO - PROCESS | 1903 | 07:28:44 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46332/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:44 INFO - PROCESS | 1903 | RSS: Main: 150499328 07:28:44 INFO - PROCESS | 1903 | 07:28:47 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46332/tests/kraken/driver.html?testName=audio-dft) 07:28:48 INFO - PROCESS | 1903 | RSS: Main: 151261184 07:28:48 INFO - PROCESS | 1903 | 07:28:51 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46332/tests/kraken/driver.html?testName=audio-fft) 07:28:51 INFO - PROCESS | 1903 | RSS: Main: 146305024 07:28:51 INFO - PROCESS | 1903 | 07:28:53 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46332/tests/kraken/driver.html?testName=audio-oscillator) 07:28:54 INFO - PROCESS | 1903 | RSS: Main: 147312640 07:28:54 INFO - PROCESS | 1903 | 07:28:56 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:57 INFO - PROCESS | 1903 | RSS: Main: 147632128 07:28:57 INFO - PROCESS | 1903 | 07:29:00 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46332/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:00 INFO - PROCESS | 1903 | RSS: Main: 148021248 07:29:00 INFO - PROCESS | 1903 | 07:29:04 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46332/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:04 INFO - PROCESS | 1903 | RSS: Main: 146685952 07:29:04 INFO - PROCESS | 1903 | 07:29:07 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46332/tests/kraken/driver.html?testName=json-parse-financial) 07:29:08 INFO - PROCESS | 1903 | RSS: Main: 147435520 07:29:08 INFO - PROCESS | 1903 | 07:29:10 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:10 INFO - PROCESS | 1903 | RSS: Main: 148799488 07:29:10 INFO - PROCESS | 1903 | 07:29:12 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:13 INFO - PROCESS | 1903 | RSS: Main: 148893696 07:29:13 INFO - PROCESS | 1903 | 07:29:15 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:16 INFO - PROCESS | 1903 | RSS: Main: 148930560 07:29:16 INFO - PROCESS | 1903 | 07:29:18 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:19 INFO - PROCESS | 1903 | RSS: Main: 147304448 07:29:19 INFO - PROCESS | 1903 | 07:29:21 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:22 INFO - PROCESS | 1903 | RSS: Main: 148393984 07:29:22 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:46332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46332/tests/kraken/driver.html?testName=ai-astar) 07:29:24 INFO - PROCESS | 1903 | RSS: Main: 149487616 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | __start_tp_report 07:29:24 INFO - PROCESS | 1903 | _x_x_mozilla_page_load 07:29:24 INFO - PROCESS | 1903 | _x_x_mozilla_page_load_details 07:29:24 INFO - PROCESS | 1903 | |i|pagename|runs| 07:29:24 INFO - PROCESS | 1903 | |0;ai-astar;114;110;112;115;114;126;114;113;115;115 07:29:24 INFO - PROCESS | 1903 | |1;audio-beat-detection;160;135;156;172;138;162;166;130;165;134 07:29:24 INFO - PROCESS | 1903 | |2;audio-dft;163;163;164;163;166;168;169;167;165;165 07:29:24 INFO - PROCESS | 1903 | |3;audio-fft;74;73;73;72;142;72;74;73;72;94 07:29:24 INFO - PROCESS | 1903 | |4;audio-oscillator;97;99;135;97;97;97;147;97;97;142 07:29:24 INFO - PROCESS | 1903 | |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;110;110 07:29:24 INFO - PROCESS | 1903 | |6;imaging-darkroom;148;149;150;148;150;148;147;147;150;148 07:29:24 INFO - PROCESS | 1903 | |7;imaging-desaturate;96;97;97;95;96;96;97;97;96;97 07:29:24 INFO - PROCESS | 1903 | |8;json-parse-financial;74;75;74;76;75;75;80;73;74;73 07:29:24 INFO - PROCESS | 1903 | |9;json-stringify-tinderbox;67;68;67;67;68;67;67;67;70;67 07:29:24 INFO - PROCESS | 1903 | |10;stanford-crypto-aes;85;83;86;84;86;85;90;84;85;84 07:29:24 INFO - PROCESS | 1903 | |11;stanford-crypto-ccm;129;133;119;132;132;129;134;122;132;129 07:29:24 INFO - PROCESS | 1903 | |12;stanford-crypto-pbkdf2;144;156;155;143;150;142;151;149;151;138 07:29:24 INFO - PROCESS | 1903 | |13;stanford-crypto-sha256-iterative;74;74;75;72;73;71;73;71;71;73 07:29:24 INFO - PROCESS | 1903 | __end_tp_report 07:29:24 INFO - PROCESS | 1903 | __start_cc_report 07:29:24 INFO - PROCESS | 1903 | _x_x_mozilla_cycle_collect,792 07:29:24 INFO - PROCESS | 1903 | __end_cc_report 07:29:24 INFO - PROCESS | 1903 | __startTimestamp1452526164606__endTimestamp 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | ------- Summary: start ------- 07:29:24 INFO - PROCESS | 1903 | Number of tests: 14 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.24 (3.7%) stddev-sans-first:4.48 07:29:24 INFO - PROCESS | 1903 | Values: 114.0 110.0 112.0 115.0 114.0 126.0 114.0 113.0 115.0 115.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:161.00 stddev:15.77 (9.8%) stddev-sans-first:16.44 07:29:24 INFO - PROCESS | 1903 | Values: 160.0 135.0 156.0 172.0 138.0 162.0 166.0 130.0 165.0 134.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.16 (1.3%) stddev-sans-first:2.13 07:29:24 INFO - PROCESS | 1903 | Values: 163.0 163.0 164.0 163.0 166.0 168.0 169.0 167.0 165.0 165.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#3] audio-fft Cycles:10 Average:81.90 Median:73.00 stddev:22.15 (30.3%) stddev-sans-first:23.31 07:29:24 INFO - PROCESS | 1903 | Values: 74.0 73.0 73.0 72.0 142.0 72.0 74.0 73.0 72.0 94.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:97.00 stddev:21.47 (22.1%) stddev-sans-first:22.21 07:29:24 INFO - PROCESS | 1903 | Values: 97.0 99.0 135.0 97.0 97.0 97.0 147.0 97.0 97.0 142.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:29:24 INFO - PROCESS | 1903 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.18 (0.8%) stddev-sans-first:1.24 07:29:24 INFO - PROCESS | 1903 | Values: 148.0 149.0 150.0 148.0 150.0 148.0 147.0 147.0 150.0 148.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:29:24 INFO - PROCESS | 1903 | Values: 96.0 97.0 97.0 95.0 96.0 96.0 97.0 97.0 96.0 97.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#8] json-parse-financial Cycles:10 Average:74.90 Median:75.00 stddev:2.02 (2.7%) stddev-sans-first:2.12 07:29:24 INFO - PROCESS | 1903 | Values: 74.0 75.0 74.0 76.0 75.0 75.0 80.0 73.0 74.0 73.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 07:29:24 INFO - PROCESS | 1903 | Values: 67.0 68.0 67.0 67.0 68.0 67.0 67.0 67.0 70.0 67.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.93 (2.3%) stddev-sans-first:2.05 07:29:24 INFO - PROCESS | 1903 | Values: 85.0 83.0 86.0 84.0 86.0 85.0 90.0 84.0 85.0 84.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:132.00 stddev:4.91 (3.7%) stddev-sans-first:5.21 07:29:24 INFO - PROCESS | 1903 | Values: 129.0 133.0 119.0 132.0 132.0 129.0 134.0 122.0 132.0 129.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.50 stddev:5.90 (3.9%) stddev-sans-first:6.08 07:29:24 INFO - PROCESS | 1903 | Values: 144.0 156.0 155.0 143.0 150.0 142.0 151.0 149.0 151.0 138.0 07:29:24 INFO - PROCESS | 1903 | 07:29:24 INFO - PROCESS | 1903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.42 (1.9%) stddev-sans-first:1.42 07:29:24 INFO - PROCESS | 1903 | Values: 74.0 74.0 75.0 72.0 73.0 71.0 73.0 71.0 71.0 73.0 07:29:24 INFO - PROCESS | 1903 | -------- Summary: end -------- 07:29:24 INFO - PROCESS | 1903 | 07:29:25 INFO - TEST-INFO | 1903: exit 0 07:29:25 INFO - TEST-OK | kraken | took 62697ms 07:29:25 INFO - TEST-START | v8_7 07:29:25 INFO - operating with platform_type : linux_ 07:29:25 INFO - Initialising browser for v8_7 test... 07:29:25 INFO - TEST-INFO | started process 2188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY40k9G/profile http://localhost:46332/getInfo.html) 07:29:30 INFO - PROCESS | 2188 | 07:29:30 INFO - PROCESS | 2188 | (process:2261): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:29:31 INFO - PROCESS | 2188 | __metrics Screen width/height:1600/1200 07:29:31 INFO - PROCESS | 2188 | colorDepth:24 07:29:31 INFO - PROCESS | 2188 | Browser inner width/height: 1024/697 07:29:31 INFO - PROCESS | 2188 | __metrics 07:29:31 INFO - PROCESS | 2188 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:29:32 INFO - TEST-INFO | 2188: exit 0 07:29:32 INFO - Browser initialized. 07:29:32 INFO - Running cycle 1/1 for v8_7 test... 07:29:32 INFO - TEST-INFO | started process 2310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY40k9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:33 INFO - PROCESS | 2310 | 07:29:33 INFO - PROCESS | 2310 | (process:2442): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:29:44 INFO - PROCESS | 2310 | RSS: Main: 150433792 07:29:44 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:46332/tests/v8_7/run.html (next: http://localhost:46332/tests/v8_7/run.html) 07:30:06 INFO - PROCESS | 2310 | RSS: Main: 146264064 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | __start_tp_report 07:30:06 INFO - PROCESS | 2310 | _x_x_mozilla_page_load 07:30:06 INFO - PROCESS | 2310 | _x_x_mozilla_page_load_details 07:30:06 INFO - PROCESS | 2310 | |i|pagename|runs| 07:30:06 INFO - PROCESS | 2310 | |0;Richards;167.64459346186086 07:30:06 INFO - PROCESS | 2310 | |1;DeltaBlue;187.02075930428276 07:30:06 INFO - PROCESS | 2310 | |2;Encrypt;279.01785714285717 07:30:06 INFO - PROCESS | 2310 | |3;Decrypt;5164.948453608247 07:30:06 INFO - PROCESS | 2310 | |4;RayTrace;1062.6992561105208 07:30:06 INFO - PROCESS | 2310 | |5;Earley;729.3946024799417 07:30:06 INFO - PROCESS | 2310 | |6;Boyer;12444.444444444445 07:30:06 INFO - PROCESS | 2310 | |7;RegExp;43382.97872340425 07:30:06 INFO - PROCESS | 2310 | |8;Splay;621.8905472636816 07:30:06 INFO - PROCESS | 2310 | |9;NavierStokes;4835.748792270531 07:30:06 INFO - PROCESS | 2310 | __end_tp_report 07:30:06 INFO - PROCESS | 2310 | __startTimestamp1452526206973__endTimestamp 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | ------- Summary: start ------- 07:30:06 INFO - PROCESS | 2310 | Number of tests: 10 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 167.6 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#1] DeltaBlue Cycles:1 Average:187.02 Median:187.02 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 187.0 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 279.0 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 5164.9 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 1062.7 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#5] Earley Cycles:1 Average:729.39 Median:729.39 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 729.4 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 12444.4 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#7] RegExp Cycles:1 Average:43382.98 Median:43382.98 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 43383.0 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#8] Splay Cycles:1 Average:621.89 Median:621.89 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 621.9 07:30:06 INFO - PROCESS | 2310 | 07:30:06 INFO - PROCESS | 2310 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:30:06 INFO - PROCESS | 2310 | Values: 4835.7 07:30:06 INFO - PROCESS | 2310 | -------- Summary: end -------- 07:30:06 INFO - PROCESS | 2310 | 07:30:08 INFO - TEST-INFO | 2310: exit 0 07:30:08 INFO - TEST-OK | v8_7 | took 42431ms 07:30:08 INFO - SUITE-END | took 1220s 07:30:08 INFO - Completed test suite (00:20:20) 07:30:08 INFO - Working with test: dromaeo_css 07:30:08 INFO - Generating results file: dromaeo_css 07:30:08 INFO - Working with test: kraken 07:30:08 INFO - Generating results file: kraken 07:30:08 INFO - javascript benchmark 07:30:08 INFO - Working with test: v8_7 07:30:08 INFO - Generating results file: v8_7 07:30:08 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:30:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:30:08 INFO - process_Request line: dromaeo_css 6140.92 graph.html#tests=[[72,132,43]] 07:30:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:30:08 INFO - process_Request line: kraken 1556.40 graph.html#tests=[[232,132,43]] 07:30:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:30:08 INFO - process_Request line: v8_7 20170.38 graph.html#tests=[[230,132,43]] 07:30:08 INFO - RETURN: dromaeo_css: 6140.92 07:30:08 INFO - RETURN: kraken: 1556.40 07:30:08 INFO - RETURN: v8_7: 20170.38 07:30:08 INFO - javascript benchmark 07:30:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2645.153550863724, 2686.7850571954245, 2716.2258756254473, 2734.056750421104, 2735.124760076776, 4525.34382514536, 4552.749598772066, 4601.585857272845, 4622.0, 4670.112678591069, 4523.660725445597, 4615.423072115986, 4637.443506779183, 4669.019505903764, 4714.622830173586, 4103.507579090513, 4336.609705126538, 4345.261305578044, 4393.626541743955, 4429.247028005247, 4146.564610715876, 4328.458942632171, 4369.584889435499, 4381.298992161255, 4388.188185185751, 4253.2769429197115, 4279.87160385189, 4345.760983145926, 4383.364412160219, 4386.71486353386, 4298.247806633858, 4309.073549186908, 4310.762908040057, 4320.546342634009, 4345.782710864444, 4174.70777045607, 4284.592963668447, 4292.5492823253735, 4307.203167414038, 4343.891402714958, 4483.439570053743, 4492.0, 4539.296409056601, 4613.961858581826, 4622.95377046232, 4995.750212489397, 5000.024995125952, 5004.524570165829, 5049.798008079709, 5058.570021548173, 4893.902121957576, 5070.011347787183, 5080.212567052113, 5085.974570127126, 5125.103106956268, 4591.586757191835, 4591.678582499193, 4698.1778188816825, 4708.599769019604, 4760.500147484534, 5150.866809301948, 5165.793368265227, 5170.353705786777, 5182.093133701587, 5196.9740151299, 4755.690880092783, 4870.14772414826, 4961.950380496221, 4971.527704868032, 5011.774470148852, 4931.7040977541465, 4939.925901111486, 5013.997200559903, 5041.168207245837, 5049.82325618609, 4930.654854160174, 4942.308076869242, 4949.876253093629, 4950.975245123751, 4997.900041999213, 4772.117158325721, 4898.926516102261, 4920.3111564381015, 4927.581155601814, 4948.505149485023, 4136.896577585524, 4189.497260328719, 4198.916021679549, 4207.789610519461, 4236.618704316565, 3712.925741485155, 3726.2174943261675, 3731.2164445466215, 3745.0824547985917, 3766.322062028861, 4195.412642230091, 4368.322909948963, 4379.5182529921685, 4380.6933514653665, 4428.3800267962515, 4879.219324907997, 4956.157453232959, 5047.570956468741, 5073.898522029539, 5102.387713474407, 4303.053328267776, 4337.0458499130145, 4354.085642015212, 4363.52001279859, 4391.165678521071, 4363.80362883671, 4462.174497717932, 4485.416895803524, 4488.708233964782, 4518.819247230074, 4653.255479123324, 4716.9292460613115, 4772.49888761675, 4780.569748722632, 4823.8552843415455, 4986.227134794112, 5019.7490125494305, 5021.096202683552, 5023.949760502494, 5064.848054558369, 4627.259638457831, 4720.504347043511, 4766.594839438548, 4772.5227477252, 4814.085323788469, 4892.730899800403, 4932.1122198004705, 4955.72743499111, 4960.206366981266, 5000.12497812874, 4956.653034287565, 5007.198848184273, 5010.098182327216, 5015.699058056528, 5060.569851562511, 4706.458757242961, 4779.06808172403, 4859.343988561499, 4860.100881336823, 4898.461169271449, 4806.158922188533, 4814.855554333376, 4821.831235906727, 4840.83057093, 4842.346283251857, 4696.671233013656, 4705.106029854317, 4710.1757192490495, 4715.0, 4751.239801631722, 4725.810967561397, 4806.567408933212, 4817.0365926815475, 4824.469308376006, 4852.8301509447, 4790.496997815179, 4792.616590672807, 4808.591269742111, 4810.350602668735, 4846.39420072491], "unit": "score", "name": "dojo.html", "value": 4586.206993365804}, {"lowerIsBetter": false, "replicates": [482.52230292010915, 484.6147312886257, 489.5080444153625, 511.52683767515083, 512.1063743767127, 25387.0, 27174.184774456775, 31611.20971975702, 32430.18924526888, 32518.837405812996, 34725.47911781319, 35078.82460587694, 35112.64887351132, 35321.11697207571, 35359.2928141437, 7520.8119797004965, 7624.123225829017, 7660.693572257103, 7690.3078722914925, 7696.384289256846, 7410.851782964364, 7555.697772089137, 7587.241275872396, 7591.696332146735, 7604.353629941462, 7761.417893657998, 7770.0, 7832.490888092284, 7858.803529911741, 7867.134615192324, 7714.459987800856, 7784.922150778476, 7796.298333150044, 7797.33722633574, 7809.453338266324, 7542.094948606147, 7611.847763044708, 7620.733274335372, 7677.078750549914, 7678.5392876427595, 35426.0, 35888.0, 35903.82048089769, 35931.28137437263, 36121.27757444863, 2729.9454010919867, 2866.3693987322754, 2870.7846911481515, 3028.4094601552706, 3356.9328613427597, 27023.483132673733, 27311.180664580093, 27487.45025099507, 27964.440711185664, 28085.29786755327, 3245.480723084319, 3268.3299923515624, 3293.4565796643765, 3297.0, 3320.352531256406, 211551.0, 211586.0, 212223.0, 212577.0, 212790.0, 48435.5156448431, 48445.27332090022, 48557.0, 48610.0, 48736.0, 59641.403585963584, 60647.696761516796, 60665.69667151636, 60722.392776071676, 60800.69599651973, 13588.456461741618, 13636.318184090756, 13766.93116534411, 13863.098898571561, 13865.4453821846, 10898.18263630215, 10976.451177441097, 11016.17378696585, 11018.50416731249, 11032.50353734084, 19452.0, 19733.506662333555, 19738.802611973984, 19757.506062348268, 19763.209471621263, 7515.586642734702, 7674.431389403954, 7731.690732370642, 7773.611319434119, 7778.183290754502, 777.2616014785863, 824.74432925792, 865.3899001204136, 979.5249304087512, 1015.669907280137, 24434.0, 24609.507809843704, 24681.259562213163, 24807.62788558173, 24816.751832481805, 904.5251243097294, 905.9456432614064, 925.8194652042787, 953.1516949914582, 970.9417434953925, 13088.476460941647, 13255.73488530224, 13338.466461341632, 13427.328633568282, 13457.05800593949, 304611.0, 307274.0, 308612.0, 309329.0, 310110.0, 46891.0, 47506.28740568894, 47514.28728569005, 47526.5247347529, 47677.76161119172, 1195.3485350484007, 1202.1404695642657, 1206.2943178240828, 1221.2489319068886, 1226.9018478521698, 24289.635655465536, 25107.0, 25330.0, 25495.23514294574, 25557.0, 36257.0, 36560.45159322665, 36578.634213657526, 36580.63419365772, 36582.63417365899, 233911.0, 235531.0, 237066.0, 237509.0, 237630.0, 28886.566701499072, 38192.42711359276, 38927.416088758124, 38945.80527097346, 39098.0, 35222.0, 37584.91014759878, 37694.246115078095, 38181.80909095548, 38434.0, 32311.0, 32451.837740811145, 33151.502727458625, 33723.66276337205, 34092.488612670335, 33108.66891331152, 33263.0, 33510.32979340448, 33932.151696207795, 34006.48990265198, 32736.181595460304, 34977.475337869444, 35611.46582801312, 35711.46432803458, 35916.4612530807, 25330.873345633154, 27198.0, 28848.7115128846, 29243.561346580245, 29638.40723185481, 23243.418914527272, 23267.18564850222, 23343.76656233416, 23405.0, 23691.0], "unit": "score", "name": "ext.html", "value": 16522.36832930911}, {"lowerIsBetter": false, "replicates": [338.32504154212353, 340.54027063464326, 342.91598558353206, 343.1763766959298, 343.50363724418224, 14125.152490850543, 14289.214093224868, 14804.0, 15388.38446462143, 15783.447579334726, 10340.482975851197, 10414.375137491756, 10439.947800261007, 13250.33748312583, 14857.257137143126, 4426.535213802553, 4433.423654924855, 4579.0, 4628.467726211495, 4632.0, 4523.909521809562, 4600.240960241556, 4606.677532572721, 4609.746463944482, 4610.285405762095, 3449.379111759882, 4574.176648203322, 4584.312353147021, 4597.448306203243, 5140.794368225266, 5059.443461219263, 5087.0, 5110.488951104897, 5117.8464646060675, 5117.948820511803, 4817.56641902227, 5026.095302845486, 5048.873778155539, 5053.545180933696, 5058.215976523645, 16414.6717065658, 16606.75089873653, 16822.66354672912, 17960.101994900204, 17990.370337038272, 1747.6155245845894, 1813.791413987382, 1858.8141185881439, 1946.707993800927, 2232.8883555822144, 8643.35174861888, 8740.825183496294, 8812.911870881273, 8866.024737278894, 8986.595603197871, 1716.3134746101534, 1716.7339062445342, 1740.3125765322752, 1823.9908800456046, 1832.5327041604305, 46496.76751616254, 47636.28545571819, 47674.52325476736, 47933.52066479361, 48014.759926200146, 9350.205232555172, 9430.905690943002, 9536.427814331162, 9575.0, 9597.616095356247, 12166.087543434101, 12278.815817762741, 12281.324527151093, 12287.692807679701, 12292.323922184365, 6902.206246281641, 6967.651617419108, 6994.68523916425, 7005.0893383859775, 7010.544314619533, 6543.051257567626, 6553.115329430466, 6578.539502234893, 6599.901001484982, 6642.0, 4077.6533994610195, 4094.815733292009, 4119.402686610425, 4127.669786417079, 4151.543330233671, 1608.308427376216, 1631.4453085950597, 1698.8131305556378, 1758.648270345936, 1767.7083281258706, 747.8392145688595, 861.6596444404425, 865.6623916672503, 904.9773755656066, 988.7972965542046, 13137.802932956014, 13936.0, 14044.508442204473, 14421.495247666282, 15340.0, 853.2917678326974, 860.1742327365799, 886.9489654759132, 901.4095767272447, 948.1466679988066, 8325.708600199085, 8572.742817715478, 8585.570721463902, 8603.096674849176, 8671.783205419788, 420070.0, 431340.0, 431551.0, 434906.0, 442033.0, 62516.68741656263, 62684.37315626877, 62822.0, 63109.36890631127, 63689.681551591944, 1064.1380481809758, 1089.7929393415225, 1105.8783533811275, 1115.1914861725184, 1120.7366268926633, 13006.219626822422, 13966.58100256994, 14208.928955355157, 14265.358058887168, 14359.138451692932, 27242.72757272402, 28132.0, 30419.39161216719, 30875.69124308728, 31328.06015819529, 34376.656233437345, 34954.65045349514, 36080.27839443249, 36604.633953661185, 37012.44481332728, 5934.970325148347, 6169.907451388143, 6290.119383286252, 6373.936260637334, 6407.551471397144, 7533.359664428585, 8855.0, 8981.685641002534, 9177.403468774775, 9414.717558473258, 7508.399328053633, 7832.960835195788, 8132.105468398589, 8201.671933122609, 8208.753737387888, 8269.875951860606, 8308.916910831056, 8321.459105158145, 8539.615717292612, 8664.176903194186, 8054.677812887418, 8078.919210807817, 8142.0, 8216.055153657167, 8264.628091735765, 6387.265464471459, 6696.096027036482, 6730.360615741497, 6743.055972163803, 6759.86480270382, 7011.544249623758, 8027.4380793346245, 8101.149379315087, 8162.306203972729, 8230.876536852073], "unit": "score", "name": "jquery.html", "value": 7233.185016655334}, {"lowerIsBetter": false, "replicates": [1367.4530187924827, 1370.2600595678332, 1482.2440555316784, 1684.9578760530992, 1693.0857337038, 6178.28949670788, 6263.686815659222, 6958.652067396629, 7143.2142464328945, 7192.568445893244, 6797.76207832726, 6968.96515517423, 7040.964795176017, 7042.366187043165, 7044.859102817941, 2138.561594873051, 2171.2400659769114, 2172.348295511348, 2173.1416090644184, 2179.226374637005, 2114.503091773432, 2122.172352782416, 2174.630312846812, 2180.106156475845, 2180.3349978256624, 2114.978850211501, 2119.5231073008604, 2124.948150665423, 2126.680997850327, 2146.399008277677, 2151.8170955468727, 2152.8923553822324, 2153.2894144932134, 2162.740471143465, 2167.111484291433, 2137.700721898935, 2184.322859913432, 2186.158329043314, 2187.8359123065834, 2195.560887822426, 7318.853622927511, 7337.853242935112, 7346.706131754723, 7379.225181355988, 7422.406207503441, 4151.937720934158, 4301.913961720779, 4316.503602085769, 4325.567443255649, 4331.718438301532, 2793.5949287353424, 2828.717128287155, 2848.458792829356, 2851.543752999531, 2865.3409715765283, 834.6369329341755, 863.1356270455848, 867.5445391169624, 868.2055918834259, 894.2532984957568, 9711.174550163245, 9812.018798120202, 9817.950910245403, 9818.9509052455, 9823.115919567274, 3915.393114067267, 3973.7417067890497, 4025.2352053109817, 4034.1931613676793, 4066.573009833984, 8412.957935210285, 8452.74641760748, 8471.110533394029, 8476.576171191417, 8490.660373585111, 4301.376300436419, 4320.481542214954, 4323.502797178365, 4330.9350359744, 4334.089841133335, 3351.9329613407594, 3417.2823707021307, 3791.33651610967, 3918.9020274492796, 3923.3918742594374, 3515.4199557073307, 3538.327717733622, 3541.026217790128, 3543.7342199335153, 3574.8033858137533, 1147.8507793986896, 1149.747055647756, 1160.0778028166258, 1169.473736818435, 1169.6783384569142, 1179.5340840368178, 1183.952641894332, 1196.6888608961558, 1206.2340413837276, 1209.9516019359303, 6285.308616052231, 6334.651594162273, 6359.268684101295, 6376.1392212051705, 6856.417204537571, 438.8376300768736, 446.32604766802365, 448.0501337165231, 448.3521311704621, 449.0188937172289, 5249.317588713519, 5307.124324486494, 5307.49578790022, 5309.3894202166475, 5316.069687804618, 8130.30892374143, 8279.8344033119, 8377.120402357787, 8730.825383492422, 8767.430117042371, 8346.20711032463, 8366.832663346699, 8372.330213582898, 8383.203595658402, 8452.943382077241, 6719.697613607497, 6791.252962174157, 6867.244603093655, 6875.5874647521305, 6898.862022759517, 6757.256701762901, 6899.6205208712, 6914.723411063703, 6917.965410172917, 6937.202221744564, 7644.350230230492, 7784.170719880936, 7820.608969551614, 7880.369570434466, 7928.445008849556, 7720.0, 7939.563324017235, 8012.839743204987, 8052.235037671412, 8080.959595201986, 5526.336839579276, 5629.6903670298525, 6070.332263450929, 6500.577462464925, 6603.141591593062, 6649.867002660017, 6664.266930637723, 6680.231773346128, 6688.531802773759, 6705.497087718343, 6294.842628934313, 6375.330590288138, 6516.315786842503, 6522.934770652233, 6541.0, 6189.412005859436, 6252.874942501216, 6266.968665156645, 6324.588901721373, 6342.587731797418, 6443.516736244706, 6444.065610486359, 6493.512986526124, 6517.8696426072165, 6528.053432252392, 5918.644881306963, 5935.614185077956, 5978.222831031938, 5981.700914954322, 5993.700314984146, 6053.424924632153, 6088.969555152373, 6097.359777223505, 6111.327753947151, 6114.327423983447], "unit": "score", "name": "mootools.html", "value": 4061.858694786068}, {"lowerIsBetter": false, "replicates": [320.8219438211792, 321.0528939628096, 324.2073131194231, 329.93236386540747, 332.4365200984331, 5414.864628384293, 5512.173174023898, 5586.748596313166, 5610.66336019838, 5631.915521267179, 5362.91955620666, 5445.727713614313, 5462.180672899067, 5467.234587157801, 5481.835544933659, 4344.565543445662, 4350.934735978963, 4366.497852746935, 4370.803313850868, 4381.693281470299, 4356.455443069616, 4363.847265345714, 4373.125374925012, 4384.649228061763, 4384.824607015716, 4116.97941510292, 4236.131593023423, 4334.501532323791, 4334.84828031019, 4357.041450880801, 4258.957410425903, 4265.338872474771, 4276.059266961263, 4282.2506061439435, 4282.850100246492, 3744.157564547982, 3746.456763769238, 3749.8312575933874, 3754.812259387047, 3759.191773768653, 5338.039152952467, 5340.06548853949, 5342.572594192494, 5347.358317001946, 5359.5444387227135, 4833.0, 4941.184704523749, 4941.357623508957, 4955.4548999610015, 4962.379702537183, 5825.271841019872, 5828.795992140297, 5830.7667693292215, 5839.883202335929, 5845.473907348359, 4040.0, 4056.4726585543985, 4058.269511487931, 4063.9187216255805, 4068.877933661995, 6062.151298818169, 6170.629762214281, 6177.25872895251, 6177.7837775677635, 6181.598196117238, 4041.3533834586324, 4052.77709725962, 4198.433211516406, 4199.391088292181, 4212.978935105305, 4112.239235741397, 4120.340745480768, 4122.134351786099, 4123.958760412357, 4140.23405669952, 4775.737334446639, 4812.037592481518, 4816.759162041884, 4825.831095911626, 4826.927596085991, 5853.180554722342, 5853.590248682552, 5855.238818953509, 5863.091220860773, 5872.236609240771, 1466.5453709350136, 1483.406637345049, 1515.4165646226281, 1519.8784097272192, 1521.5739592914001, 1006.1347241372414, 1016.9288149829589, 1017.8422344536609, 1029.7374169586708, 1031.7781676939344, 5053.797848086109, 5109.3613298337705, 5110.207917772751, 5115.079285728604, 5115.411727651293, 6015.127806468037, 6030.668313242813, 6033.155358249848, 6045.879082418327, 6060.393960603904, 5041.117804384291, 5095.668781529189, 5100.923486147711, 5105.5149760772665, 5118.283440318359, 3196.31279274957, 3241.918952026218, 3267.39553182662, 3283.4089863824743, 3290.9962461449486, 5724.513416359656, 5734.340550836624, 5802.390748971382, 5803.100519419497, 5819.214406055213, 6217.751289948352, 6230.283517395557, 6249.0, 6254.249490061222, 6269.373062693694, 5644.6330988485615, 5689.573282003867, 5693.202951586781, 5714.342850572154, 5735.340435849931, 6176.0, 6179.134921110958, 6179.876402472015, 6188.535859810622, 6197.0, 5999.760009599567, 6014.248218972629, 6019.097135429721, 6029.939700602938, 6046.1535385045245, 5767.826965191051, 5768.480836724715, 5781.161731548817, 5799.4780469757925, 5834.329052159056, 4032.5967403259438, 4183.728057676241, 4206.915861682811, 4220.409142720083, 4222.387753775747, 5929.318128415115, 6129.938700612936, 6147.108669243024, 6156.815295541141, 6169.951108311508, 5862.443067908542, 5872.882542349214, 5905.379935106752, 5929.902967950943, 5931.169636251015, 5917.763289468545, 5920.0, 5921.0, 5926.970365148319, 5940.881182376242, 5664.631798933056, 5784.1034639630925, 5810.709464526842, 5818.389069147678, 5820.388859169726, 5936.079907614327, 5951.732172052181, 5958.672273024852, 5965.821025369246, 5966.49284810796, 5772.797952071657, 5807.564432667482, 5820.534357251495, 5825.592208545361, 5826.242588463472], "unit": "score", "name": "prototype.html", "value": 4401.031870099284}, {"lowerIsBetter": false, "replicates": [775.8681024225884, 787.7164220880486, 796.4783067091056, 800.6957356204641, 810.3274282345653, 10423.530941107649, 10478.10936070433, 10549.41978191199, 10584.576616935314, 10610.469476526172, 10706.19703522237, 10738.463076846165, 10738.624148154817, 10742.355458672486, 10752.870948550408, 612.3386742318286, 622.8349487385824, 777.2732495117084, 792.7661339904713, 793.2028311546916, 774.4346626962321, 779.9727009554666, 781.316348195329, 781.7732857471326, 782.6517199846071, 823.2960818500186, 825.6119623776815, 828.1759649149105, 828.4035494443991, 828.4366630691128, 811.1645005644195, 818.8157664525494, 819.4304958054155, 822.3421262989614, 823.2960818500216, 585.5842351930135, 587.7061469265367, 588.6791698524314, 605.6003037994902, 616.2420223125581, 11546.942265288704, 11591.24656897299, 11617.361045142514, 11632.941835290854, 11704.356260405675, 11402.942985285103, 11695.590654327143, 12063.276203427822, 12092.214006089576, 12252.938735306356, 9397.906020939772, 9437.952810235973, 9495.192908602778, 9811.754706132333, 10002.199824014062, 3217.8551965161623, 3246.107320486861, 3275.2630658101975, 3279.2293810954407, 3282.113829266085, 36590.0, 36717.0, 36822.0, 36848.0, 37573.62426375729, 8603.397762156588, 8695.347848911231, 8736.15143595298, 8768.824623507495, 8821.955890220508, 15550.611234718996, 15596.376144954074, 15665.921670391803, 15674.68650626981, 15715.371385144696, 5974.074018527135, 6091.116788065794, 6120.969395153084, 6354.555181137276, 6467.773627923, 3562.91092722684, 3576.2668652926086, 3612.7832330060282, 3618.5295911531334, 3636.07280143567, 2656.6413534173025, 2662.347724807396, 2668.946621067568, 2679.209633158223, 2682.061278552491, 475.60524764445427, 480.5578867441962, 489.5716248282753, 492.450917227289, 493.62977766674993, 452.9026259354255, 456.4978523623987, 460.37389150755615, 478.2305469761895, 608.7004245934961, 7092.680829362691, 7203.243659415791, 7271.709131634781, 7327.45044121693, 7559.055118110236, 567.5204452237853, 569.7179895951448, 574.6724367110706, 577.2034592262651, 602.4397310501275, 3416.7095796857548, 3433.3991551478393, 3456.6024907135497, 3474.2530355973586, 3518.20840310928, 43378.56621433745, 44052.55947440548, 44102.55897441049, 44291.11417771626, 44351.33472997908, 45400.0, 45453.54546454559, 45518.08963820705, 46288.0, 46776.0, 36037.63962360395, 36402.0, 36988.0, 37284.44073338902, 37604.623953760114, 7355.632218389166, 7376.868953386121, 7588.430867684835, 7625.084989801259, 7667.88498172539, 28736.712632873405, 29153.41693166167, 29282.121536353945, 29511.0, 29767.55348669815, 33284.0, 33297.83351083229, 36440.453393199656, 36444.27111457703, 36648.45027324645, 9215.907840921505, 9383.624655013997, 9589.616415343588, 9743.658971935949, 10058.396496210251, 10230.079292863678, 10677.199210059121, 10905.618303359344, 10946.397948112612, 11264.436778161224, 9233.815323693623, 9347.532623368941, 9433.669821556212, 9491.952540237255, 10299.3820370778, 9555.856662150212, 9705.757356066155, 9758.0, 9875.209983201183, 10059.446730429896, 9644.324897257125, 9873.703788886345, 10002.24983126283, 10084.142847858015, 10113.342632728849, 7782.766517004499, 7900.723474678359, 8340.623797073415, 8824.823503530022, 8932.821343573221, 8449.197326253996, 8551.35864810154, 8638.17937295956, 8719.65121395137, 8822.867656985021], "unit": "score", "name": "yui.html", "value": 5472.9679823363795}], "name": "dromaeo_css", "value": 6140.917064624504}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 112.0, 115.0, 114.0, 126.0, 114.0, 113.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [160.0, 135.0, 156.0, 172.0, 138.0, 162.0, 166.0, 130.0, 165.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 163.0, 166.0, 168.0, 169.0, 167.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 72.0, 142.0, 72.0, 74.0, 73.0, 72.0, 94.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 135.0, 97.0, 97.0, 97.0, 147.0, 97.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 150.0, 148.0, 150.0, 148.0, 147.0, 147.0, 150.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 74.0, 76.0, 75.0, 75.0, 80.0, 73.0, 74.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 74.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 70.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 86.0, 84.0, 86.0, 85.0, 90.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [129.0, 133.0, 119.0, 132.0, 132.0, 129.0, 134.0, 122.0, 132.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.1}, {"lowerIsBetter": true, "replicates": [144.0, 156.0, 155.0, 143.0, 150.0, 142.0, 151.0, 149.0, 151.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 72.0, 73.0, 71.0, 73.0, 71.0, 71.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.7}], "name": "kraken", "value": 1556.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [187.02075930428276], "unit": "score", "name": "DeltaBlue", "value": 353.5329460000002}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [729.3946024799417], "unit": "score", "name": "Earley", "value": 913.7207730000002}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [43382.97872340425], "unit": "score", "name": "RegExp", "value": 20.998673369298682}, {"lowerIsBetter": false, "replicates": [621.8905472636816], "unit": "score", "name": "Splay", "value": 131.03752799999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20170.384890213332}]} 07:30:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20170.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1556.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6140.92"}}} 07:30:08 INFO - Return code: 0 07:30:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:30:08 INFO - # TBPL SUCCESS # 07:30:08 INFO - Running post-action listener: _resource_record_post_action 07:30:08 INFO - Running post-run listener: _resource_record_post_run 07:30:10 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 0; Write bytes: 321957888; Read time: 0; Write time: 384128 07:30:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20697088; Read time: 0; Write time: 4056 07:30:10 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 301260800; Read time: 0; Write time: 380072 07:30:10 INFO - Running post-run listener: _upload_blobber_files 07:30:10 INFO - Blob upload gear active. 07:30:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:10 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 07:30:10 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'] 07:30:10 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 07:30:10 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:11 INFO - (blobuploader) - INFO - Done attempting. 07:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:12 INFO - (blobuploader) - INFO - Done attempting. 07:30:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:12 INFO - Return code: 0 07:30:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11d6d99c89501a4fb4882e2482251417175404ef303d7f9f35b64a49e2d014f555232cae5f5cc0640fc791569bdc4ddd0bb688e38e222d39020db34ffbbf5aa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/077a0644aec0fe2069b61b58931080ad78a904b250bed634c7c001a24ba12037bb322ddf85ac4952fce173f7472f0df10b134527a272215e404864ac0f94874f"} 07:30:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:12 INFO - Contents: 07:30:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11d6d99c89501a4fb4882e2482251417175404ef303d7f9f35b64a49e2d014f555232cae5f5cc0640fc791569bdc4ddd0bb688e38e222d39020db34ffbbf5aa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/077a0644aec0fe2069b61b58931080ad78a904b250bed634c7c001a24ba12037bb322ddf85ac4952fce173f7472f0df10b134527a272215e404864ac0f94874f"} 07:30:12 INFO - Copying logs to upload dir... 07:30:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1302.813510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-01-11 07:30:11.946565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 07:30:11.952796) ========= 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=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11d6d99c89501a4fb4882e2482251417175404ef303d7f9f35b64a49e2d014f555232cae5f5cc0640fc791569bdc4ddd0bb688e38e222d39020db34ffbbf5aa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/077a0644aec0fe2069b61b58931080ad78a904b250bed634c7c001a24ba12037bb322ddf85ac4952fce173f7472f0df10b134527a272215e404864ac0f94874f"} build_url:https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/FP6uQbiZSpSoOZ31CkAyyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11d6d99c89501a4fb4882e2482251417175404ef303d7f9f35b64a49e2d014f555232cae5f5cc0640fc791569bdc4ddd0bb688e38e222d39020db34ffbbf5aa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/077a0644aec0fe2069b61b58931080ad78a904b250bed634c7c001a24ba12037bb322ddf85ac4952fce173f7472f0df10b134527a272215e404864ac0f94874f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 07:30:11.978788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:30:11.979115) ========= 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=af724c981e2a0f424dbabf99000001e7-1452519605.78913-1736258424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 07:30:12.063542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 07:30:12.063857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 07:30:12.064152) ========= ========= Total master_lag: 0.22 =========