builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1453377435.85 results: success (0) buildid: 20160121031622 builduid: 7c3d8cea988e4a4a832e226cc960c617 revision: b2e729decd54914536ed5ce29cf9a201d2f0eb45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.855316) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.855784) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.856099) ========= 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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006388 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.913747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.914068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.939784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.940078) ========= 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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004673 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.995420) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.995757) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.996216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:15.996615) ========= 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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 03:57:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-21 03:57:16 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.168724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.169039) ========= 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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022340 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.218291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.218657) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b2e729decd54914536ed5ce29cf9a201d2f0eb45 --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 b2e729decd54914536ed5ce29cf9a201d2f0eb45 --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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 03:57:16,854 truncating revision to first 12 chars 2016-01-21 03:57:16,854 Setting DEBUG logging. 2016-01-21 03:57:16,854 attempt 1/10 2016-01-21 03:57:16,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b2e729decd54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 03:57:17,106 unpacking tar archive at: fx-team-b2e729decd54/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552550 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.784496) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.784894) ========= echo b2e729decd54914536ed5ce29cf9a201d2f0eb45 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b2e729decd54914536ed5ce29cf9a201d2f0eb45'] 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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b2e729decd54914536ed5ce29cf9a201d2f0eb45 program finished with exit code 0 elapsedTime=0.003774 script_repo_revision: 'b2e729decd54914536ed5ce29cf9a201d2f0eb45' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.834185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.834517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.851888) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.852163) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/b2e729decd54914536ed5ce29cf9a201d2f0eb45 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 03:57:16.852595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 32 secs) (at 2016-01-21 03:57:16.852919) ========= /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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:57:17 INFO - MultiFileLogger online at 20160121 03:57:17 in /builds/slave/test 03:57:17 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 03:57:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:17 INFO - {'append_to_log': False, 03:57:17 INFO - 'base_work_dir': '/builds/slave/test', 03:57:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:57:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:17 INFO - 'branch': 'Fx-Team-Non-PGO', 03:57:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:17 INFO - 'config_files': ('talos/linux_config.py',), 03:57:17 INFO - 'default_actions': ('clobber', 03:57:17 INFO - 'read-buildbot-config', 03:57:17 INFO - 'download-and-extract', 03:57:17 INFO - 'populate-webroot', 03:57:17 INFO - 'create-virtualenv', 03:57:17 INFO - 'install', 03:57:17 INFO - 'run-tests'), 03:57:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:17 INFO - 'download_minidump_stackwalk': True, 03:57:17 INFO - 'download_symbols': 'ondemand', 03:57:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:17 INFO - 'installer_path': 'installer.exe', 03:57:17 INFO - 'log_level': 'info', 03:57:17 INFO - 'log_name': 'talos', 03:57:17 INFO - 'log_to_console': True, 03:57:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:57:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:57:17 INFO - 'opt_config_files': (), 03:57:17 INFO - 'pip_index': False, 03:57:17 INFO - 'sps_profile': False, 03:57:17 INFO - 'sps_profile_interval': 0, 03:57:17 INFO - 'suite': 'dromaeojs-e10s', 03:57:17 INFO - 'system_bits': '32', 03:57:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:17 INFO - 'title': 'talos-linux64-ix-034', 03:57:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:17 INFO - 'use_talos_json': True, 03:57:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:17 INFO - 'work_dir': 'build'} 03:57:17 INFO - ##### 03:57:17 INFO - ##### Running clobber step. 03:57:17 INFO - ##### 03:57:17 INFO - Running pre-action listener: _resource_record_pre_action 03:57:17 INFO - Running main action method: clobber 03:57:17 INFO - rmtree: /builds/slave/test/build 03:57:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:18 INFO - Running post-action listener: _resource_record_post_action 03:57:18 INFO - ##### 03:57:18 INFO - ##### Running read-buildbot-config step. 03:57:18 INFO - ##### 03:57:18 INFO - Running pre-action listener: _resource_record_pre_action 03:57:18 INFO - Running main action method: read_buildbot_config 03:57:18 INFO - Using buildbot properties: 03:57:18 INFO - { 03:57:18 INFO - "project": "", 03:57:18 INFO - "product": "firefox", 03:57:18 INFO - "script_repo_revision": "production", 03:57:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:57:18 INFO - "repository": "", 03:57:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:57:18 INFO - "buildid": "20160121031622", 03:57:18 INFO - "pgo_build": "False", 03:57:18 INFO - "basedir": "/builds/slave/test", 03:57:18 INFO - "buildnumber": 684, 03:57:18 INFO - "slavename": "talos-linux64-ix-034", 03:57:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:57:18 INFO - "platform": "ubuntu64_hw", 03:57:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:57:18 INFO - "branch": "fx-team", 03:57:18 INFO - "repo_path": "integration/fx-team", 03:57:18 INFO - "revision": "b2e729decd54914536ed5ce29cf9a201d2f0eb45", 03:57:18 INFO - "stage_platform": "linux64", 03:57:18 INFO - "builduid": "7c3d8cea988e4a4a832e226cc960c617", 03:57:18 INFO - "slavebuilddir": "test" 03:57:18 INFO - } 03:57:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:57:18 INFO - Running post-action listener: _resource_record_post_action 03:57:18 INFO - ##### 03:57:18 INFO - ##### Running download-and-extract step. 03:57:18 INFO - ##### 03:57:18 INFO - Running pre-action listener: _resource_record_pre_action 03:57:18 INFO - Running main action method: download_and_extract 03:57:18 INFO - mkdir: /builds/slave/test/build/tests 03:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:18 INFO - https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/test_packages.json 03:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/test_packages.json 03:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:57:27 INFO - Downloaded 1448 bytes. 03:57:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:57:27 INFO - Using the following test package requirements: 03:57:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:57:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:57:27 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:57:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'jsshell-linux-x86_64.zip'], 03:57:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:57:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:57:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:57:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:57:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:57:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:57:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:57:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:57: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')]} 03:57:27 INFO - https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:57:35 INFO - Downloaded 21217723 bytes. 03:57:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:57:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:57:36 INFO - Return code: 0 03:57: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 03:57: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')]} 03:57:36 INFO - https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:57:39 INFO - Downloaded 21217723 bytes. 03:57:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:57:40 INFO - Return code: 0 03:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:40 INFO - https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:57:41 INFO - Downloaded 11133201 bytes. 03:57:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:57:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:57:41 INFO - Return code: 0 03:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:41 INFO - https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 03:58:13 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 03:58:13 INFO - retry: attempt #1 caught exception: The read operation timed out 03:58:13 INFO - retry: Failed, sleeping 30 seconds before retrying 03:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QiK3ONsNQxWPBI2zd1K35A/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 #2 03:58:47 INFO - Downloaded 54178304 bytes. 03:58:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:58:47 INFO - mkdir: /builds/slave/test/properties 03:58:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:47 INFO - Contents: 03:58:47 INFO - build_url:https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:58:47 INFO - Running post-action listener: _resource_record_post_action 03:58:47 INFO - Running post-action listener: set_extra_try_arguments 03:58:47 INFO - ##### 03:58:47 INFO - ##### Running populate-webroot step. 03:58:47 INFO - ##### 03:58:47 INFO - Running pre-action listener: _resource_record_pre_action 03:58:47 INFO - Running main action method: populate_webroot 03:58:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:47 INFO - '--tppagecycles', 03:58:47 INFO - '7'], 03:58:47 INFO - 'tests': ['tsvgm']}}, 03:58:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:58:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:58:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:58:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'tests': ['damp', 'tps']}, 03:58:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['damp', 'tps']}, 03:58:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:58:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:47 INFO - 'other': {'tests': ['a11yr', 03:58:47 INFO - 'ts_paint', 03:58:47 INFO - 'tpaint', 03:58:47 INFO - 'sessionrestore', 03:58:47 INFO - 'sessionrestore_no_auto_restore']}, 03:58:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['a11yr', 03:58:47 INFO - 'ts_paint', 03:58:47 INFO - 'tpaint', 03:58:47 INFO - 'sessionrestore', 03:58:47 INFO - 'sessionrestore_no_auto_restore']}, 03:58:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['a11yr', 03:58:47 INFO - 'ts_paint', 03:58:47 INFO - 'tpaint', 03:58:47 INFO - 'sessionrestore', 03:58:47 INFO - 'sessionrestore_no_auto_restore']}, 03:58:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['a11yr', 03:58:47 INFO - 'ts_paint', 03:58:47 INFO - 'tpaint', 03:58:47 INFO - 'sessionrestore', 03:58:47 INFO - 'sessionrestore_no_auto_restore']}, 03:58:47 INFO - 'other_l64': {'tests': ['a11yr', 03:58:47 INFO - 'ts_paint', 03:58:47 INFO - 'tpaint', 03:58:47 INFO - 'sessionrestore', 03:58:47 INFO - 'sessionrestore_no_auto_restore']}, 03:58:47 INFO - 'other_nol64': {'tests': ['a11yr', 03:58:47 INFO - 'ts_paint', 03:58:47 INFO - 'tpaint', 03:58:47 INFO - 'sessionrestore', 03:58:47 INFO - 'sessionrestore_no_auto_restore']}, 03:58:47 INFO - 'svgr': {'tests': ['tsvgx', 03:58:47 INFO - 'tsvgr_opacity', 03:58:47 INFO - 'tart', 03:58:47 INFO - 'tscrollx', 03:58:47 INFO - 'cart']}, 03:58:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['tsvgx', 03:58:47 INFO - 'tsvgr_opacity', 03:58:47 INFO - 'tart', 03:58:47 INFO - 'tscrollx', 03:58:47 INFO - 'cart']}, 03:58:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'tests': ['tp5o']}, 03:58:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'talos_options': ['--e10s'], 03:58:47 INFO - 'tests': ['tp5o']}, 03:58:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'talos_options': ['--xperf_path', 03:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:47 INFO - 'tests': ['tp5n']}, 03:58:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:47 INFO - 'talos_options': ['--e10s', 03:58:47 INFO - '--xperf_path', 03:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:47 INFO - 'tests': ['tp5n']}}, 03:58:47 INFO - 'talos.zip': {'path': '', 03:58:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:47 INFO - Running post-action listener: _resource_record_post_action 03:58:47 INFO - ##### 03:58:47 INFO - ##### Running create-virtualenv step. 03:58:47 INFO - ##### 03:58:47 INFO - Running pre-action listener: _resource_record_pre_action 03:58:47 INFO - Running main action method: create_virtualenv 03:58:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:47 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 03:58:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:47 INFO - Using real prefix '/usr' 03:58:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:49 INFO - Installing pip.................done. 03:58:49 INFO - Return code: 0 03:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58:49 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')]} 03:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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')]} 03:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:58:49 INFO - Using env: {'DISPLAY': ':0', 03:58:49 INFO - 'HOME': '/home/cltbld', 03:58:49 INFO - 'LANG': 'en_US.UTF-8', 03:58:49 INFO - 'LANGUAGE': 'en_US:en', 03:58:49 INFO - 'LOGNAME': 'cltbld', 03:58:49 INFO - 'MAIL': '/var/mail/cltbld', 03:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:49 INFO - 'MOZ_NO_REMOTE': '1', 03:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:49 INFO - 'NO_EM_RESTART': '1', 03:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:49 INFO - 'PWD': '/builds/slave/test', 03:58:49 INFO - 'SHELL': '/bin/bash', 03:58:49 INFO - 'SHLVL': '1', 03:58:49 INFO - 'TERM': 'linux', 03:58:49 INFO - 'TMOUT': '86400', 03:58:49 INFO - 'USER': 'cltbld', 03:58:49 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:49 INFO - '_': '/tools/buildbot/bin/python'} 03:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:50 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 03:58:50 INFO - Cleaning up... 03:58:50 INFO - Return code: 0 03:58:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:58:50 INFO - Using env: {'DISPLAY': ':0', 03:58:50 INFO - 'HOME': '/home/cltbld', 03:58:50 INFO - 'LANG': 'en_US.UTF-8', 03:58:50 INFO - 'LANGUAGE': 'en_US:en', 03:58:50 INFO - 'LOGNAME': 'cltbld', 03:58:50 INFO - 'MAIL': '/var/mail/cltbld', 03:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:50 INFO - 'MOZ_NO_REMOTE': '1', 03:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:50 INFO - 'NO_EM_RESTART': '1', 03:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:50 INFO - 'PWD': '/builds/slave/test', 03:58:50 INFO - 'SHELL': '/bin/bash', 03:58:50 INFO - 'SHLVL': '1', 03:58:50 INFO - 'TERM': 'linux', 03:58:50 INFO - 'TMOUT': '86400', 03:58:50 INFO - 'USER': 'cltbld', 03:58:50 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:50 INFO - '_': '/tools/buildbot/bin/python'} 03:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:50 INFO - Downloading/unpacking psutil>=0.7.1 03:58:50 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 03:58:50 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 03:58:50 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 03:58:50 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 03:58:50 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 03:58:50 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 03:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:52 INFO - Installing collected packages: psutil 03:58:52 INFO - Running setup.py install for psutil 03:58:52 INFO - building 'psutil._psutil_linux' extension 03:58:52 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 03:58:52 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 03:58:52 INFO - building 'psutil._psutil_posix' extension 03:58:52 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 03:58:52 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 03:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:52 INFO - Successfully installed psutil 03:58:52 INFO - Cleaning up... 03:58:52 INFO - Return code: 0 03:58:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:58:52 INFO - Using env: {'DISPLAY': ':0', 03:58:52 INFO - 'HOME': '/home/cltbld', 03:58:52 INFO - 'LANG': 'en_US.UTF-8', 03:58:52 INFO - 'LANGUAGE': 'en_US:en', 03:58:52 INFO - 'LOGNAME': 'cltbld', 03:58:52 INFO - 'MAIL': '/var/mail/cltbld', 03:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:52 INFO - 'MOZ_NO_REMOTE': '1', 03:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:52 INFO - 'NO_EM_RESTART': '1', 03:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:52 INFO - 'PWD': '/builds/slave/test', 03:58:52 INFO - 'SHELL': '/bin/bash', 03:58:52 INFO - 'SHLVL': '1', 03:58:52 INFO - 'TERM': 'linux', 03:58:52 INFO - 'TMOUT': '86400', 03:58:52 INFO - 'USER': 'cltbld', 03:58:52 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:52 INFO - '_': '/tools/buildbot/bin/python'} 03:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:58:54 INFO - Installing collected packages: mozsystemmonitor 03:58:54 INFO - Running setup.py install for mozsystemmonitor 03:58:54 INFO - Successfully installed mozsystemmonitor 03:58:54 INFO - Cleaning up... 03:58:54 INFO - Return code: 0 03:58:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:58:54 INFO - Using env: {'DISPLAY': ':0', 03:58:54 INFO - 'HOME': '/home/cltbld', 03:58:54 INFO - 'LANG': 'en_US.UTF-8', 03:58:54 INFO - 'LANGUAGE': 'en_US:en', 03:58:54 INFO - 'LOGNAME': 'cltbld', 03:58:54 INFO - 'MAIL': '/var/mail/cltbld', 03:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:54 INFO - 'MOZ_NO_REMOTE': '1', 03:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:54 INFO - 'NO_EM_RESTART': '1', 03:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:54 INFO - 'PWD': '/builds/slave/test', 03:58:54 INFO - 'SHELL': '/bin/bash', 03:58:54 INFO - 'SHLVL': '1', 03:58:54 INFO - 'TERM': 'linux', 03:58:54 INFO - 'TMOUT': '86400', 03:58:54 INFO - 'USER': 'cltbld', 03:58:54 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:54 INFO - '_': '/tools/buildbot/bin/python'} 03:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:58:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:57 INFO - Downloading docopt-0.6.1.tar.gz 03:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:57 INFO - Running setup.py install for blobuploader 03:58:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:58:57 INFO - Running setup.py install for requests 03:58:58 INFO - Running setup.py install for docopt 03:58:58 INFO - Successfully installed blobuploader requests docopt 03:58:58 INFO - Cleaning up... 03:58:58 INFO - Return code: 0 03:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:58 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')]} 03:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 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')]} 03:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 03:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 03:58:58 INFO - Using env: {'DISPLAY': ':0', 03:58:58 INFO - 'HOME': '/home/cltbld', 03:58:58 INFO - 'LANG': 'en_US.UTF-8', 03:58:58 INFO - 'LANGUAGE': 'en_US:en', 03:58:58 INFO - 'LOGNAME': 'cltbld', 03:58:58 INFO - 'MAIL': '/var/mail/cltbld', 03:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:58 INFO - 'MOZ_NO_REMOTE': '1', 03:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:58 INFO - 'NO_EM_RESTART': '1', 03:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:58 INFO - 'PWD': '/builds/slave/test', 03:58:58 INFO - 'SHELL': '/bin/bash', 03:58:58 INFO - 'SHLVL': '1', 03:58:58 INFO - 'TERM': 'linux', 03:58:58 INFO - 'TMOUT': '86400', 03:58:58 INFO - 'USER': 'cltbld', 03:58:58 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:58 INFO - '_': '/tools/buildbot/bin/python'} 03:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:58 INFO - Running setup.py (path:/tmp/pip-sKORAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:58 INFO - Running setup.py (path:/tmp/pip-mdQZW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:58 INFO - Running setup.py (path:/tmp/pip-r1L_OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:58 INFO - Running setup.py (path:/tmp/pip-t_GBRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:58 INFO - Running setup.py (path:/tmp/pip-ZZlWkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:58 INFO - Running setup.py (path:/tmp/pip-GvXT55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:58 INFO - Running setup.py (path:/tmp/pip-YmaLPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:58 INFO - Running setup.py (path:/tmp/pip-YAL8dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:59 INFO - Running setup.py (path:/tmp/pip-p6kCFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:59 INFO - Running setup.py (path:/tmp/pip-wAHkq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:59 INFO - Running setup.py (path:/tmp/pip-JuVuXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:59 INFO - Running setup.py (path:/tmp/pip-W14ffM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:59 INFO - Running setup.py (path:/tmp/pip-5_vgww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:59 INFO - Running setup.py (path:/tmp/pip-B3VAhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:59 INFO - Running setup.py (path:/tmp/pip-bN_5Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:59 INFO - Running setup.py (path:/tmp/pip-srzdB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:59 INFO - Running setup.py (path:/tmp/pip-GowhGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:59 INFO - Running setup.py install for manifestparser 03:58:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:58:59 INFO - Running setup.py install for mozcrash 03:58:59 INFO - Running setup.py install for mozdebug 03:58:59 INFO - Running setup.py install for mozdevice 03:59:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Running setup.py install for mozfile 03:59:00 INFO - Running setup.py install for mozhttpd 03:59:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Running setup.py install for mozinfo 03:59:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Running setup.py install for mozInstall 03:59:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Running setup.py install for mozleak 03:59:00 INFO - Running setup.py install for mozlog 03:59:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Running setup.py install for moznetwork 03:59:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:00 INFO - Running setup.py install for mozprocess 03:59:00 INFO - Running setup.py install for mozprofile 03:59:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:01 INFO - Running setup.py install for mozrunner 03:59:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:01 INFO - Running setup.py install for mozscreenshot 03:59:01 INFO - Running setup.py install for moztest 03:59:01 INFO - Running setup.py install for mozversion 03:59:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:01 INFO - Cleaning up... 03:59:01 INFO - Return code: 0 03:59:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:59:01 INFO - Using env: {'DISPLAY': ':0', 03:59:01 INFO - 'HOME': '/home/cltbld', 03:59:01 INFO - 'LANG': 'en_US.UTF-8', 03:59:01 INFO - 'LANGUAGE': 'en_US:en', 03:59:01 INFO - 'LOGNAME': 'cltbld', 03:59:01 INFO - 'MAIL': '/var/mail/cltbld', 03:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:01 INFO - 'MOZ_NO_REMOTE': '1', 03:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:01 INFO - 'NO_EM_RESTART': '1', 03:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:01 INFO - 'PWD': '/builds/slave/test', 03:59:01 INFO - 'SHELL': '/bin/bash', 03:59:01 INFO - 'SHLVL': '1', 03:59:01 INFO - 'TERM': 'linux', 03:59:01 INFO - 'TMOUT': '86400', 03:59:01 INFO - 'USER': 'cltbld', 03:59:01 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:01 INFO - '_': '/tools/buildbot/bin/python'} 03:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:01 INFO - Running setup.py (path:/tmp/pip-3_U24h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:01 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)) 03:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:01 INFO - Running setup.py (path:/tmp/pip-oFo17f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:01 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)) 03:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:01 INFO - Running setup.py (path:/tmp/pip-p2UQG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:01 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)) 03:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:01 INFO - Running setup.py (path:/tmp/pip-otaG_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:01 INFO - Running setup.py (path:/tmp/pip-gV3BfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:02 INFO - Running setup.py (path:/tmp/pip-A6ZgC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:02 INFO - Running setup.py (path:/tmp/pip-Swca1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:02 INFO - Running setup.py (path:/tmp/pip-AEQ49s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:02 INFO - Running setup.py (path:/tmp/pip-vbOzsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:02 INFO - Running setup.py (path:/tmp/pip-ZRezvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:02 INFO - Running setup.py (path:/tmp/pip-oN5EII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:02 INFO - Running setup.py (path:/tmp/pip-NlxWJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:02 INFO - Running setup.py (path:/tmp/pip-_L5_ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:02 INFO - Running setup.py (path:/tmp/pip-lGMg51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:02 INFO - Running setup.py (path:/tmp/pip-1eURKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:02 INFO - Running setup.py (path:/tmp/pip-CwOB_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:02 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)) 03:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:02 INFO - Running setup.py (path:/tmp/pip-b3MbsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:02 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)) 03:59:02 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)) 03:59:02 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)) 03:59:02 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)) 03:59:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:02 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 03:59:02 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 03:59:02 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 03:59:02 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 03:59:02 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 03:59:02 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 03:59:04 INFO - Downloading blessings-1.6.tar.gz 03:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:04 INFO - Installing collected packages: blessings 03:59:04 INFO - Running setup.py install for blessings 03:59:04 INFO - Successfully installed blessings 03:59:04 INFO - Cleaning up... 03:59:04 INFO - Return code: 0 03:59:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:05 INFO - Reading from file tmpfile_stdout 03:59:05 INFO - Current package versions: 03:59:05 INFO - argparse == 1.2.1 03:59:05 INFO - blessings == 1.6 03:59:05 INFO - blobuploader == 1.2.4 03:59:05 INFO - docopt == 0.6.1 03:59:05 INFO - manifestparser == 1.1 03:59:05 INFO - mozInstall == 1.12 03:59:05 INFO - mozcrash == 0.16 03:59:05 INFO - mozdebug == 0.1 03:59:05 INFO - mozdevice == 0.48 03:59:05 INFO - mozfile == 1.2 03:59:05 INFO - mozhttpd == 0.7 03:59:05 INFO - mozinfo == 0.9 03:59:05 INFO - mozleak == 0.1 03:59:05 INFO - mozlog == 3.1 03:59:05 INFO - moznetwork == 0.27 03:59:05 INFO - mozprocess == 0.22 03:59:05 INFO - mozprofile == 0.28 03:59:05 INFO - mozrunner == 6.11 03:59:05 INFO - mozscreenshot == 0.1 03:59:05 INFO - mozsystemmonitor == 0.0 03:59:05 INFO - moztest == 0.7 03:59:05 INFO - mozversion == 1.4 03:59:05 INFO - psutil == 3.1.1 03:59:05 INFO - requests == 1.2.3 03:59:05 INFO - wsgiref == 0.1.2 03:59:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:05 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')]} 03:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 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')]} 03:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:59:05 INFO - Using env: {'DISPLAY': ':0', 03:59:05 INFO - 'HOME': '/home/cltbld', 03:59:05 INFO - 'LANG': 'en_US.UTF-8', 03:59:05 INFO - 'LANGUAGE': 'en_US:en', 03:59:05 INFO - 'LOGNAME': 'cltbld', 03:59:05 INFO - 'MAIL': '/var/mail/cltbld', 03:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:05 INFO - 'MOZ_NO_REMOTE': '1', 03:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:05 INFO - 'NO_EM_RESTART': '1', 03:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:05 INFO - 'PWD': '/builds/slave/test', 03:59:05 INFO - 'SHELL': '/bin/bash', 03:59:05 INFO - 'SHLVL': '1', 03:59:05 INFO - 'TERM': 'linux', 03:59:05 INFO - 'TMOUT': '86400', 03:59:05 INFO - 'USER': 'cltbld', 03:59:05 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:05 INFO - '_': '/tools/buildbot/bin/python'} 03:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 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)) 03:59:05 INFO - Cleaning up... 03:59:05 INFO - Return code: 0 03:59:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:05 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')]} 03:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 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')]} 03:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:59:05 INFO - Using env: {'DISPLAY': ':0', 03:59:05 INFO - 'HOME': '/home/cltbld', 03:59:05 INFO - 'LANG': 'en_US.UTF-8', 03:59:05 INFO - 'LANGUAGE': 'en_US:en', 03:59:05 INFO - 'LOGNAME': 'cltbld', 03:59:05 INFO - 'MAIL': '/var/mail/cltbld', 03:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:05 INFO - 'MOZ_NO_REMOTE': '1', 03:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:05 INFO - 'NO_EM_RESTART': '1', 03:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:05 INFO - 'PWD': '/builds/slave/test', 03:59:05 INFO - 'SHELL': '/bin/bash', 03:59:05 INFO - 'SHLVL': '1', 03:59:05 INFO - 'TERM': 'linux', 03:59:05 INFO - 'TMOUT': '86400', 03:59:05 INFO - 'USER': 'cltbld', 03:59:05 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:05 INFO - '_': '/tools/buildbot/bin/python'} 03:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:05 INFO - Downloading/unpacking jsonschema 03:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:07 INFO - Downloading/unpacking functools32 (from jsonschema) 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:07 INFO - warning: no files found matching '*.txt' 03:59:07 INFO - no previously-included directories found matching 'build' 03:59:07 INFO - no previously-included directories found matching 'dist' 03:59:07 INFO - no previously-included directories found matching '.git*' 03:59:07 INFO - Installing collected packages: jsonschema, functools32 03:59:07 INFO - Running setup.py install for functools32 03:59:07 INFO - warning: no files found matching '*.txt' 03:59:07 INFO - no previously-included directories found matching 'build' 03:59:07 INFO - no previously-included directories found matching 'dist' 03:59:07 INFO - no previously-included directories found matching '.git*' 03:59:07 INFO - Successfully installed jsonschema functools32 03:59:07 INFO - Cleaning up... 03:59:07 INFO - Return code: 0 03:59:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f36dc1d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edcdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, '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': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', '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 03:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:59:07 INFO - Using env: {'DISPLAY': ':0', 03:59:07 INFO - 'HOME': '/home/cltbld', 03:59:07 INFO - 'LANG': 'en_US.UTF-8', 03:59:07 INFO - 'LANGUAGE': 'en_US:en', 03:59:07 INFO - 'LOGNAME': 'cltbld', 03:59:07 INFO - 'MAIL': '/var/mail/cltbld', 03:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:07 INFO - 'MOZ_NO_REMOTE': '1', 03:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:07 INFO - 'NO_EM_RESTART': '1', 03:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:07 INFO - 'PWD': '/builds/slave/test', 03:59:07 INFO - 'SHELL': '/bin/bash', 03:59:07 INFO - 'SHLVL': '1', 03:59:07 INFO - 'TERM': 'linux', 03:59:07 INFO - 'TMOUT': '86400', 03:59:07 INFO - 'USER': 'cltbld', 03:59:07 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:07 INFO - '_': '/tools/buildbot/bin/python'} 03:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:07 INFO - Downloading/unpacking flake8 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:59:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:59:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:59:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:59:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:59:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:59:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:59:10 INFO - no previously-included directories found matching 'docs/_build' 03:59:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:59:10 INFO - Running setup.py install for pep8 03:59:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:59:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:59:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:59:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:59:10 INFO - no previously-included directories found matching 'docs/_build' 03:59:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:59:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:59:10 INFO - Cleaning up... 03:59:10 INFO - Return code: 0 03:59:10 INFO - Running post-action listener: _resource_record_post_action 03:59:10 INFO - Running post-action listener: _start_resource_monitoring 03:59:10 INFO - Starting resource monitoring. 03:59:10 INFO - ##### 03:59:10 INFO - ##### Running install step. 03:59:10 INFO - ##### 03:59:10 INFO - Running pre-action listener: _resource_record_pre_action 03:59:10 INFO - Running main action method: install 03:59:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:10 INFO - Reading from file tmpfile_stdout 03:59:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:59:10 INFO - Reading from file tmpfile_stdout 03:59:10 INFO - Output received: 03:59:10 INFO - Usage: mozinstall [options] installer 03:59:10 INFO - Options: 03:59:10 INFO - -h, --help show this help message and exit 03:59:10 INFO - -d DEST, --destination=DEST 03:59:10 INFO - Directory to install application into. [default: 03:59:11 INFO - "/builds/slave/test"] 03:59:11 INFO - --app=APP Application being installed. [default: firefox] 03:59:11 INFO - mkdir: /builds/slave/test/build/application 03:59:11 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'] 03:59:11 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 03:59:26 INFO - Reading from file tmpfile_stdout 03:59:26 INFO - Output received: 03:59:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:59:26 INFO - Running post-action listener: _resource_record_post_action 03:59:26 INFO - ##### 03:59:26 INFO - ##### Running run-tests step. 03:59:26 INFO - ##### 03:59:26 INFO - Running pre-action listener: _resource_record_pre_action 03:59:26 INFO - Running main action method: run_tests 03:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:26 INFO - Python 2.7.3 03:59:26 INFO - Return code: 0 03:59:26 INFO - grabbing minidump binary from tooltool 03:59:26 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')]} 03:59:26 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 0x1f6f3d0>, '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 0x1edaed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:26 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 03:59:26 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 03:59:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:26 INFO - Return code: 0 03:59:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:59:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:59:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:59:27 INFO - Return code: 0 03:59:27 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/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 03:59:27 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/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 03:59:27 INFO - Using env: {'DISPLAY': ':0', 03:59:27 INFO - 'HOME': '/home/cltbld', 03:59:27 INFO - 'LANG': 'en_US.UTF-8', 03:59:27 INFO - 'LANGUAGE': 'en_US:en', 03:59:27 INFO - 'LOGNAME': 'cltbld', 03:59:27 INFO - 'MAIL': '/var/mail/cltbld', 03:59:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:27 INFO - 'MOZ_NO_REMOTE': '1', 03:59:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:27 INFO - 'NO_EM_RESTART': '1', 03:59:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:27 INFO - 'PWD': '/builds/slave/test', 03:59:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:27 INFO - 'SHELL': '/bin/bash', 03:59:27 INFO - 'SHLVL': '1', 03:59:27 INFO - 'TERM': 'linux', 03:59:27 INFO - 'TMOUT': '86400', 03:59:27 INFO - 'USER': 'cltbld', 03:59:27 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139', 03:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:27 INFO - '_': '/tools/buildbot/bin/python'} 03:59:27 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/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 03:59:28 INFO - mozversion application_buildid: 20160121031622 03:59:28 INFO - mozversion application_changeset: b2e729decd54914536ed5ce29cf9a201d2f0eb45 03:59:28 INFO - mozversion application_display_name: Nightly 03:59:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:28 INFO - mozversion application_name: Firefox 03:59:28 INFO - mozversion application_remotingname: firefox 03:59:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:59:28 INFO - mozversion application_vendor: Mozilla 03:59:28 INFO - mozversion application_version: 46.0a1 03:59:28 INFO - mozversion platform_buildid: 20160121031622 03:59:28 INFO - mozversion platform_changeset: b2e729decd54914536ed5ce29cf9a201d2f0eb45 03:59:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:59:28 INFO - mozversion platform_version: 46.0a1 03:59:28 INFO - using testdate: 1453377568 03:59:28 INFO - actual date: 1453377568 03:59:28 INFO - starting webserver on 'localhost:49842' 03:59:28 INFO - SUITE-START | Running 3 tests 03:59:28 INFO - TEST-START | dromaeo_css 03:59:28 INFO - operating with platform_type : linux_ 03:59:28 INFO - Initialising browser for dromaeo_css test... 03:59:28 INFO - TEST-INFO | started process 16661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi4BhJy/profile http://localhost:49842/getInfo.html) 03:59:32 INFO - PROCESS | 16661 | 03:59:32 INFO - PROCESS | 16661 | (process:16741): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:59:33 INFO - PROCESS | 16661 | __metrics Screen width/height:1600/1200 03:59:33 INFO - PROCESS | 16661 | colorDepth:24 03:59:33 INFO - PROCESS | 16661 | Browser inner width/height: 1024/697 03:59:33 INFO - PROCESS | 16661 | __metrics 03:59:33 INFO - PROCESS | 16661 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:59:33 INFO - PROCESS | 16661 | 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. 03:59:34 INFO - TEST-INFO | 16661: exit 0 03:59:34 INFO - Browser initialized. 03:59:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:59:34 INFO - TEST-INFO | started process 16791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi4BhJy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:35 INFO - PROCESS | 16791 | -- checkerboarding starts below -- 03:59:35 INFO - PROCESS | 16791 | RENDERTRACE 0.078534 rect red 0 0 10 10 // viewport 03:59:35 INFO - PROCESS | 16791 | RENDERTRACE 34.5121 rect brown 0 0 10 10 // page 03:59:35 INFO - PROCESS | 16791 | RENDERTRACE 34.5318 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 03:59:35 INFO - PROCESS | 16791 | Checkerboarded for 1 frames (50.3687 ms), 100 peak, 2 severity. 03:59:35 INFO - PROCESS | 16791 | 03:59:35 INFO - PROCESS | 16791 | (process:16846): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:59:46 INFO - PROCESS | 16791 | RSS: Main: 150032384 03:59:46 INFO - PROCESS | 16791 | 04:00:35 INFO - PROCESS | 16791 | 1453377635862 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] 04:02:47 INFO - PROCESS | 16791 | Cycle 1(1): loaded http://localhost:49842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49842/tests/dromaeo/cssquery-ext.html) 04:02:48 INFO - PROCESS | 16791 | RSS: Main: 152625152 04:02:48 INFO - PROCESS | 16791 | 04:05:50 INFO - PROCESS | 16791 | Cycle 1(1): loaded http://localhost:49842/tests/dromaeo/cssquery-ext.html (next: http://localhost:49842/tests/dromaeo/cssquery-jquery.html) 04:05:51 INFO - PROCESS | 16791 | RSS: Main: 155590656 04:05:51 INFO - PROCESS | 16791 | 04:08:53 INFO - PROCESS | 16791 | Cycle 1(1): loaded http://localhost:49842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49842/tests/dromaeo/cssquery-mootools.html) 04:08:53 INFO - PROCESS | 16791 | RSS: Main: 150769664 04:08:53 INFO - PROCESS | 16791 | 04:11:55 INFO - PROCESS | 16791 | Cycle 1(1): loaded http://localhost:49842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49842/tests/dromaeo/cssquery-prototype.html) 04:11:56 INFO - PROCESS | 16791 | RSS: Main: 150392832 04:11:56 INFO - PROCESS | 16791 | 04:14:59 INFO - PROCESS | 16791 | Cycle 1(1): loaded http://localhost:49842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49842/tests/dromaeo/cssquery-yui.html) 04:14:59 INFO - PROCESS | 16791 | RSS: Main: 151293952 04:14:59 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | Cycle 1(1): loaded http://localhost:49842/tests/dromaeo/cssquery-yui.html (next: http://localhost:49842/tests/dromaeo/cssquery-dojo.html) 04:18:02 INFO - PROCESS | 16791 | RSS: Main: 153051136 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | __start_tp_report 04:18:02 INFO - PROCESS | 16791 | _x_x_mozilla_page_load 04:18:02 INFO - PROCESS | 16791 | _x_x_mozilla_page_load_details 04:18:02 INFO - PROCESS | 16791 | |i|pagename|runs| 04:18:02 INFO - PROCESS | 16791 | |0;dojo.html;2591.144922175682;2599.8830052647627;2641;2648.4967856107337;2658.109533306342;4380.474343078827;4519.118771839497;4545.545445455453;4597.5402459754005;4616.769161541922;4523.6607254455885;4525.2533332000185;4557.977210113945;4650.72095674259;4667.813287468505;4192.706510544255;4231.344141658048;4295.012147206145;4299.333603291495;4305.182015417061;4015.9743216511733;4258.127083947798;4266.935995960063;4275.5510671379525;4326.7187632803925;4136.73111247768;4219.07180420307;4222.619964203236;4260.424842646234;4286.485621725397;4192.371144328345;4224.788760561991;4229.619334259901;4293.8711838644895;4294.141171765628;4223.535411104806;4226.640735537483;4235.618794308496;4272.722273052242;4282.657387409;4355.80398882051;4478.865634030984;4485.192665320241;4506.729596224237;4552.863414097583;4818.7831547580445;4863.24619683946;4898.681585696918;4909.0181963607065;4948.307236986825;4865.537773911508;4897.51024897511;4906.31311616374;4906.828261010847;4942.085714142859;4436.778161091933;4512.390827238313;4528.184926713223;4537.455505339381;4581.289900065495;4985.351904252497;5037.496250375007;5049.899002020013;5062.038212739568;5098.617603679739;4820;4850.684705494132;4856.757162141878;4871.48849370811;4884.535969082932;4721.102990431807;4799.592034677022;4836.226203807444;4933.802647894116;5011.599072074226;4791.976040119777;4798.448178459522;4799.544043315879;4807.519248075165;4851;4777.689450185727;4783.1390349737385;4793.712377257376;4819.204831202883;4856.41722993236;4018.778967156776;4035.435039094529;4050.088730035777;4097.836086556505;4108.67130629549;3560.5203760818167;3575.6424357564556;3577.141486043331;3584.623614520438;3595.5865075516126;4240.067185219247;4243.27864263076;4244.830206791756;4247.660187185018;4284.421603083544;4726.574608285202;4779.713217206979;4797.328374027639;4838.056578967067;4901.950980490149;4145.326025099647;4182.163567286555;4195.077083041726;4202.285611446062;4242.109157077049;4206.978965105155;4270.829166833354;4286.721363111388;4306.0526684129445;4328.177646247203;4578.336141259565;4662.370579971728;4693.155232058262;4718.386609740712;4744.312074749211;4886.193778026586;4886.29148773433;4903.092927808367;4926.901461970812;4934.777934993006;4530.139273538017;4609.239475486641;4650.348951146774;4670.906581868276;4711.363965864564;4792.2332426811545;4811.78346974394;4818.518148185153;4840.370751802243;4864.051509955525;4773.164696178085;4793.592544633745;4800.5199480051715;4808.326834243138;4814.277858321279;4550.726956382628;4622.05247924168;4652.790624421977;4690.437147542317;4705.176594096088;4592.9540704593865;4714.740689262124;4752.144613969381;4776.140294746979;4801.735904525284;4648.349231107715;4648.395708557866;4651.162790697572;4686.226772582486;4691.132140554008;4633.559811817872;4742.312364707029;4748.976255118702;4784.473707892199;4787.640926930564;4617.653675974382;4635.119327327797;4716.410448693913;4735.100330937111;4749.7625118743235 04:18:02 INFO - PROCESS | 16791 | |1;ext.html;484.4622469059346;499.85254349966766;501.46092950078673;517.4049842680917;518.4245487508866;32166.356672866557;32888;33020.33959320812;33145.834270828644;33219.83390083052;36149;36297;36498.63501364986;36718.816405918;36796.632033679656;7635.121960974489;7827.843443131134;7835.373170146403;7845.882311765328;7846.529208247495;7375.668094935714;7455.4781165318445;7475.962620186919;7495.425960548291;7498.625068746568;7594.468387212897;7672.46292759507;7709.498882572615;7712.6914923403;7714.652840622158;7596.392288616925;7609.315161635424;7661.540307581563;7674.2709442603145;7676.923230767677;7695.846083078363;7823.100343460461;7832.412569057286;7836.529808211469;7859.096203936563;36045.63954360449;36477.27045459076;36505.45241821375;36538.26923461516;36564.451533227024;2989.925251868699;3534.169470174507;3540.309639620275;3573.6069032406413;3620.583632882226;26849.865750671317;27807.304817379525;28408;29004.41991160165;29107.70892291071;3384.5430866832908;3490.3019396120876;3495.8077305748175;3562.2341196642587;3616.4575313702894;221326;221719.89140054357;222438;223239;223595;47463;48315.51684483181;54054;55899.44100559023;56868.43131568714;49537;49741.25388119181;49767.50232497629;49823.25265121026;50192.247116293285;13295.867041329657;13444.798328025088;13462;13500.729985400238;13572.524961626494;9905.10854023127;9966.053224943618;9970;10008.849867251996;10100.797984040279;18877;19061.714074288895;19184.90407547981;19300.613987720168;19302.517437063903;7289.671964761598;7433.293837085468;7579.734709285149;7600;7613.695452181851;827.5365795154732;836.2599099796723;836.8117173635883;857.8370109679141;920.7329874336367;25883.223503294932;25983;26214.73785262123;26289.342766430993;26407.735922640913;923.2844545477309;943.3160958305311;1037.657573000923;1043.5251960358019;1070.8768491623564;13617.387217575233;13830.170189788645;13922.930385348009;14054.929725351512;14109.15345079278;256983;261413;262851;263498;264023;44512.10975780466;45146.77426612846;45271.54728452739;45371.319430208576;45627.315590266175;1181.2440038375446;1182.379250893288;1182.9349385783864;1196.730735584504;1308.1562392256942;24592.754072459047;25043.499130016935;25497.490050199263;25569.48861022806;25753.871230643726;39839.80080099581;39876.80061599673;39956.80021599874;39991;40019.199616008096;245672;248048;248336.5831708371;248821;249506;28173.71826281711;28716.856415717786;28735.568966465937;28778;28977.85511072431;32706;32752.836235818668;33405;33646.327073457905;33684.3263134731;27921;28123.859380702965;28548.85725571359;28660.85669571639;28912.277193070342;28608.42783144367;30397.544036839907;30632.693673062982;31017.534736978512;31237.219069523442;28579;28829.56755648709;28891.42217155687;29431.411371772017;29432.26419339534;26274.452948852424;28333.858330708215;29374.265643359086;30403.84798076084;32540.186495337806;22448.66327005129;22694.319170424915;23378.766212338338;23456;24105.156319529433 04:18:02 INFO - PROCESS | 16791 | |2;jquery.html;329.9241174529858;331.72632578123046;335.5369589965847;336.5607881714362;338.74424809269;13985.440582376705;14512.12927224366;14521.056131351455;14942.178180200084;15682.451114211004;8663.393562450616;8864.822703545926;9529.666461673844;14873.405063797461;14879.40482380706;4368;4606.055758569485;4610.054938737568;4620.422447194101;4876.463589005207;4995.525425084611;5016.573591244749;5025.296458495814;5035.320231768719;5054.772535235905;4082.6937979651498;4101.282275601773;4149.875503734893;4913.3612630358;5130.4356520782685;4726.7400292983875;4911.557959783619;4912.5578697917;4926.359573255471;4946.282788995612;4822.469528351879;4826.4690884003085;4831.492693267227;4841.443234028096;4843.854684359475;12515.74968500634;15856.286467109008;17002.064886431242;17082.14589270544;17136.22886970089;1642.983570164295;1804.5067781224657;1816.8546516278798;1903.800100989404;1918.6546421644098;8192.959035204845;8400.705975290897;8504.48973061612;8673.522956237404;8788.8681669775;1666.3501234518546;1695.127009590062;1743.4682421861328;1763.8711224816127;1769.0800783592588;47122.5287747125;49563.999999999636;50419.98374899644;50669.49330506685;51074;9025.81948361029;9119.452832830051;9185.173334399937;9232;9254.629814807467;11303.434828258718;11390;11413.600523981788;11459.369734664673;11502.367369794742;6311.684415779193;6491.091247225392;6497.090407342976;6549.214094308713;6552.967235163794;6098.176746139215;6128.724207410677;6188.845278867974;6202.658853763086;6221.906671399933;3843.1545060086737;3897.649211570972;3925.450436938831;3952.1898010907694;3953.0710283083454;1558.4934896158568;1627.9023258604523;1639.6064944413492;1659.1289572974044;1663.2182874049176;750.4296734481833;808.4906508899473;856.3534531428731;862.3532350736947;940.3699521320732;14124.788128178085;14754.336054877556;15357.001794883297;15891.26555259513;16035.438759643357;769.8075481129717;812.3014207781304;816.147126253067;824.0523398092122;838.8112674648278;8137.389695772841;8300;8361.790955226046;8383.28742056932;8521.233089022018;449565;452155;459081.7045914749;460437;462920;62387.68806156031;62778.37221627816;63227.68386158132;64823.35176648267;65770.67114664396;1055.9524821383209;1061.3843970497094;1066.9573217071386;1082.5128692088592;1086.5708045322053;12737.235765854079;12942.352882356034;13180.143290686075;13191.472341106248;13393.330333483482;27979.740911658617;28650.42699146047;30549.694503055573;30700.385992279582;31533.211669708442;37454.62545374512;37934.24131517409;37950.72295662269;38028;38280.23439531138;6073.605215660968;6118.663473508822;6145.170401995673;6254.530910181846;6460.289368169404;7314.748629973588;9609.807803844024;9790.951045244728;9795.80408391814;9816;8194.22154895284;8404.537750423786;8924.375293729376;8927.107289271022;9095.681651142178;7899.723509677364;8377.623006964579;8579.313654907717;8757.518336491554;8768.517731524827;8548.829023419372;8647.618480413263;8676.826463470568;8772.868406974028;8839.823203536022;6452.096706461193;6590.637514936533;6654.667266636746;6658.766943156967;6784.253732089367;8955.507447090473;8996.290704766336;9098.545072746203;9127.726168214964;9234.676786312446 04:18:02 INFO - PROCESS | 16791 | |3;mootools.html;1327.4424741608525;1336.1782503760187;1413.314542446913;1642.7617995390676;1647.8269781672932;5965.403459654032;6097.481714054311;6648.667566621668;6880.4839637027235;6890.069840571521;6291.591046581969;6455.225372955252;6503.252126005511;6506.837329066776;6506.967465162679;2007.387746737248;2061.793820617941;2063.9587208255825;2065.070718176819;2069.244725675125;1984.5931584025313;1987.8210961013506;2002.9298974535893;2017.959640807183;2020.5251765835017;1978.574606459611;2008.5882394109246;2014.6172227276843;2020.7777144514166;2025.0381068992185;2051.1692764430354;2056.629806634805;2057.567910738747;2059.268959519364;2061.5464597788464;1965.8230759231594;1972.3491247888162;1982.0288058851204;1993.7707163676218;1993.9202431902852;6857.725690972356;6865.107536020335;6902.102726645554;6957.9652101739675;6978.127734033246;4025.6175663311938;4091.1408604193157;4111.116110036327;4130.153318569716;4132.607402296777;2629.184952664661;2649.4038841260754;2701.2976626077166;2725.0870958229016;2732.398872248122;824.5918270456102;828.362161135922;858.7080392666523;859.6647307550061;1780.830821071996;9166.908330916673;9240.029796871298;9248.815023699555;9321.114494123047;9337.253019758404;3490.9650903491147;3558.822058897045;3562.608113107556;3613.9277214456088;3623.456481527739;7648.273414025659;7654.2345765424125;7658.195889431529;7659.540427574363;7679.462437629312;4020.0954785173685;4045.5954404559307;4054.3310353791294;4056.472658554428;4066.9389959150635;3244.3997860395903;3318.8672453101603;3594.964050359463;3747.868824591126;3763.5671897732113;3107.1144723753623;3140.4190224808485;3152.8423578820966;3155.3216058547523;3161.351922855809;942.6512190489426;971.0774763974111;973.4451362723321;973.6008236623093;977.3061126600052;886.3751055505853;910.7449914024083;1152.504423098059;1165.953361865516;1171.4494187731752;6330.303666596671;6352.7141278642575;6357.809265722036;6363.395477429637;6396.936030639634;965.1313817564248;1019.2508506247901;1027.409239687183;1030.5826140413144;1066.195022757813;5047.596192304607;5204.531592156724;5205.2192171173865;5205.583553315726;5212.7914883405;7567.697292108364;7723;7806.843863122705;8092.3930705197345;8257.174282571696;7661.655225514865;7670.041244844395;7701.191374905667;7730.188330225358;7762.2237776223055;6067.211262535842;6173.536984726074;6242.531810114259;6277.089821975788;6308.053791931247;5959.463648271676;6048.546359023179;6068.666223357581;6070.939290607037;6091.847703807441;7014.228434872262;7180.748673796392;7192.352688258082;7296.7081316746735;7336;7019.789406317818;7268.927310726825;7319.194888562148;7353.77938661841;7477.214892436215;5449.209864569536;5598;6018.247719035121;6066.3023752269055;6066.969665151646;6303.716332764945;6444.645544494911;6482.708278127401;6486.708098135501;6494.188226471691;5683.658980461186;5788.479036886701;5851.531877449709;5907.261592300963;5956.672383018976;5799.362070172193;5984.700764961647;6022.277326720647;6043.244594425697;6113.5414843886;5975.25309336333;6022.45797878193;6157;6162.938370616416;6180.47465965398;5620.494155526022;5636.0418728815375;5653.773849045992;5660.745266462936;5668.178114173339;5682.77268909239;5729.169270455677;5764.567657425794;5802.564807639359;5809.157672137432 04:18:02 INFO - PROCESS | 16791 | |4;prototype.html;278.835487062633;281.51860318854756;284.91879814252934;286.17153341077596;299.0698926339086;5514.117741161415;5569.164625306201;5571.860703482415;5691.1747796569525;5737.885242295151;5540.141278101891;5577.051901176799;5578.3584887737925;5610.410906854782;5611.046122159232;4208.5791420857895;4212.662986961036;4213.346931225665;4213.894652633693;4214.620684138427;4223.387608796723;4223.556526564713;4223.767692776896;4224.429701990238;4230.492340919079;4039.171969746195;4138;4175.6033176848305;4177.791110444481;4179.185058913513;4167.5832416758385;4195.62239398454;4198.5591512891015;4202.2646036943415;4203.201391735576;3616.077900135475;3621.203335266237;3622.4204127339763;3623.800690961996;3624.0939765058733;5260.631755777097;5260.92108618371;5282.894342113174;5291.656042357235;5299.4700529946695;4728.290756386536;4793.3049707792525;4812.831550895702;4824.975875120602;4830.106430310404;5764.971175144097;5776.422357764232;5790.7973220937065;5792.623479473863;5798.217240672539;3935.567087620388;3936.409538569209;3940.271049855786;3943.1522222721965;3949.0522274654163;6117.816465505997;6189.071639254103;6194.039923811816;6208.50331973441;6221;3952.288588054178;4090.3864420337186;4098.467199264077;4106.2198182345255;4120.814563344657;4149.149424367997;4163.875083747493;4175.791210439465;4177.164567086595;4187.392828039978;4831.903361932812;4834.033193361342;4834.975825120852;4846.539578740014;4848.127337079289;5835.095560188178;5874.441928016831;5880.853233619403;5882.117682347682;5893.6463812171405;1441.502681574855;1447.037719916244;1467.772495263236;1471.4849802569015;1471.8969672122848;952.9047095290415;954.5227386306847;958.3100167879115;966.4153187321709;971.2278738402987;5089.211172268304;5103.132467480463;5106.514881086291;5120.385553733576;5124.743762811844;6055.091736239599;6069.878602428015;6079.118527813443;6083;6133.355997620186;4895.412550493964;5057.140286151363;5076.390833100052;5091.312672789126;5111.463296353903;3221.4684577044527;3225.774195806271;3268.313654132611;3274.6889045540634;3288.8355582220793;5703.17303990919;5748.971255143698;5752.13717942312;5755.280589926259;5771.6537007778825;6294.748210071546;6296.968515157395;6303.086052522451;6311.621302721851;6313.905291420632;5592.217089607459;5741;5762.971185144132;5818.854528636818;5819.0689489681445;6056.606320589324;6130.356312587114;6173.506119510518;6186.041163619646;6186.072089186658;6005.759769609167;6012.669303188367;6026.0659597762415;6038.879222415615;6058.7273572688455;5594.216809646734;5788.942110579009;5789.45000224978;5790.160426738184;5833.212516310414;4164.43780089684;4235.851745188904;4238.131183107517;4239.554846741171;4252.936205956851;6084.513238940785;6088.178095956989;6091.451769340781;6103.267607887082;6109.266887973472;5750.821081678329;5831.241938547962;5928.822135335947;5950.821475355746;5956.463918247378;5861.325947515919;5862.94137058624;5872.412758724094;5889.087191485327;5953.642781433128;5745.97127014379;5754.712264386848;5755.3381361144;5762.30852297727;5776.220210271727;5859.472647461749;5896.3514013457625;5900.911486327623;5911.438413350725;5922.348541660328;5614.129809879475;5724.084146536534;5757.798477053283;5768.451997060272;5771.797987070432 04:18:02 INFO - PROCESS | 16791 | |5;yui.html;668.8796016716992;719.9820004499887;728.7595093619104;761.8442980715816;772.3589420780753;11689.357085360301;11694.941525292383;11736.471858766354;11752.823707644382;11757.118216133782;10949.890501094987;12344.691382715437;12580;12595.118341716083;12622.24266544008;730.8794048981938;738.7709809958903;743.8177646476594;744.8137965508623;746.5184955703568;745.589925540953;746.4289818288986;747.6710247491113;749.3518106837573;750.973715919943;775.1357236681088;775.4068137874531;775.9030121234846;779.2207792207793;781.9061712594497;761.0220866186978;763.7250589787644;765.5559775330295;766.5553978692345;774.3108633316353;566.218618306734;575.1315513574533;576.2451188942499;577.3995045153035;577.7862190989318;12446.937765311206;12504.624861254086;12521.74956500874;12540.74918501634;12564.874351256552;11032.062274706659;11117.555297788078;11124.61063862761;11310.095192384671;11649.650510484698;9239;9280.211182049534;9308.301877359225;9387.62449502019;9454.33819632626;3135.6237251529733;3214.276787722767;3238.9028329150165;3243.5621191139367;3256.430124728187;40668.79665601653;40990.590094098974;41113.588864111574;41177.382339264936;41445.37831932523;8404.07555168931;8758.693445729368;8881.467111973303;9358.438493690264;9360.812783744286;15669.138197399025;15705.764413533807;15719.764203536955;15721.292541835644;15759.13324767126;6337.96831015842;6487.318831522716;6587.473002159816;6671.266160722316;6739.59562426256;3549.982250088733;3635.4365073413665;3659.396199627032;3769.4345848122452;3775.7356985010783;2658.933526661849;2662.6937902141112;2666.1335066103593;2669.746374094458;2689.367998520346;478.77258302306825;484.97575121243796;486.50862628744517;487.51735781576696;505.3405306075533;492.8669259299969;532.4941305759544;547.6385585513542;566.9971650141723;572.3532408378505;6890.93109068913;7155.248698886646;7201.279872012757;7266.346028857428;7311.634418279171;443.4146926057637;469.4694994656085;505.21439162102547;532.7922110376957;537.6263496869637;3327.517509961042;3366.208940898887;3500.1424650960166;3511.367953768346;3565.7682250653625;50088.24867626988;50291.245631315556;50407.747961259956;50522.49477505252;50573;43988.78005609952;44304;44623.776881116035;44646.55353446489;44776.55223447724;35428.82285588504;35701.82149089238;35703.10742231465;35824.28351432957;36704.26591468209;7379.704811807467;7402.777916662509;7438.888416673646;7489.176190619137;7868.370530357673;29368;29789.10632681023;30534.38931221319;30589.847050764605;30855.537166942064;37384;38694;38711.806440967615;38904;39034;9212.49331286759;9375.437473751597;9691.563879625575;9892.505374731378;10332.225083118647;10722.839157412802;10852.891471085188;11001.339919604849;11255.380954047607;11302.717432064264;9713.805723885342;9816.067473589997;9884;9904.50477476109;10378.584856605954;9986.35088719231;10027.949860250652;10069.244806639677;10496.265261431932;10597.841032384675;9853.211743060681;9877.654282100091;9882.901170988198;9933.453660048766;9982.550785214538;8548.914510854811;8677.479351238946;8718.60766265507;8728.781780455285;8799.736007919773;8101.9594902027475;8341.290990265652;8525.573721314033;8749.912500875165;8775.254103401026 04:18:02 INFO - PROCESS | 16791 | __end_tp_report 04:18:02 INFO - PROCESS | 16791 | __start_cc_report 04:18:02 INFO - PROCESS | 16791 | _x_x_mozilla_cycle_collect,329 04:18:02 INFO - PROCESS | 16791 | __end_cc_report 04:18:02 INFO - PROCESS | 16791 | __startTimestamp1453378682407__endTimestamp 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | ------- Summary: start ------- 04:18:02 INFO - PROCESS | 16791 | Number of tests: 6 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | [#0] dojo.html Cycles:165 Average:4503.35 Median:4648.35 stddev:459.75 (9.9%) stddev-sans-first:436.00 04:18:02 INFO - PROCESS | 16791 | Values: 2591.1 2599.9 2641.0 2648.5 2658.1 4380.5 4519.1 4545.5 4597.5 4616.8 4523.7 4525.3 4558.0 4650.7 4667.8 4192.7 4231.3 4295.0 4299.3 4305.2 4016.0 4258.1 4266.9 4275.6 4326.7 4136.7 4219.1 4222.6 4260.4 4286.5 4192.4 4224.8 4229.6 4293.9 4294.1 4223.5 4226.6 4235.6 4272.7 4282.7 4355.8 4478.9 4485.2 4506.7 4552.9 4818.8 4863.2 4898.7 4909.0 4948.3 4865.5 4897.5 4906.3 4906.8 4942.1 4436.8 4512.4 4528.2 4537.5 4581.3 4985.4 5037.5 5049.9 5062.0 5098.6 4820.0 4850.7 4856.8 4871.5 4884.5 4721.1 4799.6 4836.2 4933.8 5011.6 4792.0 4798.4 4799.5 4807.5 4851.0 4777.7 4783.1 4793.7 4819.2 4856.4 4018.8 4035.4 4050.1 4097.8 4108.7 3560.5 3575.6 3577.1 3584.6 3595.6 4240.1 4243.3 4244.8 4247.7 4284.4 4726.6 4779.7 4797.3 4838.1 4902.0 4145.3 4182.2 4195.1 4202.3 4242.1 4207.0 4270.8 4286.7 4306.1 4328.2 4578.3 4662.4 4693.2 4718.4 4744.3 4886.2 4886.3 4903.1 4926.9 4934.8 4530.1 4609.2 4650.3 4670.9 4711.4 4792.2 4811.8 4818.5 4840.4 4864.1 4773.2 4793.6 4800.5 4808.3 4814.3 4550.7 4622.1 4652.8 4690.4 4705.2 4593.0 4714.7 4752.1 4776.1 4801.7 4648.3 4648.4 4651.2 4686.2 4691.1 4633.6 4742.3 4749.0 4784.5 4787.6 4617.7 4635.1 4716.4 4735.1 4749.8 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | [#1] ext.html Cycles:180 Average:39459.12 Median:33083.09 stddev:63726.66 (192.6%) stddev-sans-first:63838.24 04:18:02 INFO - PROCESS | 16791 | Values: 484.5 499.9 501.5 517.4 518.4 32166.4 32888.0 33020.3 33145.8 33219.8 36149.0 36297.0 36498.6 36718.8 36796.6 7635.1 7827.8 7835.4 7845.9 7846.5 7375.7 7455.5 7476.0 7495.4 7498.6 7594.5 7672.5 7709.5 7712.7 7714.7 7596.4 7609.3 7661.5 7674.3 7676.9 7695.8 7823.1 7832.4 7836.5 7859.1 36045.6 36477.3 36505.5 36538.3 36564.5 2989.9 3534.2 3540.3 3573.6 3620.6 26849.9 27807.3 28408.0 29004.4 29107.7 3384.5 3490.3 3495.8 3562.2 3616.5 221326.0 221719.9 222438.0 223239.0 223595.0 47463.0 48315.5 54054.0 55899.4 56868.4 49537.0 49741.3 49767.5 49823.3 50192.2 13295.9 13444.8 13462.0 13500.7 13572.5 9905.1 9966.1 9970.0 10008.8 10100.8 18877.0 19061.7 19184.9 19300.6 19302.5 7289.7 7433.3 7579.7 7600.0 7613.7 827.5 836.3 836.8 857.8 920.7 25883.2 25983.0 26214.7 26289.3 26407.7 923.3 943.3 1037.7 1043.5 1070.9 13617.4 13830.2 13922.9 14054.9 14109.2 256983.0 261413.0 262851.0 263498.0 264023.0 44512.1 45146.8 45271.5 45371.3 45627.3 1181.2 1182.4 1182.9 1196.7 1308.2 24592.8 25043.5 25497.5 25569.5 25753.9 39839.8 39876.8 39956.8 39991.0 40019.2 245672.0 248048.0 248336.6 248821.0 249506.0 28173.7 28716.9 28735.6 28778.0 28977.9 32706.0 32752.8 33405.0 33646.3 33684.3 27921.0 28123.9 28548.9 28660.9 28912.3 28608.4 30397.5 30632.7 31017.5 31237.2 28579.0 28829.6 28891.4 29431.4 29432.3 26274.5 28333.9 29374.3 30403.8 32540.2 22448.7 22694.3 23378.8 23456.0 24105.2 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | [#2] jquery.html Cycles:180 Average:23657.65 Median:4936.32 stddev:74654.65 (1512.4%) stddev-sans-first:74843.53 04:18:02 INFO - PROCESS | 16791 | Values: 329.9 331.7 335.5 336.6 338.7 13985.4 14512.1 14521.1 14942.2 15682.5 8663.4 8864.8 9529.7 14873.4 14879.4 4368.0 4606.1 4610.1 4620.4 4876.5 4995.5 5016.6 5025.3 5035.3 5054.8 4082.7 4101.3 4149.9 4913.4 5130.4 4726.7 4911.6 4912.6 4926.4 4946.3 4822.5 4826.5 4831.5 4841.4 4843.9 12515.7 15856.3 17002.1 17082.1 17136.2 1643.0 1804.5 1816.9 1903.8 1918.7 8193.0 8400.7 8504.5 8673.5 8788.9 1666.4 1695.1 1743.5 1763.9 1769.1 47122.5 49564.0 50420.0 50669.5 51074.0 9025.8 9119.5 9185.2 9232.0 9254.6 11303.4 11390.0 11413.6 11459.4 11502.4 6311.7 6491.1 6497.1 6549.2 6553.0 6098.2 6128.7 6188.8 6202.7 6221.9 3843.2 3897.6 3925.5 3952.2 3953.1 1558.5 1627.9 1639.6 1659.1 1663.2 750.4 808.5 856.4 862.4 940.4 14124.8 14754.3 15357.0 15891.3 16035.4 769.8 812.3 816.1 824.1 838.8 8137.4 8300.0 8361.8 8383.3 8521.2 449565.0 452155.0 459081.7 460437.0 462920.0 62387.7 62778.4 63227.7 64823.4 65770.7 1056.0 1061.4 1067.0 1082.5 1086.6 12737.2 12942.4 13180.1 13191.5 13393.3 27979.7 28650.4 30549.7 30700.4 31533.2 37454.6 37934.2 37950.7 38028.0 38280.2 6073.6 6118.7 6145.2 6254.5 6460.3 7314.7 9609.8 9791.0 9795.8 9816.0 8194.2 8404.5 8924.4 8927.1 9095.7 7899.7 8377.6 8579.3 8757.5 8768.5 8548.8 8647.6 8676.8 8772.9 8839.8 6452.1 6590.6 6654.7 6658.8 6784.3 8955.5 8996.3 9098.5 9127.7 9234.7 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | [#3] mootools.html Cycles:180 Average:4695.05 Median:5958.07 stddev:2377.26 (39.9%) stddev-sans-first:2370.45 04:18:02 INFO - PROCESS | 16791 | Values: 1327.4 1336.2 1413.3 1642.8 1647.8 5965.4 6097.5 6648.7 6880.5 6890.1 6291.6 6455.2 6503.3 6506.8 6507.0 2007.4 2061.8 2064.0 2065.1 2069.2 1984.6 1987.8 2002.9 2018.0 2020.5 1978.6 2008.6 2014.6 2020.8 2025.0 2051.2 2056.6 2057.6 2059.3 2061.5 1965.8 1972.3 1982.0 1993.8 1993.9 6857.7 6865.1 6902.1 6958.0 6978.1 4025.6 4091.1 4111.1 4130.2 4132.6 2629.2 2649.4 2701.3 2725.1 2732.4 824.6 828.4 858.7 859.7 1780.8 9166.9 9240.0 9248.8 9321.1 9337.3 3491.0 3558.8 3562.6 3613.9 3623.5 7648.3 7654.2 7658.2 7659.5 7679.5 4020.1 4045.6 4054.3 4056.5 4066.9 3244.4 3318.9 3595.0 3747.9 3763.6 3107.1 3140.4 3152.8 3155.3 3161.4 942.7 971.1 973.4 973.6 977.3 886.4 910.7 1152.5 1166.0 1171.4 6330.3 6352.7 6357.8 6363.4 6396.9 965.1 1019.3 1027.4 1030.6 1066.2 5047.6 5204.5 5205.2 5205.6 5212.8 7567.7 7723.0 7806.8 8092.4 8257.2 7661.7 7670.0 7701.2 7730.2 7762.2 6067.2 6173.5 6242.5 6277.1 6308.1 5959.5 6048.5 6068.7 6070.9 6091.8 7014.2 7180.7 7192.4 7296.7 7336.0 7019.8 7268.9 7319.2 7353.8 7477.2 5449.2 5598.0 6018.2 6066.3 6067.0 6303.7 6444.6 6482.7 6486.7 6494.2 5683.7 5788.5 5851.5 5907.3 5956.7 5799.4 5984.7 6022.3 6043.2 6113.5 5975.3 6022.5 6157.0 6162.9 6180.5 5620.5 5636.0 5653.8 5660.7 5668.2 5682.8 5729.2 5764.6 5802.6 5809.2 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | [#4] prototype.html Cycles:180 Average:4831.96 Median:5585.29 stddev:1459.02 (26.1%) stddev-sans-first:1422.52 04:18:02 INFO - PROCESS | 16791 | Values: 278.8 281.5 284.9 286.2 299.1 5514.1 5569.2 5571.9 5691.2 5737.9 5540.1 5577.1 5578.4 5610.4 5611.0 4208.6 4212.7 4213.3 4213.9 4214.6 4223.4 4223.6 4223.8 4224.4 4230.5 4039.2 4138.0 4175.6 4177.8 4179.2 4167.6 4195.6 4198.6 4202.3 4203.2 3616.1 3621.2 3622.4 3623.8 3624.1 5260.6 5260.9 5282.9 5291.7 5299.5 4728.3 4793.3 4812.8 4825.0 4830.1 5765.0 5776.4 5790.8 5792.6 5798.2 3935.6 3936.4 3940.3 3943.2 3949.1 6117.8 6189.1 6194.0 6208.5 6221.0 3952.3 4090.4 4098.5 4106.2 4120.8 4149.1 4163.9 4175.8 4177.2 4187.4 4831.9 4834.0 4835.0 4846.5 4848.1 5835.1 5874.4 5880.9 5882.1 5893.6 1441.5 1447.0 1467.8 1471.5 1471.9 952.9 954.5 958.3 966.4 971.2 5089.2 5103.1 5106.5 5120.4 5124.7 6055.1 6069.9 6079.1 6083.0 6133.4 4895.4 5057.1 5076.4 5091.3 5111.5 3221.5 3225.8 3268.3 3274.7 3288.8 5703.2 5749.0 5752.1 5755.3 5771.7 6294.7 6297.0 6303.1 6311.6 6313.9 5592.2 5741.0 5763.0 5818.9 5819.1 6056.6 6130.4 6173.5 6186.0 6186.1 6005.8 6012.7 6026.1 6038.9 6058.7 5594.2 5788.9 5789.5 5790.2 5833.2 4164.4 4235.9 4238.1 4239.6 4252.9 6084.5 6088.2 6091.5 6103.3 6109.3 5750.8 5831.2 5928.8 5950.8 5956.5 5861.3 5862.9 5872.4 5889.1 5953.6 5746.0 5754.7 5755.3 5762.3 5776.2 5859.5 5896.4 5900.9 5911.4 5922.3 5614.1 5724.1 5757.8 5768.5 5771.8 04:18:02 INFO - PROCESS | 16791 | 04:18:02 INFO - PROCESS | 16791 | [#5] yui.html Cycles:180 Average:11955.87 Median:25456.48 stddev:13569.95 (53.3%) stddev-sans-first:13581.55 04:18:02 INFO - PROCESS | 16791 | Values: 668.9 720.0 728.8 761.8 772.4 11689.4 11694.9 11736.5 11752.8 11757.1 10949.9 12344.7 12580.0 12595.1 12622.2 730.9 738.8 743.8 744.8 746.5 745.6 746.4 747.7 749.4 751.0 775.1 775.4 775.9 779.2 781.9 761.0 763.7 765.6 766.6 774.3 566.2 575.1 576.2 577.4 577.8 12446.9 12504.6 12521.7 12540.7 12564.9 11032.1 11117.6 11124.6 11310.1 11649.7 9239.0 9280.2 9308.3 9387.6 9454.3 3135.6 3214.3 3238.9 3243.6 3256.4 40668.8 40990.6 41113.6 41177.4 41445.4 8404.1 8758.7 8881.5 9358.4 9360.8 15669.1 15705.8 15719.8 15721.3 15759.1 6338.0 6487.3 6587.5 6671.3 6739.6 3550.0 3635.4 3659.4 3769.4 3775.7 2658.9 2662.7 2666.1 2669.7 2689.4 478.8 485.0 486.5 487.5 505.3 492.9 532.5 547.6 567.0 572.4 6890.9 7155.2 7201.3 7266.3 7311.6 443.4 469.5 505.2 532.8 537.6 3327.5 3366.2 3500.1 3511.4 3565.8 50088.2 50291.2 50407.7 50522.5 50573.0 43988.8 44304.0 44623.8 44646.6 44776.6 35428.8 35701.8 35703.1 35824.3 36704.3 7379.7 7402.8 7438.9 7489.2 7868.4 29368.0 29789.1 30534.4 30589.8 30855.5 37384.0 38694.0 38711.8 38904.0 39034.0 9212.5 9375.4 9691.6 9892.5 10332.2 10722.8 10852.9 11001.3 11255.4 11302.7 9713.8 9816.1 9884.0 9904.5 10378.6 9986.4 10027.9 10069.2 10496.3 10597.8 9853.2 9877.7 9882.9 9933.5 9982.6 8548.9 8677.5 8718.6 8728.8 8799.7 8102.0 8341.3 8525.6 8749.9 8775.3 04:18:02 INFO - PROCESS | 16791 | -------- Summary: end -------- 04:18:02 INFO - PROCESS | 16791 | 04:18:03 INFO - TEST-INFO | 16791: exit 0 04:18:03 INFO - TEST-OK | dromaeo_css | took 1115002ms 04:18:03 INFO - TEST-START | kraken 04:18:03 INFO - operating with platform_type : linux_ 04:18:03 INFO - Initialising browser for kraken test... 04:18:03 INFO - TEST-INFO | started process 17033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusk9hf/profile http://localhost:49842/getInfo.html) 04:18:06 INFO - PROCESS | 17033 | 04:18:06 INFO - PROCESS | 17033 | (process:17107): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:18:07 INFO - PROCESS | 17033 | __metrics Screen width/height:1600/1200 04:18:07 INFO - PROCESS | 17033 | colorDepth:24 04:18:07 INFO - PROCESS | 17033 | Browser inner width/height: 1024/697 04:18:07 INFO - PROCESS | 17033 | __metrics 04:18:08 INFO - PROCESS | 17033 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:18:08 INFO - TEST-INFO | 17033: exit 0 04:18:08 INFO - Browser initialized. 04:18:08 INFO - Running cycle 1/1 for kraken test... 04:18:08 INFO - TEST-INFO | started process 17156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusk9hf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:09 INFO - PROCESS | 17156 | -- checkerboarding starts below -- 04:18:09 INFO - PROCESS | 17156 | RENDERTRACE 0.032788 rect red 0 0 10 10 // viewport 04:18:09 INFO - PROCESS | 17156 | RENDERTRACE 48.4867 rect brown 0 0 10 10 // page 04:18:09 INFO - PROCESS | 17156 | RENDERTRACE 48.5053 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:18:09 INFO - PROCESS | 17156 | Checkerboarded for 1 frames (48.583 ms), 100 peak, 1 severity. 04:18:10 INFO - PROCESS | 17156 | 04:18:10 INFO - PROCESS | 17156 | (process:17213): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:18:20 INFO - PROCESS | 17156 | RSS: Main: 149127168 04:18:20 INFO - PROCESS | 17156 | 04:18:23 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49842/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:24 INFO - PROCESS | 17156 | RSS: Main: 151801856 04:18:24 INFO - PROCESS | 17156 | 04:18:26 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49842/tests/kraken/driver.html?testName=audio-dft) 04:18:27 INFO - PROCESS | 17156 | RSS: Main: 154542080 04:18:27 INFO - PROCESS | 17156 | 04:18:30 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49842/tests/kraken/driver.html?testName=audio-fft) 04:18:31 INFO - PROCESS | 17156 | RSS: Main: 146825216 04:18:31 INFO - PROCESS | 17156 | 04:18:33 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49842/tests/kraken/driver.html?testName=audio-oscillator) 04:18:33 INFO - PROCESS | 17156 | RSS: Main: 146481152 04:18:33 INFO - PROCESS | 17156 | 04:18:36 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:36 INFO - PROCESS | 17156 | RSS: Main: 148803584 04:18:36 INFO - PROCESS | 17156 | 04:18:39 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49842/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:40 INFO - PROCESS | 17156 | RSS: Main: 147050496 04:18:40 INFO - PROCESS | 17156 | 04:18:43 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49842/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:44 INFO - PROCESS | 17156 | RSS: Main: 147775488 04:18:44 INFO - PROCESS | 17156 | 04:18:47 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49842/tests/kraken/driver.html?testName=json-parse-financial) 04:18:47 INFO - PROCESS | 17156 | RSS: Main: 148082688 04:18:47 INFO - PROCESS | 17156 | 04:18:49 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:50 INFO - PROCESS | 17156 | RSS: Main: 149299200 04:18:50 INFO - PROCESS | 17156 | 04:18:52 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:52 INFO - PROCESS | 17156 | RSS: Main: 149270528 04:18:52 INFO - PROCESS | 17156 | 04:18:54 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:55 INFO - PROCESS | 17156 | RSS: Main: 148951040 04:18:55 INFO - PROCESS | 17156 | 04:18:58 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:58 INFO - PROCESS | 17156 | RSS: Main: 148623360 04:18:58 INFO - PROCESS | 17156 | 04:19:01 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:01 INFO - PROCESS | 17156 | RSS: Main: 150003712 04:19:01 INFO - PROCESS | 17156 | 04:19:03 INFO - PROCESS | 17156 | Cycle 1(1): loaded http://localhost:49842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49842/tests/kraken/driver.html?testName=ai-astar) 04:19:04 INFO - PROCESS | 17156 | RSS: Main: 148807680 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | __start_tp_report 04:19:04 INFO - PROCESS | 17156 | _x_x_mozilla_page_load 04:19:04 INFO - PROCESS | 17156 | _x_x_mozilla_page_load_details 04:19:04 INFO - PROCESS | 17156 | |i|pagename|runs| 04:19:04 INFO - PROCESS | 17156 | |0;ai-astar;114;110;116;115;115;127;116;114;115;115 04:19:04 INFO - PROCESS | 17156 | |1;audio-beat-detection;155;133;163;173;131;163;155;147;175;137 04:19:04 INFO - PROCESS | 17156 | |2;audio-dft;165;164;162;162;164;164;168;163;164;162 04:19:04 INFO - PROCESS | 17156 | |3;audio-fft;74;75;77;148;74;74;77;75;159;75 04:19:04 INFO - PROCESS | 17156 | |4;audio-oscillator;98;98;131;99;100;97;149;98;97;134 04:19:04 INFO - PROCESS | 17156 | |5;imaging-gaussian-blur;110;109;109;110;110;111;110;109;111;110 04:19:04 INFO - PROCESS | 17156 | |6;imaging-darkroom;148;148;148;147;148;147;148;149;148;148 04:19:04 INFO - PROCESS | 17156 | |7;imaging-desaturate;96;96;96;101;96;97;96;97;97;96 04:19:04 INFO - PROCESS | 17156 | |8;json-parse-financial;71;69;72;70;70;71;70;72;72;72 04:19:04 INFO - PROCESS | 17156 | |9;json-stringify-tinderbox;70;67;68;68;68;68;68;68;69;68 04:19:04 INFO - PROCESS | 17156 | |10;stanford-crypto-aes;86;84;95;85;89;82;84;84;85;85 04:19:04 INFO - PROCESS | 17156 | |11;stanford-crypto-ccm;127;124;139;122;122;128;128;126;128;138 04:19:04 INFO - PROCESS | 17156 | |12;stanford-crypto-pbkdf2;138;144;155;154;150;142;158;148;151;141 04:19:04 INFO - PROCESS | 17156 | |13;stanford-crypto-sha256-iterative;75;71;73;71;70;70;72;74;73;75 04:19:04 INFO - PROCESS | 17156 | __end_tp_report 04:19:04 INFO - PROCESS | 17156 | __start_cc_report 04:19:04 INFO - PROCESS | 17156 | _x_x_mozilla_cycle_collect,794 04:19:04 INFO - PROCESS | 17156 | __end_cc_report 04:19:04 INFO - PROCESS | 17156 | __startTimestamp1453378744034__endTimestamp 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | ------- Summary: start ------- 04:19:04 INFO - PROCESS | 17156 | Number of tests: 14 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.00 stddev:4.32 (3.8%) stddev-sans-first:4.54 04:19:04 INFO - PROCESS | 17156 | Values: 114.0 110.0 116.0 115.0 115.0 127.0 116.0 114.0 115.0 115.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:159.00 stddev:15.87 (10.0%) stddev-sans-first:16.82 04:19:04 INFO - PROCESS | 17156 | Values: 155.0 133.0 163.0 173.0 131.0 163.0 155.0 147.0 175.0 137.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.81 (1.1%) stddev-sans-first:1.87 04:19:04 INFO - PROCESS | 17156 | Values: 165.0 164.0 162.0 162.0 164.0 164.0 168.0 163.0 164.0 162.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#3] audio-fft Cycles:10 Average:90.80 Median:75.00 stddev:33.17 (44.2%) stddev-sans-first:34.62 04:19:04 INFO - PROCESS | 17156 | Values: 74.0 75.0 77.0 148.0 74.0 74.0 77.0 75.0 159.0 75.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:97.50 stddev:19.80 (20.3%) stddev-sans-first:20.51 04:19:04 INFO - PROCESS | 17156 | Values: 98.0 98.0 131.0 99.0 100.0 97.0 149.0 98.0 97.0 134.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 04:19:04 INFO - PROCESS | 17156 | Values: 110.0 109.0 109.0 110.0 110.0 111.0 110.0 109.0 111.0 110.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:19:04 INFO - PROCESS | 17156 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 148.0 149.0 148.0 148.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 04:19:04 INFO - PROCESS | 17156 | Values: 96.0 96.0 96.0 101.0 96.0 97.0 96.0 97.0 97.0 96.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#8] json-parse-financial Cycles:10 Average:70.90 Median:71.50 stddev:1.10 (1.5%) stddev-sans-first:1.17 04:19:04 INFO - PROCESS | 17156 | Values: 71.0 69.0 72.0 70.0 70.0 71.0 70.0 72.0 72.0 72.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.50 04:19:04 INFO - PROCESS | 17156 | Values: 70.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:3.67 (4.3%) stddev-sans-first:3.89 04:19:04 INFO - PROCESS | 17156 | Values: 86.0 84.0 95.0 85.0 89.0 82.0 84.0 84.0 85.0 85.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.00 stddev:5.90 (4.6%) stddev-sans-first:6.24 04:19:04 INFO - PROCESS | 17156 | Values: 127.0 124.0 139.0 122.0 122.0 128.0 128.0 126.0 128.0 138.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.50 stddev:6.66 (4.4%) stddev-sans-first:5.97 04:19:04 INFO - PROCESS | 17156 | Values: 138.0 144.0 155.0 154.0 150.0 142.0 158.0 148.0 151.0 141.0 04:19:04 INFO - PROCESS | 17156 | 04:19:04 INFO - PROCESS | 17156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.90 (2.6%) stddev-sans-first:1.76 04:19:04 INFO - PROCESS | 17156 | Values: 75.0 71.0 73.0 71.0 70.0 70.0 72.0 74.0 73.0 75.0 04:19:04 INFO - PROCESS | 17156 | -------- Summary: end -------- 04:19:04 INFO - PROCESS | 17156 | 04:19:05 INFO - TEST-INFO | 17156: exit 0 04:19:05 INFO - TEST-OK | kraken | took 61966ms 04:19:05 INFO - TEST-START | v8_7 04:19:05 INFO - operating with platform_type : linux_ 04:19:05 INFO - Initialising browser for v8_7 test... 04:19:05 INFO - TEST-INFO | started process 17441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5in6Hz/profile http://localhost:49842/getInfo.html) 04:19:08 INFO - PROCESS | 17441 | 04:19:08 INFO - PROCESS | 17441 | (process:17512): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:09 INFO - PROCESS | 17441 | __metrics Screen width/height:1600/1200 04:19:09 INFO - PROCESS | 17441 | colorDepth:24 04:19:09 INFO - PROCESS | 17441 | Browser inner width/height: 1024/697 04:19:09 INFO - PROCESS | 17441 | __metrics 04:19:09 INFO - PROCESS | 17441 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:19:10 INFO - TEST-INFO | 17441: exit 0 04:19:10 INFO - Browser initialized. 04:19:10 INFO - Running cycle 1/1 for v8_7 test... 04:19:10 INFO - TEST-INFO | started process 17561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5in6Hz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:11 INFO - PROCESS | 17561 | -- checkerboarding starts below -- 04:19:11 INFO - PROCESS | 17561 | RENDERTRACE 0.050476 rect red 0 0 10 10 // viewport 04:19:11 INFO - PROCESS | 17561 | RENDERTRACE 14.7145 rect brown 0 0 10 10 // page 04:19:11 INFO - PROCESS | 17561 | RENDERTRACE 14.7382 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:19:11 INFO - PROCESS | 17561 | Checkerboarded for 1 frames (14.7893 ms), 100 peak, 1 severity. 04:19:12 INFO - PROCESS | 17561 | 04:19:12 INFO - PROCESS | 17561 | (process:17617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:22 INFO - PROCESS | 17561 | RSS: Main: 149504000 04:19:22 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:49842/tests/v8_7/run.html (next: http://localhost:49842/tests/v8_7/run.html) 04:19:45 INFO - PROCESS | 17561 | RSS: Main: 145330176 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | __start_tp_report 04:19:45 INFO - PROCESS | 17561 | _x_x_mozilla_page_load 04:19:45 INFO - PROCESS | 17561 | _x_x_mozilla_page_load_details 04:19:45 INFO - PROCESS | 17561 | |i|pagename|runs| 04:19:45 INFO - PROCESS | 17561 | |0;Richards;166.36167027116952 04:19:45 INFO - PROCESS | 17561 | |1;DeltaBlue;187.16077110237694 04:19:45 INFO - PROCESS | 17561 | |2;Encrypt;277.31558513588465 04:19:45 INFO - PROCESS | 17561 | |3;Decrypt;5268.421052631579 04:19:45 INFO - PROCESS | 17561 | |4;RayTrace;1090.5125408942204 04:19:45 INFO - PROCESS | 17561 | |5;Earley;727.2727272727273 04:19:45 INFO - PROCESS | 17561 | |6;Boyer;12587.5 04:19:45 INFO - PROCESS | 17561 | |7;RegExp;42936.17021276596 04:19:45 INFO - PROCESS | 17561 | |8;Splay;606.060606060606 04:19:45 INFO - PROCESS | 17561 | |9;NavierStokes;4845.410628019324 04:19:45 INFO - PROCESS | 17561 | __end_tp_report 04:19:45 INFO - PROCESS | 17561 | __startTimestamp1453378785339__endTimestamp 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | ------- Summary: start ------- 04:19:45 INFO - PROCESS | 17561 | Number of tests: 10 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 166.4 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#1] DeltaBlue Cycles:1 Average:187.16 Median:187.16 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 187.2 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#2] Encrypt Cycles:1 Average:277.32 Median:277.32 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 277.3 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 5268.4 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#4] RayTrace Cycles:1 Average:1090.51 Median:1090.51 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 1090.5 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#5] Earley Cycles:1 Average:727.27 Median:727.27 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 727.3 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 12587.5 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#7] RegExp Cycles:1 Average:42936.17 Median:42936.17 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 42936.2 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#8] Splay Cycles:1 Average:606.06 Median:606.06 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 606.1 04:19:45 INFO - PROCESS | 17561 | 04:19:45 INFO - PROCESS | 17561 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:19:45 INFO - PROCESS | 17561 | Values: 4845.4 04:19:45 INFO - PROCESS | 17561 | -------- Summary: end -------- 04:19:45 INFO - PROCESS | 17561 | 04:19:46 INFO - TEST-INFO | 17561: exit 0 04:19:46 INFO - TEST-OK | v8_7 | took 41196ms 04:19:46 INFO - SUITE-END | took 1218s 04:19:46 INFO - Completed test suite (00:20:18) 04:19:46 INFO - Working with test: dromaeo_css 04:19:46 INFO - Generating results file: dromaeo_css 04:19:46 INFO - Working with test: kraken 04:19:46 INFO - Generating results file: kraken 04:19:46 INFO - javascript benchmark 04:19:46 INFO - Working with test: v8_7 04:19:46 INFO - Generating results file: v8_7 04:19:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 04:19:46 INFO - process_Request line: dromaeo_css 6055.31 graph.html#tests=[[72,132,43]] 04:19:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:46 INFO - process_Request line: kraken 1561.90 graph.html#tests=[[232,132,43]] 04:19:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:46 INFO - process_Request line: v8_7 20156.07 graph.html#tests=[[230,132,43]] 04:19:46 INFO - RETURN: dromaeo_css: 6055.31 04:19:46 INFO - RETURN: kraken: 1561.90 04:19:46 INFO - RETURN: v8_7: 20156.07 04:19:46 INFO - javascript benchmark 04:19:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.144922175682, 2599.8830052647627, 2641.0, 2648.4967856107337, 2658.109533306342, 4380.474343078827, 4519.118771839497, 4545.545445455453, 4597.5402459754005, 4616.769161541922, 4523.6607254455885, 4525.2533332000185, 4557.977210113945, 4650.72095674259, 4667.813287468505, 4192.706510544255, 4231.344141658048, 4295.012147206145, 4299.333603291495, 4305.182015417061, 4015.9743216511733, 4258.127083947798, 4266.935995960063, 4275.5510671379525, 4326.7187632803925, 4136.73111247768, 4219.07180420307, 4222.619964203236, 4260.424842646234, 4286.485621725397, 4192.371144328345, 4224.788760561991, 4229.619334259901, 4293.8711838644895, 4294.141171765628, 4223.535411104806, 4226.640735537483, 4235.618794308496, 4272.722273052242, 4282.657387409, 4355.80398882051, 4478.865634030984, 4485.192665320241, 4506.729596224237, 4552.863414097583, 4818.7831547580445, 4863.24619683946, 4898.681585696918, 4909.0181963607065, 4948.307236986825, 4865.537773911508, 4897.51024897511, 4906.31311616374, 4906.828261010847, 4942.085714142859, 4436.778161091933, 4512.390827238313, 4528.184926713223, 4537.455505339381, 4581.289900065495, 4985.351904252497, 5037.496250375007, 5049.899002020013, 5062.038212739568, 5098.617603679739, 4820.0, 4850.684705494132, 4856.757162141878, 4871.48849370811, 4884.535969082932, 4721.102990431807, 4799.592034677022, 4836.226203807444, 4933.802647894116, 5011.599072074226, 4791.976040119777, 4798.448178459522, 4799.544043315879, 4807.519248075165, 4851.0, 4777.689450185727, 4783.1390349737385, 4793.712377257376, 4819.204831202883, 4856.41722993236, 4018.778967156776, 4035.435039094529, 4050.088730035777, 4097.836086556505, 4108.67130629549, 3560.5203760818167, 3575.6424357564556, 3577.141486043331, 3584.623614520438, 3595.5865075516126, 4240.067185219247, 4243.27864263076, 4244.830206791756, 4247.660187185018, 4284.421603083544, 4726.574608285202, 4779.713217206979, 4797.328374027639, 4838.056578967067, 4901.950980490149, 4145.326025099647, 4182.163567286555, 4195.077083041726, 4202.285611446062, 4242.109157077049, 4206.978965105155, 4270.829166833354, 4286.721363111388, 4306.0526684129445, 4328.177646247203, 4578.336141259565, 4662.370579971728, 4693.155232058262, 4718.386609740712, 4744.312074749211, 4886.193778026586, 4886.29148773433, 4903.092927808367, 4926.901461970812, 4934.777934993006, 4530.139273538017, 4609.239475486641, 4650.348951146774, 4670.906581868276, 4711.363965864564, 4792.2332426811545, 4811.78346974394, 4818.518148185153, 4840.370751802243, 4864.051509955525, 4773.164696178085, 4793.592544633745, 4800.5199480051715, 4808.326834243138, 4814.277858321279, 4550.726956382628, 4622.05247924168, 4652.790624421977, 4690.437147542317, 4705.176594096088, 4592.9540704593865, 4714.740689262124, 4752.144613969381, 4776.140294746979, 4801.735904525284, 4648.349231107715, 4648.395708557866, 4651.162790697572, 4686.226772582486, 4691.132140554008, 4633.559811817872, 4742.312364707029, 4748.976255118702, 4784.473707892199, 4787.640926930564, 4617.653675974382, 4635.119327327797, 4716.410448693913, 4735.100330937111, 4749.7625118743235], "unit": "score", "name": "dojo.html", "value": 4475.267728595058}, {"lowerIsBetter": false, "replicates": [484.4622469059346, 499.85254349966766, 501.46092950078673, 517.4049842680917, 518.4245487508866, 32166.356672866557, 32888.0, 33020.33959320812, 33145.834270828644, 33219.83390083052, 36149.0, 36297.0, 36498.63501364986, 36718.816405918, 36796.632033679656, 7635.121960974489, 7827.843443131134, 7835.373170146403, 7845.882311765328, 7846.529208247495, 7375.668094935714, 7455.4781165318445, 7475.962620186919, 7495.425960548291, 7498.625068746568, 7594.468387212897, 7672.46292759507, 7709.498882572615, 7712.6914923403, 7714.652840622158, 7596.392288616925, 7609.315161635424, 7661.540307581563, 7674.2709442603145, 7676.923230767677, 7695.846083078363, 7823.100343460461, 7832.412569057286, 7836.529808211469, 7859.096203936563, 36045.63954360449, 36477.27045459076, 36505.45241821375, 36538.26923461516, 36564.451533227024, 2989.925251868699, 3534.169470174507, 3540.309639620275, 3573.6069032406413, 3620.583632882226, 26849.865750671317, 27807.304817379525, 28408.0, 29004.41991160165, 29107.70892291071, 3384.5430866832908, 3490.3019396120876, 3495.8077305748175, 3562.2341196642587, 3616.4575313702894, 221326.0, 221719.89140054357, 222438.0, 223239.0, 223595.0, 47463.0, 48315.51684483181, 54054.0, 55899.44100559023, 56868.43131568714, 49537.0, 49741.25388119181, 49767.50232497629, 49823.25265121026, 50192.247116293285, 13295.867041329657, 13444.798328025088, 13462.0, 13500.729985400238, 13572.524961626494, 9905.10854023127, 9966.053224943618, 9970.0, 10008.849867251996, 10100.797984040279, 18877.0, 19061.714074288895, 19184.90407547981, 19300.613987720168, 19302.517437063903, 7289.671964761598, 7433.293837085468, 7579.734709285149, 7600.0, 7613.695452181851, 827.5365795154732, 836.2599099796723, 836.8117173635883, 857.8370109679141, 920.7329874336367, 25883.223503294932, 25983.0, 26214.73785262123, 26289.342766430993, 26407.735922640913, 923.2844545477309, 943.3160958305311, 1037.657573000923, 1043.5251960358019, 1070.8768491623564, 13617.387217575233, 13830.170189788645, 13922.930385348009, 14054.929725351512, 14109.15345079278, 256983.0, 261413.0, 262851.0, 263498.0, 264023.0, 44512.10975780466, 45146.77426612846, 45271.54728452739, 45371.319430208576, 45627.315590266175, 1181.2440038375446, 1182.379250893288, 1182.9349385783864, 1196.730735584504, 1308.1562392256942, 24592.754072459047, 25043.499130016935, 25497.490050199263, 25569.48861022806, 25753.871230643726, 39839.80080099581, 39876.80061599673, 39956.80021599874, 39991.0, 40019.199616008096, 245672.0, 248048.0, 248336.5831708371, 248821.0, 249506.0, 28173.71826281711, 28716.856415717786, 28735.568966465937, 28778.0, 28977.85511072431, 32706.0, 32752.836235818668, 33405.0, 33646.327073457905, 33684.3263134731, 27921.0, 28123.859380702965, 28548.85725571359, 28660.85669571639, 28912.277193070342, 28608.42783144367, 30397.544036839907, 30632.693673062982, 31017.534736978512, 31237.219069523442, 28579.0, 28829.56755648709, 28891.42217155687, 29431.411371772017, 29432.26419339534, 26274.452948852424, 28333.858330708215, 29374.265643359086, 30403.84798076084, 32540.186495337806, 22448.66327005129, 22694.319170424915, 23378.766212338338, 23456.0, 24105.156319529433], "unit": "score", "name": "ext.html", "value": 16278.691501673202}, {"lowerIsBetter": false, "replicates": [329.9241174529858, 331.72632578123046, 335.5369589965847, 336.5607881714362, 338.74424809269, 13985.440582376705, 14512.12927224366, 14521.056131351455, 14942.178180200084, 15682.451114211004, 8663.393562450616, 8864.822703545926, 9529.666461673844, 14873.405063797461, 14879.40482380706, 4368.0, 4606.055758569485, 4610.054938737568, 4620.422447194101, 4876.463589005207, 4995.525425084611, 5016.573591244749, 5025.296458495814, 5035.320231768719, 5054.772535235905, 4082.6937979651498, 4101.282275601773, 4149.875503734893, 4913.3612630358, 5130.4356520782685, 4726.7400292983875, 4911.557959783619, 4912.5578697917, 4926.359573255471, 4946.282788995612, 4822.469528351879, 4826.4690884003085, 4831.492693267227, 4841.443234028096, 4843.854684359475, 12515.74968500634, 15856.286467109008, 17002.064886431242, 17082.14589270544, 17136.22886970089, 1642.983570164295, 1804.5067781224657, 1816.8546516278798, 1903.800100989404, 1918.6546421644098, 8192.959035204845, 8400.705975290897, 8504.48973061612, 8673.522956237404, 8788.8681669775, 1666.3501234518546, 1695.127009590062, 1743.4682421861328, 1763.8711224816127, 1769.0800783592588, 47122.5287747125, 49563.999999999636, 50419.98374899644, 50669.49330506685, 51074.0, 9025.81948361029, 9119.452832830051, 9185.173334399937, 9232.0, 9254.629814807467, 11303.434828258718, 11390.0, 11413.600523981788, 11459.369734664673, 11502.367369794742, 6311.684415779193, 6491.091247225392, 6497.090407342976, 6549.214094308713, 6552.967235163794, 6098.176746139215, 6128.724207410677, 6188.845278867974, 6202.658853763086, 6221.906671399933, 3843.1545060086737, 3897.649211570972, 3925.450436938831, 3952.1898010907694, 3953.0710283083454, 1558.4934896158568, 1627.9023258604523, 1639.6064944413492, 1659.1289572974044, 1663.2182874049176, 750.4296734481833, 808.4906508899473, 856.3534531428731, 862.3532350736947, 940.3699521320732, 14124.788128178085, 14754.336054877556, 15357.001794883297, 15891.26555259513, 16035.438759643357, 769.8075481129717, 812.3014207781304, 816.147126253067, 824.0523398092122, 838.8112674648278, 8137.389695772841, 8300.0, 8361.790955226046, 8383.28742056932, 8521.233089022018, 449565.0, 452155.0, 459081.7045914749, 460437.0, 462920.0, 62387.68806156031, 62778.37221627816, 63227.68386158132, 64823.35176648267, 65770.67114664396, 1055.9524821383209, 1061.3843970497094, 1066.9573217071386, 1082.5128692088592, 1086.5708045322053, 12737.235765854079, 12942.352882356034, 13180.143290686075, 13191.472341106248, 13393.330333483482, 27979.740911658617, 28650.42699146047, 30549.694503055573, 30700.385992279582, 31533.211669708442, 37454.62545374512, 37934.24131517409, 37950.72295662269, 38028.0, 38280.23439531138, 6073.605215660968, 6118.663473508822, 6145.170401995673, 6254.530910181846, 6460.289368169404, 7314.748629973588, 9609.807803844024, 9790.951045244728, 9795.80408391814, 9816.0, 8194.22154895284, 8404.537750423786, 8924.375293729376, 8927.107289271022, 9095.681651142178, 7899.723509677364, 8377.623006964579, 8579.313654907717, 8757.518336491554, 8768.517731524827, 8548.829023419372, 8647.618480413263, 8676.826463470568, 8772.868406974028, 8839.823203536022, 6452.096706461193, 6590.637514936533, 6654.667266636746, 6658.766943156967, 6784.253732089367, 8955.507447090473, 8996.290704766336, 9098.545072746203, 9127.726168214964, 9234.676786312446], "unit": "score", "name": "jquery.html", "value": 7191.014953436161}, {"lowerIsBetter": false, "replicates": [1327.4424741608525, 1336.1782503760187, 1413.314542446913, 1642.7617995390676, 1647.8269781672932, 5965.403459654032, 6097.481714054311, 6648.667566621668, 6880.4839637027235, 6890.069840571521, 6291.591046581969, 6455.225372955252, 6503.252126005511, 6506.837329066776, 6506.967465162679, 2007.387746737248, 2061.793820617941, 2063.9587208255825, 2065.070718176819, 2069.244725675125, 1984.5931584025313, 1987.8210961013506, 2002.9298974535893, 2017.959640807183, 2020.5251765835017, 1978.574606459611, 2008.5882394109246, 2014.6172227276843, 2020.7777144514166, 2025.0381068992185, 2051.1692764430354, 2056.629806634805, 2057.567910738747, 2059.268959519364, 2061.5464597788464, 1965.8230759231594, 1972.3491247888162, 1982.0288058851204, 1993.7707163676218, 1993.9202431902852, 6857.725690972356, 6865.107536020335, 6902.102726645554, 6957.9652101739675, 6978.127734033246, 4025.6175663311938, 4091.1408604193157, 4111.116110036327, 4130.153318569716, 4132.607402296777, 2629.184952664661, 2649.4038841260754, 2701.2976626077166, 2725.0870958229016, 2732.398872248122, 824.5918270456102, 828.362161135922, 858.7080392666523, 859.6647307550061, 1780.830821071996, 9166.908330916673, 9240.029796871298, 9248.815023699555, 9321.114494123047, 9337.253019758404, 3490.9650903491147, 3558.822058897045, 3562.608113107556, 3613.9277214456088, 3623.456481527739, 7648.273414025659, 7654.2345765424125, 7658.195889431529, 7659.540427574363, 7679.462437629312, 4020.0954785173685, 4045.5954404559307, 4054.3310353791294, 4056.472658554428, 4066.9389959150635, 3244.3997860395903, 3318.8672453101603, 3594.964050359463, 3747.868824591126, 3763.5671897732113, 3107.1144723753623, 3140.4190224808485, 3152.8423578820966, 3155.3216058547523, 3161.351922855809, 942.6512190489426, 971.0774763974111, 973.4451362723321, 973.6008236623093, 977.3061126600052, 886.3751055505853, 910.7449914024083, 1152.504423098059, 1165.953361865516, 1171.4494187731752, 6330.303666596671, 6352.7141278642575, 6357.809265722036, 6363.395477429637, 6396.936030639634, 965.1313817564248, 1019.2508506247901, 1027.409239687183, 1030.5826140413144, 1066.195022757813, 5047.596192304607, 5204.531592156724, 5205.2192171173865, 5205.583553315726, 5212.7914883405, 7567.697292108364, 7723.0, 7806.843863122705, 8092.3930705197345, 8257.174282571696, 7661.655225514865, 7670.041244844395, 7701.191374905667, 7730.188330225358, 7762.2237776223055, 6067.211262535842, 6173.536984726074, 6242.531810114259, 6277.089821975788, 6308.053791931247, 5959.463648271676, 6048.546359023179, 6068.666223357581, 6070.939290607037, 6091.847703807441, 7014.228434872262, 7180.748673796392, 7192.352688258082, 7296.7081316746735, 7336.0, 7019.789406317818, 7268.927310726825, 7319.194888562148, 7353.77938661841, 7477.214892436215, 5449.209864569536, 5598.0, 6018.247719035121, 6066.3023752269055, 6066.969665151646, 6303.716332764945, 6444.645544494911, 6482.708278127401, 6486.708098135501, 6494.188226471691, 5683.658980461186, 5788.479036886701, 5851.531877449709, 5907.261592300963, 5956.672383018976, 5799.362070172193, 5984.700764961647, 6022.277326720647, 6043.244594425697, 6113.5414843886, 5975.25309336333, 6022.45797878193, 6157.0, 6162.938370616416, 6180.47465965398, 5620.494155526022, 5636.0418728815375, 5653.773849045992, 5660.745266462936, 5668.178114173339, 5682.77268909239, 5729.169270455677, 5764.567657425794, 5802.564807639359, 5809.157672137432], "unit": "score", "name": "mootools.html", "value": 3906.147829908751}, {"lowerIsBetter": false, "replicates": [278.835487062633, 281.51860318854756, 284.91879814252934, 286.17153341077596, 299.0698926339086, 5514.117741161415, 5569.164625306201, 5571.860703482415, 5691.1747796569525, 5737.885242295151, 5540.141278101891, 5577.051901176799, 5578.3584887737925, 5610.410906854782, 5611.046122159232, 4208.5791420857895, 4212.662986961036, 4213.346931225665, 4213.894652633693, 4214.620684138427, 4223.387608796723, 4223.556526564713, 4223.767692776896, 4224.429701990238, 4230.492340919079, 4039.171969746195, 4138.0, 4175.6033176848305, 4177.791110444481, 4179.185058913513, 4167.5832416758385, 4195.62239398454, 4198.5591512891015, 4202.2646036943415, 4203.201391735576, 3616.077900135475, 3621.203335266237, 3622.4204127339763, 3623.800690961996, 3624.0939765058733, 5260.631755777097, 5260.92108618371, 5282.894342113174, 5291.656042357235, 5299.4700529946695, 4728.290756386536, 4793.3049707792525, 4812.831550895702, 4824.975875120602, 4830.106430310404, 5764.971175144097, 5776.422357764232, 5790.7973220937065, 5792.623479473863, 5798.217240672539, 3935.567087620388, 3936.409538569209, 3940.271049855786, 3943.1522222721965, 3949.0522274654163, 6117.816465505997, 6189.071639254103, 6194.039923811816, 6208.50331973441, 6221.0, 3952.288588054178, 4090.3864420337186, 4098.467199264077, 4106.2198182345255, 4120.814563344657, 4149.149424367997, 4163.875083747493, 4175.791210439465, 4177.164567086595, 4187.392828039978, 4831.903361932812, 4834.033193361342, 4834.975825120852, 4846.539578740014, 4848.127337079289, 5835.095560188178, 5874.441928016831, 5880.853233619403, 5882.117682347682, 5893.6463812171405, 1441.502681574855, 1447.037719916244, 1467.772495263236, 1471.4849802569015, 1471.8969672122848, 952.9047095290415, 954.5227386306847, 958.3100167879115, 966.4153187321709, 971.2278738402987, 5089.211172268304, 5103.132467480463, 5106.514881086291, 5120.385553733576, 5124.743762811844, 6055.091736239599, 6069.878602428015, 6079.118527813443, 6083.0, 6133.355997620186, 4895.412550493964, 5057.140286151363, 5076.390833100052, 5091.312672789126, 5111.463296353903, 3221.4684577044527, 3225.774195806271, 3268.313654132611, 3274.6889045540634, 3288.8355582220793, 5703.17303990919, 5748.971255143698, 5752.13717942312, 5755.280589926259, 5771.6537007778825, 6294.748210071546, 6296.968515157395, 6303.086052522451, 6311.621302721851, 6313.905291420632, 5592.217089607459, 5741.0, 5762.971185144132, 5818.854528636818, 5819.0689489681445, 6056.606320589324, 6130.356312587114, 6173.506119510518, 6186.041163619646, 6186.072089186658, 6005.759769609167, 6012.669303188367, 6026.0659597762415, 6038.879222415615, 6058.7273572688455, 5594.216809646734, 5788.942110579009, 5789.45000224978, 5790.160426738184, 5833.212516310414, 4164.43780089684, 4235.851745188904, 4238.131183107517, 4239.554846741171, 4252.936205956851, 6084.513238940785, 6088.178095956989, 6091.451769340781, 6103.267607887082, 6109.266887973472, 5750.821081678329, 5831.241938547962, 5928.822135335947, 5950.821475355746, 5956.463918247378, 5861.325947515919, 5862.94137058624, 5872.412758724094, 5889.087191485327, 5953.642781433128, 5745.97127014379, 5754.712264386848, 5755.3381361144, 5762.30852297727, 5776.220210271727, 5859.472647461749, 5896.3514013457625, 5900.911486327623, 5911.438413350725, 5922.348541660328, 5614.129809879475, 5724.084146536534, 5757.798477053283, 5768.451997060272, 5771.797987070432], "unit": "score", "name": "prototype.html", "value": 4349.123260501625}, {"lowerIsBetter": false, "replicates": [668.8796016716992, 719.9820004499887, 728.7595093619104, 761.8442980715816, 772.3589420780753, 11689.357085360301, 11694.941525292383, 11736.471858766354, 11752.823707644382, 11757.118216133782, 10949.890501094987, 12344.691382715437, 12580.0, 12595.118341716083, 12622.24266544008, 730.8794048981938, 738.7709809958903, 743.8177646476594, 744.8137965508623, 746.5184955703568, 745.589925540953, 746.4289818288986, 747.6710247491113, 749.3518106837573, 750.973715919943, 775.1357236681088, 775.4068137874531, 775.9030121234846, 779.2207792207793, 781.9061712594497, 761.0220866186978, 763.7250589787644, 765.5559775330295, 766.5553978692345, 774.3108633316353, 566.218618306734, 575.1315513574533, 576.2451188942499, 577.3995045153035, 577.7862190989318, 12446.937765311206, 12504.624861254086, 12521.74956500874, 12540.74918501634, 12564.874351256552, 11032.062274706659, 11117.555297788078, 11124.61063862761, 11310.095192384671, 11649.650510484698, 9239.0, 9280.211182049534, 9308.301877359225, 9387.62449502019, 9454.33819632626, 3135.6237251529733, 3214.276787722767, 3238.9028329150165, 3243.5621191139367, 3256.430124728187, 40668.79665601653, 40990.590094098974, 41113.588864111574, 41177.382339264936, 41445.37831932523, 8404.07555168931, 8758.693445729368, 8881.467111973303, 9358.438493690264, 9360.812783744286, 15669.138197399025, 15705.764413533807, 15719.764203536955, 15721.292541835644, 15759.13324767126, 6337.96831015842, 6487.318831522716, 6587.473002159816, 6671.266160722316, 6739.59562426256, 3549.982250088733, 3635.4365073413665, 3659.396199627032, 3769.4345848122452, 3775.7356985010783, 2658.933526661849, 2662.6937902141112, 2666.1335066103593, 2669.746374094458, 2689.367998520346, 478.77258302306825, 484.97575121243796, 486.50862628744517, 487.51735781576696, 505.3405306075533, 492.8669259299969, 532.4941305759544, 547.6385585513542, 566.9971650141723, 572.3532408378505, 6890.93109068913, 7155.248698886646, 7201.279872012757, 7266.346028857428, 7311.634418279171, 443.4146926057637, 469.4694994656085, 505.21439162102547, 532.7922110376957, 537.6263496869637, 3327.517509961042, 3366.208940898887, 3500.1424650960166, 3511.367953768346, 3565.7682250653625, 50088.24867626988, 50291.245631315556, 50407.747961259956, 50522.49477505252, 50573.0, 43988.78005609952, 44304.0, 44623.776881116035, 44646.55353446489, 44776.55223447724, 35428.82285588504, 35701.82149089238, 35703.10742231465, 35824.28351432957, 36704.26591468209, 7379.704811807467, 7402.777916662509, 7438.888416673646, 7489.176190619137, 7868.370530357673, 29368.0, 29789.10632681023, 30534.38931221319, 30589.847050764605, 30855.537166942064, 37384.0, 38694.0, 38711.806440967615, 38904.0, 39034.0, 9212.49331286759, 9375.437473751597, 9691.563879625575, 9892.505374731378, 10332.225083118647, 10722.839157412802, 10852.891471085188, 11001.339919604849, 11255.380954047607, 11302.717432064264, 9713.805723885342, 9816.067473589997, 9884.0, 9904.50477476109, 10378.584856605954, 9986.35088719231, 10027.949860250652, 10069.244806639677, 10496.265261431932, 10597.841032384675, 9853.211743060681, 9877.654282100091, 9882.901170988198, 9933.453660048766, 9982.550785214538, 8548.914510854811, 8677.479351238946, 8718.60766265507, 8728.781780455285, 8799.736007919773, 8101.9594902027475, 8341.290990265652, 8525.573721314033, 8749.912500875165, 8775.254103401026], "unit": "score", "name": "yui.html", "value": 5538.570197452826}], "name": "dromaeo_css", "value": 6055.313953570169}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 116.0, 115.0, 115.0, 127.0, 116.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [155.0, 133.0, 163.0, 173.0, 131.0, 163.0, 155.0, 147.0, 175.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 153.2}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 162.0, 162.0, 164.0, 164.0, 168.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 77.0, 148.0, 74.0, 74.0, 77.0, 75.0, 159.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 131.0, 99.0, 100.0, 97.0, 149.0, 98.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 111.0, 110.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 101.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 72.0, 70.0, 70.0, 71.0, 70.0, 72.0, 72.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 70.9}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 95.0, 85.0, 89.0, 82.0, 84.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 139.0, 122.0, 122.0, 128.0, 128.0, 126.0, 128.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [138.0, 144.0, 155.0, 154.0, 150.0, 142.0, 158.0, 148.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 73.0, 71.0, 70.0, 70.0, 72.0, 74.0, 73.0, 75.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1561.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.36167027116952], "unit": "score", "name": "Richards", "value": 212.20032200000009}, {"lowerIsBetter": false, "replicates": [187.16077110237694], "unit": "score", "name": "DeltaBlue", "value": 353.2684740000001}, {"lowerIsBetter": false, "replicates": [277.31558513588465], "unit": "score", "name": "Encrypt", "value": 959.8486860000002}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1090.5125408942204], "unit": "score", "name": "RayTrace", "value": 678.5699129999998}, {"lowerIsBetter": false, "replicates": [727.2727272727273], "unit": "score", "name": "Earley", "value": 916.3866250000003}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [42936.17021276596], "unit": "score", "name": "RegExp", "value": 21.21719276511396}, {"lowerIsBetter": false, "replicates": [606.060606060606], "unit": "score", "name": "Splay", "value": 134.46015000000003}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20156.073759828872}]} 04:19:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20156.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1561.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6055.31"}}} 04:19:46 INFO - Return code: 0 04:19:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:19:46 INFO - # TBPL SUCCESS # 04:19:46 INFO - Running post-action listener: _resource_record_post_action 04:19:46 INFO - Running post-run listener: _resource_record_post_run 04:19:47 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 373907456; Read time: 0; Write time: 333212 04:19:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 69844992; Read time: 0; Write time: 54756 04:19:47 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 304062464; Read time: 0; Write time: 278456 04:19:47 INFO - Running post-run listener: _upload_blobber_files 04:19:47 INFO - Blob upload gear active. 04:19:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:47 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 04:19:47 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'] 04:19:47 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 04:19:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:49 INFO - (blobuploader) - INFO - Done attempting. 04:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:49 INFO - (blobuploader) - INFO - Done attempting. 04:19:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:49 INFO - Return code: 0 04:19:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f922c285c2679b543e181edb73fa096e624414103f900c24f781c0366022e56ac7eb45dd89529bfd5ec68d26a1e094d04af1eeb0a62c47b4b3c781e531e35b09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8f1efaea8d9b6c98e3b4729429cfbc08b13f9e9541906b4bdc0b418d96a136cc79bef820d6af8d1693ba8b56752f3d7c9dfb3cd874f80e19afc3d1a7285bcfb"} 04:19:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:49 INFO - Contents: 04:19:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f922c285c2679b543e181edb73fa096e624414103f900c24f781c0366022e56ac7eb45dd89529bfd5ec68d26a1e094d04af1eeb0a62c47b4b3c781e531e35b09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8f1efaea8d9b6c98e3b4729429cfbc08b13f9e9541906b4bdc0b418d96a136cc79bef820d6af8d1693ba8b56752f3d7c9dfb3cd874f80e19afc3d1a7285bcfb"} 04:19:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:49 INFO - Copying logs to upload dir... 04:19:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1352.458951 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 32 secs) (at 2016-01-21 04:19:49.327423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 04:19:49.331007) ========= 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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 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/f922c285c2679b543e181edb73fa096e624414103f900c24f781c0366022e56ac7eb45dd89529bfd5ec68d26a1e094d04af1eeb0a62c47b4b3c781e531e35b09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8f1efaea8d9b6c98e3b4729429cfbc08b13f9e9541906b4bdc0b418d96a136cc79bef820d6af8d1693ba8b56752f3d7c9dfb3cd874f80e19afc3d1a7285bcfb"} build_url:https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/QiK3ONsNQxWPBI2zd1K35A/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/f922c285c2679b543e181edb73fa096e624414103f900c24f781c0366022e56ac7eb45dd89529bfd5ec68d26a1e094d04af1eeb0a62c47b4b3c781e531e35b09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8f1efaea8d9b6c98e3b4729429cfbc08b13f9e9541906b4bdc0b418d96a136cc79bef820d6af8d1693ba8b56752f3d7c9dfb3cd874f80e19afc3d1a7285bcfb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 04:19:49.359333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 04:19:49.359929) ========= 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=f919189b672bc2eeae365d21000001d6-1453368999.970498-1028611139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 04:19:49.445476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 04:19:49.446254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 04:19:49.446649) ========= ========= Total master_lag: 0.32 =========