builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1449263058.44 results: success (0) buildid: 20151202073358 builduid: b70adde180df4deb9484abd536016bdc revision: 87204339949047f3c630cb57f37fb6e818d41f5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.444749) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.445303) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.445757) ========= 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=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005075 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.471833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.472569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.487340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.487959) ========= 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=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.538726) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.539079) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.539538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.539855) ========= 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=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 13:04:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-12-04 13:04:18 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.717999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.718371) ========= 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=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016219 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.768746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:18.769145) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 87204339949047f3c630cb57f37fb6e818d41f5f --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 87204339949047f3c630cb57f37fb6e818d41f5f --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=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 13:04:19,024 truncating revision to first 12 chars 2015-12-04 13:04:19,024 Setting DEBUG logging. 2015-12-04 13:04:19,024 attempt 1/10 2015-12-04 13:04:19,024 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/872043399490?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 13:04:19,566 unpacking tar archive at: fx-team-872043399490/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:19.613932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:19.614299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:19.624317) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:19.624626) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:04:19.625086) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-04 13:04:19.625411) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:04:19 INFO - MultiFileLogger online at 20151204 13:04:19 in /builds/slave/test 13:04:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:04:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:04:19 INFO - {'append_to_log': False, 13:04:19 INFO - 'base_work_dir': '/builds/slave/test', 13:04:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:04:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:04:19 INFO - 'branch': 'Fx-Team-Non-PGO', 13:04:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:04:19 INFO - 'config_files': ('talos/linux_config.py',), 13:04:19 INFO - 'default_actions': ('clobber', 13:04:19 INFO - 'read-buildbot-config', 13:04:19 INFO - 'download-and-extract', 13:04:19 INFO - 'populate-webroot', 13:04:19 INFO - 'create-virtualenv', 13:04:19 INFO - 'install', 13:04:19 INFO - 'run-tests'), 13:04:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:04:19 INFO - 'download_minidump_stackwalk': True, 13:04:19 INFO - 'download_symbols': 'ondemand', 13:04:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:04:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:04:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:04:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:04:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:04:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:04:19 INFO - 'installer_path': 'installer.exe', 13:04:19 INFO - 'log_level': 'info', 13:04:19 INFO - 'log_name': 'talos', 13:04:19 INFO - 'log_to_console': True, 13:04:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:04:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:04:19 INFO - 'opt_config_files': (), 13:04:19 INFO - 'pip_index': False, 13:04:19 INFO - 'sps_profile': False, 13:04:19 INFO - 'sps_profile_interval': 0, 13:04:19 INFO - 'suite': 'dromaeojs-e10s', 13:04:19 INFO - 'system_bits': '64', 13:04:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:04:19 INFO - 'title': 'talos-linux64-ix-026', 13:04:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:04:19 INFO - 'use_talos_json': True, 13:04:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:04:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:04:19 INFO - 'work_dir': 'build'} 13:04:19 INFO - ##### 13:04:19 INFO - ##### Running clobber step. 13:04:19 INFO - ##### 13:04:19 INFO - Running pre-action listener: _resource_record_pre_action 13:04:19 INFO - Running main action method: clobber 13:04:19 INFO - rmtree: /builds/slave/test/build 13:04:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:04:20 INFO - Running post-action listener: _resource_record_post_action 13:04:20 INFO - ##### 13:04:20 INFO - ##### Running read-buildbot-config step. 13:04:20 INFO - ##### 13:04:20 INFO - Running pre-action listener: _resource_record_pre_action 13:04:20 INFO - Running main action method: read_buildbot_config 13:04:20 INFO - Using buildbot properties: 13:04:20 INFO - { 13:04:20 INFO - "properties": { 13:04:20 INFO - "buildnumber": 550, 13:04:20 INFO - "product": "firefox", 13:04:20 INFO - "script_repo_revision": "production", 13:04:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:04:20 INFO - "repository": "", 13:04:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:04:20 INFO - "buildid": "20151202073358", 13:04:20 INFO - "slavename": "talos-linux64-ix-026", 13:04:20 INFO - "pgo_build": "False", 13:04:20 INFO - "basedir": "/builds/slave/test", 13:04:20 INFO - "project": "", 13:04:20 INFO - "platform": "ubuntu64_hw", 13:04:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:04:20 INFO - "slavebuilddir": "test", 13:04:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:04:20 INFO - "branch": "fx-team", 13:04:20 INFO - "repo_path": "integration/fx-team", 13:04:20 INFO - "stage_platform": "linux64", 13:04:20 INFO - "builduid": "b70adde180df4deb9484abd536016bdc", 13:04:20 INFO - "revision": "87204339949047f3c630cb57f37fb6e818d41f5f" 13:04:20 INFO - }, 13:04:20 INFO - "sourcestamp": { 13:04:20 INFO - "repository": "", 13:04:20 INFO - "hasPatch": false, 13:04:20 INFO - "project": "", 13:04:20 INFO - "branch": "fx-team-linux64-talos", 13:04:20 INFO - "changes": [ 13:04:20 INFO - { 13:04:20 INFO - "category": null, 13:04:20 INFO - "files": [ 13:04:20 INFO - { 13:04:20 INFO - "url": null, 13:04:20 INFO - "name": "https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:04:20 INFO - } 13:04:20 INFO - ], 13:04:20 INFO - "repository": "", 13:04:20 INFO - "rev": "87204339949047f3c630cb57f37fb6e818d41f5f", 13:04:20 INFO - "who": "ttromey@mozilla.com", 13:04:20 INFO - "when": 1449072987, 13:04:20 INFO - "number": 6733342, 13:04:20 INFO - "comments": "Bug 1225192 - remove leading whitespace before prettifying css; r=pbrosset\n", 13:04:20 INFO - "project": "", 13:04:20 INFO - "at": "Wed 02 Dec 2015 08:16:27", 13:04:20 INFO - "branch": "fx-team-linux64-talos", 13:04:20 INFO - "revlink": "", 13:04:20 INFO - "properties": [ 13:04:20 INFO - [ 13:04:20 INFO - "buildid", 13:04:20 INFO - "20151202073358", 13:04:20 INFO - "Change" 13:04:20 INFO - ], 13:04:20 INFO - [ 13:04:20 INFO - "builduid", 13:04:20 INFO - "b70adde180df4deb9484abd536016bdc", 13:04:20 INFO - "Change" 13:04:20 INFO - ], 13:04:20 INFO - [ 13:04:20 INFO - "pgo_build", 13:04:20 INFO - "False", 13:04:20 INFO - "Change" 13:04:20 INFO - ] 13:04:20 INFO - ], 13:04:20 INFO - "revision": "87204339949047f3c630cb57f37fb6e818d41f5f" 13:04:20 INFO - } 13:04:20 INFO - ], 13:04:20 INFO - "revision": "87204339949047f3c630cb57f37fb6e818d41f5f" 13:04:20 INFO - } 13:04:20 INFO - } 13:04:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:04:20 INFO - Running post-action listener: _resource_record_post_action 13:04:20 INFO - ##### 13:04:20 INFO - ##### Running download-and-extract step. 13:04:20 INFO - ##### 13:04:20 INFO - Running pre-action listener: _resource_record_pre_action 13:04:20 INFO - Running main action method: download_and_extract 13:04:20 INFO - mkdir: /builds/slave/test/build/tests 13:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:20 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json 13:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json 13:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:04:21 INFO - Downloaded 1302 bytes. 13:04:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:04:21 INFO - Using the following test package requirements: 13:04:21 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:04:21 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:04:21 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:21 INFO - u'jsshell-linux-x86_64.zip'], 13:04:21 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:04:21 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:04:21 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:04:21 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:04:21 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:04:21 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:04:21 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:04:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:04:21 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:04:21 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')]} 13:04:21 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:04:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:04:22 INFO - Downloaded 21774886 bytes. 13:04:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:04:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:04:23 INFO - Return code: 0 13:04:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:23 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:04:24 INFO - Downloaded 21774886 bytes. 13:04:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:04:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:04:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:04:25 INFO - Return code: 0 13:04:25 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')]} 13:04:25 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:04:26 INFO - Downloaded 11132001 bytes. 13:04:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:04:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:04:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:04:26 INFO - Return code: 0 13:04: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')]} 13:04:26 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:04:27 INFO - Downloaded 57675849 bytes. 13:04:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:04:27 INFO - mkdir: /builds/slave/test/properties 13:04:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:04:27 INFO - Writing to file /builds/slave/test/properties/build_url 13:04:27 INFO - Contents: 13:04:27 INFO - build_url:https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:04:27 INFO - Running post-action listener: _resource_record_post_action 13:04:27 INFO - Running post-action listener: set_extra_try_arguments 13:04:27 INFO - ##### 13:04:27 INFO - ##### Running populate-webroot step. 13:04:27 INFO - ##### 13:04:27 INFO - Running pre-action listener: _resource_record_pre_action 13:04:27 INFO - Running main action method: populate_webroot 13:04:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:04:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:04:27 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:04:27 INFO - '../fennec_ids.txt'], 13:04:27 INFO - 'tests': ['tcheck2']}, 13:04:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:04:27 INFO - '--tppagecycles', 13:04:27 INFO - '7'], 13:04:27 INFO - 'tests': ['tsvgm']}}, 13:04:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:04:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:04:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:04:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:04:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'tests': ['damp', 'tps']}, 13:04:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['damp', 'tps']}, 13:04:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:04:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:04:27 INFO - 'other': {'tests': ['a11yr', 13:04:27 INFO - 'ts_paint', 13:04:27 INFO - 'tpaint', 13:04:27 INFO - 'sessionrestore', 13:04:27 INFO - 'sessionrestore_no_auto_restore']}, 13:04:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['a11yr', 13:04:27 INFO - 'ts_paint', 13:04:27 INFO - 'tpaint', 13:04:27 INFO - 'sessionrestore', 13:04:27 INFO - 'sessionrestore_no_auto_restore']}, 13:04:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['a11yr', 13:04:27 INFO - 'ts_paint', 13:04:27 INFO - 'tpaint', 13:04:27 INFO - 'sessionrestore', 13:04:27 INFO - 'sessionrestore_no_auto_restore']}, 13:04:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['a11yr', 13:04:27 INFO - 'ts_paint', 13:04:27 INFO - 'tpaint', 13:04:27 INFO - 'sessionrestore', 13:04:27 INFO - 'sessionrestore_no_auto_restore']}, 13:04:27 INFO - 'other_l64': {'tests': ['a11yr', 13:04:27 INFO - 'ts_paint', 13:04:27 INFO - 'tpaint', 13:04:27 INFO - 'sessionrestore', 13:04:27 INFO - 'sessionrestore_no_auto_restore']}, 13:04:27 INFO - 'other_nol64': {'tests': ['a11yr', 13:04:27 INFO - 'ts_paint', 13:04:27 INFO - 'tpaint', 13:04:27 INFO - 'sessionrestore', 13:04:27 INFO - 'sessionrestore_no_auto_restore']}, 13:04:27 INFO - 'svgr': {'tests': ['tsvgx', 13:04:27 INFO - 'tsvgr_opacity', 13:04:27 INFO - 'tart', 13:04:27 INFO - 'tscrollx', 13:04:27 INFO - 'cart']}, 13:04:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['tsvgx', 13:04:27 INFO - 'tsvgr_opacity', 13:04:27 INFO - 'tart', 13:04:27 INFO - 'tscrollx', 13:04:27 INFO - 'cart']}, 13:04:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'tests': ['tp5o']}, 13:04:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'talos_options': ['--e10s'], 13:04:27 INFO - 'tests': ['tp5o']}, 13:04:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'talos_options': ['--xperf_path', 13:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:27 INFO - 'tests': ['tp5n']}, 13:04:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:27 INFO - 'talos_options': ['--e10s', 13:04:27 INFO - '--xperf_path', 13:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:27 INFO - 'tests': ['tp5n']}}, 13:04:27 INFO - 'talos.zip': {'path': '', 13:04:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:04:27 INFO - Running post-action listener: _resource_record_post_action 13:04:27 INFO - ##### 13:04:27 INFO - ##### Running create-virtualenv step. 13:04:27 INFO - ##### 13:04:27 INFO - Running pre-action listener: _resource_record_pre_action 13:04:27 INFO - Running main action method: create_virtualenv 13:04:27 INFO - Creating virtualenv /builds/slave/test/build/venv 13:04:27 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 13:04:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:04:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:04:28 INFO - Using real prefix '/usr' 13:04:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:04:28 INFO - Installing distribute.............................................................................................................................................................................................done. 13:04:30 INFO - Installing pip.................done. 13:04:30 INFO - Return code: 0 13:04:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:04:30 INFO - Using env: {'DISPLAY': ':0', 13:04:30 INFO - 'HOME': '/home/cltbld', 13:04:30 INFO - 'LANG': 'en_US.UTF-8', 13:04:30 INFO - 'LANGUAGE': 'en_US:en', 13:04:30 INFO - 'LOGNAME': 'cltbld', 13:04:30 INFO - 'MAIL': '/var/mail/cltbld', 13:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:30 INFO - 'MOZ_NO_REMOTE': '1', 13:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:30 INFO - 'NO_EM_RESTART': '1', 13:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:30 INFO - 'PWD': '/builds/slave/test', 13:04:30 INFO - 'SHELL': '/bin/bash', 13:04:30 INFO - 'SHLVL': '1', 13:04:30 INFO - 'TERM': 'linux', 13:04:30 INFO - 'TMOUT': '86400', 13:04:30 INFO - 'USER': 'cltbld', 13:04:30 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:30 INFO - '_': '/tools/buildbot/bin/python'} 13:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:30 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 13:04:30 INFO - Cleaning up... 13:04:30 INFO - Return code: 0 13:04:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:04:30 INFO - Using env: {'DISPLAY': ':0', 13:04:30 INFO - 'HOME': '/home/cltbld', 13:04:30 INFO - 'LANG': 'en_US.UTF-8', 13:04:30 INFO - 'LANGUAGE': 'en_US:en', 13:04:30 INFO - 'LOGNAME': 'cltbld', 13:04:30 INFO - 'MAIL': '/var/mail/cltbld', 13:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:30 INFO - 'MOZ_NO_REMOTE': '1', 13:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:30 INFO - 'NO_EM_RESTART': '1', 13:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:30 INFO - 'PWD': '/builds/slave/test', 13:04:30 INFO - 'SHELL': '/bin/bash', 13:04:30 INFO - 'SHLVL': '1', 13:04:30 INFO - 'TERM': 'linux', 13:04:30 INFO - 'TMOUT': '86400', 13:04:30 INFO - 'USER': 'cltbld', 13:04:30 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:30 INFO - '_': '/tools/buildbot/bin/python'} 13:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:31 INFO - Downloading/unpacking psutil>=0.7.1 13:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:04:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:32 INFO - Installing collected packages: psutil 13:04:32 INFO - Running setup.py install for psutil 13:04:32 INFO - building 'psutil._psutil_linux' extension 13:04:32 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 13:04:33 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 13:04:33 INFO - building 'psutil._psutil_posix' extension 13:04:33 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 13:04:33 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 13:04:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:33 INFO - Successfully installed psutil 13:04:33 INFO - Cleaning up... 13:04:33 INFO - Return code: 0 13:04:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:04:33 INFO - Using env: {'DISPLAY': ':0', 13:04:33 INFO - 'HOME': '/home/cltbld', 13:04:33 INFO - 'LANG': 'en_US.UTF-8', 13:04:33 INFO - 'LANGUAGE': 'en_US:en', 13:04:33 INFO - 'LOGNAME': 'cltbld', 13:04:33 INFO - 'MAIL': '/var/mail/cltbld', 13:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:33 INFO - 'MOZ_NO_REMOTE': '1', 13:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:33 INFO - 'NO_EM_RESTART': '1', 13:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:33 INFO - 'PWD': '/builds/slave/test', 13:04:33 INFO - 'SHELL': '/bin/bash', 13:04:33 INFO - 'SHLVL': '1', 13:04:33 INFO - 'TERM': 'linux', 13:04:33 INFO - 'TMOUT': '86400', 13:04:33 INFO - 'USER': 'cltbld', 13:04:33 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:33 INFO - '_': '/tools/buildbot/bin/python'} 13:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:04:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:04:35 INFO - Installing collected packages: mozsystemmonitor 13:04:35 INFO - Running setup.py install for mozsystemmonitor 13:04:35 INFO - Successfully installed mozsystemmonitor 13:04:35 INFO - Cleaning up... 13:04:35 INFO - Return code: 0 13:04:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:04:35 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')]} 13:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:35 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')]} 13:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:04:35 INFO - Using env: {'DISPLAY': ':0', 13:04:35 INFO - 'HOME': '/home/cltbld', 13:04:35 INFO - 'LANG': 'en_US.UTF-8', 13:04:35 INFO - 'LANGUAGE': 'en_US:en', 13:04:35 INFO - 'LOGNAME': 'cltbld', 13:04:35 INFO - 'MAIL': '/var/mail/cltbld', 13:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:35 INFO - 'MOZ_NO_REMOTE': '1', 13:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:35 INFO - 'NO_EM_RESTART': '1', 13:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:35 INFO - 'PWD': '/builds/slave/test', 13:04:35 INFO - 'SHELL': '/bin/bash', 13:04:35 INFO - 'SHLVL': '1', 13:04:35 INFO - 'TERM': 'linux', 13:04:35 INFO - 'TMOUT': '86400', 13:04:35 INFO - 'USER': 'cltbld', 13:04:35 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:35 INFO - '_': '/tools/buildbot/bin/python'} 13:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:35 INFO - Downloading/unpacking blobuploader==1.2.4 13:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:37 INFO - Downloading blobuploader-1.2.4.tar.gz 13:04:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:04:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:04:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 INFO - Downloading docopt-0.6.1.tar.gz 13:04:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:04:38 INFO - Installing collected packages: blobuploader, requests, docopt 13:04:38 INFO - Running setup.py install for blobuploader 13:04:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:04:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:04:38 INFO - Running setup.py install for requests 13:04:38 INFO - Running setup.py install for docopt 13:04:38 INFO - Successfully installed blobuploader requests docopt 13:04:38 INFO - Cleaning up... 13:04:38 INFO - Return code: 0 13:04:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:04:38 INFO - Using env: {'DISPLAY': ':0', 13:04:38 INFO - 'HOME': '/home/cltbld', 13:04:38 INFO - 'LANG': 'en_US.UTF-8', 13:04:38 INFO - 'LANGUAGE': 'en_US:en', 13:04:38 INFO - 'LOGNAME': 'cltbld', 13:04:38 INFO - 'MAIL': '/var/mail/cltbld', 13:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:38 INFO - 'MOZ_NO_REMOTE': '1', 13:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:38 INFO - 'NO_EM_RESTART': '1', 13:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:38 INFO - 'PWD': '/builds/slave/test', 13:04:38 INFO - 'SHELL': '/bin/bash', 13:04:38 INFO - 'SHLVL': '1', 13:04:38 INFO - 'TERM': 'linux', 13:04:38 INFO - 'TMOUT': '86400', 13:04:38 INFO - 'USER': 'cltbld', 13:04:38 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:38 INFO - '_': '/tools/buildbot/bin/python'} 13:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:38 INFO - Running setup.py (path:/tmp/pip-34iBoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:38 INFO - Running setup.py (path:/tmp/pip-YG3jEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:38 INFO - Running setup.py (path:/tmp/pip-xJJqMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:39 INFO - Running setup.py (path:/tmp/pip-khAloJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:39 INFO - Running setup.py (path:/tmp/pip-6fAxOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:04:39 INFO - Running setup.py (path:/tmp/pip-Qa9ibS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:04:39 INFO - Running setup.py (path:/tmp/pip-BlvD3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:04:39 INFO - Running setup.py (path:/tmp/pip-SKZMKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:04:39 INFO - Running setup.py (path:/tmp/pip-ZO7v2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:04:39 INFO - Running setup.py (path:/tmp/pip-jOj5tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:04:39 INFO - Running setup.py (path:/tmp/pip-ttjSHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:04:39 INFO - Running setup.py (path:/tmp/pip-l7Jsai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:04:39 INFO - Running setup.py (path:/tmp/pip-Ol0wuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:04:39 INFO - Running setup.py (path:/tmp/pip-LoR45n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:39 INFO - Running setup.py (path:/tmp/pip-RMrW7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:04:39 INFO - Running setup.py (path:/tmp/pip-1GyJ2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:04:39 INFO - Running setup.py (path:/tmp/pip-8ZNaq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:04:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:04:40 INFO - Running setup.py install for manifestparser 13:04:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozcrash 13:04:40 INFO - Running setup.py install for mozdebug 13:04:40 INFO - Running setup.py install for mozdevice 13:04:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozfile 13:04:40 INFO - Running setup.py install for mozhttpd 13:04:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozinfo 13:04:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozInstall 13:04:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:04:40 INFO - Running setup.py install for mozleak 13:04:40 INFO - Running setup.py install for mozlog 13:04:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for moznetwork 13:04:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for mozprocess 13:04:41 INFO - Running setup.py install for mozprofile 13:04:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for mozrunner 13:04:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Running setup.py install for mozscreenshot 13:04:41 INFO - Running setup.py install for moztest 13:04:41 INFO - Running setup.py install for mozversion 13:04:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:04:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:04:41 INFO - Cleaning up... 13:04:41 INFO - Return code: 0 13:04:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:04:41 INFO - Using env: {'DISPLAY': ':0', 13:04:41 INFO - 'HOME': '/home/cltbld', 13:04:41 INFO - 'LANG': 'en_US.UTF-8', 13:04:41 INFO - 'LANGUAGE': 'en_US:en', 13:04:41 INFO - 'LOGNAME': 'cltbld', 13:04:41 INFO - 'MAIL': '/var/mail/cltbld', 13:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:41 INFO - 'MOZ_NO_REMOTE': '1', 13:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:41 INFO - 'NO_EM_RESTART': '1', 13:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:41 INFO - 'PWD': '/builds/slave/test', 13:04:41 INFO - 'SHELL': '/bin/bash', 13:04:41 INFO - 'SHLVL': '1', 13:04:41 INFO - 'TERM': 'linux', 13:04:41 INFO - 'TMOUT': '86400', 13:04:41 INFO - 'USER': 'cltbld', 13:04:41 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:41 INFO - '_': '/tools/buildbot/bin/python'} 13:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:42 INFO - Running setup.py (path:/tmp/pip-FlgsbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:42 INFO - Running setup.py (path:/tmp/pip-khVFWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:42 INFO - Running setup.py (path:/tmp/pip-aKpb1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:42 INFO - Running setup.py (path:/tmp/pip-udA2zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:42 INFO - Running setup.py (path:/tmp/pip-WlthuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:04:42 INFO - Running setup.py (path:/tmp/pip-jDVAzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:04:42 INFO - Running setup.py (path:/tmp/pip-UI4aow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:04:42 INFO - Running setup.py (path:/tmp/pip-WwFPBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:04:42 INFO - Running setup.py (path:/tmp/pip-WSpae0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:04:42 INFO - Running setup.py (path:/tmp/pip-AYnup5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:04:42 INFO - Running setup.py (path:/tmp/pip-oKBmGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:04:42 INFO - Running setup.py (path:/tmp/pip-FyUqiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:04:42 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)) 13:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:04:42 INFO - Running setup.py (path:/tmp/pip-ScaOCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:04:43 INFO - Running setup.py (path:/tmp/pip-uB9Yg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:04:43 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)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:43 INFO - Running setup.py (path:/tmp/pip-hqv3xM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:43 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)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:04:43 INFO - Running setup.py (path:/tmp/pip-F0mlwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:04:43 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)) 13:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:04:43 INFO - Running setup.py (path:/tmp/pip-CqcVyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:04:43 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)) 13:04:43 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)) 13:04:43 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)) 13:04:43 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)) 13:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:04:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:04:43 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 13:04:43 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 13:04:43 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 13:04:43 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 13:04:43 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 13:04:43 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 13:04:44 INFO - Downloading blessings-1.5.1.tar.gz 13:04:44 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:04:45 INFO - Installing collected packages: blessings 13:04:45 INFO - Running setup.py install for blessings 13:04:45 INFO - Successfully installed blessings 13:04:45 INFO - Cleaning up... 13:04:45 INFO - Return code: 0 13:04:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:04:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:45 INFO - Reading from file tmpfile_stdout 13:04:45 INFO - Current package versions: 13:04:45 INFO - argparse == 1.2.1 13:04:45 INFO - blessings == 1.5.1 13:04:45 INFO - blobuploader == 1.2.4 13:04:45 INFO - docopt == 0.6.1 13:04:45 INFO - manifestparser == 1.1 13:04:45 INFO - mozInstall == 1.12 13:04:45 INFO - mozcrash == 0.16 13:04:45 INFO - mozdebug == 0.1 13:04:45 INFO - mozdevice == 0.47 13:04:45 INFO - mozfile == 1.2 13:04:45 INFO - mozhttpd == 0.7 13:04:45 INFO - mozinfo == 0.9 13:04:45 INFO - mozleak == 0.1 13:04:45 INFO - mozlog == 3.1 13:04:45 INFO - moznetwork == 0.27 13:04:45 INFO - mozprocess == 0.22 13:04:45 INFO - mozprofile == 0.27 13:04:45 INFO - mozrunner == 6.11 13:04:45 INFO - mozscreenshot == 0.1 13:04:45 INFO - mozsystemmonitor == 0.0 13:04:45 INFO - moztest == 0.7 13:04:45 INFO - mozversion == 1.4 13:04:45 INFO - psutil == 3.1.1 13:04:45 INFO - requests == 1.2.3 13:04:45 INFO - wsgiref == 0.1.2 13:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:45 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')]} 13:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:45 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')]} 13:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:04:45 INFO - Using env: {'DISPLAY': ':0', 13:04:45 INFO - 'HOME': '/home/cltbld', 13:04:45 INFO - 'LANG': 'en_US.UTF-8', 13:04:45 INFO - 'LANGUAGE': 'en_US:en', 13:04:45 INFO - 'LOGNAME': 'cltbld', 13:04:45 INFO - 'MAIL': '/var/mail/cltbld', 13:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:45 INFO - 'MOZ_NO_REMOTE': '1', 13:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:45 INFO - 'NO_EM_RESTART': '1', 13:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:45 INFO - 'PWD': '/builds/slave/test', 13:04:45 INFO - 'SHELL': '/bin/bash', 13:04:45 INFO - 'SHLVL': '1', 13:04:45 INFO - 'TERM': 'linux', 13:04:45 INFO - 'TMOUT': '86400', 13:04:45 INFO - 'USER': 'cltbld', 13:04:45 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:45 INFO - '_': '/tools/buildbot/bin/python'} 13:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:04:45 INFO - Cleaning up... 13:04:45 INFO - Return code: 0 13:04:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:04:45 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')]} 13:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:45 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')]} 13:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:04:45 INFO - Using env: {'DISPLAY': ':0', 13:04:45 INFO - 'HOME': '/home/cltbld', 13:04:45 INFO - 'LANG': 'en_US.UTF-8', 13:04:45 INFO - 'LANGUAGE': 'en_US:en', 13:04:45 INFO - 'LOGNAME': 'cltbld', 13:04:45 INFO - 'MAIL': '/var/mail/cltbld', 13:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:45 INFO - 'MOZ_NO_REMOTE': '1', 13:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:45 INFO - 'NO_EM_RESTART': '1', 13:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:45 INFO - 'PWD': '/builds/slave/test', 13:04:45 INFO - 'SHELL': '/bin/bash', 13:04:45 INFO - 'SHLVL': '1', 13:04:45 INFO - 'TERM': 'linux', 13:04:45 INFO - 'TMOUT': '86400', 13:04:45 INFO - 'USER': 'cltbld', 13:04:45 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:45 INFO - '_': '/tools/buildbot/bin/python'} 13:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:45 INFO - Downloading/unpacking jsonschema 13:04:45 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 13:04:45 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 13:04:45 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 13:04:45 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 13:04:45 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 13:04:45 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 13:04:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:04:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:04:47 INFO - Downloading/unpacking functools32 (from jsonschema) 13:04:47 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 13:04:47 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 13:04:47 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 13:04:47 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 13:04:47 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 13:04:47 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 13:04:47 INFO - Downloading functools32-3.2.3-2.tar.gz 13:04:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:04:47 INFO - warning: no files found matching '*.txt' 13:04:47 INFO - no previously-included directories found matching 'build' 13:04:47 INFO - no previously-included directories found matching 'dist' 13:04:47 INFO - no previously-included directories found matching '.git*' 13:04:47 INFO - Installing collected packages: jsonschema, functools32 13:04:47 INFO - Running setup.py install for functools32 13:04:47 INFO - warning: no files found matching '*.txt' 13:04:47 INFO - no previously-included directories found matching 'build' 13:04:47 INFO - no previously-included directories found matching 'dist' 13:04:47 INFO - no previously-included directories found matching '.git*' 13:04:47 INFO - Successfully installed jsonschema functools32 13:04:47 INFO - Cleaning up... 13:04:47 INFO - Return code: 0 13:04:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b486cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, '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': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', '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 13:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:04:47 INFO - Using env: {'DISPLAY': ':0', 13:04:47 INFO - 'HOME': '/home/cltbld', 13:04:47 INFO - 'LANG': 'en_US.UTF-8', 13:04:47 INFO - 'LANGUAGE': 'en_US:en', 13:04:47 INFO - 'LOGNAME': 'cltbld', 13:04:47 INFO - 'MAIL': '/var/mail/cltbld', 13:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:47 INFO - 'MOZ_NO_REMOTE': '1', 13:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:47 INFO - 'NO_EM_RESTART': '1', 13:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:47 INFO - 'PWD': '/builds/slave/test', 13:04:47 INFO - 'SHELL': '/bin/bash', 13:04:47 INFO - 'SHLVL': '1', 13:04:47 INFO - 'TERM': 'linux', 13:04:47 INFO - 'TMOUT': '86400', 13:04:47 INFO - 'USER': 'cltbld', 13:04:47 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:47 INFO - '_': '/tools/buildbot/bin/python'} 13:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:48 INFO - Downloading/unpacking flake8 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:48 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 13:04:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:04:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:04:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:04:49 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 13:04:49 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 13:04:49 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 13:04:49 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 13:04:49 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 13:04:49 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 13:04:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:04:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:04:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:04:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:04:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:04:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:04:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:04:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:04:50 INFO - no previously-included directories found matching 'docs/_build' 13:04:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:04:50 INFO - Running setup.py install for pep8 13:04:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:04:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:04:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:04:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:04:50 INFO - no previously-included directories found matching 'docs/_build' 13:04:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:04:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:04:50 INFO - Cleaning up... 13:04:50 INFO - Return code: 0 13:04:50 INFO - Running post-action listener: _resource_record_post_action 13:04:50 INFO - Running post-action listener: _start_resource_monitoring 13:04:50 INFO - Starting resource monitoring. 13:04:50 INFO - ##### 13:04:50 INFO - ##### Running install step. 13:04:50 INFO - ##### 13:04:50 INFO - Running pre-action listener: _resource_record_pre_action 13:04:50 INFO - Running main action method: install 13:04:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:50 INFO - Reading from file tmpfile_stdout 13:04:51 INFO - Detecting whether we're running mozinstall >=1.0... 13:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:04:51 INFO - Reading from file tmpfile_stdout 13:04:51 INFO - Output received: 13:04:51 INFO - Usage: mozinstall [options] installer 13:04:51 INFO - Options: 13:04:51 INFO - -h, --help show this help message and exit 13:04:51 INFO - -d DEST, --destination=DEST 13:04:51 INFO - Directory to install application into. [default: 13:04:51 INFO - "/builds/slave/test"] 13:04:51 INFO - --app=APP Application being installed. [default: firefox] 13:04:51 INFO - mkdir: /builds/slave/test/build/application 13:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:05:05 INFO - Reading from file tmpfile_stdout 13:05:05 INFO - Output received: 13:05:05 INFO - /builds/slave/test/build/application/firefox/firefox 13:05:05 INFO - Running post-action listener: _resource_record_post_action 13:05:05 INFO - ##### 13:05:05 INFO - ##### Running run-tests step. 13:05:05 INFO - ##### 13:05:05 INFO - Running pre-action listener: _resource_record_pre_action 13:05:05 INFO - Running main action method: run_tests 13:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:05:05 INFO - Python 2.7.3 13:05:05 INFO - Return code: 0 13:05:05 INFO - grabbing minidump binary from tooltool 13:05: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')]} 13:05:05 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 0x28420b0>, '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 0x2842fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2843440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:05:05 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 13:05:05 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 13:05:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:05:05 INFO - Return code: 0 13:05:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:05:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:05:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:05:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:05:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:05:06 INFO - Return code: 0 13:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test/build 13:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 13:05:06 INFO - Using env: {'DISPLAY': ':0', 13:05:06 INFO - 'HOME': '/home/cltbld', 13:05:06 INFO - 'LANG': 'en_US.UTF-8', 13:05:06 INFO - 'LANGUAGE': 'en_US:en', 13:05:06 INFO - 'LOGNAME': 'cltbld', 13:05:06 INFO - 'MAIL': '/var/mail/cltbld', 13:05:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:05:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:06 INFO - 'MOZ_NO_REMOTE': '1', 13:05:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:06 INFO - 'NO_EM_RESTART': '1', 13:05:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:06 INFO - 'PWD': '/builds/slave/test', 13:05:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:05:06 INFO - 'SHELL': '/bin/bash', 13:05:06 INFO - 'SHLVL': '1', 13:05:06 INFO - 'TERM': 'linux', 13:05:06 INFO - 'TMOUT': '86400', 13:05:06 INFO - 'USER': 'cltbld', 13:05:06 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264', 13:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:06 INFO - '_': '/tools/buildbot/bin/python'} 13:05:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 13:05:06 INFO - mozversion INFO | application_buildid: 20151202073358 13:05:06 INFO - mozversion INFO | application_changeset: 87204339949047f3c630cb57f37fb6e818d41f5f 13:05:06 INFO - mozversion INFO | application_display_name: Nightly 13:05:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:05:06 INFO - mozversion INFO | application_name: Firefox 13:05:06 INFO - mozversion INFO | application_remotingname: firefox 13:05:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:05:06 INFO - mozversion INFO | application_vendor: Mozilla 13:05:06 INFO - mozversion INFO | application_version: 45.0a1 13:05:06 INFO - mozversion INFO | platform_buildid: 20151202073358 13:05:06 INFO - mozversion INFO | platform_changeset: 87204339949047f3c630cb57f37fb6e818d41f5f 13:05:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:05:06 INFO - mozversion INFO | platform_version: 45.0a1 13:05:06 INFO - 2015-12-04 13:05:06,960 DEBUG : using testdate: 1449263106 13:05:06 INFO - 2015-12-04 13:05:06,960 DEBUG : actual date: 1449263106 13:05:06 INFO - 2015-12-04 13:05:06,969 INFO : starting webserver on 'localhost:33164' 13:05:06 INFO - 2015-12-04 13:05:06,969 INFO : Starting test suite talos-linux64-ix-026.e 13:05:06 INFO - 2015-12-04 13:05:06,970 INFO : Starting test dromaeo_css 13:05:06 INFO - 2015-12-04 13:05:06,970 DEBUG : operating with platform_type : linux_ 13:05:06 INFO - 2015-12-04 13:05:06,971 INFO : Initialising browser for dromaeo_css test... 13:05:06 INFO - 2015-12-04 13:05:06,985 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSycJvf/profile http://localhost:33164/getInfo.html 13:05:10 INFO - 2015-12-04 13:05:10,515 DEBUG : BROWSER_OUTPUT: console.error: 13:05:10 INFO - 2015-12-04 13:05:10,515 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:05:10 INFO - 2015-12-04 13:05:10,515 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:05:11 INFO - 2015-12-04 13:05:11,645 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:05:11 INFO - 2015-12-04 13:05:11,645 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:05:11 INFO - 2015-12-04 13:05:11,645 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:05:11 INFO - 2015-12-04 13:05:11,646 DEBUG : BROWSER_OUTPUT: __metrics 13:05:11 INFO - 2015-12-04 13:05:11,774 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:05:12 INFO - 2015-12-04 13:05:12,851 INFO : Browser initialized. 13:05:12 INFO - 2015-12-04 13:05:12,852 INFO : Running cycle 1/1 for dromaeo_css test... 13:05:12 INFO - 2015-12-04 13:05:12,852 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSycJvf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:05:14 INFO - 2015-12-04 13:05:14,465 DEBUG : BROWSER_OUTPUT: console.error: 13:05:14 INFO - 2015-12-04 13:05:14,465 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:05:14 INFO - 2015-12-04 13:05:14,465 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:05:24 INFO - 2015-12-04 13:05:24,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 143241216 13:05:24 INFO - 2015-12-04 13:05:24,856 DEBUG : BROWSER_OUTPUT: 13:06:14 INFO - 2015-12-04 13:06:14,474 DEBUG : BROWSER_OUTPUT: 1449263174470 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] 13:08:26 INFO - 2015-12-04 13:08:26,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33164/tests/dromaeo/cssquery-ext.html) 13:08:27 INFO - 2015-12-04 13:08:27,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 146137088 13:08:27 INFO - 2015-12-04 13:08:27,290 DEBUG : BROWSER_OUTPUT: 13:11:29 INFO - 2015-12-04 13:11:29,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/dromaeo/cssquery-ext.html (next: http://localhost:33164/tests/dromaeo/cssquery-jquery.html) 13:11:29 INFO - 2015-12-04 13:11:29,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 144482304 13:11:29 INFO - 2015-12-04 13:11:29,986 DEBUG : BROWSER_OUTPUT: 13:14:31 INFO - 2015-12-04 13:14:31,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33164/tests/dromaeo/cssquery-mootools.html) 13:14:32 INFO - 2015-12-04 13:14:32,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 146161664 13:14:32 INFO - 2015-12-04 13:14:32,401 DEBUG : BROWSER_OUTPUT: 13:17:34 INFO - 2015-12-04 13:17:34,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33164/tests/dromaeo/cssquery-prototype.html) 13:17:34 INFO - 2015-12-04 13:17:34,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 144007168 13:17:34 INFO - 2015-12-04 13:17:34,797 DEBUG : BROWSER_OUTPUT: 13:20:37 INFO - 2015-12-04 13:20:37,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33164/tests/dromaeo/cssquery-yui.html) 13:20:38 INFO - 2015-12-04 13:20:38,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 144637952 13:20:38 INFO - 2015-12-04 13:20:38,017 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/dromaeo/cssquery-yui.html (next: http://localhost:33164/tests/dromaeo/cssquery-dojo.html) 13:23:40 INFO - 2015-12-04 13:23:40,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 147091456 13:23:40 INFO - 2015-12-04 13:23:40,732 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:23:40 INFO - 2015-12-04 13:23:40,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:23:40 INFO - 2015-12-04 13:23:40,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:23:40 INFO - 2015-12-04 13:23:40,733 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:23:40 INFO - 2015-12-04 13:23:40,733 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2649.231722800387;2695.514807334679;2715.321169707573;2735.398212393274;2745.835249885007;4583.702059366139;4747.691400058994;4747.952520474794;4750.809967601296;4771.35586695796;4642.6982246153975;4699.577038066574;4703.15343238217;4796.376471058767;4808.735519546423;4263.509696384925;4325.26470500015;4415.359772832937;4418.425604671388;4452;4201.159768046387;4370.847020354288;4405.6475481961525;4408.779561021952;4505.098980203972;4231.724937879028;4265.616094551474;4342.717723347972;4386.232409328387;4388.144311859189;4378.9562104378865;4398.8900277493;4412.227860124497;4416.624586910117;4476.239039363316;4161.126163505667;4281.593248641374;4385.627221686161;4399.362092496602;4434.423524941769;4609.262517997105;4687.1328804171335;4698.060387922429;4715.056988602259;4721.220998535237;5012.974935125338;5033.697978121288;5038.622103342264;5039.596832253447;5088.211327244283;4863.902721945577;4925.187344088221;4958.057968985881;5058.772355244023;5098.337216161913;4741.502142275081;4751.881202969919;4759.809607615691;4762.499937506581;4800.039992001613;5220;5230.3985041719925;5232.162853943427;5251.789928402897;5257.08001099806;4699.929501057487;4804.663673542888;4869.366982292279;4977.32806071183;5048.469910659328;5074.11203039474;5078.796848126033;5098.566621837185;5104.234364845229;5138.691678499227;5045.747712614355;5056.772445239973;5060.974695126501;5064.316317297192;5064.924026139611;4784.784684689197;4876.804927802848;4902.681325713817;4964.751762411937;4998.850034498971;4133.42132101506;4174.603412675791;4203.222403855297;4211.989122610551;4242.278812601865;3593.4789455529326;3693.8153092345274;3710.257948410275;3724.1620635356826;3726.2547490502006;4246.596573325529;4332.523422423531;4335.891602709894;4335.978320108442;4375.584319489643;5114.462981386975;5124.7950081996305;5126.615503837153;5128.794848206105;5139.563137133386;4218.303979843353;4362.280223763044;4418.7127836690515;4425.778711064434;4470.061287129674;4415.602595766396;4455.465344158657;4469.128519938646;4494.865154045384;4501.144782491317;4817.855464336076;4871.537203965618;4879.682820616648;4891.144049791344;4920.48334924842;4864.562189402971;4987.825426110068;4997.375328083989;5074.517920797518;5097.413797413345;4881.463039065771;4894.290327902506;4914.434839993446;4916.434610019894;4966.130927087817;5090.338256026693;5097.337346144977;5100;5107.41264754558;5115.488451154854;4777.880552986064;4930.235813448921;4939.16034274167;4946.1097002538445;5199.090159222045;4902.485239049848;4915.213565829593;4918.040982008617;4928.408590969107;4929.630277729257;4962.8759281018265;4964.35463389757;4969.155243608668;4976.975115124401;4986.227134794112;4623.214053610962;4661.790219440066;4743.620510359232;4847.684900481458;4866.099771542276;4914.827981020647;4932.457429682804;4933.851984440473;4941.466851201265;4976.751162441936;4796.784144713566;4798.760061996956;4811.591014763784;4811.735354555533;4847.61219102478 13:23:40 INFO - 2015-12-04 13:23:40,733 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.3340949084653;568.2215364950019;576.0725232375871;589.0457458916555;592.1029640095256;27060.05289814857;35406.0526671033;35863.28273434536;35869.46195807062;36013.0996725082;37735.433968490426;38284.80857595708;38320;38336.616633833655;38352.42471362932;7976.2821346078845;8063.516189028648;8079.394045446615;8103.027636683606;8131.837363252732;7737.651805668758;7926.445148839583;7928.563928983904;7930.801729956739;7945.205479452037;7864.606769661523;7969.641366138509;7971.163027882076;7974.920250797476;7982.401319901031;7882.369410447151;7909.485883417588;7942.126366099725;7961.761147165595;7967.880481792778;7781;7997.120316765151;8007.839843203162;8009.799755006172;8022.719204827861;35740.82129589361;36146.45780313297;36320.63679363199;36349.454758178385;36385.45421818675;2814.1698199031334;2871.684114747376;3173.016364926857;3174.4286028514857;3372.4941258811127;27550.862245688844;27756.167314980583;28297.292567685767;28344.433111337865;28594.14217573476;3175.5712978747806;3192.9361412771846;3206.8236247006407;3222.4682927316962;3249;218342;223413;223741;224231;225987.87006065028;46319;47199.5280047202;53725.1941220882;53872;53982;63886.36113638897;64402.677986609764;64582.35417645764;65194.67402662956;65427.34572654308;14270.500532481521;14408.567742967727;14488.710225795425;14503.202323872289;14532.200728959797;10897.455127243764;10965.671029869116;10987.230893837355;10993.340399576051;11000.22998390121;18808.247670093042;19082;19087;19101.140448679842;19162.52093697641;7575.431842611826;7858.214178582096;7869.685212591432;7918.6436610352675;7970.4819186752675;884.8716936044366;894.2482231268033;957.3107362698846;1023.636609003793;1029.984550231747;26130.86934565315;26429.603555946676;26957;29144.85427572891;30636.080917572508;947.8672985781996;975.4293738163112;1003.6085926488676;1056.8573242612304;1070.8714954205545;13209.603711888467;13595.252261125734;13627.318634068257;13627.931860340834;14813.703725925421;317082;321634;321668;322948.8525573712;326523;46695.533044669115;46862.297065544044;46926.5307346929;47046.29430558544;47154;1190.1549899571228;1220.4446976625613;1225.9203151795105;1227.699213692651;1235.7775600392015;26706.332341691614;26886.59670104989;27271.318217044733;27304.72695273022;27520.724792751815;38601.227975439775;39008.414873776346;39229.41155882607;39374;39383.2123357537;256391;259592;259975;260283;261475;29306.069393060523;38761.224775504896;38920.6107938917;39127.413088804264;39226;37101.814490927376;38439.423408649454;38667.613323867525;39080.41379379368;39636;33126.503102453;33647.663523364456;33773.66226337705;33798.83100584481;34046;33057.173570660925;33705.494417583264;33730.325393491505;33924;34058.14854628654;34593.30813383769;34950.82524587361;35371.64628353684;35487.11282217965;35557.46663799993;29435.41129177447;30418.391632167677;30446.695533044385;30789.23026924345;30809.38381232318;24003.63994540118;24086;25892.482150357264;27248.591271130554;27364.72635273622 13:23:40 INFO - 2015-12-04 13:23:40,733 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.4897606661808;333.59135059552034;338.78317876559004;338.8915547024952;340.1224839913024;15759.684806303867;15917.840821591795;16013.83986160138;16406.26171822268;16711.749323760137;9677.806443871119;9917.107460328569;12438.875611243884;14255.429782808702;14316.71366572668;4507.368968344426;4626.97686511567;4639.814407423699;4657.161710892038;5145.434002259748;5110.693358398489;5118.07874582575;5131.512506311894;5136.537711605954;5148.768305426246;4920.089783390084;5067.721275329855;5072.695638261697;5137;5159.845204643848;4997.300377947054;5014.147594908874;5037.823676171335;5061.164907790228;5102.311187989611;5163.5352818246165;5165.173572228463;5169.612279079084;5190.247414124969;5195.68825870449;10602.204834637432;10653.9467302663;10839.67480975572;11270.774584508265;11382.715432114263;1870.261246807517;1888.2635772048911;1898.7531620889197;1919.155571548528;1978.792226816178;9033.187013168847;9132.08679132088;9172.908270917338;11220.551177952872;12578.748425031448;1725.9395921142825;1732.1858726398573;1765.3821162593117;1827.2416946966994;1860.7860096088987;56043.43956560464;56249;56365.43634563684;57094;57112.71443642797;9871.259655525864;9921.80156396868;9933.205343572497;9986.750331241778;10034.197264218845;12469;12541;12577;12582.24506529611;12615.369231538387;6948.791536253921;7043.542169758949;7064.646767661699;7097.9645101775195;7112.35988761014;6767.796966091025;6772.255051944282;6780.084688567079;6806.897896531556;6815.625140617313;4120.958790412057;4175.770332631673;4207.137536804948;4223.1975924574235;4260.318349064197;1760.0847559269364;1767.169430367725;1776.5114593486635;1790.6955817511055;1796.8293012163824;377.8904117805861;381.26035491147087;386.54387822369875;394.9131191137945;421.6647765026811;9589.42463452195;10106.191504679608;10184;10287.845682314772;10372.688819335432;392.1275162762887;400.7755656832183;412.9318662420727;422.12409250804706;429.40312964978705;5497.36780270274;5632.155176723442;8967.775805604912;9388.95305523468;9399.90600094004;454818;454977;459528;476056;480488;62147;63331;65286.67356663281;71836.64081679663;73980.26019739841;969.5685419988179;989.4459102902398;998.9800203995879;1000.6347683095618;1026.1688032693542;14852.925735371255;15081.622959426102;15205.163715995726;15226.162561059247;15476.767848482057;32706.182345441553;33043.66956330406;33643.327133457686;34000.82999584986;34178.24039355619;40979.795101024305;41184.38223426591;45379.54620453753;47952.28071578999;49327.26009109938;8497.575121244037;8721.476711397336;8775.166359195866;8823.69117080899;8842.778930526789;10093.899061009295;11239.887601123884;16852.15739213059;17074.829251707324;17106.657866842346;13140.0801943863;13146.342682865627;13510.324483775968;13674.247916364298;14285.142891426547;13739.24434156131;13744;13848.376823042785;14007.859921401063;14381.92809035948;13314.733705326033;14313.603075977628;14336.139831610137;14680.339384727926;15032.173230472428;8309.459885107448;8420.11588783169;8691.521966291662;8747.081556436482;8757.737267881974;10123.341982771097;12536.185147965352;12669.873301267238;13279.66800829987;13530.93234533821 13:23:40 INFO - 2015-12-04 13:23:40,735 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1450.3690894460917;1635.1415506858898;1684.5367523930918;1716.0647447141312;1723.1901006526937;6122.173506576611;6368.586041907272;6731.629760363184;7124.964375178123;7199.208087110427;6819.488538359618;7023.19233288172;7086.645667716606;7106.360427561532;7114.324139206767;2051.8358531317535;2104.926327578535;2107.7154584131176;2107.8524503284775;2109.050927082811;2100.2544096845627;2120.7455105387376;2138.29436286026;2152.924647637333;2157.0832396231617;1981.6333978214004;2019.8081182287733;2047.0072015072678;2047.9590408191827;2048.9282875099375;2073.9170433182653;2086.6035453263985;2087.405089549479;2093.706881036656;2101;2028.1684509351244;2060.6393881070753;2064.112431654388;2064.3910046536307;2066.9379918602467;7112.110986126734;7206.1352637683285;7209.243029481934;7210.2789721028;7218.530795498328;4033.616806403387;4121.732087414309;4124.216398884202;4126.319157339036;4129.91740165195;2324.372419446757;2380.3929997850437;2656.5749480083095;2686.892524299026;2705.188443466952;893.0877590351847;898.1422741282059;920.9685152629031;935.7567032571512;942.5475771629656;9475.431474111507;9654.131128198425;9676.225901927828;9685.661001864972;9692.95153524235;3704.870329538507;3812.4471951566866;3826.196498735241;3831.2912111259507;3952.960470395259;8311.792205194919;8321;8370.79073023167;8371.665133394596;8384.748457546284;4214.515330736943;4217.0511634881905;4247.299195632748;4261.4673165854265;4276.059266961263;3824.579296277407;3834.463175155425;3851.094992676719;3854.5374555053572;3854.9614503855164;3320.93358132836;3322.318924620447;3324.3849887770357;3347.4644056951256;3353.3628610563915;1043.6764602973103;1045.1429827541342;1053.0680347892016;1053.657561292583;1053.8893416191343;914.1498406481903;925.8194652042787;936.5083331251011;967.2552134856262;1218.2386008744534;6752.426043786235;6778.627175505296;6787.592744435349;6817.761378351734;6827.2931767058235;418.30978884839647;423.03336875239927;1063.7074804428844;1112.6606385052637;1125.994370028161;5365.141577347606;5385.3268341457315;5408.91886621701;5413.431589683105;5420.457954204627;8219.465734727224;8441.198086181803;8553.486790792573;8557.743267701979;8578.78553036179;8392.28665563434;8406.789830254293;8426.620802063922;8441.535715535705;8449.36629752771;6740.662966851736;6763;6813.454923606;6847.554908930903;6884.277150899184;6592.90110648331;6632.867342653023;6648.401643852077;6673.866522669422;6683.030960510796;7312.707491700486;7519.511231769918;7524.924750752422;7532.924670753441;7562.357199637872;7578.545287282781;7685.654145563351;7760.728374506865;7785.104712958082;7840.80397990032;6093.116498107661;6459.321771213955;6532.934670653232;6537.444317233088;6578.572392794453;6696.966515167393;6784.457243420416;6822.317768223138;6835.555688880207;6844.555103918229;6369.172007638977;6463.64449955257;6540.901886471802;6609.966950165219;6660.300668429745;6482.57863238888;6513.348665133638;6563.343665633399;6572.868542629216;6604.0754294399785;6660.83347916306;6661.833454163685;6677.76627818024;6684.264730879697;6707.195136583641;5967.254093238345;6018.127371531016;6065.120557519223;6094.08588711679;6130.448259656652;6142.170806941006;6180.8763824722355;6188.133661287334;6197.4732147767945;6215.81352559424 13:23:40 INFO - 2015-12-04 13:23:40,738 DEBUG : BROWSER_OUTPUT: |4;prototype.html;297.83916684990106;305.74775809956793;306.7760534809589;312.22100858358397;315.0595472514544;5492;5564.276644036279;5597.636153650015;5719.799807006755;5737.942620573798;5561.193626924104;5605;5617.775288988436;5624.775008999645;5628.887422251552;4135.483064616923;4242.936355954663;4294.09823936972;4294.312909934411;4296.613304802567;4217.325227963526;4238.894027649318;4240.97879510602;4242.512111107231;4243;4187.979060104695;4188.099558594901;4190.28765109932;4194.97902510487;4205.936910946339;4191.559886211934;4206.621404073633;4214.304639734441;4218.641415479688;4220.050488640047;3578.3380074686265;3669.6330366963357;3686.4286035664513;3688.243909998444;3694.242680250542;5214.582833373321;5336.706481143536;5344.599155063347;5367.570594352443;5367.758450869681;4833.371661683994;4855.053264613402;4855.223164293696;4861.124997500448;4874.122657921573;5843.561732870052;5848.795292164754;5855.180274761537;5857.150713146612;5869.383714709937;3846.230753849213;3972.920541589152;3996.540397854255;3999.9400008999887;4005.018770401241;6100.267967843887;6176.258848938156;6179.258488981306;6184.938150618526;6190.907136392958;4078.857239996586;4083.448734420815;4086.0397806515443;4088.856890008895;4089.97955010229;4149.25313443583;4149.7095203335475;4155.750654960651;4156.044109854751;4167.354060120686;4706.717596944194;4806.423229212447;4810.350602668665;4811.879703007383;4816.662833601615;5827.912581311284;5832.708364581754;5834.066549352084;5839.9124013139835;5852.824415267549;1460.8685218330402;1483.1323675649867;1484.383980648019;1486.3385793322084;1486.37572219668;964.9276304277207;982.6708052802248;988.41189492252;991.7421470417744;993.3592832622918;5095.8726031848755;5103.566196873233;5110.131277682803;5114.002769459994;5116.8464946050935;6003.159557661931;6024.096385542204;6050.062240352752;6077.513798896078;6081.148639190517;5057.216131499624;5058.671186372874;5085.084684756779;5085.567726743194;5101.948980510221;3205.599300087489;3255.544223808669;3261.9347613047607;3270;3293.637699853014;5633.239512665819;5734.77060917567;5752.223449834219;5762.1068734346245;5806.44838740319;6316.178896743394;6316.30520642729;6336.714847831767;6337.873242535124;6339.873202535923;5817;5817.069268916953;5817.447342502455;5830.76676932918;5839.328477225088;5915.526757859275;6135.202423684892;6137.570370074052;6143.354947730424;6147.293061298008;5922.082077278029;5990.101484777144;5994.700264986646;6008.849778755566;6012.158297838394;5792.189093526994;5813.7674493021495;5823.679697616672;5829.038208695518;5833.620814647034;4085.754854708727;4144.834206631822;4146.170765846782;4164.729292595972;4168.979155104205;6005.249343832021;6122.326544080059;6137.171481849893;6139.079138129137;6145.600535965148;5823.068309070529;5850.356460789395;5879.617824841372;5890.4993075589055;5904.911426328695;5837.270341207349;5847.093700476433;5896.027155519291;5898.557608179318;5903;5623.718814059363;5762.2221000164445;5770.6249093808765;5775.884482310246;5776.786874756348;5941.732622032106;5947.316058653138;5947.851303717442;5961.225040744675;5963.850903727442;5746.051901436216;5753.338366087954;5753.884922301614;5759.193712880116;5759.424057594207 13:23:40 INFO - 2015-12-04 13:23:40,738 DEBUG : BROWSER_OUTPUT: |5;yui.html;642.8088860628701;681.8704446155233;701.5545128843185;708.9220185779564;724.2865777209448;10443.582256709722;10503.474826258685;10680.839787403176;10704.30422022568;10769.569217231301;11018.44907754611;13046.869531304685;13355.933220333909;13362;13389.93305033476;615.59986009094;623.4575918950519;790.2729488870239;802.863513202754;803.5982008995502;788.0346575445092;796.8127490039836;800.607702225908;806.1374329467473;807.3904202327235;810.2586133687669;834.1991687979516;834.6577903059747;842.7092653034694;844.8310337932407;808.640155130967;823.7734622978699;829.7261903571807;829.8755186721979;830.1200727229126;594.6313285762811;607.034814644717;616.0451300484276;618.4495798739126;618.5237367227255;11794.764104717944;11816.172867899251;11869.228500147548;11941.462634181482;11968;10363.948180259125;10692.358458492516;11014.944925275322;11143.888561114447;11238.66284011481;9272.30457715674;9310.487923164223;9458.52707364629;9680.031996800333;9692.903070969342;3240.287136829894;3250.3011852451837;3251.1872031992;3333.1333853198103;3339.1151344893624;40151;40205.39691904624;40577.391339129936;40822.18355632871;40968.59031409708;9164.404313719588;9203.493807840632;9313.34806563534;9352.345335826563;9484.193843523377;16241.106739129225;16246.025238485492;16248.268827902773;16279.837201628068;16288.837111628969;6185.319614842364;6223.439890409885;6238.438540531374;6308.589941653778;6406.199225096863;3525.7003154732133;3530.382183117944;3558.822058897045;3566.6433356664643;3606.206634540397;2761.4477104578764;2793.385455199853;2803.1170181392795;2804.831710097401;2806.116073436861;474.29803890242636;481.898801251734;482.41627630566705;485.89310351722565;486.99026019479413;469.6172619315247;610.4902406490542;630.4011189370117;635.2789583822395;637.0285314894822;7641.579713115721;8772.166644168921;8844.55777211137;8849.867251991225;8894.777630559287;552.3454706173197;588.1853632718716;595.8689088400545;603.3815339277188;616.3035769580435;3632.2553876455263;3677.2093999790172;3744.26986737589;3858.3055050090693;3860.1507668312925;48830.26754598684;51969.5038120235;52380;52717.47282527126;53113.468865311625;42534;43551.34672979908;43784.343234851505;44624.107517849465;44695.776521117186;41698.37452438216;41811.58188418077;41983.58016419797;42404.363934541005;42606.57393426026;7831.843363132592;7956.482828616122;8190.262876341158;8323.875141872755;8478.364122690946;29772;29828.552571711876;30517.542236866022;30757;30774.692253077184;38807.61192388153;39006;39193;40359;40614.344708976336;9956.900430995598;10105.040021197974;10153.543090560795;10214.540345684314;10569.471526423495;11423.314601123959;11468.94265528667;11606.651800446;11647.534098635959;11782.764344712887;10880.94559527229;11205.775884482428;11238.83141752858;11306.717332066764;11699.122565807429;10991.450427478754;10996.230263881771;11030.558777649125;11080.5567777288;11082.889171108185;10836.620718274822;10945.83581246266;11030.889691102986;11340.716482088013;11384.658460246206;9216.95391523038;9306.208972237166;9353.812923741623;9557.569909354235;9807.411555306704;9059.501727405055;9226.446413215228;9291.860622090539;9385.577649005674;9570.569324380558 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: __startTimestamp1449264220725__endTimestamp 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,740 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4668.69 Median:4804.66 stddev:488.54 (10.2%) stddev-sans-first:463.64 13:23:40 INFO - 2015-12-04 13:23:40,741 DEBUG : BROWSER_OUTPUT: Values: 2649.2 2695.5 2715.3 2735.4 2745.8 4583.7 4747.7 4748.0 4750.8 4771.4 4642.7 4699.6 4703.2 4796.4 4808.7 4263.5 4325.3 4415.4 4418.4 4452.0 4201.2 4370.8 4405.6 4408.8 4505.1 4231.7 4265.6 4342.7 4386.2 4388.1 4379.0 4398.9 4412.2 4416.6 4476.2 4161.1 4281.6 4385.6 4399.4 4434.4 4609.3 4687.1 4698.1 4715.1 4721.2 5013.0 5033.7 5038.6 5039.6 5088.2 4863.9 4925.2 4958.1 5058.8 5098.3 4741.5 4751.9 4759.8 4762.5 4800.0 5220.0 5230.4 5232.2 5251.8 5257.1 4699.9 4804.7 4869.4 4977.3 5048.5 5074.1 5078.8 5098.6 5104.2 5138.7 5045.7 5056.8 5061.0 5064.3 5064.9 4784.8 4876.8 4902.7 4964.8 4998.9 4133.4 4174.6 4203.2 4212.0 4242.3 3593.5 3693.8 3710.3 3724.2 3726.3 4246.6 4332.5 4335.9 4336.0 4375.6 5114.5 5124.8 5126.6 5128.8 5139.6 4218.3 4362.3 4418.7 4425.8 4470.1 4415.6 4455.5 4469.1 4494.9 4501.1 4817.9 4871.5 4879.7 4891.1 4920.5 4864.6 4987.8 4997.4 5074.5 5097.4 4881.5 4894.3 4914.4 4916.4 4966.1 5090.3 5097.3 5100.0 5107.4 5115.5 4777.9 4930.2 4939.2 4946.1 5199.1 4902.5 4915.2 4918.0 4928.4 4929.6 4962.9 4964.4 4969.2 4977.0 4986.2 4623.2 4661.8 4743.6 4847.7 4866.1 4914.8 4932.5 4933.9 4941.5 4976.8 4796.8 4798.8 4811.6 4811.7 4847.6 13:23:40 INFO - 2015-12-04 13:23:40,741 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,741 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43006.42 Median:34052.07 stddev:70965.96 (208.4%) stddev-sans-first:71093.43 13:23:40 INFO - 2015-12-04 13:23:40,741 DEBUG : BROWSER_OUTPUT: Values: 548.3 568.2 576.1 589.0 592.1 27060.1 35406.1 35863.3 35869.5 36013.1 37735.4 38284.8 38320.0 38336.6 38352.4 7976.3 8063.5 8079.4 8103.0 8131.8 7737.7 7926.4 7928.6 7930.8 7945.2 7864.6 7969.6 7971.2 7974.9 7982.4 7882.4 7909.5 7942.1 7961.8 7967.9 7781.0 7997.1 8007.8 8009.8 8022.7 35740.8 36146.5 36320.6 36349.5 36385.5 2814.2 2871.7 3173.0 3174.4 3372.5 27550.9 27756.2 28297.3 28344.4 28594.1 3175.6 3192.9 3206.8 3222.5 3249.0 218342.0 223413.0 223741.0 224231.0 225987.9 46319.0 47199.5 53725.2 53872.0 53982.0 63886.4 64402.7 64582.4 65194.7 65427.3 14270.5 14408.6 14488.7 14503.2 14532.2 10897.5 10965.7 10987.2 10993.3 11000.2 18808.2 19082.0 19087.0 19101.1 19162.5 7575.4 7858.2 7869.7 7918.6 7970.5 884.9 894.2 957.3 1023.6 1030.0 26130.9 26429.6 26957.0 29144.9 30636.1 947.9 975.4 1003.6 1056.9 1070.9 13209.6 13595.3 13627.3 13627.9 14813.7 317082.0 321634.0 321668.0 322948.9 326523.0 46695.5 46862.3 46926.5 47046.3 47154.0 1190.2 1220.4 1225.9 1227.7 1235.8 26706.3 26886.6 27271.3 27304.7 27520.7 38601.2 39008.4 39229.4 39374.0 39383.2 256391.0 259592.0 259975.0 260283.0 261475.0 29306.1 38761.2 38920.6 39127.4 39226.0 37101.8 38439.4 38667.6 39080.4 39636.0 33126.5 33647.7 33773.7 33798.8 34046.0 33057.2 33705.5 33730.3 33924.0 34058.1 34593.3 34950.8 35371.6 35487.1 35557.5 29435.4 30418.4 30446.7 30789.2 30809.4 24003.6 24086.0 25892.5 27248.6 27364.7 13:23:40 INFO - 2015-12-04 13:23:40,741 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,741 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25261.01 Median:2266.95 stddev:76058.14 (3355.1%) stddev-sans-first:76248.47 13:23:40 INFO - 2015-12-04 13:23:40,742 DEBUG : BROWSER_OUTPUT: Values: 333.5 333.6 338.8 338.9 340.1 15759.7 15917.8 16013.8 16406.3 16711.7 9677.8 9917.1 12438.9 14255.4 14316.7 4507.4 4627.0 4639.8 4657.2 5145.4 5110.7 5118.1 5131.5 5136.5 5148.8 4920.1 5067.7 5072.7 5137.0 5159.8 4997.3 5014.1 5037.8 5061.2 5102.3 5163.5 5165.2 5169.6 5190.2 5195.7 10602.2 10653.9 10839.7 11270.8 11382.7 1870.3 1888.3 1898.8 1919.2 1978.8 9033.2 9132.1 9172.9 11220.6 12578.7 1725.9 1732.2 1765.4 1827.2 1860.8 56043.4 56249.0 56365.4 57094.0 57112.7 9871.3 9921.8 9933.2 9986.8 10034.2 12469.0 12541.0 12577.0 12582.2 12615.4 6948.8 7043.5 7064.6 7098.0 7112.4 6767.8 6772.3 6780.1 6806.9 6815.6 4121.0 4175.8 4207.1 4223.2 4260.3 1760.1 1767.2 1776.5 1790.7 1796.8 377.9 381.3 386.5 394.9 421.7 9589.4 10106.2 10184.0 10287.8 10372.7 392.1 400.8 412.9 422.1 429.4 5497.4 5632.2 8967.8 9389.0 9399.9 454818.0 454977.0 459528.0 476056.0 480488.0 62147.0 63331.0 65286.7 71836.6 73980.3 969.6 989.4 999.0 1000.6 1026.2 14852.9 15081.6 15205.2 15226.2 15476.8 32706.2 33043.7 33643.3 34000.8 34178.2 40979.8 41184.4 45379.5 47952.3 49327.3 8497.6 8721.5 8775.2 8823.7 8842.8 10093.9 11239.9 16852.2 17074.8 17106.7 13140.1 13146.3 13510.3 13674.2 14285.1 13739.2 13744.0 13848.4 14007.9 14381.9 13314.7 14313.6 14336.1 14680.3 15032.2 8309.5 8420.1 8691.5 8747.1 8757.7 10123.3 12536.2 12669.9 13279.7 13530.9 13:23:40 INFO - 2015-12-04 13:23:40,742 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,743 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4990.34 Median:6461.48 stddev:2587.33 (40.0%) stddev-sans-first:2580.91 13:23:40 INFO - 2015-12-04 13:23:40,743 DEBUG : BROWSER_OUTPUT: Values: 1450.4 1635.1 1684.5 1716.1 1723.2 6122.2 6368.6 6731.6 7125.0 7199.2 6819.5 7023.2 7086.6 7106.4 7114.3 2051.8 2104.9 2107.7 2107.9 2109.1 2100.3 2120.7 2138.3 2152.9 2157.1 1981.6 2019.8 2047.0 2048.0 2048.9 2073.9 2086.6 2087.4 2093.7 2101.0 2028.2 2060.6 2064.1 2064.4 2066.9 7112.1 7206.1 7209.2 7210.3 7218.5 4033.6 4121.7 4124.2 4126.3 4129.9 2324.4 2380.4 2656.6 2686.9 2705.2 893.1 898.1 921.0 935.8 942.5 9475.4 9654.1 9676.2 9685.7 9693.0 3704.9 3812.4 3826.2 3831.3 3953.0 8311.8 8321.0 8370.8 8371.7 8384.7 4214.5 4217.1 4247.3 4261.5 4276.1 3824.6 3834.5 3851.1 3854.5 3855.0 3320.9 3322.3 3324.4 3347.5 3353.4 1043.7 1045.1 1053.1 1053.7 1053.9 914.1 925.8 936.5 967.3 1218.2 6752.4 6778.6 6787.6 6817.8 6827.3 418.3 423.0 1063.7 1112.7 1126.0 5365.1 5385.3 5408.9 5413.4 5420.5 8219.5 8441.2 8553.5 8557.7 8578.8 8392.3 8406.8 8426.6 8441.5 8449.4 6740.7 6763.0 6813.5 6847.6 6884.3 6592.9 6632.9 6648.4 6673.9 6683.0 7312.7 7519.5 7524.9 7532.9 7562.4 7578.5 7685.7 7760.7 7785.1 7840.8 6093.1 6459.3 6532.9 6537.4 6578.6 6697.0 6784.5 6822.3 6835.6 6844.6 6369.2 6463.6 6540.9 6610.0 6660.3 6482.6 6513.3 6563.3 6572.9 6604.1 6660.8 6661.8 6677.8 6684.3 6707.2 5967.3 6018.1 6065.1 6094.1 6130.4 6142.2 6180.9 6188.1 6197.5 6215.8 13:23:40 INFO - 2015-12-04 13:23:40,743 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,743 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4842.30 Median:5620.75 stddev:1454.49 (25.9%) stddev-sans-first:1418.01 13:23:40 INFO - 2015-12-04 13:23:40,744 DEBUG : BROWSER_OUTPUT: Values: 297.8 305.7 306.8 312.2 315.1 5492.0 5564.3 5597.6 5719.8 5737.9 5561.2 5605.0 5617.8 5624.8 5628.9 4135.5 4242.9 4294.1 4294.3 4296.6 4217.3 4238.9 4241.0 4242.5 4243.0 4188.0 4188.1 4190.3 4195.0 4205.9 4191.6 4206.6 4214.3 4218.6 4220.1 3578.3 3669.6 3686.4 3688.2 3694.2 5214.6 5336.7 5344.6 5367.6 5367.8 4833.4 4855.1 4855.2 4861.1 4874.1 5843.6 5848.8 5855.2 5857.2 5869.4 3846.2 3972.9 3996.5 3999.9 4005.0 6100.3 6176.3 6179.3 6184.9 6190.9 4078.9 4083.4 4086.0 4088.9 4090.0 4149.3 4149.7 4155.8 4156.0 4167.4 4706.7 4806.4 4810.4 4811.9 4816.7 5827.9 5832.7 5834.1 5839.9 5852.8 1460.9 1483.1 1484.4 1486.3 1486.4 964.9 982.7 988.4 991.7 993.4 5095.9 5103.6 5110.1 5114.0 5116.8 6003.2 6024.1 6050.1 6077.5 6081.1 5057.2 5058.7 5085.1 5085.6 5101.9 3205.6 3255.5 3261.9 3270.0 3293.6 5633.2 5734.8 5752.2 5762.1 5806.4 6316.2 6316.3 6336.7 6337.9 6339.9 5817.0 5817.1 5817.4 5830.8 5839.3 5915.5 6135.2 6137.6 6143.4 6147.3 5922.1 5990.1 5994.7 6008.8 6012.2 5792.2 5813.8 5823.7 5829.0 5833.6 4085.8 4144.8 4146.2 4164.7 4169.0 6005.2 6122.3 6137.2 6139.1 6145.6 5823.1 5850.4 5879.6 5890.5 5904.9 5837.3 5847.1 5896.0 5898.6 5903.0 5623.7 5762.2 5770.6 5775.9 5776.8 5941.7 5947.3 5947.9 5961.2 5963.9 5746.1 5753.3 5753.9 5759.2 5759.4 13:23:40 INFO - 2015-12-04 13:23:40,745 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-04 13:23:40,745 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12389.15 Median:43667.84 stddev:13966.32 (32.0%) stddev-sans-first:13977.64 13:23:40 INFO - 2015-12-04 13:23:40,745 DEBUG : BROWSER_OUTPUT: Values: 642.8 681.9 701.6 708.9 724.3 10443.6 10503.5 10680.8 10704.3 10769.6 11018.4 13046.9 13355.9 13362.0 13389.9 615.6 623.5 790.3 802.9 803.6 788.0 796.8 800.6 806.1 807.4 810.3 834.2 834.7 842.7 844.8 808.6 823.8 829.7 829.9 830.1 594.6 607.0 616.0 618.4 618.5 11794.8 11816.2 11869.2 11941.5 11968.0 10363.9 10692.4 11014.9 11143.9 11238.7 9272.3 9310.5 9458.5 9680.0 9692.9 3240.3 3250.3 3251.2 3333.1 3339.1 40151.0 40205.4 40577.4 40822.2 40968.6 9164.4 9203.5 9313.3 9352.3 9484.2 16241.1 16246.0 16248.3 16279.8 16288.8 6185.3 6223.4 6238.4 6308.6 6406.2 3525.7 3530.4 3558.8 3566.6 3606.2 2761.4 2793.4 2803.1 2804.8 2806.1 474.3 481.9 482.4 485.9 487.0 469.6 610.5 630.4 635.3 637.0 7641.6 8772.2 8844.6 8849.9 8894.8 552.3 588.2 595.9 603.4 616.3 3632.3 3677.2 3744.3 3858.3 3860.2 48830.3 51969.5 52380.0 52717.5 53113.5 42534.0 43551.3 43784.3 44624.1 44695.8 41698.4 41811.6 41983.6 42404.4 42606.6 7831.8 7956.5 8190.3 8323.9 8478.4 29772.0 29828.6 30517.5 30757.0 30774.7 38807.6 39006.0 39193.0 40359.0 40614.3 9956.9 10105.0 10153.5 10214.5 10569.5 11423.3 11468.9 11606.7 11647.5 11782.8 10880.9 11205.8 11238.8 11306.7 11699.1 10991.5 10996.2 11030.6 11080.6 11082.9 10836.6 10945.8 11030.9 11340.7 11384.7 9217.0 9306.2 9353.8 9557.6 9807.4 9059.5 9226.4 9291.9 9385.6 9570.6 13:23:40 INFO - 2015-12-04 13:23:40,745 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:23:40 INFO - 2015-12-04 13:23:40,745 DEBUG : BROWSER_OUTPUT: 13:23:41 INFO - 2015-12-04 13:23:41,459 INFO : Browser exited with error code: 0 13:23:41 INFO - 2015-12-04 13:23:41,478 INFO : Completed test dromaeo_css (00:18:34) 13:23:41 INFO - 2015-12-04 13:23:41,478 INFO : Starting test kraken 13:23:41 INFO - 2015-12-04 13:23:41,478 DEBUG : operating with platform_type : linux_ 13:23:41 INFO - 2015-12-04 13:23:41,479 INFO : Initialising browser for kraken test... 13:23:41 INFO - 2015-12-04 13:23:41,485 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVqMC3/profile http://localhost:33164/getInfo.html 13:23:44 INFO - 2015-12-04 13:23:44,996 DEBUG : BROWSER_OUTPUT: console.error: 13:23:44 INFO - 2015-12-04 13:23:44,996 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:23:44 INFO - 2015-12-04 13:23:44,996 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:23:46 INFO - 2015-12-04 13:23:46,261 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:23:46 INFO - 2015-12-04 13:23:46,261 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:23:46 INFO - 2015-12-04 13:23:46,261 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:23:46 INFO - 2015-12-04 13:23:46,261 DEBUG : BROWSER_OUTPUT: __metrics 13:23:46 INFO - 2015-12-04 13:23:46,378 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:23:47 INFO - 2015-12-04 13:23:47,251 INFO : Browser initialized. 13:23:47 INFO - 2015-12-04 13:23:47,252 INFO : Running cycle 1/1 for kraken test... 13:23:47 INFO - 2015-12-04 13:23:47,252 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVqMC3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:23:48 INFO - 2015-12-04 13:23:48,967 DEBUG : BROWSER_OUTPUT: console.error: 13:23:48 INFO - 2015-12-04 13:23:48,968 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:23:48 INFO - 2015-12-04 13:23:48,968 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:23:59 INFO - 2015-12-04 13:23:59,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 143921152 13:23:59 INFO - 2015-12-04 13:23:59,326 DEBUG : BROWSER_OUTPUT: 13:24:01 INFO - 2015-12-04 13:24:01,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33164/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:02 INFO - 2015-12-04 13:24:02,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 143757312 13:24:02 INFO - 2015-12-04 13:24:02,483 DEBUG : BROWSER_OUTPUT: 13:24:05 INFO - 2015-12-04 13:24:05,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33164/tests/kraken/driver.html?testName=audio-dft) 13:24:05 INFO - 2015-12-04 13:24:05,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 143126528 13:24:05 INFO - 2015-12-04 13:24:05,848 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2015-12-04 13:24:08,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33164/tests/kraken/driver.html?testName=audio-fft) 13:24:09 INFO - 2015-12-04 13:24:09,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 138457088 13:24:09 INFO - 2015-12-04 13:24:09,340 DEBUG : BROWSER_OUTPUT: 13:24:11 INFO - 2015-12-04 13:24:11,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33164/tests/kraken/driver.html?testName=audio-oscillator) 13:24:12 INFO - 2015-12-04 13:24:12,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 139464704 13:24:12 INFO - 2015-12-04 13:24:12,052 DEBUG : BROWSER_OUTPUT: 13:24:14 INFO - 2015-12-04 13:24:14,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:24:14 INFO - 2015-12-04 13:24:14,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 140611584 13:24:14 INFO - 2015-12-04 13:24:14,880 DEBUG : BROWSER_OUTPUT: 13:24:17 INFO - 2015-12-04 13:24:17,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33164/tests/kraken/driver.html?testName=imaging-darkroom) 13:24:18 INFO - 2015-12-04 13:24:18,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 141348864 13:24:18 INFO - 2015-12-04 13:24:18,554 DEBUG : BROWSER_OUTPUT: 13:24:22 INFO - 2015-12-04 13:24:22,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33164/tests/kraken/driver.html?testName=imaging-desaturate) 13:24:22 INFO - 2015-12-04 13:24:22,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 138567680 13:24:22 INFO - 2015-12-04 13:24:22,631 DEBUG : BROWSER_OUTPUT: 13:24:25 INFO - 2015-12-04 13:24:25,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33164/tests/kraken/driver.html?testName=json-parse-financial) 13:24:26 INFO - 2015-12-04 13:24:26,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 139374592 13:24:26 INFO - 2015-12-04 13:24:26,078 DEBUG : BROWSER_OUTPUT: 13:24:27 INFO - 2015-12-04 13:24:27,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:24:28 INFO - 2015-12-04 13:24:28,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 140734464 13:24:28 INFO - 2015-12-04 13:24:28,420 DEBUG : BROWSER_OUTPUT: 13:24:30 INFO - 2015-12-04 13:24:30,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:24:30 INFO - 2015-12-04 13:24:30,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 140005376 13:24:30 INFO - 2015-12-04 13:24:30,917 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2015-12-04 13:24:33,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:24:33 INFO - 2015-12-04 13:24:33,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 140820480 13:24:33 INFO - 2015-12-04 13:24:33,663 DEBUG : BROWSER_OUTPUT: 13:24:36 INFO - 2015-12-04 13:24:36,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:24:36 INFO - 2015-12-04 13:24:36,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424 13:24:36 INFO - 2015-12-04 13:24:36,863 DEBUG : BROWSER_OUTPUT: 13:24:39 INFO - 2015-12-04 13:24:39,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:24:40 INFO - 2015-12-04 13:24:40,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 140308480 13:24:40 INFO - 2015-12-04 13:24:40,046 DEBUG : BROWSER_OUTPUT: 13:24:41 INFO - 2015-12-04 13:24:41,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33164/tests/kraken/driver.html?testName=ai-astar) 13:24:42 INFO - 2015-12-04 13:24:42,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 140861440 13:24:42 INFO - 2015-12-04 13:24:42,061 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,065 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:24:42 INFO - 2015-12-04 13:24:42,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:24:42 INFO - 2015-12-04 13:24:42,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:24:42 INFO - 2015-12-04 13:24:42,065 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:24:42 INFO - 2015-12-04 13:24:42,066 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;107;109;110;111;123;111;109;111;112 13:24:42 INFO - 2015-12-04 13:24:42,066 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;129;155;162;129;157;150;135;172;129 13:24:42 INFO - 2015-12-04 13:24:42,066 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;163;163;163;164;168;164;164;161 13:24:42 INFO - 2015-12-04 13:24:42,066 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;72;75;72;74;129;72;73;73;73 13:24:42 INFO - 2015-12-04 13:24:42,066 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;135;94;93;95;140;93;95;132 13:24:42 INFO - 2015-12-04 13:24:42,066 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;111;110;111;111;110;109;110;110 13:24:42 INFO - 2015-12-04 13:24:42,066 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;149;147;147;147;149;150 13:24:42 INFO - 2015-12-04 13:24:42,067 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;98;96;95;95;95;96;96;96 13:24:42 INFO - 2015-12-04 13:24:42,067 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;77;74;72;73;72;72;70;69 13:24:42 INFO - 2015-12-04 13:24:42,067 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;70;69;69;70;69;69;69;70 13:24:42 INFO - 2015-12-04 13:24:42,067 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;84;84;86;84;85;84;83;86 13:24:42 INFO - 2015-12-04 13:24:42,067 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;133;135;125;138;130;133;130;126;132 13:24:42 INFO - 2015-12-04 13:24:42,067 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;155;145;145;149;145;147;145;138;141 13:24:42 INFO - 2015-12-04 13:24:42,067 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;70;70;70;70;68;71;70;68 13:24:42 INFO - 2015-12-04 13:24:42,068 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:24:42 INFO - 2015-12-04 13:24:42,068 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:24:42 INFO - 2015-12-04 13:24:42,068 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,827 13:24:42 INFO - 2015-12-04 13:24:42,068 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:24:42 INFO - 2015-12-04 13:24:42,068 DEBUG : BROWSER_OUTPUT: __startTimestamp1449264282063__endTimestamp 13:24:42 INFO - 2015-12-04 13:24:42,068 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,072 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:24:42 INFO - 2015-12-04 13:24:42,072 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:24:42 INFO - 2015-12-04 13:24:42,072 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,072 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.33 (3.9%) stddev-sans-first:4.59 13:24:42 INFO - 2015-12-04 13:24:42,073 DEBUG : BROWSER_OUTPUT: Values: 112.0 107.0 109.0 110.0 111.0 123.0 111.0 109.0 111.0 112.0 13:24:42 INFO - 2015-12-04 13:24:42,073 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,073 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.20 Median:154.50 stddev:15.59 (10.1%) stddev-sans-first:16.34 13:24:42 INFO - 2015-12-04 13:24:42,073 DEBUG : BROWSER_OUTPUT: Values: 154.0 129.0 155.0 162.0 129.0 157.0 150.0 135.0 172.0 129.0 13:24:42 INFO - 2015-12-04 13:24:42,073 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,073 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.77 (1.1%) stddev-sans-first:1.87 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 163.0 163.0 163.0 164.0 168.0 164.0 164.0 161.0 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:73.00 stddev:17.63 (24.1%) stddev-sans-first:18.69 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: Values: 80.0 72.0 75.0 72.0 74.0 129.0 72.0 73.0 73.0 73.0 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:94.00 stddev:20.23 (21.5%) stddev-sans-first:20.94 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 135.0 94.0 93.0 95.0 140.0 93.0 95.0 132.0 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 111.0 110.0 111.0 111.0 110.0 109.0 110.0 110.0 13:24:42 INFO - 2015-12-04 13:24:42,074 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 149.0 147.0 147.0 147.0 149.0 150.0 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 98.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:2.16 (3.0%) stddev-sans-first:2.29 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 77.0 74.0 72.0 73.0 72.0 72.0 70.0 69.0 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,075 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 69.0 69.0 70.0 69.0 69.0 69.0 70.0 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.01 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 84.0 84.0 86.0 84.0 85.0 84.0 83.0 86.0 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:132.50 stddev:3.89 (2.9%) stddev-sans-first:4.12 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: Values: 132.0 133.0 135.0 125.0 138.0 130.0 133.0 130.0 126.0 132.0 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:145.00 stddev:4.50 (3.1%) stddev-sans-first:4.77 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: Values: 145.0 155.0 145.0 145.0 149.0 145.0 147.0 145.0 138.0 141.0 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 70.0 70.0 68.0 71.0 70.0 68.0 13:24:42 INFO - 2015-12-04 13:24:42,076 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:24:42 INFO - 2015-12-04 13:24:42,077 DEBUG : BROWSER_OUTPUT: 13:24:42 INFO - 2015-12-04 13:24:42,927 INFO : Browser exited with error code: 0 13:24:42 INFO - 2015-12-04 13:24:42,984 INFO : Completed test kraken (00:01:01) 13:24:42 INFO - 2015-12-04 13:24:42,984 INFO : Starting test v8_7 13:24:42 INFO - 2015-12-04 13:24:42,984 DEBUG : operating with platform_type : linux_ 13:24:42 INFO - 2015-12-04 13:24:42,984 INFO : Initialising browser for v8_7 test... 13:24:42 INFO - 2015-12-04 13:24:42,990 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJU0oQ5/profile http://localhost:33164/getInfo.html 13:24:46 INFO - 2015-12-04 13:24:46,541 DEBUG : BROWSER_OUTPUT: console.error: 13:24:46 INFO - 2015-12-04 13:24:46,542 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:24:46 INFO - 2015-12-04 13:24:46,542 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:24:47 INFO - 2015-12-04 13:24:47,768 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:24:47 INFO - 2015-12-04 13:24:47,768 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:24:47 INFO - 2015-12-04 13:24:47,768 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:24:47 INFO - 2015-12-04 13:24:47,768 DEBUG : BROWSER_OUTPUT: __metrics 13:24:47 INFO - 2015-12-04 13:24:47,930 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:24:48 INFO - 2015-12-04 13:24:48,875 INFO : Browser initialized. 13:24:48 INFO - 2015-12-04 13:24:48,876 INFO : Running cycle 1/1 for v8_7 test... 13:24:48 INFO - 2015-12-04 13:24:48,876 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJU0oQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:24:50 INFO - 2015-12-04 13:24:50,531 DEBUG : BROWSER_OUTPUT: console.error: 13:24:50 INFO - 2015-12-04 13:24:50,531 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:24:50 INFO - 2015-12-04 13:24:50,531 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:25:00 INFO - 2015-12-04 13:25:00,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 143642624 13:25:00 INFO - 2015-12-04 13:25:00,904 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33164/tests/v8_7/run.html (next: http://localhost:33164/tests/v8_7/run.html) 13:25:22 INFO - 2015-12-04 13:25:22,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 137904128 13:25:22 INFO - 2015-12-04 13:25:22,573 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,574 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:25:22 INFO - 2015-12-04 13:25:22,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:25:22 INFO - 2015-12-04 13:25:22,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:25:22 INFO - 2015-12-04 13:25:22,574 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:25:22 INFO - 2015-12-04 13:25:22,574 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6451880072884 13:25:22 INFO - 2015-12-04 13:25:22,574 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.21948508983144 13:25:22 INFO - 2015-12-04 13:25:22,574 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 13:25:22 INFO - 2015-12-04 13:25:22,575 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 13:25:22 INFO - 2015-12-04 13:25:22,575 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1052.6315789473683 13:25:22 INFO - 2015-12-04 13:25:22,575 DEBUG : BROWSER_OUTPUT: |5;Earley;700.2801120448179 13:25:22 INFO - 2015-12-04 13:25:22,575 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 13:25:22 INFO - 2015-12-04 13:25:22,575 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 13:25:22 INFO - 2015-12-04 13:25:22,575 DEBUG : BROWSER_OUTPUT: |8;Splay;604.2296072507553 13:25:22 INFO - 2015-12-04 13:25:22,576 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:25:22 INFO - 2015-12-04 13:25:22,576 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:25:22 INFO - 2015-12-04 13:25:22,576 DEBUG : BROWSER_OUTPUT: __startTimestamp1449264322572__endTimestamp 13:25:22 INFO - 2015-12-04 13:25:22,576 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,576 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:25:22 INFO - 2015-12-04 13:25:22,577 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:25:22 INFO - 2015-12-04 13:25:22,577 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,577 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.65 Median:165.65 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,577 DEBUG : BROWSER_OUTPUT: Values: 165.6 13:25:22 INFO - 2015-12-04 13:25:22,577 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,577 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.22 Median:185.22 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,577 DEBUG : BROWSER_OUTPUT: Values: 185.2 13:25:22 INFO - 2015-12-04 13:25:22,578 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,579 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,579 DEBUG : BROWSER_OUTPUT: Values: 278.2 13:25:22 INFO - 2015-12-04 13:25:22,579 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,579 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,579 DEBUG : BROWSER_OUTPUT: Values: 5138.5 13:25:22 INFO - 2015-12-04 13:25:22,580 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,580 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1052.63 Median:1052.63 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,580 DEBUG : BROWSER_OUTPUT: Values: 1052.6 13:25:22 INFO - 2015-12-04 13:25:22,580 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,580 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,580 DEBUG : BROWSER_OUTPUT: Values: 700.3 13:25:22 INFO - 2015-12-04 13:25:22,580 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,581 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,581 DEBUG : BROWSER_OUTPUT: Values: 12231.7 13:25:22 INFO - 2015-12-04 13:25:22,581 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,581 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,581 DEBUG : BROWSER_OUTPUT: Values: 25871.8 13:25:22 INFO - 2015-12-04 13:25:22,581 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,581 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.23 Median:604.23 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,582 DEBUG : BROWSER_OUTPUT: Values: 604.2 13:25:22 INFO - 2015-12-04 13:25:22,582 DEBUG : BROWSER_OUTPUT: 13:25:22 INFO - 2015-12-04 13:25:22,582 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:25:22 INFO - 2015-12-04 13:25:22,582 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:25:22 INFO - 2015-12-04 13:25:22,582 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:25:22 INFO - 2015-12-04 13:25:22,582 DEBUG : BROWSER_OUTPUT: 13:25:23 INFO - 2015-12-04 13:25:23,483 INFO : Browser exited with error code: 0 13:25:23 INFO - 2015-12-04 13:25:23,498 INFO : Completed test v8_7 (00:00:40) 13:25:23 INFO - 2015-12-04 13:25:23,567 INFO : Completed test suite (00:20:16) 13:25:23 INFO - 2015-12-04 13:25:23,567 DEBUG : Working with test: dromaeo_css 13:25:23 INFO - 2015-12-04 13:25:23,567 DEBUG : Generating results file: dromaeo_css 13:25:23 INFO - 2015-12-04 13:25:23,568 DEBUG : Working with test: kraken 13:25:23 INFO - 2015-12-04 13:25:23,569 DEBUG : Generating results file: kraken 13:25:23 INFO - 2015-12-04 13:25:23,569 INFO : javascript benchmark 13:25:23 INFO - 2015-12-04 13:25:23,569 DEBUG : Working with test: v8_7 13:25:23 INFO - 2015-12-04 13:25:23,569 DEBUG : Generating results file: v8_7 13:25:23 INFO - 2015-12-04 13:25:23,570 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:25:23 INFO - 2015-12-04 13:25:23,694 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 13:25:23 INFO - 2015-12-04 13:25:23,694 DEBUG : process_Request line: dromaeo_css 6312.33 graph.html#tests=[[72,132,43]] 13:25:23 INFO - 2015-12-04 13:25:23,694 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:25:23 INFO - 2015-12-04 13:25:23,723 DEBUG : process_Request line: kraken 1534.50 graph.html#tests=[[232,132,43]] 13:25:23 INFO - 2015-12-04 13:25:23,724 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:25:23 INFO - 2015-12-04 13:25:23,756 DEBUG : process_Request line: v8_7 21476.70 graph.html#tests=[[230,132,43]] 13:25:23 INFO - 2015-12-04 13:25:23,757 INFO : javascript benchmark 13:25:23 INFO - 2015-12-04 13:25:23,760 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2649.231722800387, 2695.514807334679, 2715.321169707573, 2735.398212393274, 2745.835249885007, 4583.702059366139, 4747.691400058994, 4747.952520474794, 4750.809967601296, 4771.35586695796, 4642.6982246153975, 4699.577038066574, 4703.15343238217, 4796.376471058767, 4808.735519546423, 4263.509696384925, 4325.26470500015, 4415.359772832937, 4418.425604671388, 4452.0, 4201.159768046387, 4370.847020354288, 4405.6475481961525, 4408.779561021952, 4505.098980203972, 4231.724937879028, 4265.616094551474, 4342.717723347972, 4386.232409328387, 4388.144311859189, 4378.9562104378865, 4398.8900277493, 4412.227860124497, 4416.624586910117, 4476.239039363316, 4161.126163505667, 4281.593248641374, 4385.627221686161, 4399.362092496602, 4434.423524941769, 4609.262517997105, 4687.1328804171335, 4698.060387922429, 4715.056988602259, 4721.220998535237, 5012.974935125338, 5033.697978121288, 5038.622103342264, 5039.596832253447, 5088.211327244283, 4863.902721945577, 4925.187344088221, 4958.057968985881, 5058.772355244023, 5098.337216161913, 4741.502142275081, 4751.881202969919, 4759.809607615691, 4762.499937506581, 4800.039992001613, 5220.0, 5230.3985041719925, 5232.162853943427, 5251.789928402897, 5257.08001099806, 4699.929501057487, 4804.663673542888, 4869.366982292279, 4977.32806071183, 5048.469910659328, 5074.11203039474, 5078.796848126033, 5098.566621837185, 5104.234364845229, 5138.691678499227, 5045.747712614355, 5056.772445239973, 5060.974695126501, 5064.316317297192, 5064.924026139611, 4784.784684689197, 4876.804927802848, 4902.681325713817, 4964.751762411937, 4998.850034498971, 4133.42132101506, 4174.603412675791, 4203.222403855297, 4211.989122610551, 4242.278812601865, 3593.4789455529326, 3693.8153092345274, 3710.257948410275, 3724.1620635356826, 3726.2547490502006, 4246.596573325529, 4332.523422423531, 4335.891602709894, 4335.978320108442, 4375.584319489643, 5114.462981386975, 5124.7950081996305, 5126.615503837153, 5128.794848206105, 5139.563137133386, 4218.303979843353, 4362.280223763044, 4418.7127836690515, 4425.778711064434, 4470.061287129674, 4415.602595766396, 4455.465344158657, 4469.128519938646, 4494.865154045384, 4501.144782491317, 4817.855464336076, 4871.537203965618, 4879.682820616648, 4891.144049791344, 4920.48334924842, 4864.562189402971, 4987.825426110068, 4997.375328083989, 5074.517920797518, 5097.413797413345, 4881.463039065771, 4894.290327902506, 4914.434839993446, 4916.434610019894, 4966.130927087817, 5090.338256026693, 5097.337346144977, 5100.0, 5107.41264754558, 5115.488451154854, 4777.880552986064, 4930.235813448921, 4939.16034274167, 4946.1097002538445, 5199.090159222045, 4902.485239049848, 4915.213565829593, 4918.040982008617, 4928.408590969107, 4929.630277729257, 4962.8759281018265, 4964.35463389757, 4969.155243608668, 4976.975115124401, 4986.227134794112, 4623.214053610962, 4661.790219440066, 4743.620510359232, 4847.684900481458, 4866.099771542276, 4914.827981020647, 4932.457429682804, 4933.851984440473, 4941.466851201265, 4976.751162441936, 4796.784144713566, 4798.760061996956, 4811.591014763784, 4811.735354555533, 4847.61219102478], "unit": "ms", "name": "dojo.html", "value": 4638.282465136545}, {"lowerIsBetter": false, "replicates": [548.3340949084653, 568.2215364950019, 576.0725232375871, 589.0457458916555, 592.1029640095256, 27060.05289814857, 35406.0526671033, 35863.28273434536, 35869.46195807062, 36013.0996725082, 37735.433968490426, 38284.80857595708, 38320.0, 38336.616633833655, 38352.42471362932, 7976.2821346078845, 8063.516189028648, 8079.394045446615, 8103.027636683606, 8131.837363252732, 7737.651805668758, 7926.445148839583, 7928.563928983904, 7930.801729956739, 7945.205479452037, 7864.606769661523, 7969.641366138509, 7971.163027882076, 7974.920250797476, 7982.401319901031, 7882.369410447151, 7909.485883417588, 7942.126366099725, 7961.761147165595, 7967.880481792778, 7781.0, 7997.120316765151, 8007.839843203162, 8009.799755006172, 8022.719204827861, 35740.82129589361, 36146.45780313297, 36320.63679363199, 36349.454758178385, 36385.45421818675, 2814.1698199031334, 2871.684114747376, 3173.016364926857, 3174.4286028514857, 3372.4941258811127, 27550.862245688844, 27756.167314980583, 28297.292567685767, 28344.433111337865, 28594.14217573476, 3175.5712978747806, 3192.9361412771846, 3206.8236247006407, 3222.4682927316962, 3249.0, 218342.0, 223413.0, 223741.0, 224231.0, 225987.87006065028, 46319.0, 47199.5280047202, 53725.1941220882, 53872.0, 53982.0, 63886.36113638897, 64402.677986609764, 64582.35417645764, 65194.67402662956, 65427.34572654308, 14270.500532481521, 14408.567742967727, 14488.710225795425, 14503.202323872289, 14532.200728959797, 10897.455127243764, 10965.671029869116, 10987.230893837355, 10993.340399576051, 11000.22998390121, 18808.247670093042, 19082.0, 19087.0, 19101.140448679842, 19162.52093697641, 7575.431842611826, 7858.214178582096, 7869.685212591432, 7918.6436610352675, 7970.4819186752675, 884.8716936044366, 894.2482231268033, 957.3107362698846, 1023.636609003793, 1029.984550231747, 26130.86934565315, 26429.603555946676, 26957.0, 29144.85427572891, 30636.080917572508, 947.8672985781996, 975.4293738163112, 1003.6085926488676, 1056.8573242612304, 1070.8714954205545, 13209.603711888467, 13595.252261125734, 13627.318634068257, 13627.931860340834, 14813.703725925421, 317082.0, 321634.0, 321668.0, 322948.8525573712, 326523.0, 46695.533044669115, 46862.297065544044, 46926.5307346929, 47046.29430558544, 47154.0, 1190.1549899571228, 1220.4446976625613, 1225.9203151795105, 1227.699213692651, 1235.7775600392015, 26706.332341691614, 26886.59670104989, 27271.318217044733, 27304.72695273022, 27520.724792751815, 38601.227975439775, 39008.414873776346, 39229.41155882607, 39374.0, 39383.2123357537, 256391.0, 259592.0, 259975.0, 260283.0, 261475.0, 29306.069393060523, 38761.224775504896, 38920.6107938917, 39127.413088804264, 39226.0, 37101.814490927376, 38439.423408649454, 38667.613323867525, 39080.41379379368, 39636.0, 33126.503102453, 33647.663523364456, 33773.66226337705, 33798.83100584481, 34046.0, 33057.173570660925, 33705.494417583264, 33730.325393491505, 33924.0, 34058.14854628654, 34593.30813383769, 34950.82524587361, 35371.64628353684, 35487.11282217965, 35557.46663799993, 29435.41129177447, 30418.391632167677, 30446.695533044385, 30789.23026924345, 30809.38381232318, 24003.63994540118, 24086.0, 25892.482150357264, 27248.591271130554, 27364.72635273622], "unit": "ms", "name": "ext.html", "value": 17278.41679871411}, {"lowerIsBetter": false, "replicates": [333.4897606661808, 333.59135059552034, 338.78317876559004, 338.8915547024952, 340.1224839913024, 15759.684806303867, 15917.840821591795, 16013.83986160138, 16406.26171822268, 16711.749323760137, 9677.806443871119, 9917.107460328569, 12438.875611243884, 14255.429782808702, 14316.71366572668, 4507.368968344426, 4626.97686511567, 4639.814407423699, 4657.161710892038, 5145.434002259748, 5110.693358398489, 5118.07874582575, 5131.512506311894, 5136.537711605954, 5148.768305426246, 4920.089783390084, 5067.721275329855, 5072.695638261697, 5137.0, 5159.845204643848, 4997.300377947054, 5014.147594908874, 5037.823676171335, 5061.164907790228, 5102.311187989611, 5163.5352818246165, 5165.173572228463, 5169.612279079084, 5190.247414124969, 5195.68825870449, 10602.204834637432, 10653.9467302663, 10839.67480975572, 11270.774584508265, 11382.715432114263, 1870.261246807517, 1888.2635772048911, 1898.7531620889197, 1919.155571548528, 1978.792226816178, 9033.187013168847, 9132.08679132088, 9172.908270917338, 11220.551177952872, 12578.748425031448, 1725.9395921142825, 1732.1858726398573, 1765.3821162593117, 1827.2416946966994, 1860.7860096088987, 56043.43956560464, 56249.0, 56365.43634563684, 57094.0, 57112.71443642797, 9871.259655525864, 9921.80156396868, 9933.205343572497, 9986.750331241778, 10034.197264218845, 12469.0, 12541.0, 12577.0, 12582.24506529611, 12615.369231538387, 6948.791536253921, 7043.542169758949, 7064.646767661699, 7097.9645101775195, 7112.35988761014, 6767.796966091025, 6772.255051944282, 6780.084688567079, 6806.897896531556, 6815.625140617313, 4120.958790412057, 4175.770332631673, 4207.137536804948, 4223.1975924574235, 4260.318349064197, 1760.0847559269364, 1767.169430367725, 1776.5114593486635, 1790.6955817511055, 1796.8293012163824, 377.8904117805861, 381.26035491147087, 386.54387822369875, 394.9131191137945, 421.6647765026811, 9589.42463452195, 10106.191504679608, 10184.0, 10287.845682314772, 10372.688819335432, 392.1275162762887, 400.7755656832183, 412.9318662420727, 422.12409250804706, 429.40312964978705, 5497.36780270274, 5632.155176723442, 8967.775805604912, 9388.95305523468, 9399.90600094004, 454818.0, 454977.0, 459528.0, 476056.0, 480488.0, 62147.0, 63331.0, 65286.67356663281, 71836.64081679663, 73980.26019739841, 969.5685419988179, 989.4459102902398, 998.9800203995879, 1000.6347683095618, 1026.1688032693542, 14852.925735371255, 15081.622959426102, 15205.163715995726, 15226.162561059247, 15476.767848482057, 32706.182345441553, 33043.66956330406, 33643.327133457686, 34000.82999584986, 34178.24039355619, 40979.795101024305, 41184.38223426591, 45379.54620453753, 47952.28071578999, 49327.26009109938, 8497.575121244037, 8721.476711397336, 8775.166359195866, 8823.69117080899, 8842.778930526789, 10093.899061009295, 11239.887601123884, 16852.15739213059, 17074.829251707324, 17106.657866842346, 13140.0801943863, 13146.342682865627, 13510.324483775968, 13674.247916364298, 14285.142891426547, 13739.24434156131, 13744.0, 13848.376823042785, 14007.859921401063, 14381.92809035948, 13314.733705326033, 14313.603075977628, 14336.139831610137, 14680.339384727926, 15032.173230472428, 8309.459885107448, 8420.11588783169, 8691.521966291662, 8747.081556436482, 8757.737267881974, 10123.341982771097, 12536.185147965352, 12669.873301267238, 13279.66800829987, 13530.93234533821], "unit": "ms", "name": "jquery.html", "value": 7660.129250879263}, {"lowerIsBetter": false, "replicates": [1450.3690894460917, 1635.1415506858898, 1684.5367523930918, 1716.0647447141312, 1723.1901006526937, 6122.173506576611, 6368.586041907272, 6731.629760363184, 7124.964375178123, 7199.208087110427, 6819.488538359618, 7023.19233288172, 7086.645667716606, 7106.360427561532, 7114.324139206767, 2051.8358531317535, 2104.926327578535, 2107.7154584131176, 2107.8524503284775, 2109.050927082811, 2100.2544096845627, 2120.7455105387376, 2138.29436286026, 2152.924647637333, 2157.0832396231617, 1981.6333978214004, 2019.8081182287733, 2047.0072015072678, 2047.9590408191827, 2048.9282875099375, 2073.9170433182653, 2086.6035453263985, 2087.405089549479, 2093.706881036656, 2101.0, 2028.1684509351244, 2060.6393881070753, 2064.112431654388, 2064.3910046536307, 2066.9379918602467, 7112.110986126734, 7206.1352637683285, 7209.243029481934, 7210.2789721028, 7218.530795498328, 4033.616806403387, 4121.732087414309, 4124.216398884202, 4126.319157339036, 4129.91740165195, 2324.372419446757, 2380.3929997850437, 2656.5749480083095, 2686.892524299026, 2705.188443466952, 893.0877590351847, 898.1422741282059, 920.9685152629031, 935.7567032571512, 942.5475771629656, 9475.431474111507, 9654.131128198425, 9676.225901927828, 9685.661001864972, 9692.95153524235, 3704.870329538507, 3812.4471951566866, 3826.196498735241, 3831.2912111259507, 3952.960470395259, 8311.792205194919, 8321.0, 8370.79073023167, 8371.665133394596, 8384.748457546284, 4214.515330736943, 4217.0511634881905, 4247.299195632748, 4261.4673165854265, 4276.059266961263, 3824.579296277407, 3834.463175155425, 3851.094992676719, 3854.5374555053572, 3854.9614503855164, 3320.93358132836, 3322.318924620447, 3324.3849887770357, 3347.4644056951256, 3353.3628610563915, 1043.6764602973103, 1045.1429827541342, 1053.0680347892016, 1053.657561292583, 1053.8893416191343, 914.1498406481903, 925.8194652042787, 936.5083331251011, 967.2552134856262, 1218.2386008744534, 6752.426043786235, 6778.627175505296, 6787.592744435349, 6817.761378351734, 6827.2931767058235, 418.30978884839647, 423.03336875239927, 1063.7074804428844, 1112.6606385052637, 1125.994370028161, 5365.141577347606, 5385.3268341457315, 5408.91886621701, 5413.431589683105, 5420.457954204627, 8219.465734727224, 8441.198086181803, 8553.486790792573, 8557.743267701979, 8578.78553036179, 8392.28665563434, 8406.789830254293, 8426.620802063922, 8441.535715535705, 8449.36629752771, 6740.662966851736, 6763.0, 6813.454923606, 6847.554908930903, 6884.277150899184, 6592.90110648331, 6632.867342653023, 6648.401643852077, 6673.866522669422, 6683.030960510796, 7312.707491700486, 7519.511231769918, 7524.924750752422, 7532.924670753441, 7562.357199637872, 7578.545287282781, 7685.654145563351, 7760.728374506865, 7785.104712958082, 7840.80397990032, 6093.116498107661, 6459.321771213955, 6532.934670653232, 6537.444317233088, 6578.572392794453, 6696.966515167393, 6784.457243420416, 6822.317768223138, 6835.555688880207, 6844.555103918229, 6369.172007638977, 6463.64449955257, 6540.901886471802, 6609.966950165219, 6660.300668429745, 6482.57863238888, 6513.348665133638, 6563.343665633399, 6572.868542629216, 6604.0754294399785, 6660.83347916306, 6661.833454163685, 6677.76627818024, 6684.264730879697, 6707.195136583641, 5967.254093238345, 6018.127371531016, 6065.120557519223, 6094.08588711679, 6130.448259656652, 6142.170806941006, 6180.8763824722355, 6188.133661287334, 6197.4732147767945, 6215.81352559424], "unit": "ms", "name": "mootools.html", "value": 4080.9795703846753}, {"lowerIsBetter": false, "replicates": [297.83916684990106, 305.74775809956793, 306.7760534809589, 312.22100858358397, 315.0595472514544, 5492.0, 5564.276644036279, 5597.636153650015, 5719.799807006755, 5737.942620573798, 5561.193626924104, 5605.0, 5617.775288988436, 5624.775008999645, 5628.887422251552, 4135.483064616923, 4242.936355954663, 4294.09823936972, 4294.312909934411, 4296.613304802567, 4217.325227963526, 4238.894027649318, 4240.97879510602, 4242.512111107231, 4243.0, 4187.979060104695, 4188.099558594901, 4190.28765109932, 4194.97902510487, 4205.936910946339, 4191.559886211934, 4206.621404073633, 4214.304639734441, 4218.641415479688, 4220.050488640047, 3578.3380074686265, 3669.6330366963357, 3686.4286035664513, 3688.243909998444, 3694.242680250542, 5214.582833373321, 5336.706481143536, 5344.599155063347, 5367.570594352443, 5367.758450869681, 4833.371661683994, 4855.053264613402, 4855.223164293696, 4861.124997500448, 4874.122657921573, 5843.561732870052, 5848.795292164754, 5855.180274761537, 5857.150713146612, 5869.383714709937, 3846.230753849213, 3972.920541589152, 3996.540397854255, 3999.9400008999887, 4005.018770401241, 6100.267967843887, 6176.258848938156, 6179.258488981306, 6184.938150618526, 6190.907136392958, 4078.857239996586, 4083.448734420815, 4086.0397806515443, 4088.856890008895, 4089.97955010229, 4149.25313443583, 4149.7095203335475, 4155.750654960651, 4156.044109854751, 4167.354060120686, 4706.717596944194, 4806.423229212447, 4810.350602668665, 4811.879703007383, 4816.662833601615, 5827.912581311284, 5832.708364581754, 5834.066549352084, 5839.9124013139835, 5852.824415267549, 1460.8685218330402, 1483.1323675649867, 1484.383980648019, 1486.3385793322084, 1486.37572219668, 964.9276304277207, 982.6708052802248, 988.41189492252, 991.7421470417744, 993.3592832622918, 5095.8726031848755, 5103.566196873233, 5110.131277682803, 5114.002769459994, 5116.8464946050935, 6003.159557661931, 6024.096385542204, 6050.062240352752, 6077.513798896078, 6081.148639190517, 5057.216131499624, 5058.671186372874, 5085.084684756779, 5085.567726743194, 5101.948980510221, 3205.599300087489, 3255.544223808669, 3261.9347613047607, 3270.0, 3293.637699853014, 5633.239512665819, 5734.77060917567, 5752.223449834219, 5762.1068734346245, 5806.44838740319, 6316.178896743394, 6316.30520642729, 6336.714847831767, 6337.873242535124, 6339.873202535923, 5817.0, 5817.069268916953, 5817.447342502455, 5830.76676932918, 5839.328477225088, 5915.526757859275, 6135.202423684892, 6137.570370074052, 6143.354947730424, 6147.293061298008, 5922.082077278029, 5990.101484777144, 5994.700264986646, 6008.849778755566, 6012.158297838394, 5792.189093526994, 5813.7674493021495, 5823.679697616672, 5829.038208695518, 5833.620814647034, 4085.754854708727, 4144.834206631822, 4146.170765846782, 4164.729292595972, 4168.979155104205, 6005.249343832021, 6122.326544080059, 6137.171481849893, 6139.079138129137, 6145.600535965148, 5823.068309070529, 5850.356460789395, 5879.617824841372, 5890.4993075589055, 5904.911426328695, 5837.270341207349, 5847.093700476433, 5896.027155519291, 5898.557608179318, 5903.0, 5623.718814059363, 5762.2221000164445, 5770.6249093808765, 5775.884482310246, 5776.786874756348, 5941.732622032106, 5947.316058653138, 5947.851303717442, 5961.225040744675, 5963.850903727442, 5746.051901436216, 5753.338366087954, 5753.884922301614, 5759.193712880116, 5759.424057594207], "unit": "ms", "name": "prototype.html", "value": 4370.197450748514}, {"lowerIsBetter": false, "replicates": [642.8088860628701, 681.8704446155233, 701.5545128843185, 708.9220185779564, 724.2865777209448, 10443.582256709722, 10503.474826258685, 10680.839787403176, 10704.30422022568, 10769.569217231301, 11018.44907754611, 13046.869531304685, 13355.933220333909, 13362.0, 13389.93305033476, 615.59986009094, 623.4575918950519, 790.2729488870239, 802.863513202754, 803.5982008995502, 788.0346575445092, 796.8127490039836, 800.607702225908, 806.1374329467473, 807.3904202327235, 810.2586133687669, 834.1991687979516, 834.6577903059747, 842.7092653034694, 844.8310337932407, 808.640155130967, 823.7734622978699, 829.7261903571807, 829.8755186721979, 830.1200727229126, 594.6313285762811, 607.034814644717, 616.0451300484276, 618.4495798739126, 618.5237367227255, 11794.764104717944, 11816.172867899251, 11869.228500147548, 11941.462634181482, 11968.0, 10363.948180259125, 10692.358458492516, 11014.944925275322, 11143.888561114447, 11238.66284011481, 9272.30457715674, 9310.487923164223, 9458.52707364629, 9680.031996800333, 9692.903070969342, 3240.287136829894, 3250.3011852451837, 3251.1872031992, 3333.1333853198103, 3339.1151344893624, 40151.0, 40205.39691904624, 40577.391339129936, 40822.18355632871, 40968.59031409708, 9164.404313719588, 9203.493807840632, 9313.34806563534, 9352.345335826563, 9484.193843523377, 16241.106739129225, 16246.025238485492, 16248.268827902773, 16279.837201628068, 16288.837111628969, 6185.319614842364, 6223.439890409885, 6238.438540531374, 6308.589941653778, 6406.199225096863, 3525.7003154732133, 3530.382183117944, 3558.822058897045, 3566.6433356664643, 3606.206634540397, 2761.4477104578764, 2793.385455199853, 2803.1170181392795, 2804.831710097401, 2806.116073436861, 474.29803890242636, 481.898801251734, 482.41627630566705, 485.89310351722565, 486.99026019479413, 469.6172619315247, 610.4902406490542, 630.4011189370117, 635.2789583822395, 637.0285314894822, 7641.579713115721, 8772.166644168921, 8844.55777211137, 8849.867251991225, 8894.777630559287, 552.3454706173197, 588.1853632718716, 595.8689088400545, 603.3815339277188, 616.3035769580435, 3632.2553876455263, 3677.2093999790172, 3744.26986737589, 3858.3055050090693, 3860.1507668312925, 48830.26754598684, 51969.5038120235, 52380.0, 52717.47282527126, 53113.468865311625, 42534.0, 43551.34672979908, 43784.343234851505, 44624.107517849465, 44695.776521117186, 41698.37452438216, 41811.58188418077, 41983.58016419797, 42404.363934541005, 42606.57393426026, 7831.843363132592, 7956.482828616122, 8190.262876341158, 8323.875141872755, 8478.364122690946, 29772.0, 29828.552571711876, 30517.542236866022, 30757.0, 30774.692253077184, 38807.61192388153, 39006.0, 39193.0, 40359.0, 40614.344708976336, 9956.900430995598, 10105.040021197974, 10153.543090560795, 10214.540345684314, 10569.471526423495, 11423.314601123959, 11468.94265528667, 11606.651800446, 11647.534098635959, 11782.764344712887, 10880.94559527229, 11205.775884482428, 11238.83141752858, 11306.717332066764, 11699.122565807429, 10991.450427478754, 10996.230263881771, 11030.558777649125, 11080.5567777288, 11082.889171108185, 10836.620718274822, 10945.83581246266, 11030.889691102986, 11340.716482088013, 11384.658460246206, 9216.95391523038, 9306.208972237166, 9353.812923741623, 9557.569909354235, 9807.411555306704, 9059.501727405055, 9226.446413215228, 9291.860622090539, 9385.577649005674, 9570.569324380558], "unit": "ms", "name": "yui.html", "value": 5777.3849280314635}], "name": "dromaeo_css", "value": 6312.328695944208}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 109.0, 110.0, 111.0, 123.0, 111.0, 109.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 155.0, 162.0, 129.0, 157.0, 150.0, 135.0, 172.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 164.0, 168.0, 164.0, 164.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 75.0, 72.0, 74.0, 129.0, 72.0, 73.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 135.0, 94.0, 93.0, 95.0, 140.0, 93.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 149.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 98.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 77.0, 74.0, 72.0, 73.0, 72.0, 72.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 84.0, 84.0, 86.0, 84.0, 85.0, 84.0, 83.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [132.0, 133.0, 135.0, 125.0, 138.0, 130.0, 133.0, 130.0, 126.0, 132.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 131.4}, {"lowerIsBetter": true, "replicates": [145.0, 155.0, 145.0, 145.0, 149.0, 145.0, 147.0, 145.0, 138.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 68.0, 71.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1534.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6451880072884], "unit": "score", "name": "Richards", "value": 213.11817399999993}, {"lowerIsBetter": false, "replicates": [185.21948508983144], "unit": "score", "name": "DeltaBlue", "value": 356.97108199999985}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1052.6315789473683], "unit": "score", "name": "RayTrace", "value": 702.9895499999999}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Earley", "value": 951.7091640000002}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [604.2296072507553], "unit": "score", "name": "Splay", "value": 134.86760500000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21476.700858669843}]} 13:25:23 INFO - RETURN: dromaeo_css: 6312.33 13:25:23 INFO - RETURN: kraken: 1534.50 13:25:23 INFO - RETURN: v8_7: 21476.70 13:25:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21476.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1534.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6312.33"}}} 13:25:23 INFO - Return code: 0 13:25:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:25:23 INFO - # TBPL SUCCESS # 13:25:23 INFO - Running post-action listener: _resource_record_post_action 13:25:23 INFO - Running post-run listener: _resource_record_post_run 13:25:24 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520204288; Read time: 12; Write time: 457988 13:25:24 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 230785024; Read time: 0; Write time: 251416 13:25:25 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274075648; Read time: 12; Write time: 181640 13:25:25 INFO - Running post-run listener: _upload_blobber_files 13:25:25 INFO - Blob upload gear active. 13:25:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:25:25 INFO - Copying logs to upload dir... 13:25:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.204954 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-04 13:25:24.846870) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:25:24.850864) ========= 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=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010029 build_url: 'https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:25:24.901187) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:25:24.901512) ========= 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=a65b340e283ce644d68cb24e000001c9-1449263057.937798-1662755264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:25:24.951182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:25:24.951500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:25:24.951795) ========= ========= Total master_lag: 0.23 =========