builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1449254519.08 results: success (0) buildid: 20151204092716 builduid: 0286db1e1eca49b195f71af644232f3a revision: f682b6e626841acb178c9ab57d2bc924bda7094a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 10:41:59.082737) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 10:41:59.083420) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 10:41:59.083732) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006296 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 10:41:59.114455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 10:41:59.114804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 10:41:59.128128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 10:41:59.128436) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004691 ========= master_lag: 1.39 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 10:42:00.525638) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:00.525974) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:00.526391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:00.526665) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 10:42:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-12-04 10:42:00 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:00.660751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:00.664151) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019717 ========= master_lag: 0.31 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:00.998151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:00.998491) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f682b6e626841acb178c9ab57d2bc924bda7094a --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 f682b6e626841acb178c9ab57d2bc924bda7094a --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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 10:42:01,018 truncating revision to first 12 chars 2015-12-04 10:42:01,018 Setting DEBUG logging. 2015-12-04 10:42:01,018 attempt 1/10 2015-12-04 10:42:01,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f682b6e62684?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 10:42:01,283 unpacking tar archive at: fx-team-f682b6e62684/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:01.573218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:01.573543) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:01.585887) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:01.586218) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 10:42:01.586660) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 30 secs) (at 2015-12-04 10:42:01.586943) ========= /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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:42:01 INFO - MultiFileLogger online at 20151204 10:42:01 in /builds/slave/test 10:42:01 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 10:42:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:42:01 INFO - {'append_to_log': False, 10:42:01 INFO - 'base_work_dir': '/builds/slave/test', 10:42:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:42:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:42:01 INFO - 'branch': 'Fx-Team-Non-PGO', 10:42:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:42:01 INFO - 'config_files': ('talos/linux_config.py',), 10:42:01 INFO - 'default_actions': ('clobber', 10:42:01 INFO - 'read-buildbot-config', 10:42:01 INFO - 'download-and-extract', 10:42:01 INFO - 'populate-webroot', 10:42:01 INFO - 'create-virtualenv', 10:42:01 INFO - 'install', 10:42:01 INFO - 'run-tests'), 10:42:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:42:01 INFO - 'download_minidump_stackwalk': True, 10:42:01 INFO - 'download_symbols': 'ondemand', 10:42:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:42:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:42:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:42:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:42:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:42:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:42:01 INFO - 'installer_path': 'installer.exe', 10:42:01 INFO - 'log_level': 'info', 10:42:01 INFO - 'log_name': 'talos', 10:42:01 INFO - 'log_to_console': True, 10:42:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:42:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:42:01 INFO - 'opt_config_files': (), 10:42:01 INFO - 'pip_index': False, 10:42:01 INFO - 'sps_profile': False, 10:42:01 INFO - 'sps_profile_interval': 0, 10:42:01 INFO - 'suite': 'dromaeojs-e10s', 10:42:01 INFO - 'system_bits': '64', 10:42:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:42:01 INFO - 'title': 'talos-linux64-ix-036', 10:42:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:42:01 INFO - 'use_talos_json': True, 10:42:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:42:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:42:01 INFO - 'work_dir': 'build'} 10:42:01 INFO - ##### 10:42:01 INFO - ##### Running clobber step. 10:42:01 INFO - ##### 10:42:01 INFO - Running pre-action listener: _resource_record_pre_action 10:42:01 INFO - Running main action method: clobber 10:42:01 INFO - rmtree: /builds/slave/test/build 10:42:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:42:02 INFO - Running post-action listener: _resource_record_post_action 10:42:02 INFO - ##### 10:42:02 INFO - ##### Running read-buildbot-config step. 10:42:02 INFO - ##### 10:42:02 INFO - Running pre-action listener: _resource_record_pre_action 10:42:02 INFO - Running main action method: read_buildbot_config 10:42:02 INFO - Using buildbot properties: 10:42:02 INFO - { 10:42:02 INFO - "properties": { 10:42:02 INFO - "buildnumber": 799, 10:42:02 INFO - "product": "firefox", 10:42:02 INFO - "script_repo_revision": "production", 10:42:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:42:02 INFO - "repository": "", 10:42:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:42:02 INFO - "buildid": "20151204092716", 10:42:02 INFO - "slavename": "talos-linux64-ix-036", 10:42:02 INFO - "pgo_build": "False", 10:42:02 INFO - "basedir": "/builds/slave/test", 10:42:02 INFO - "project": "", 10:42:02 INFO - "platform": "ubuntu64_hw", 10:42:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:42:02 INFO - "slavebuilddir": "test", 10:42:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:42:02 INFO - "branch": "fx-team", 10:42:02 INFO - "repo_path": "integration/fx-team", 10:42:02 INFO - "stage_platform": "linux64", 10:42:02 INFO - "builduid": "0286db1e1eca49b195f71af644232f3a", 10:42:02 INFO - "revision": "f682b6e626841acb178c9ab57d2bc924bda7094a" 10:42:02 INFO - }, 10:42:02 INFO - "sourcestamp": { 10:42:02 INFO - "repository": "", 10:42:02 INFO - "hasPatch": false, 10:42:02 INFO - "project": "", 10:42:02 INFO - "branch": "fx-team-linux64-talos", 10:42:02 INFO - "changes": [ 10:42:02 INFO - { 10:42:02 INFO - "category": null, 10:42:02 INFO - "files": [ 10:42:02 INFO - { 10:42:02 INFO - "url": null, 10:42:02 INFO - "name": "https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:42:02 INFO - } 10:42:02 INFO - ], 10:42:02 INFO - "repository": "", 10:42:02 INFO - "rev": "f682b6e626841acb178c9ab57d2bc924bda7094a", 10:42:02 INFO - "who": "mbanner@mozilla.com", 10:42:02 INFO - "when": 1449252330, 10:42:02 INFO - "number": 6745265, 10:42:02 INFO - "comments": "Bug 1230192 - Loop's desktop unit tests are doing lots of unnecessary console.log of dispatcher actions. r=dcritch", 10:42:02 INFO - "project": "", 10:42:02 INFO - "at": "Fri 04 Dec 2015 10:05:30", 10:42:02 INFO - "branch": "fx-team-linux64-talos", 10:42:02 INFO - "revlink": "", 10:42:02 INFO - "properties": [ 10:42:02 INFO - [ 10:42:02 INFO - "buildid", 10:42:02 INFO - "20151204092716", 10:42:02 INFO - "Change" 10:42:02 INFO - ], 10:42:02 INFO - [ 10:42:02 INFO - "builduid", 10:42:02 INFO - "0286db1e1eca49b195f71af644232f3a", 10:42:02 INFO - "Change" 10:42:02 INFO - ], 10:42:02 INFO - [ 10:42:02 INFO - "pgo_build", 10:42:02 INFO - "False", 10:42:02 INFO - "Change" 10:42:02 INFO - ] 10:42:02 INFO - ], 10:42:02 INFO - "revision": "f682b6e626841acb178c9ab57d2bc924bda7094a" 10:42:02 INFO - } 10:42:02 INFO - ], 10:42:02 INFO - "revision": "f682b6e626841acb178c9ab57d2bc924bda7094a" 10:42:02 INFO - } 10:42:02 INFO - } 10:42:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:42:02 INFO - Running post-action listener: _resource_record_post_action 10:42:02 INFO - ##### 10:42:02 INFO - ##### Running download-and-extract step. 10:42:02 INFO - ##### 10:42:02 INFO - Running pre-action listener: _resource_record_pre_action 10:42:02 INFO - Running main action method: download_and_extract 10:42:02 INFO - mkdir: /builds/slave/test/build/tests 10:42:02 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')]} 10:42:02 INFO - https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/test_packages.json 10:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/test_packages.json 10:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:42:03 INFO - Downloaded 1302 bytes. 10:42:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:42:03 INFO - Using the following test package requirements: 10:42:03 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:42:03 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:42:03 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:03 INFO - u'jsshell-linux-x86_64.zip'], 10:42:03 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:42:03 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:42:03 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:42:03 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:42:03 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:42:03 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:42:03 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:42:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:42:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:42:03 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')]} 10:42:03 INFO - https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:42:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:42:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:42:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:04 INFO - Downloaded 21849117 bytes. 10:42:04 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 10:42:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:42:04 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 10:42:05 INFO - Return code: 0 10:42:05 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 10:42: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')]} 10:42:05 INFO - https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:42:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:42:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:42:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:07 INFO - Downloaded 21849117 bytes. 10:42:07 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 10:42:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:42:07 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 10:42:08 INFO - Return code: 0 10:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:08 INFO - https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:42:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:42:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:42:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:10 INFO - Downloaded 11132001 bytes. 10:42:10 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 10:42:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:42:10 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 10:42:10 INFO - Return code: 0 10:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:10 INFO - https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:42:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:42:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:42:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn-SMDMEQpmzxaMof6m52w/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 10:42:11 INFO - Downloaded 57698654 bytes. 10:42:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:42:11 INFO - mkdir: /builds/slave/test/properties 10:42:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:42:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:42:11 INFO - Contents: 10:42:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:42:11 INFO - Running post-action listener: _resource_record_post_action 10:42:11 INFO - Running post-action listener: set_extra_try_arguments 10:42:11 INFO - ##### 10:42:11 INFO - ##### Running populate-webroot step. 10:42:11 INFO - ##### 10:42:11 INFO - Running pre-action listener: _resource_record_pre_action 10:42:11 INFO - Running main action method: populate_webroot 10:42:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:42:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:42:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:42:11 INFO - '../fennec_ids.txt'], 10:42:11 INFO - 'tests': ['tcheck2']}, 10:42:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:42:11 INFO - '--tppagecycles', 10:42:11 INFO - '7'], 10:42:11 INFO - 'tests': ['tsvgm']}}, 10:42:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:42:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:42:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:42:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:42:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'tests': ['damp', 'tps']}, 10:42:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['damp', 'tps']}, 10:42:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:42:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:42:11 INFO - 'other': {'tests': ['a11yr', 10:42:11 INFO - 'ts_paint', 10:42:11 INFO - 'tpaint', 10:42:11 INFO - 'sessionrestore', 10:42:11 INFO - 'sessionrestore_no_auto_restore']}, 10:42:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['a11yr', 10:42:11 INFO - 'ts_paint', 10:42:11 INFO - 'tpaint', 10:42:11 INFO - 'sessionrestore', 10:42:11 INFO - 'sessionrestore_no_auto_restore']}, 10:42:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['a11yr', 10:42:11 INFO - 'ts_paint', 10:42:11 INFO - 'tpaint', 10:42:11 INFO - 'sessionrestore', 10:42:11 INFO - 'sessionrestore_no_auto_restore']}, 10:42:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['a11yr', 10:42:11 INFO - 'ts_paint', 10:42:11 INFO - 'tpaint', 10:42:11 INFO - 'sessionrestore', 10:42:11 INFO - 'sessionrestore_no_auto_restore']}, 10:42:11 INFO - 'other_l64': {'tests': ['a11yr', 10:42:11 INFO - 'ts_paint', 10:42:11 INFO - 'tpaint', 10:42:11 INFO - 'sessionrestore', 10:42:11 INFO - 'sessionrestore_no_auto_restore']}, 10:42:11 INFO - 'other_nol64': {'tests': ['a11yr', 10:42:11 INFO - 'ts_paint', 10:42:11 INFO - 'tpaint', 10:42:11 INFO - 'sessionrestore', 10:42:11 INFO - 'sessionrestore_no_auto_restore']}, 10:42:11 INFO - 'svgr': {'tests': ['tsvgx', 10:42:11 INFO - 'tsvgr_opacity', 10:42:11 INFO - 'tart', 10:42:11 INFO - 'tscrollx', 10:42:11 INFO - 'cart']}, 10:42:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['tsvgx', 10:42:11 INFO - 'tsvgr_opacity', 10:42:11 INFO - 'tart', 10:42:11 INFO - 'tscrollx', 10:42:11 INFO - 'cart']}, 10:42:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'tests': ['tp5o']}, 10:42:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'talos_options': ['--e10s'], 10:42:11 INFO - 'tests': ['tp5o']}, 10:42:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'talos_options': ['--xperf_path', 10:42:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:11 INFO - 'tests': ['tp5n']}, 10:42:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:42:11 INFO - 'talos_options': ['--e10s', 10:42:11 INFO - '--xperf_path', 10:42:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:11 INFO - 'tests': ['tp5n']}}, 10:42:11 INFO - 'talos.zip': {'path': '', 10:42:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:42:11 INFO - Running post-action listener: _resource_record_post_action 10:42:11 INFO - ##### 10:42:11 INFO - ##### Running create-virtualenv step. 10:42:11 INFO - ##### 10:42:11 INFO - Running pre-action listener: _resource_record_pre_action 10:42:11 INFO - Running main action method: create_virtualenv 10:42:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:42:11 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 10:42:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:42:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:42:11 INFO - Using real prefix '/usr' 10:42:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:42:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:42:14 INFO - Installing pip.................done. 10:42:14 INFO - Return code: 0 10:42:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:42:14 INFO - Using env: {'DISPLAY': ':0', 10:42:14 INFO - 'HOME': '/home/cltbld', 10:42:14 INFO - 'LANG': 'en_US.UTF-8', 10:42:14 INFO - 'LANGUAGE': 'en_US:en', 10:42:14 INFO - 'LOGNAME': 'cltbld', 10:42:14 INFO - 'MAIL': '/var/mail/cltbld', 10:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:14 INFO - 'MOZ_NO_REMOTE': '1', 10:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:14 INFO - 'NO_EM_RESTART': '1', 10:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:14 INFO - 'PWD': '/builds/slave/test', 10:42:14 INFO - 'SHELL': '/bin/bash', 10:42:14 INFO - 'SHLVL': '1', 10:42:14 INFO - 'TERM': 'linux', 10:42:14 INFO - 'TMOUT': '86400', 10:42:14 INFO - 'USER': 'cltbld', 10:42:14 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:14 INFO - '_': '/tools/buildbot/bin/python'} 10:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:14 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 10:42:14 INFO - Cleaning up... 10:42:14 INFO - Return code: 0 10:42:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:42:14 INFO - Using env: {'DISPLAY': ':0', 10:42:14 INFO - 'HOME': '/home/cltbld', 10:42:14 INFO - 'LANG': 'en_US.UTF-8', 10:42:14 INFO - 'LANGUAGE': 'en_US:en', 10:42:14 INFO - 'LOGNAME': 'cltbld', 10:42:14 INFO - 'MAIL': '/var/mail/cltbld', 10:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:14 INFO - 'MOZ_NO_REMOTE': '1', 10:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:14 INFO - 'NO_EM_RESTART': '1', 10:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:14 INFO - 'PWD': '/builds/slave/test', 10:42:14 INFO - 'SHELL': '/bin/bash', 10:42:14 INFO - 'SHLVL': '1', 10:42:14 INFO - 'TERM': 'linux', 10:42:14 INFO - 'TMOUT': '86400', 10:42:14 INFO - 'USER': 'cltbld', 10:42:14 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:14 INFO - '_': '/tools/buildbot/bin/python'} 10:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:14 INFO - Downloading/unpacking psutil>=0.7.1 10:42:14 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 10:42:14 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 10:42:14 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 10:42:14 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 10:42:14 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 10:42:14 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 10:42:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:42:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:42:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:16 INFO - Installing collected packages: psutil 10:42:16 INFO - Running setup.py install for psutil 10:42:16 INFO - building 'psutil._psutil_linux' extension 10:42:16 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 10:42:16 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 10:42:16 INFO - building 'psutil._psutil_posix' extension 10:42:16 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 10:42:16 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 10:42:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:17 INFO - Successfully installed psutil 10:42:17 INFO - Cleaning up... 10:42:17 INFO - Return code: 0 10:42:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:17 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 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:17 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 10:42:17 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 10:42:17 INFO - Using env: {'DISPLAY': ':0', 10:42:17 INFO - 'HOME': '/home/cltbld', 10:42:17 INFO - 'LANG': 'en_US.UTF-8', 10:42:17 INFO - 'LANGUAGE': 'en_US:en', 10:42:17 INFO - 'LOGNAME': 'cltbld', 10:42:17 INFO - 'MAIL': '/var/mail/cltbld', 10:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:17 INFO - 'MOZ_NO_REMOTE': '1', 10:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:17 INFO - 'NO_EM_RESTART': '1', 10:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:17 INFO - 'PWD': '/builds/slave/test', 10:42:17 INFO - 'SHELL': '/bin/bash', 10:42:17 INFO - 'SHLVL': '1', 10:42:17 INFO - 'TERM': 'linux', 10:42:17 INFO - 'TMOUT': '86400', 10:42:17 INFO - 'USER': 'cltbld', 10:42:17 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:17 INFO - '_': '/tools/buildbot/bin/python'} 10:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:42:17 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 10:42:17 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 10:42:17 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 10:42:17 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 10:42:17 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 10:42:17 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 10:42:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:42:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:42:18 INFO - Installing collected packages: mozsystemmonitor 10:42:18 INFO - Running setup.py install for mozsystemmonitor 10:42:19 INFO - Successfully installed mozsystemmonitor 10:42:19 INFO - Cleaning up... 10:42:19 INFO - Return code: 0 10:42:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:42:19 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')]} 10:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:19 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')]} 10:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:19 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 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:19 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 10:42:19 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 10:42:19 INFO - Using env: {'DISPLAY': ':0', 10:42:19 INFO - 'HOME': '/home/cltbld', 10:42:19 INFO - 'LANG': 'en_US.UTF-8', 10:42:19 INFO - 'LANGUAGE': 'en_US:en', 10:42:19 INFO - 'LOGNAME': 'cltbld', 10:42:19 INFO - 'MAIL': '/var/mail/cltbld', 10:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:19 INFO - 'MOZ_NO_REMOTE': '1', 10:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:19 INFO - 'NO_EM_RESTART': '1', 10:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:19 INFO - 'PWD': '/builds/slave/test', 10:42:19 INFO - 'SHELL': '/bin/bash', 10:42:19 INFO - 'SHLVL': '1', 10:42:19 INFO - 'TERM': 'linux', 10:42:19 INFO - 'TMOUT': '86400', 10:42:19 INFO - 'USER': 'cltbld', 10:42:19 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:19 INFO - '_': '/tools/buildbot/bin/python'} 10:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:19 INFO - Downloading/unpacking blobuploader==1.2.4 10:42:19 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 10:42:19 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 10:42:19 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 10:42:19 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 10:42:19 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 10:42:19 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 10:42:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:42:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:42:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:42:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 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 10:42:21 INFO - Downloading docopt-0.6.1.tar.gz 10:42:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:42:21 INFO - Installing collected packages: blobuploader, requests, docopt 10:42:21 INFO - Running setup.py install for blobuploader 10:42:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:42:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:42:21 INFO - Running setup.py install for requests 10:42:22 INFO - Running setup.py install for docopt 10:42:22 INFO - Successfully installed blobuploader requests docopt 10:42:22 INFO - Cleaning up... 10:42:22 INFO - Return code: 0 10:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:22 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')]} 10:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:22 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')]} 10:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:22 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 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:22 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 10:42:22 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 10:42:22 INFO - Using env: {'DISPLAY': ':0', 10:42:22 INFO - 'HOME': '/home/cltbld', 10:42:22 INFO - 'LANG': 'en_US.UTF-8', 10:42:22 INFO - 'LANGUAGE': 'en_US:en', 10:42:22 INFO - 'LOGNAME': 'cltbld', 10:42:22 INFO - 'MAIL': '/var/mail/cltbld', 10:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:22 INFO - 'MOZ_NO_REMOTE': '1', 10:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:22 INFO - 'NO_EM_RESTART': '1', 10:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:22 INFO - 'PWD': '/builds/slave/test', 10:42:22 INFO - 'SHELL': '/bin/bash', 10:42:22 INFO - 'SHLVL': '1', 10:42:22 INFO - 'TERM': 'linux', 10:42:22 INFO - 'TMOUT': '86400', 10:42:22 INFO - 'USER': 'cltbld', 10:42:22 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:22 INFO - '_': '/tools/buildbot/bin/python'} 10:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:22 INFO - Running setup.py (path:/tmp/pip-TPY2ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:22 INFO - Running setup.py (path:/tmp/pip-Ih81QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:22 INFO - Running setup.py (path:/tmp/pip-n2P34X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:22 INFO - Running setup.py (path:/tmp/pip-0qa30T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:22 INFO - Running setup.py (path:/tmp/pip-NqViM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:22 INFO - Running setup.py (path:/tmp/pip-yR2R4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:23 INFO - Running setup.py (path:/tmp/pip-HmXCW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:23 INFO - Running setup.py (path:/tmp/pip-vcZnJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:23 INFO - Running setup.py (path:/tmp/pip-ZuOAnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:23 INFO - Running setup.py (path:/tmp/pip-V19UzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:23 INFO - Running setup.py (path:/tmp/pip-NdQjMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:23 INFO - Running setup.py (path:/tmp/pip-GzGYVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:23 INFO - Running setup.py (path:/tmp/pip-un4ehH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:23 INFO - Running setup.py (path:/tmp/pip-Lxba1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:23 INFO - Running setup.py (path:/tmp/pip-bkLe8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:23 INFO - Running setup.py (path:/tmp/pip-VRQ0ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:23 INFO - Running setup.py (path:/tmp/pip-KRG7LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:42:23 INFO - Running setup.py install for manifestparser 10:42:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:42:23 INFO - Running setup.py install for mozcrash 10:42:24 INFO - Running setup.py install for mozdebug 10:42:24 INFO - Running setup.py install for mozdevice 10:42:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Running setup.py install for mozfile 10:42:24 INFO - Running setup.py install for mozhttpd 10:42:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Running setup.py install for mozinfo 10:42:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Running setup.py install for mozInstall 10:42:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Running setup.py install for mozleak 10:42:24 INFO - Running setup.py install for mozlog 10:42:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Running setup.py install for moznetwork 10:42:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:42:24 INFO - Running setup.py install for mozprocess 10:42:25 INFO - Running setup.py install for mozprofile 10:42:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:42:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:42:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:42:25 INFO - Running setup.py install for mozrunner 10:42:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:42:25 INFO - Running setup.py install for mozscreenshot 10:42:25 INFO - Running setup.py install for moztest 10:42:25 INFO - Running setup.py install for mozversion 10:42:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:42:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:42:25 INFO - Cleaning up... 10:42:25 INFO - Return code: 0 10:42:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42: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')]} 10:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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')]} 10:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:25 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 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:25 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 10:42:25 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 10:42:25 INFO - Using env: {'DISPLAY': ':0', 10:42:25 INFO - 'HOME': '/home/cltbld', 10:42:25 INFO - 'LANG': 'en_US.UTF-8', 10:42:25 INFO - 'LANGUAGE': 'en_US:en', 10:42:25 INFO - 'LOGNAME': 'cltbld', 10:42:25 INFO - 'MAIL': '/var/mail/cltbld', 10:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:25 INFO - 'MOZ_NO_REMOTE': '1', 10:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:25 INFO - 'NO_EM_RESTART': '1', 10:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:25 INFO - 'PWD': '/builds/slave/test', 10:42:25 INFO - 'SHELL': '/bin/bash', 10:42:25 INFO - 'SHLVL': '1', 10:42:25 INFO - 'TERM': 'linux', 10:42:25 INFO - 'TMOUT': '86400', 10:42:25 INFO - 'USER': 'cltbld', 10:42:25 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:25 INFO - '_': '/tools/buildbot/bin/python'} 10:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:25 INFO - Running setup.py (path:/tmp/pip-bOIIjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:25 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)) 10:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:25 INFO - Running setup.py (path:/tmp/pip-wY8hPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:25 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)) 10:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:25 INFO - Running setup.py (path:/tmp/pip-VieBDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:26 INFO - Running setup.py (path:/tmp/pip-bC0CCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:26 INFO - Running setup.py (path:/tmp/pip-kLTxYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:26 INFO - Running setup.py (path:/tmp/pip-EVr5fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:26 INFO - Running setup.py (path:/tmp/pip-X2HwjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:26 INFO - Running setup.py (path:/tmp/pip-oHHY3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:26 INFO - Running setup.py (path:/tmp/pip-swmVlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:26 INFO - Running setup.py (path:/tmp/pip-eNlWtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:26 INFO - Running setup.py (path:/tmp/pip-_8_5XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:26 INFO - Running setup.py (path:/tmp/pip-2kZ7oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:26 INFO - Running setup.py (path:/tmp/pip-vO14fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:26 INFO - Running setup.py (path:/tmp/pip-0n3xD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:26 INFO - Running setup.py (path:/tmp/pip-k615Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:26 INFO - Running setup.py (path:/tmp/pip-q8Zgoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:26 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)) 10:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:27 INFO - Running setup.py (path:/tmp/pip-cvwg9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:27 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)) 10:42:27 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)) 10:42:27 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)) 10:42:27 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)) 10:42:27 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)) 10:42:27 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)) 10:42:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:28 INFO - Downloading blessings-1.5.1.tar.gz 10:42:28 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 10:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:42:28 INFO - Installing collected packages: blessings 10:42:28 INFO - Running setup.py install for blessings 10:42:28 INFO - Successfully installed blessings 10:42:28 INFO - Cleaning up... 10:42:28 INFO - Return code: 0 10:42:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:29 INFO - Reading from file tmpfile_stdout 10:42:29 INFO - Current package versions: 10:42:29 INFO - argparse == 1.2.1 10:42:29 INFO - blessings == 1.5.1 10:42:29 INFO - blobuploader == 1.2.4 10:42:29 INFO - docopt == 0.6.1 10:42:29 INFO - manifestparser == 1.1 10:42:29 INFO - mozInstall == 1.12 10:42:29 INFO - mozcrash == 0.16 10:42:29 INFO - mozdebug == 0.1 10:42:29 INFO - mozdevice == 0.47 10:42:29 INFO - mozfile == 1.2 10:42:29 INFO - mozhttpd == 0.7 10:42:29 INFO - mozinfo == 0.9 10:42:29 INFO - mozleak == 0.1 10:42:29 INFO - mozlog == 3.1 10:42:29 INFO - moznetwork == 0.27 10:42:29 INFO - mozprocess == 0.22 10:42:29 INFO - mozprofile == 0.27 10:42:29 INFO - mozrunner == 6.11 10:42:29 INFO - mozscreenshot == 0.1 10:42:29 INFO - mozsystemmonitor == 0.0 10:42:29 INFO - moztest == 0.7 10:42:29 INFO - mozversion == 1.4 10:42:29 INFO - psutil == 3.1.1 10:42:29 INFO - requests == 1.2.3 10:42:29 INFO - wsgiref == 0.1.2 10:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:29 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')]} 10:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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')]} 10:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:29 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 10:42:29 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 10:42:29 INFO - Using env: {'DISPLAY': ':0', 10:42:29 INFO - 'HOME': '/home/cltbld', 10:42:29 INFO - 'LANG': 'en_US.UTF-8', 10:42:29 INFO - 'LANGUAGE': 'en_US:en', 10:42:29 INFO - 'LOGNAME': 'cltbld', 10:42:29 INFO - 'MAIL': '/var/mail/cltbld', 10:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:29 INFO - 'MOZ_NO_REMOTE': '1', 10:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:29 INFO - 'NO_EM_RESTART': '1', 10:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:29 INFO - 'PWD': '/builds/slave/test', 10:42:29 INFO - 'SHELL': '/bin/bash', 10:42:29 INFO - 'SHLVL': '1', 10:42:29 INFO - 'TERM': 'linux', 10:42:29 INFO - 'TMOUT': '86400', 10:42:29 INFO - 'USER': 'cltbld', 10:42:29 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:29 INFO - '_': '/tools/buildbot/bin/python'} 10:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 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)) 10:42:29 INFO - Cleaning up... 10:42:29 INFO - Return code: 0 10:42:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:42:29 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')]} 10:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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')]} 10:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:29 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 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:29 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 10:42:29 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 10:42:29 INFO - Using env: {'DISPLAY': ':0', 10:42:29 INFO - 'HOME': '/home/cltbld', 10:42:29 INFO - 'LANG': 'en_US.UTF-8', 10:42:29 INFO - 'LANGUAGE': 'en_US:en', 10:42:29 INFO - 'LOGNAME': 'cltbld', 10:42:29 INFO - 'MAIL': '/var/mail/cltbld', 10:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:29 INFO - 'MOZ_NO_REMOTE': '1', 10:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:29 INFO - 'NO_EM_RESTART': '1', 10:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:29 INFO - 'PWD': '/builds/slave/test', 10:42:29 INFO - 'SHELL': '/bin/bash', 10:42:29 INFO - 'SHLVL': '1', 10:42:29 INFO - 'TERM': 'linux', 10:42:29 INFO - 'TMOUT': '86400', 10:42:29 INFO - 'USER': 'cltbld', 10:42:29 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:29 INFO - '_': '/tools/buildbot/bin/python'} 10:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:29 INFO - Downloading/unpacking jsonschema 10:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:42:31 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 10:42:31 INFO - Downloading/unpacking functools32 (from jsonschema) 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42:31 INFO - Downloading functools32-3.2.3-2.tar.gz 10:42:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:42:31 INFO - warning: no files found matching '*.txt' 10:42:31 INFO - no previously-included directories found matching 'build' 10:42:31 INFO - no previously-included directories found matching 'dist' 10:42:31 INFO - no previously-included directories found matching '.git*' 10:42:31 INFO - Installing collected packages: jsonschema, functools32 10:42:31 INFO - Running setup.py install for functools32 10:42:31 INFO - warning: no files found matching '*.txt' 10:42:31 INFO - no previously-included directories found matching 'build' 10:42:31 INFO - no previously-included directories found matching 'dist' 10:42:31 INFO - no previously-included directories found matching '.git*' 10:42:31 INFO - Successfully installed jsonschema functools32 10:42:31 INFO - Cleaning up... 10:42:31 INFO - Return code: 0 10:42:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15183fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2947240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', '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 10:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:42:31 INFO - Using env: {'DISPLAY': ':0', 10:42:31 INFO - 'HOME': '/home/cltbld', 10:42:31 INFO - 'LANG': 'en_US.UTF-8', 10:42:31 INFO - 'LANGUAGE': 'en_US:en', 10:42:31 INFO - 'LOGNAME': 'cltbld', 10:42:31 INFO - 'MAIL': '/var/mail/cltbld', 10:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:31 INFO - 'MOZ_NO_REMOTE': '1', 10:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:31 INFO - 'NO_EM_RESTART': '1', 10:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:31 INFO - 'PWD': '/builds/slave/test', 10:42:31 INFO - 'SHELL': '/bin/bash', 10:42:31 INFO - 'SHLVL': '1', 10:42:31 INFO - 'TERM': 'linux', 10:42:31 INFO - 'TMOUT': '86400', 10:42:31 INFO - 'USER': 'cltbld', 10:42:31 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:31 INFO - '_': '/tools/buildbot/bin/python'} 10:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:31 INFO - Downloading/unpacking flake8 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:42:33 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 10:42:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:42:33 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 10:42:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42:34 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 10:42:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:42:34 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 10:42:34 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 10:42:34 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 10:42:34 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 10:42:34 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 10:42:34 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 10:42:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:42:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:34 INFO - no previously-included directories found matching 'docs/_build' 10:42:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:42:34 INFO - Running setup.py install for pep8 10:42:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:34 INFO - no previously-included directories found matching 'docs/_build' 10:42:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:42:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:42:34 INFO - Cleaning up... 10:42:34 INFO - Return code: 0 10:42:34 INFO - Running post-action listener: _resource_record_post_action 10:42:34 INFO - Running post-action listener: _start_resource_monitoring 10:42:34 INFO - Starting resource monitoring. 10:42:34 INFO - ##### 10:42:34 INFO - ##### Running install step. 10:42:34 INFO - ##### 10:42:34 INFO - Running pre-action listener: _resource_record_pre_action 10:42:34 INFO - Running main action method: install 10:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:34 INFO - Reading from file tmpfile_stdout 10:42:34 INFO - Detecting whether we're running mozinstall >=1.0... 10:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:42:34 INFO - Reading from file tmpfile_stdout 10:42:34 INFO - Output received: 10:42:34 INFO - Usage: mozinstall [options] installer 10:42:34 INFO - Options: 10:42:34 INFO - -h, --help show this help message and exit 10:42:34 INFO - -d DEST, --destination=DEST 10:42:34 INFO - Directory to install application into. [default: 10:42:34 INFO - "/builds/slave/test"] 10:42:34 INFO - --app=APP Application being installed. [default: firefox] 10:42:34 INFO - mkdir: /builds/slave/test/build/application 10:42:34 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'] 10:42:34 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 10:42:49 INFO - Reading from file tmpfile_stdout 10:42:49 INFO - Output received: 10:42:49 INFO - /builds/slave/test/build/application/firefox/firefox 10:42:49 INFO - Running post-action listener: _resource_record_post_action 10:42:49 INFO - ##### 10:42:49 INFO - ##### Running run-tests step. 10:42:49 INFO - ##### 10:42:49 INFO - Running pre-action listener: _resource_record_pre_action 10:42:49 INFO - Running main action method: run_tests 10:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:42:49 INFO - Python 2.7.3 10:42:49 INFO - Return code: 0 10:42:49 INFO - grabbing minidump binary from tooltool 10:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:49 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 0x29d60b0>, '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 0x29d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:42:49 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 10:42:49 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 10:42:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:42:49 INFO - Return code: 0 10:42:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:42:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:42:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:42:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:42:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:42:50 INFO - Return code: 0 10:42:50 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/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 10:42:50 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/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 10:42:50 INFO - Using env: {'DISPLAY': ':0', 10:42:50 INFO - 'HOME': '/home/cltbld', 10:42:50 INFO - 'LANG': 'en_US.UTF-8', 10:42:50 INFO - 'LANGUAGE': 'en_US:en', 10:42:50 INFO - 'LOGNAME': 'cltbld', 10:42:50 INFO - 'MAIL': '/var/mail/cltbld', 10:42:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:42:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:50 INFO - 'MOZ_NO_REMOTE': '1', 10:42:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:50 INFO - 'NO_EM_RESTART': '1', 10:42:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:50 INFO - 'PWD': '/builds/slave/test', 10:42:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:42:50 INFO - 'SHELL': '/bin/bash', 10:42:50 INFO - 'SHLVL': '1', 10:42:50 INFO - 'TERM': 'linux', 10:42:50 INFO - 'TMOUT': '86400', 10:42:50 INFO - 'USER': 'cltbld', 10:42:50 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419', 10:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:50 INFO - '_': '/tools/buildbot/bin/python'} 10:42:50 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/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 10:42:50 INFO - mozversion INFO | application_buildid: 20151204092716 10:42:50 INFO - mozversion INFO | application_changeset: f682b6e626841acb178c9ab57d2bc924bda7094a 10:42:50 INFO - mozversion INFO | application_display_name: Nightly 10:42:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:42:50 INFO - mozversion INFO | application_name: Firefox 10:42:50 INFO - mozversion INFO | application_remotingname: firefox 10:42:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:42:50 INFO - mozversion INFO | application_vendor: Mozilla 10:42:50 INFO - mozversion INFO | application_version: 45.0a1 10:42:50 INFO - mozversion INFO | platform_buildid: 20151204092716 10:42:50 INFO - mozversion INFO | platform_changeset: f682b6e626841acb178c9ab57d2bc924bda7094a 10:42:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:42:50 INFO - mozversion INFO | platform_version: 45.0a1 10:42:50 INFO - 2015-12-04 10:42:50,564 DEBUG : using testdate: 1449254570 10:42:50 INFO - 2015-12-04 10:42:50,564 DEBUG : actual date: 1449254570 10:42:50 INFO - 2015-12-04 10:42:50,577 INFO : starting webserver on 'localhost:55981' 10:42:50 INFO - 2015-12-04 10:42:50,578 INFO : Starting test suite talos-linux64-ix-036.e 10:42:50 INFO - 2015-12-04 10:42:50,578 INFO : Starting test dromaeo_css 10:42:50 INFO - 2015-12-04 10:42:50,578 DEBUG : operating with platform_type : linux_ 10:42:50 INFO - 2015-12-04 10:42:50,579 INFO : Initialising browser for dromaeo_css test... 10:42:50 INFO - 2015-12-04 10:42:50,595 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6T2EWB/profile http://localhost:55981/getInfo.html 10:42:55 INFO - 2015-12-04 10:42:55,995 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:42:55 INFO - 2015-12-04 10:42:55,995 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:42:55 INFO - 2015-12-04 10:42:55,995 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:42:55 INFO - 2015-12-04 10:42:55,995 DEBUG : BROWSER_OUTPUT: __metrics 10:42:56 INFO - 2015-12-04 10:42:56,096 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] 10:42:57 INFO - 2015-12-04 10:42:57,109 INFO : Browser initialized. 10:42:57 INFO - 2015-12-04 10:42:57,109 INFO : Running cycle 1/1 for dromaeo_css test... 10:42:57 INFO - 2015-12-04 10:42:57,110 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6T2EWB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:43:09 INFO - 2015-12-04 10:43:09,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 143147008 10:43:09 INFO - 2015-12-04 10:43:09,134 DEBUG : BROWSER_OUTPUT: 10:43:58 INFO - 2015-12-04 10:43:58,762 DEBUG : BROWSER_OUTPUT: 1449254638754 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] 10:46:11 INFO - 2015-12-04 10:46:11,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55981/tests/dromaeo/cssquery-ext.html) 10:46:12 INFO - 2015-12-04 10:46:12,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 145858560 10:46:12 INFO - 2015-12-04 10:46:12,601 DEBUG : BROWSER_OUTPUT: 10:49:14 INFO - 2015-12-04 10:49:14,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/dromaeo/cssquery-ext.html (next: http://localhost:55981/tests/dromaeo/cssquery-jquery.html) 10:49:15 INFO - 2015-12-04 10:49:15,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 144461824 10:49:15 INFO - 2015-12-04 10:49:15,258 DEBUG : BROWSER_OUTPUT: 10:52:17 INFO - 2015-12-04 10:52:17,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55981/tests/dromaeo/cssquery-mootools.html) 10:52:17 INFO - 2015-12-04 10:52:17,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 145285120 10:52:17 INFO - 2015-12-04 10:52:17,662 DEBUG : BROWSER_OUTPUT: 10:55:19 INFO - 2015-12-04 10:55:19,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55981/tests/dromaeo/cssquery-prototype.html) 10:55:19 INFO - 2015-12-04 10:55:19,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 143126528 10:55:19 INFO - 2015-12-04 10:55:19,995 DEBUG : BROWSER_OUTPUT: 10:58:22 INFO - 2015-12-04 10:58:22,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55981/tests/dromaeo/cssquery-yui.html) 10:58:23 INFO - 2015-12-04 10:58:23,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 143982592 10:58:23 INFO - 2015-12-04 10:58:23,198 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/dromaeo/cssquery-yui.html (next: http://localhost:55981/tests/dromaeo/cssquery-dojo.html) 11:01:25 INFO - 2015-12-04 11:01:25,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 147787776 11:01:25 INFO - 2015-12-04 11:01:25,767 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,769 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:01:25 INFO - 2015-12-04 11:01:25,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:01:25 INFO - 2015-12-04 11:01:25,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:01:25 INFO - 2015-12-04 11:01:25,769 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:01:25 INFO - 2015-12-04 11:01:25,772 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2683.745044220799;2726.522858499762;2759.117082533589;2765.8755356008965;2768.667759868816;4609.239475486549;4750.524947505248;4774.40319960005;4789.64077694173;4799.1841386964215;4681.0169864328445;4681.7659117044095;4681.882952926178;4698.64760142989;4705.929411058828;4404.889877753066;4436.556344365562;4459;4468.530804265554;4498.955010449903;4430.4240448741775;4477.753723545204;4492.124035813018;4503.572160644733;4510.233260345749;4207.1375368049785;4333.198358303724;4419.712718673276;4444.488883778375;4494.213512635292;4424.11517696462;4473.172463094338;4481.955180448186;4494.168578812897;4506.346579745951;4124.298869192245;4440.111977604492;4455.2203364411425;4463.531329210418;4503.076869241798;4626.560476754737;4648.279516674921;4649.953500464986;4678.345031695565;4751.809927602926;5143.022825663112;5163.7676304566385;5175.249588809639;5177.326947496801;5216.947830521684;5212.843614691566;5213.348331458567;5217.895642087137;5218.060749065166;5227.764750586232;4540.77296135192;4679.625629949596;4683.95316046842;4724.976375118171;4823.686460380064;5291.365036195682;5293.179557168645;5309;5313.0967735485065;5370.516653501204;5064.392272927199;5079.669821461667;5087.338645976073;5110.4634013428795;5131.204663277198;4913.557779799764;5015.648904576645;5059.139946209153;5168.638195326291;5184.040952423814;5101.566366858784;5128.282040514331;5134.717590532482;5140.817611949273;5143.485651434827;5066.088104141216;5103.668261562986;5105.897882042338;5112.284280200774;5149.819756308586;4046.1705350403095;4170.541240463546;4191.036061705825;4253.744775313491;4286.635635970915;3736.9626303736613;3758.511393518825;3761.1349389640536;3768.811559422018;3796.0509872531866;4268.466441694788;4459.531749166291;4479.10417916418;4484.573965473275;4496.775161241925;5010.64925455222;5013.072581572421;5020.924686129711;5029.119904016782;5085.593152547787;4474.351219073216;4479.731216127043;4481.5070342262325;4487.237169681162;4525.864224073283;4578.061497393026;4585.12882552314;4589.58693717567;4595.6783025187915;4627.699199552018;4662.673612847136;4773;4852.296417019583;4946.159152944008;4974.452810190804;5194.091034069098;5198.402183748917;5206.01085793698;5213.765380557808;5224.921626175535;4952.380952380952;4956.77694503741;4957.6281778866005;4959.13215187348;4993.80024799004;4811.807527698853;4905.2151655734915;4945.1346014448045;5005.099082165245;5045.697258164375;5126.666766660155;5142.971405718797;5163.044836705221;5175.301334319819;5216.321878155815;4766.213574760126;5003.949960500494;5006.224035274538;5010.148274793221;5017.347744793299;4838.806447742191;4913.48408417111;4945.332380128781;4995.475475075064;5029.321041659476;4819.927701084556;4871.585915197248;4923.556879880828;4933.038057578738;4949.554540091409;4740.194166991689;4840.467548569584;5043.092243396224;5048.949510504995;5049.065922804293;4831.4202295724735;4870.391201099863;4873.561379475864;4898.779554919965;4920.21276595743 11:01:25 INFO - 2015-12-04 11:01:25,773 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.5547561950439;563.3802816901409;573.8565358660335;581.8341772594812;584.1500616602842;35920.64079359206;36996.81501592492;37011.25977480449;37026;37055;39357.212855742866;39794.60205397945;39923;39925;40042;8003.8799418008775;8119.9188008120045;8172.18278172184;8174.713885014025;8189.631466584018;7915.881261781078;8020.719274825382;8067.9193208068045;8070.354371650254;8071.838563228732;8013.799655008643;8062.516249025048;8065.112837587861;8093.5143891366415;8104.756857294261;8032.678692852279;8091.069527004411;8092.3930705197345;8132.552709600969;8140.837183256332;7847.293743563107;7857.489263197874;7932.524048557105;7961.482503637303;7962.203779622049;37194.8140259297;37716.62283377186;37736.43395349072;37762.62237377646;37800;2545.630883521879;2599.0773275487118;2671.4523522677805;2753.2703833484143;2997.370552184044;26614.866925665443;26746;26912.850373583216;27083.10418270722;27434.45131097367;3377.527146199534;3454.5854497460464;3465.5321531593163;3540.0795793093725;3571.1786289153642;217111;217916;217954;218623;218948;45023.549764501935;52692;52998.73500632472;53026.469735302926;53042.46957530452;46274.30588541175;62788.37211627916;64124.358756411835;64488.355116448234;64670.353296466434;14623;14853.108813471226;14873.405063797327;14906.403743850342;14978;10230.897691023143;10246.743831404274;10262.43556604394;10269.794604107876;10275.02387273208;18096.366627167987;18479.35322263741;18562.350317739085;18568;18607;6896.7586134485055;7118.323759242864;7179.89230161548;7244.529105608119;7259.274072592804;866.6100254885326;899.3299991506369;917.3761841947539;996.0388225362415;1014.8985101489792;25644.743552564236;26261.21216363474;28162.71837281601;28510.572341414896;29083;911.7401540561041;958.5638534466801;958.6596758150756;979;987.3532835992437;12896.246778430756;13017.804732929013;13185.802212966813;13206;13217.73564528704;263117;265025;267489;267859;269161;44079.77960110179;44230;44428.555714443086;44483;44505.10989780186;1209.9576514821938;1225.7671042501895;1235.5366737473448;1243.4963839644959;1246.7007918099773;25175.49649007046;25390.238292851245;25451.618225726997;25466.363340916625;25533.87233063897;39044.804775975936;39462.21075578415;39668.40497392484;39723.60276397199;39733.60266397415;246560;246694;246843;248263;250032;27958.161255162377;28910.710892890802;29545.704542955154;29680.851595741882;29737.702622973495;34568.308633827684;35423.29153416866;35567.822160890064;35667.64332356643;35907.82046089753;32359.352812944082;32409.837950811037;32713.672863272015;32936.835315823264;33316.666833332325;32701.836490817393;32891;32908.1772955678;32964.1758956028;33162;32484.35031299408;32544.51183232301;32665.673343266262;32961.34077318488;33044.50433243455;28372.574411383433;29147.562786558643;29411.264718382212;30129.246768830955;30526.236844079074;21749.238776642742;22305.776942230368;22847.543049138592;23296.184633537745;23484 11:01:25 INFO - 2015-12-04 11:01:25,776 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.2752593830513;330.04452111138255;330.1136448635414;331.81915855858557;333.9966600333996;14625.780613290795;15162.241887905602;15639.374425022985;15988.440404585841;16522.09128497932;12811.551595694153;12862.292573908431;12865.871341286584;13238.53665121721;13325.600231993032;4468.173387923236;4555.339475776011;4570.200214962369;4975.353204083464;4985.027919555688;4915.434725006634;4991.251312303166;4993.475685053054;4995.500449955011;4996.150654388744;3311.4867195584725;3525.4711793230963;4955.529224723646;4966.155753521892;5214.296070030536;5129.512696293846;5141.794328226866;5203.609729270301;5210.16637338026;5215.687058776467;4923.359963204796;5006.224035274538;5016.046951079284;5033;5044.495550444926;18464.72302915444;18606.813931860645;18837.62324753497;19130.330438434587;19141.90429047846;1703.8040625328122;1778.662054209696;1822.7630408047003;1839.0345068838833;1841.272697284565;8279.710210142677;8561;12299;12467.688307792287;12621.368931553478;1125.3697929159614;1607.4373969110834;1649.6948064607966;1664.4507312586938;1692.957676058096;55125.1731224028;57664.711676441766;57698.423015770146;58002;58286.70856645732;9635.13283804447;9657.9034209657;9724.9027509724;9760.755981100529;9768.609255629695;12323.198992065487;12364.56724014655;12378.76212378773;12385.876141238652;12388.81416778749;7257.491975561766;7323.231060738546;7498.250174982458;7529.435292352986;7537.736179233811;7369.484136110421;7380.483366164424;7392.297731715478;7406.851862962711;7425.62871856405;4053.4527838741983;4066.6136717011836;4109.239790638741;4116.526599441043;4118.114605359862;1660.9086500242602;1790.719635460652;1790.7582476365524;1792.793828709689;1793.5516120969758;349.798865652251;349.9632538583463;837.7068026190784;872.2716531696104;964.5948701545368;8962.68630597926;9636;9771.364861283993;9903.554340054714;10040.748981275527;372.7185974589168;831.3141658131944;860.7030574451804;860.8880845490171;877.1272583779181;8383.916160838435;8811.691590794291;8833;8921.063288354759;8988.910110898938;473563;482968;486059;486857;493374;72989.6350518244;73519.63240183765;75858.24141758622;76966.6151669238;77112;1034.896510348959;1045.8378951262566;1052.9578816847393;1093.2620481175175;1095;14233.786493202817;14283.785743213652;14390.640233993816;14525.92737036308;14608.196549189472;31910;32123;32665.510017349283;32902.83548582242;34444.65555344414;40614;41161.58838411578;41668;41997.580024200586;46057;8631.136886311318;8640.13598640131;8952.462852228888;9159.450432974043;9160;10188.592456301665;10250.794984100425;14488.420463181776;16371.754423683893;16647.583810404838;13384.130031547918;13425.798613020617;13743.931280343535;13913.513027044004;13950.232737199145;12455.875441245471;12791.168574042658;12811.167274127152;12821.743565128832;13585.79621305701;13236.205827650372;13341.533046343331;13435.596932092052;13565.86434135646;13910.652233693834;8199.180081991753;8224.300934420642;8304.418690691593;8337.541435221121;8358.03882553514;12679.112462127563;12786.936065319614;13018.088733788543;13359.465621375037;13653.863461365656 11:01:25 INFO - 2015-12-04 11:01:25,777 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1498.2134379450795;1643.983560164398;1690.6027083635342;1713.7857767779024;1716.2877405876561;5816.941830581693;5922.526197904157;7009.5794252344895;7165.462590305729;7171.390431813295;6824.72701091957;6991.89512157318;7044.682989265482;7045.964770176155;7046;2045.7647370552354;2086.0925497408675;2090.1325949730845;2090.362439455965;2093.0685844799073;2042.6629606115048;2085.0825636719796;2086.113401804227;2090.7804680508557;2094;2029.0970518119443;2041.9387418377473;2078.3764870538853;2079.0540304161646;2090.707300977864;2015.707722380254;2042.213747707136;2042.4689580708973;2043.3869839048375;2049.385184444668;2008.648486514854;2032.3902829151343;2037.6943458481198;2039.3983774786325;2043.7036629688612;7029.402500787439;7132.286771322878;7166.355028047501;7200.711971521133;7210.567365958059;3998.0604557928864;4039.838406463767;4076.6127217914545;4091.652209562191;4094.1197642507004;2609.1129016134605;2621.7116117227088;2638.722934091931;2662.8002899782596;2673.331667083229;796.8962986264008;797.6171437709932;811.4401063266328;823.2837431434631;826.801567623766;9504.572294246775;9522.761930951712;9551.808963820684;9563.856542151872;9617.71146865595;3842.366009608383;3844.826982785781;3880.864169754045;3889.086064774776;3964.960350396459;8353.16468353172;8372.916270837335;8373.07896131425;8383.748487545261;8387.95806020966;4123.793810309532;4125.50493940729;4148.191102734998;4151.605597468296;4157.958420415757;3128.0615815255333;3162.905112846618;3713.665770080706;3719.442083687414;3783.4135708964604;3480.3735327641266;3501.142220156027;3507.4563442666426;3528.40017197072;3528.6118526962014;1112.071420364005;1125.201107213871;1129.13056946151;1133.450276615857;1136.72718547548;1191.4042978510745;1203.4283715235367;1210.3585099896893;1223.443333283354;1231.950721971111;6661.16735408074;6665.333466653393;6719.764808231688;6747.696353664097;6770.864582708318;406.86166703321015;423.2656341247932;430.4081887404818;430.77384373203694;432.7338686707715;5393.056215162409;5410.648307859977;5415.10650742631;5442.809501667422;5469.535089517356;8321.500709957421;8391.95804020976;8465.238128568335;8583.527905965107;8590.828183436297;8461.323094152576;8526.87209691855;8563.186497282748;8584.785380365416;8597.785055373666;6465.4827613790785;6507.544471887017;6516.674166291667;6531.575447595986;6799.762008329685;6443.96778016107;6471.611703297817;6482.35176482348;6489.448396886318;6509.967450162719;7474.850502989801;7549.547027178387;7696.15342312334;7744.186860379805;7758.573278469738;7678.424118191047;7703.88444173349;7824.569648669378;7850.2542258485355;7859;4863.513648635108;5266.605004624592;6106.969465152646;6163.291221509584;6210.627362358273;6809.795706128824;6818.965905170442;6841.24746277919;6851;6858.211305699909;6166.167567378526;6314.936850631435;6448.838779030561;6503.837404064936;6520.902186467112;6244.562880598314;6275.937240627535;6291.213598300213;6326.841828954313;6343.9365606343345;6141.170941922784;6152.107944347955;6179.351168127461;6197.876042479035;6216.502679785697;5647.237622920853;5651.858703532444;5756.971215144065;5772.884542309214;5779.335376431596;5713.771449141987;5753.654780713171;5763.423657634203;5782.7686892523825;5791.160281759206 11:01:25 INFO - 2015-12-04 11:01:25,778 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.0729174452733;273.7700331721354;279.10546697833433;279.1931318489564;279.81532188755415;5527.088030474967;5575.330960284767;5596.440355964407;5608.270924779778;5672.17753425753;5526.834194974157;5539.695316757577;5539.695316757577;5575.804846830361;5595.580331475136;4199.811008504609;4200.915981680365;4202.600752928467;4204.138151678913;4205.684573656973;4204.516480604739;4209.116085622023;4212.53662097169;4214.789260536976;4215.683823713219;4000.6999475039343;4161.895952601179;4163.75017498951;4175.603317684815;4179.853705120321;4095.4675892133832;4097.282975479309;4098.73358231717;4102.159057393242;4107.815148318318;3525.1363415962996;3526.4357702767434;3542.1144713821545;3552.147484603702;3573.160307327776;5356.866078348034;5368.543673787733;5372.167314066326;5376.758045887945;5377.46225377463;4762.833105889079;4781.2350023996;4788.928166077511;4792.880177995543;4807.029118061578;5710.8001219957105;5736.254286942671;5821.417858214187;5834.766609335621;5847.8245652630485;3841.519810023747;3854.1520865409566;3855.1133239354826;3855.807209639535;3856.8264428100524;6071.51427885768;6109.816705498843;6132.386761323876;6139.324674285825;6144.354842741493;3985.780782056957;3987.860424885115;3988.960110398917;3989.341758609855;3990.3216453203027;3842.711796615265;4012.7792971386853;4017.0760725033406;4024.215278020816;4045.6561192298395;4680.789364478606;4691.7888695008805;4718.103560323528;4723.504032076651;4731.172044892199;5806;5813.273340832396;5814.883702325929;5819.679917604488;5838.241028666331;1374.8212732344932;1398.5664444022386;1414.8655877691604;1415.6956254405352;1415.801787749716;902.1294450854956;902.697596305245;904.0597778310615;915.6657819895823;916.6150216908915;4961.50384961501;5040.193569028937;5042.899142017139;5056.848294551096;5073.061483625541;5983.970080149571;5988.700564971734;5999.220101386792;6012.30858451275;6021.126936594169;5043.924341134886;5045.697258164449;5057.974710126426;5061.519155680205;5064.240363945438;3182.2203560127455;3230.919227019296;3233.4664780311455;3274.1323549259464;3309.189248634052;5824.301083869878;5832.62087964281;5838.854028649318;5840.5035571976005;5840.941590584125;6314.9684251579365;6328.208973878265;6333.619982801047;6343.651099189497;6345.873082538324;5625.54995600351;5800.447802966765;5803.332616749043;5815.273090863642;5818.156367326714;6127.111568822406;6133.9079913802225;6141.109539116893;6142.170806941006;6143.385661433821;5955.374685657944;5980.970095149496;5985.162077309267;5985.730642121028;5993.370696077023;5774.797882074107;5782.5663075268685;5790.768369265183;5796.62321949072;5804.6807425592;3921.0785465415033;3932.07596214895;4011.538673052636;4039.91920161601;4047.2310261050307;5965;6137.202163718866;6145.600535965148;6151.96924015377;6153.4154255345675;5856.472917437451;5904.084866845646;5906.734196961061;5909.349971503218;5910.231669882888;5856.180134781049;5889.322727886177;5894.970525147347;5896.439838215363;5898.498627616701;5623.803166889139;5738.929672625126;5743.368229494668;5760.0783874579865;5770.653760774367;5922.496587790086;5945;5950;5957.255343082114;5959.642421454727;5743.770249190153;5747.827565173052;5751.33859606134;5754.4533269339345;5759.683217422914 11:01:25 INFO - 2015-12-04 11:01:25,779 DEBUG : BROWSER_OUTPUT: |5;yui.html;717.4977515738984;737.8302990312228;754.8075240813591;774.2257742257741;777.9105402878671;11006.449677516122;11215.60745373913;11229.32624042557;11244.325340479578;11306.152038597118;11232.438378081084;11309.547618095286;11348.60279890204;11350.375729334883;11359.1480638952;632.1339764522611;637.018990754238;792.4848848248627;798.7923139983588;818.758466252457;746.7498388040013;789.4079440419686;797.5573556676043;800.7757827808223;802.1377019703842;841.2176675691604;847.2163248994686;849.9617517211709;851.5529347092764;852.722865068852;834.8121672623641;835.1439774231401;835.4360806455618;837.0081453477649;842.1368097699846;620.1596836286857;623.2489849731109;624.8968920128174;625.8560531077877;628.1300398947445;11428.428578571038;11529.135314851335;11540.884591154148;11547.133964952662;11568.710782230428;11147.442627868573;11796.233244839059;11992.220505667105;12091.45588448522;12253.759426640709;8641.135886411308;8723.38936274461;8806.306978038889;8849.867251991162;8907.73276801697;3181.2524056846623;3243.189202699325;3273.1489812648647;3281.1305004173914;3323.601167859848;40968.795156024324;41211.175776484306;41268;41286.587134128575;41412.792936035126;9567.043295670377;9638.566264518113;9648.75878103053;9834.557444914995;9859.605615775432;17201.827981720024;17271.222794974256;17332.480025599252;17357.3057077718;17410.39063632767;6132.816015519542;6209.285932117774;6339.270983836917;6343.809685709344;6437.195350581177;3480.4779283107737;3511.227529943408;3524.7885126891956;3536.1159710072484;3570.0896271450615;2605.0751983045748;2653.6284920111198;2655.1503518873774;2663.0945478537;2663.2542887991394;459.1162013124721;464.59812262392785;465.80773042616454;474.964377671676;480.6971607887009;408.02278542889616;411.8846722917528;422.1283050500706;426.54785926917566;482.91790395632825;7156.749513766993;7320.341169294789;7374.115106187184;7455.627218639046;7461.403087752967;442.637037629141;454.3253268895687;593.430306905367;596.6479776931632;616.1497133955113;3522.5244591979754;3529.435290353531;3536.398812201932;3604.4052731299566;3655.1775850433974;55353;55586.72206638941;55658.72170639121;55801.72099139478;55842.44157558454;42151.57848421476;42382;42607.57392426098;42953.140937181706;43175.56824431715;41832.37251441231;42959.57040429618;43127.784361078;43491.565084349386;43640.563594364285;7166.175889772743;7366.7053317866685;7521.811954701177;7548.886766698394;7716.228377162239;32271;32277.838610806797;32441.837790810896;32760.50859237161;33876.15309617181;41598.584014159474;41657.58342416537;41907.7904610475;42037;42070.36894446525;10154.593816247267;10324.741881453023;10407;10465.372077675363;10681.198910081619;11481;11517.308961462339;11549.78727233662;11829.112816538965;11917.582884598998;10183.185345172516;10360.533775979948;10363.585456581652;10378.688639340831;10379.11777498921;10635.549904006906;10787.352758834495;10825.296355737168;10956.12351011933;11297.943510282395;10928.344299342065;11040.061594764215;11046.944765276123;11285.548578056785;11428.94285528567;9529;9829.262805289774;9846.163076138608;9931;10024.398536087858;8549.444286121383;8992.640294388151;9040.63837446521;9070.501122438329;9092.136247056518 11:01:25 INFO - 2015-12-04 11:01:25,779 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:01:25 INFO - 2015-12-04 11:01:25,779 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:01:25 INFO - 2015-12-04 11:01:25,779 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,313 11:01:25 INFO - 2015-12-04 11:01:25,779 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: __startTimestamp1449255685768__endTimestamp 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4730.06 Median:4838.81 stddev:495.79 (10.2%) stddev-sans-first:470.61 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: Values: 2683.7 2726.5 2759.1 2765.9 2768.7 4609.2 4750.5 4774.4 4789.6 4799.2 4681.0 4681.8 4681.9 4698.6 4705.9 4404.9 4436.6 4459.0 4468.5 4499.0 4430.4 4477.8 4492.1 4503.6 4510.2 4207.1 4333.2 4419.7 4444.5 4494.2 4424.1 4473.2 4482.0 4494.2 4506.3 4124.3 4440.1 4455.2 4463.5 4503.1 4626.6 4648.3 4650.0 4678.3 4751.8 5143.0 5163.8 5175.2 5177.3 5216.9 5212.8 5213.3 5217.9 5218.1 5227.8 4540.8 4679.6 4684.0 4725.0 4823.7 5291.4 5293.2 5309.0 5313.1 5370.5 5064.4 5079.7 5087.3 5110.5 5131.2 4913.6 5015.6 5059.1 5168.6 5184.0 5101.6 5128.3 5134.7 5140.8 5143.5 5066.1 5103.7 5105.9 5112.3 5149.8 4046.2 4170.5 4191.0 4253.7 4286.6 3737.0 3758.5 3761.1 3768.8 3796.1 4268.5 4459.5 4479.1 4484.6 4496.8 5010.6 5013.1 5020.9 5029.1 5085.6 4474.4 4479.7 4481.5 4487.2 4525.9 4578.1 4585.1 4589.6 4595.7 4627.7 4662.7 4773.0 4852.3 4946.2 4974.5 5194.1 5198.4 5206.0 5213.8 5224.9 4952.4 4956.8 4957.6 4959.1 4993.8 4811.8 4905.2 4945.1 5005.1 5045.7 5126.7 5143.0 5163.0 5175.3 5216.3 4766.2 5003.9 5006.2 5010.1 5017.3 4838.8 4913.5 4945.3 4995.5 5029.3 4819.9 4871.6 4923.6 4933.0 4949.6 4740.2 4840.5 5043.1 5048.9 5049.1 4831.4 4870.4 4873.6 4898.8 4920.2 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40315.87 Median:18347.10 stddev:63813.05 (347.8%) stddev-sans-first:63922.23 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: Values: 556.6 563.4 573.9 581.8 584.2 35920.6 36996.8 37011.3 37026.0 37055.0 39357.2 39794.6 39923.0 39925.0 40042.0 8003.9 8119.9 8172.2 8174.7 8189.6 7915.9 8020.7 8067.9 8070.4 8071.8 8013.8 8062.5 8065.1 8093.5 8104.8 8032.7 8091.1 8092.4 8132.6 8140.8 7847.3 7857.5 7932.5 7961.5 7962.2 37194.8 37716.6 37736.4 37762.6 37800.0 2545.6 2599.1 2671.5 2753.3 2997.4 26614.9 26746.0 26912.9 27083.1 27434.5 3377.5 3454.6 3465.5 3540.1 3571.2 217111.0 217916.0 217954.0 218623.0 218948.0 45023.5 52692.0 52998.7 53026.5 53042.5 46274.3 62788.4 64124.4 64488.4 64670.4 14623.0 14853.1 14873.4 14906.4 14978.0 10230.9 10246.7 10262.4 10269.8 10275.0 18096.4 18479.4 18562.4 18568.0 18607.0 6896.8 7118.3 7179.9 7244.5 7259.3 866.6 899.3 917.4 996.0 1014.9 25644.7 26261.2 28162.7 28510.6 29083.0 911.7 958.6 958.7 979.0 987.4 12896.2 13017.8 13185.8 13206.0 13217.7 263117.0 265025.0 267489.0 267859.0 269161.0 44079.8 44230.0 44428.6 44483.0 44505.1 1210.0 1225.8 1235.5 1243.5 1246.7 25175.5 25390.2 25451.6 25466.4 25533.9 39044.8 39462.2 39668.4 39723.6 39733.6 246560.0 246694.0 246843.0 248263.0 250032.0 27958.2 28910.7 29545.7 29680.9 29737.7 34568.3 35423.3 35567.8 35667.6 35907.8 32359.4 32409.8 32713.7 32936.8 33316.7 32701.8 32891.0 32908.2 32964.2 33162.0 32484.4 32544.5 32665.7 32961.3 33044.5 28372.6 29147.6 29411.3 30129.2 30526.2 21749.2 22305.8 22847.5 23296.2 23484.0 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,780 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26128.57 Median:22340.31 stddev:79263.34 (354.8%) stddev-sans-first:79462.02 11:01:25 INFO - 2015-12-04 11:01:25,782 DEBUG : BROWSER_OUTPUT: Values: 327.3 330.0 330.1 331.8 334.0 14625.8 15162.2 15639.4 15988.4 16522.1 12811.6 12862.3 12865.9 13238.5 13325.6 4468.2 4555.3 4570.2 4975.4 4985.0 4915.4 4991.3 4993.5 4995.5 4996.2 3311.5 3525.5 4955.5 4966.2 5214.3 5129.5 5141.8 5203.6 5210.2 5215.7 4923.4 5006.2 5016.0 5033.0 5044.5 18464.7 18606.8 18837.6 19130.3 19141.9 1703.8 1778.7 1822.8 1839.0 1841.3 8279.7 8561.0 12299.0 12467.7 12621.4 1125.4 1607.4 1649.7 1664.5 1693.0 55125.2 57664.7 57698.4 58002.0 58286.7 9635.1 9657.9 9724.9 9760.8 9768.6 12323.2 12364.6 12378.8 12385.9 12388.8 7257.5 7323.2 7498.3 7529.4 7537.7 7369.5 7380.5 7392.3 7406.9 7425.6 4053.5 4066.6 4109.2 4116.5 4118.1 1660.9 1790.7 1790.8 1792.8 1793.6 349.8 350.0 837.7 872.3 964.6 8962.7 9636.0 9771.4 9903.6 10040.7 372.7 831.3 860.7 860.9 877.1 8383.9 8811.7 8833.0 8921.1 8988.9 473563.0 482968.0 486059.0 486857.0 493374.0 72989.6 73519.6 75858.2 76966.6 77112.0 1034.9 1045.8 1053.0 1093.3 1095.0 14233.8 14283.8 14390.6 14525.9 14608.2 31910.0 32123.0 32665.5 32902.8 34444.7 40614.0 41161.6 41668.0 41997.6 46057.0 8631.1 8640.1 8952.5 9159.5 9160.0 10188.6 10250.8 14488.4 16371.8 16647.6 13384.1 13425.8 13743.9 13913.5 13950.2 12455.9 12791.2 12811.2 12821.7 13585.8 13236.2 13341.5 13435.6 13565.9 13910.7 8199.2 8224.3 8304.4 8337.5 8358.0 12679.1 12786.9 13018.1 13359.5 13653.9 11:01:25 INFO - 2015-12-04 11:01:25,782 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,782 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4902.14 Median:5786.96 stddev:2568.09 (44.4%) stddev-sans-first:2562.55 11:01:25 INFO - 2015-12-04 11:01:25,782 DEBUG : BROWSER_OUTPUT: Values: 1498.2 1644.0 1690.6 1713.8 1716.3 5816.9 5922.5 7009.6 7165.5 7171.4 6824.7 6991.9 7044.7 7046.0 7046.0 2045.8 2086.1 2090.1 2090.4 2093.1 2042.7 2085.1 2086.1 2090.8 2094.0 2029.1 2041.9 2078.4 2079.1 2090.7 2015.7 2042.2 2042.5 2043.4 2049.4 2008.6 2032.4 2037.7 2039.4 2043.7 7029.4 7132.3 7166.4 7200.7 7210.6 3998.1 4039.8 4076.6 4091.7 4094.1 2609.1 2621.7 2638.7 2662.8 2673.3 796.9 797.6 811.4 823.3 826.8 9504.6 9522.8 9551.8 9563.9 9617.7 3842.4 3844.8 3880.9 3889.1 3965.0 8353.2 8372.9 8373.1 8383.7 8388.0 4123.8 4125.5 4148.2 4151.6 4158.0 3128.1 3162.9 3713.7 3719.4 3783.4 3480.4 3501.1 3507.5 3528.4 3528.6 1112.1 1125.2 1129.1 1133.5 1136.7 1191.4 1203.4 1210.4 1223.4 1232.0 6661.2 6665.3 6719.8 6747.7 6770.9 406.9 423.3 430.4 430.8 432.7 5393.1 5410.6 5415.1 5442.8 5469.5 8321.5 8392.0 8465.2 8583.5 8590.8 8461.3 8526.9 8563.2 8584.8 8597.8 6465.5 6507.5 6516.7 6531.6 6799.8 6444.0 6471.6 6482.4 6489.4 6510.0 7474.9 7549.5 7696.2 7744.2 7758.6 7678.4 7703.9 7824.6 7850.3 7859.0 4863.5 5266.6 6107.0 6163.3 6210.6 6809.8 6819.0 6841.2 6851.0 6858.2 6166.2 6314.9 6448.8 6503.8 6520.9 6244.6 6275.9 6291.2 6326.8 6343.9 6141.2 6152.1 6179.4 6197.9 6216.5 5647.2 5651.9 5757.0 5772.9 5779.3 5713.8 5753.7 5763.4 5782.8 5791.2 11:01:25 INFO - 2015-12-04 11:01:25,782 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,782 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4801.54 Median:5585.69 stddev:1478.40 (26.5%) stddev-sans-first:1442.94 11:01:25 INFO - 2015-12-04 11:01:25,782 DEBUG : BROWSER_OUTPUT: Values: 273.1 273.8 279.1 279.2 279.8 5527.1 5575.3 5596.4 5608.3 5672.2 5526.8 5539.7 5539.7 5575.8 5595.6 4199.8 4200.9 4202.6 4204.1 4205.7 4204.5 4209.1 4212.5 4214.8 4215.7 4000.7 4161.9 4163.8 4175.6 4179.9 4095.5 4097.3 4098.7 4102.2 4107.8 3525.1 3526.4 3542.1 3552.1 3573.2 5356.9 5368.5 5372.2 5376.8 5377.5 4762.8 4781.2 4788.9 4792.9 4807.0 5710.8 5736.3 5821.4 5834.8 5847.8 3841.5 3854.2 3855.1 3855.8 3856.8 6071.5 6109.8 6132.4 6139.3 6144.4 3985.8 3987.9 3989.0 3989.3 3990.3 3842.7 4012.8 4017.1 4024.2 4045.7 4680.8 4691.8 4718.1 4723.5 4731.2 5806.0 5813.3 5814.9 5819.7 5838.2 1374.8 1398.6 1414.9 1415.7 1415.8 902.1 902.7 904.1 915.7 916.6 4961.5 5040.2 5042.9 5056.8 5073.1 5984.0 5988.7 5999.2 6012.3 6021.1 5043.9 5045.7 5058.0 5061.5 5064.2 3182.2 3230.9 3233.5 3274.1 3309.2 5824.3 5832.6 5838.9 5840.5 5840.9 6315.0 6328.2 6333.6 6343.7 6345.9 5625.5 5800.4 5803.3 5815.3 5818.2 6127.1 6133.9 6141.1 6142.2 6143.4 5955.4 5981.0 5985.2 5985.7 5993.4 5774.8 5782.6 5790.8 5796.6 5804.7 3921.1 3932.1 4011.5 4039.9 4047.2 5965.0 6137.2 6145.6 6152.0 6153.4 5856.5 5904.1 5906.7 5909.3 5910.2 5856.2 5889.3 5895.0 5896.4 5898.5 5623.8 5738.9 5743.4 5760.1 5770.7 5922.5 5945.0 5950.0 5957.3 5959.6 5743.8 5747.8 5751.3 5754.5 5759.7 11:01:25 INFO - 2015-12-04 11:01:25,783 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-04 11:01:25,783 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12560.99 Median:21402.06 stddev:14546.69 (68.0%) stddev-sans-first:14560.31 11:01:25 INFO - 2015-12-04 11:01:25,783 DEBUG : BROWSER_OUTPUT: Values: 717.5 737.8 754.8 774.2 777.9 11006.4 11215.6 11229.3 11244.3 11306.2 11232.4 11309.5 11348.6 11350.4 11359.1 632.1 637.0 792.5 798.8 818.8 746.7 789.4 797.6 800.8 802.1 841.2 847.2 850.0 851.6 852.7 834.8 835.1 835.4 837.0 842.1 620.2 623.2 624.9 625.9 628.1 11428.4 11529.1 11540.9 11547.1 11568.7 11147.4 11796.2 11992.2 12091.5 12253.8 8641.1 8723.4 8806.3 8849.9 8907.7 3181.3 3243.2 3273.1 3281.1 3323.6 40968.8 41211.2 41268.0 41286.6 41412.8 9567.0 9638.6 9648.8 9834.6 9859.6 17201.8 17271.2 17332.5 17357.3 17410.4 6132.8 6209.3 6339.3 6343.8 6437.2 3480.5 3511.2 3524.8 3536.1 3570.1 2605.1 2653.6 2655.2 2663.1 2663.3 459.1 464.6 465.8 475.0 480.7 408.0 411.9 422.1 426.5 482.9 7156.7 7320.3 7374.1 7455.6 7461.4 442.6 454.3 593.4 596.6 616.1 3522.5 3529.4 3536.4 3604.4 3655.2 55353.0 55586.7 55658.7 55801.7 55842.4 42151.6 42382.0 42607.6 42953.1 43175.6 41832.4 42959.6 43127.8 43491.6 43640.6 7166.2 7366.7 7521.8 7548.9 7716.2 32271.0 32277.8 32441.8 32760.5 33876.2 41598.6 41657.6 41907.8 42037.0 42070.4 10154.6 10324.7 10407.0 10465.4 10681.2 11481.0 11517.3 11549.8 11829.1 11917.6 10183.2 10360.5 10363.6 10378.7 10379.1 10635.5 10787.4 10825.3 10956.1 11297.9 10928.3 11040.1 11046.9 11285.5 11428.9 9529.0 9829.3 9846.2 9931.0 10024.4 8549.4 8992.6 9040.6 9070.5 9092.1 11:01:25 INFO - 2015-12-04 11:01:25,784 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:01:25 INFO - 2015-12-04 11:01:25,784 DEBUG : BROWSER_OUTPUT: 11:01:26 INFO - 2015-12-04 11:01:26,497 INFO : Browser exited with error code: 0 11:01:26 INFO - 2015-12-04 11:01:26,516 INFO : Completed test dromaeo_css (00:18:35) 11:01:26 INFO - 2015-12-04 11:01:26,516 INFO : Starting test kraken 11:01:26 INFO - 2015-12-04 11:01:26,516 DEBUG : operating with platform_type : linux_ 11:01:26 INFO - 2015-12-04 11:01:26,516 INFO : Initialising browser for kraken test... 11:01:26 INFO - 2015-12-04 11:01:26,522 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppu5aAP/profile http://localhost:55981/getInfo.html 11:01:31 INFO - 2015-12-04 11:01:31,649 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:01:31 INFO - 2015-12-04 11:01:31,650 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:01:31 INFO - 2015-12-04 11:01:31,650 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:01:31 INFO - 2015-12-04 11:01:31,650 DEBUG : BROWSER_OUTPUT: __metrics 11:01:31 INFO - 2015-12-04 11:01:31,811 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] 11:01:32 INFO - 2015-12-04 11:01:32,717 INFO : Browser initialized. 11:01:32 INFO - 2015-12-04 11:01:32,717 INFO : Running cycle 1/1 for kraken test... 11:01:32 INFO - 2015-12-04 11:01:32,718 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppu5aAP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:01:44 INFO - 2015-12-04 11:01:44,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 143441920 11:01:44 INFO - 2015-12-04 11:01:44,776 DEBUG : BROWSER_OUTPUT: 11:01:47 INFO - 2015-12-04 11:01:47,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55981/tests/kraken/driver.html?testName=audio-beat-detection) 11:01:47 INFO - 2015-12-04 11:01:47,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 142819328 11:01:47 INFO - 2015-12-04 11:01:47,964 DEBUG : BROWSER_OUTPUT: 11:01:50 INFO - 2015-12-04 11:01:50,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55981/tests/kraken/driver.html?testName=audio-dft) 11:01:51 INFO - 2015-12-04 11:01:51,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 142622720 11:01:51 INFO - 2015-12-04 11:01:51,335 DEBUG : BROWSER_OUTPUT: 11:01:54 INFO - 2015-12-04 11:01:54,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55981/tests/kraken/driver.html?testName=audio-fft) 11:01:54 INFO - 2015-12-04 11:01:54,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 138280960 11:01:54 INFO - 2015-12-04 11:01:54,820 DEBUG : BROWSER_OUTPUT: 11:01:56 INFO - 2015-12-04 11:01:56,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55981/tests/kraken/driver.html?testName=audio-oscillator) 11:01:57 INFO - 2015-12-04 11:01:57,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 139014144 11:01:57 INFO - 2015-12-04 11:01:57,532 DEBUG : BROWSER_OUTPUT: 11:01:59 INFO - 2015-12-04 11:01:59,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55981/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:02:00 INFO - 2015-12-04 11:02:00,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 140193792 11:02:00 INFO - 2015-12-04 11:02:00,389 DEBUG : BROWSER_OUTPUT: 11:02:03 INFO - 2015-12-04 11:02:03,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55981/tests/kraken/driver.html?testName=imaging-darkroom) 11:02:04 INFO - 2015-12-04 11:02:04,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 139214848 11:02:04 INFO - 2015-12-04 11:02:04,096 DEBUG : BROWSER_OUTPUT: 11:02:07 INFO - 2015-12-04 11:02:07,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55981/tests/kraken/driver.html?testName=imaging-desaturate) 11:02:08 INFO - 2015-12-04 11:02:08,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 138727424 11:02:08 INFO - 2015-12-04 11:02:08,180 DEBUG : BROWSER_OUTPUT: 11:02:11 INFO - 2015-12-04 11:02:11,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55981/tests/kraken/driver.html?testName=json-parse-financial) 11:02:11 INFO - 2015-12-04 11:02:11,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 138240000 11:02:11 INFO - 2015-12-04 11:02:11,662 DEBUG : BROWSER_OUTPUT: 11:02:13 INFO - 2015-12-04 11:02:13,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55981/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:02:14 INFO - 2015-12-04 11:02:14,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 140562432 11:02:14 INFO - 2015-12-04 11:02:14,006 DEBUG : BROWSER_OUTPUT: 11:02:15 INFO - 2015-12-04 11:02:15,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:02:16 INFO - 2015-12-04 11:02:16,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 140914688 11:02:16 INFO - 2015-12-04 11:02:16,502 DEBUG : BROWSER_OUTPUT: 11:02:18 INFO - 2015-12-04 11:02:18,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:02:19 INFO - 2015-12-04 11:02:19,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 11:02:19 INFO - 2015-12-04 11:02:19,278 DEBUG : BROWSER_OUTPUT: 11:02:21 INFO - 2015-12-04 11:02:21,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:02:22 INFO - 2015-12-04 11:02:22,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 141725696 11:02:22 INFO - 2015-12-04 11:02:22,449 DEBUG : BROWSER_OUTPUT: 11:02:25 INFO - 2015-12-04 11:02:25,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:02:25 INFO - 2015-12-04 11:02:25,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 140640256 11:02:25 INFO - 2015-12-04 11:02:25,688 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55981/tests/kraken/driver.html?testName=ai-astar) 11:02:27 INFO - 2015-12-04 11:02:27,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 141160448 11:02:27 INFO - 2015-12-04 11:02:27,674 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,675 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:02:27 INFO - 2015-12-04 11:02:27,675 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:02:27 INFO - 2015-12-04 11:02:27,676 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:02:27 INFO - 2015-12-04 11:02:27,676 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:02:27 INFO - 2015-12-04 11:02:27,677 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;112;112;112;124;113;110;112;116 11:02:27 INFO - 2015-12-04 11:02:27,678 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;135;160;171;130;160;155;139;182;131 11:02:27 INFO - 2015-12-04 11:02:27,678 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;164;161;164;166;160;163;163 11:02:27 INFO - 2015-12-04 11:02:27,678 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;73;72;76;72;135;72;72;75 11:02:27 INFO - 2015-12-04 11:02:27,678 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;135;94;94;95;132;94;95;131 11:02:27 INFO - 2015-12-04 11:02:27,678 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;111;110;110;110;110;110 11:02:27 INFO - 2015-12-04 11:02:27,679 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;151;151;150;148;149;148;148;148;147 11:02:27 INFO - 2015-12-04 11:02:27,679 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;104;96;96;96;96;98;96;95 11:02:27 INFO - 2015-12-04 11:02:27,679 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;71;72;72;73;72;71;72;70 11:02:27 INFO - 2015-12-04 11:02:27,679 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;70;68;69;68;68;68 11:02:27 INFO - 2015-12-04 11:02:27,680 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;86;85;84;86;88;85;84;87 11:02:27 INFO - 2015-12-04 11:02:27,680 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;134;134;121;123;130;122;128;125;122 11:02:27 INFO - 2015-12-04 11:02:27,680 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;152;146;149;147;156;143;150;154;139 11:02:27 INFO - 2015-12-04 11:02:27,680 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;71;72;69;68;68;72;69;70 11:02:27 INFO - 2015-12-04 11:02:27,680 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:02:27 INFO - 2015-12-04 11:02:27,681 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:02:27 INFO - 2015-12-04 11:02:27,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,793 11:02:27 INFO - 2015-12-04 11:02:27,681 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:02:27 INFO - 2015-12-04 11:02:27,681 DEBUG : BROWSER_OUTPUT: __startTimestamp1449255747675__endTimestamp 11:02:27 INFO - 2015-12-04 11:02:27,682 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,683 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:02:27 INFO - 2015-12-04 11:02:27,684 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:02:27 INFO - 2015-12-04 11:02:27,685 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,685 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:112.50 stddev:4.22 (3.8%) stddev-sans-first:4.44 11:02:27 INFO - 2015-12-04 11:02:27,685 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 112.0 112.0 112.0 124.0 113.0 110.0 112.0 116.0 11:02:27 INFO - 2015-12-04 11:02:27,685 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,685 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.40 Median:160.00 stddev:17.83 (11.1%) stddev-sans-first:18.64 11:02:27 INFO - 2015-12-04 11:02:27,685 DEBUG : BROWSER_OUTPUT: Values: 161.0 135.0 160.0 171.0 130.0 160.0 155.0 139.0 182.0 131.0 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.69 (1.0%) stddev-sans-first:1.76 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 164.0 161.0 164.0 166.0 160.0 163.0 163.0 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:72.50 stddev:19.66 (27.1%) stddev-sans-first:20.68 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 72.0 76.0 72.0 135.0 72.0 72.0 75.0 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,686 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:18.50 (19.7%) stddev-sans-first:19.20 11:02:27 INFO - 2015-12-04 11:02:27,687 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 135.0 94.0 94.0 95.0 132.0 94.0 95.0 131.0 11:02:27 INFO - 2015-12-04 11:02:27,687 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,687 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:02:27 INFO - 2015-12-04 11:02:27,687 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 11:02:27 INFO - 2015-12-04 11:02:27,687 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,687 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.50 stddev:1.40 (0.9%) stddev-sans-first:1.45 11:02:27 INFO - 2015-12-04 11:02:27,688 DEBUG : BROWSER_OUTPUT: Values: 148.0 151.0 151.0 150.0 148.0 149.0 148.0 148.0 148.0 147.0 11:02:27 INFO - 2015-12-04 11:02:27,688 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,688 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.00 stddev:2.60 (2.7%) stddev-sans-first:2.73 11:02:27 INFO - 2015-12-04 11:02:27,688 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 104.0 96.0 96.0 96.0 96.0 98.0 96.0 95.0 11:02:27 INFO - 2015-12-04 11:02:27,688 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,688 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:72.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 72.0 72.0 73.0 72.0 71.0 72.0 70.0 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 70.0 68.0 69.0 68.0 68.0 68.0 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:1.66 (1.9%) stddev-sans-first:1.58 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 86.0 85.0 84.0 86.0 88.0 85.0 84.0 87.0 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:129.00 stddev:5.06 (3.9%) stddev-sans-first:5.15 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: Values: 131.0 134.0 134.0 121.0 123.0 130.0 122.0 128.0 125.0 122.0 11:02:27 INFO - 2015-12-04 11:02:27,689 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,690 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:151.00 stddev:5.89 (3.9%) stddev-sans-first:5.36 11:02:27 INFO - 2015-12-04 11:02:27,690 DEBUG : BROWSER_OUTPUT: Values: 158.0 152.0 146.0 149.0 147.0 156.0 143.0 150.0 154.0 139.0 11:02:27 INFO - 2015-12-04 11:02:27,690 DEBUG : BROWSER_OUTPUT: 11:02:27 INFO - 2015-12-04 11:02:27,690 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 11:02:27 INFO - 2015-12-04 11:02:27,690 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 72.0 69.0 68.0 68.0 72.0 69.0 70.0 11:02:27 INFO - 2015-12-04 11:02:27,690 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:02:27 INFO - 2015-12-04 11:02:27,690 DEBUG : BROWSER_OUTPUT: 11:02:28 INFO - 2015-12-04 11:02:28,601 INFO : Browser exited with error code: 0 11:02:28 INFO - 2015-12-04 11:02:28,650 INFO : Completed test kraken (00:01:02) 11:02:28 INFO - 2015-12-04 11:02:28,650 INFO : Starting test v8_7 11:02:28 INFO - 2015-12-04 11:02:28,650 DEBUG : operating with platform_type : linux_ 11:02:28 INFO - 2015-12-04 11:02:28,650 INFO : Initialising browser for v8_7 test... 11:02:28 INFO - 2015-12-04 11:02:28,656 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVLMfLv/profile http://localhost:55981/getInfo.html 11:02:33 INFO - 2015-12-04 11:02:33,670 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:02:33 INFO - 2015-12-04 11:02:33,670 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:02:33 INFO - 2015-12-04 11:02:33,671 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:02:33 INFO - 2015-12-04 11:02:33,671 DEBUG : BROWSER_OUTPUT: __metrics 11:02:33 INFO - 2015-12-04 11:02:33,787 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] 11:02:34 INFO - 2015-12-04 11:02:34,717 INFO : Browser initialized. 11:02:34 INFO - 2015-12-04 11:02:34,718 INFO : Running cycle 1/1 for v8_7 test... 11:02:34 INFO - 2015-12-04 11:02:34,718 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVLMfLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:02:46 INFO - 2015-12-04 11:02:46,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 142766080 11:02:46 INFO - 2015-12-04 11:02:46,768 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55981/tests/v8_7/run.html (next: http://localhost:55981/tests/v8_7/run.html) 11:03:08 INFO - 2015-12-04 11:03:08,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 137244672 11:03:08 INFO - 2015-12-04 11:03:08,441 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,442 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:03:08 INFO - 2015-12-04 11:03:08,442 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:03:08 INFO - 2015-12-04 11:03:08,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:03:08 INFO - 2015-12-04 11:03:08,443 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:03:08 INFO - 2015-12-04 11:03:08,443 DEBUG : BROWSER_OUTPUT: |0;Richards;164.6090534979424 11:03:08 INFO - 2015-12-04 11:03:08,443 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.93857965451056 11:03:08 INFO - 2015-12-04 11:03:08,443 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 11:03:08 INFO - 2015-12-04 11:03:08,444 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 11:03:08 INFO - 2015-12-04 11:03:08,444 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 11:03:08 INFO - 2015-12-04 11:03:08,444 DEBUG : BROWSER_OUTPUT: |5;Earley;698.8120195667366 11:03:08 INFO - 2015-12-04 11:03:08,444 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 11:03:08 INFO - 2015-12-04 11:03:08,444 DEBUG : BROWSER_OUTPUT: |7;RegExp;26256.410256410258 11:03:08 INFO - 2015-12-04 11:03:08,445 DEBUG : BROWSER_OUTPUT: |8;Splay;597.7286312014345 11:03:08 INFO - 2015-12-04 11:03:08,445 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 11:03:08 INFO - 2015-12-04 11:03:08,445 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:03:08 INFO - 2015-12-04 11:03:08,445 DEBUG : BROWSER_OUTPUT: __startTimestamp1449255788441__endTimestamp 11:03:08 INFO - 2015-12-04 11:03:08,446 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,446 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:03:08 INFO - 2015-12-04 11:03:08,446 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:03:08 INFO - 2015-12-04 11:03:08,446 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,447 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.61 Median:164.61 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,448 DEBUG : BROWSER_OUTPUT: Values: 164.6 11:03:08 INFO - 2015-12-04 11:03:08,448 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,448 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,448 DEBUG : BROWSER_OUTPUT: Values: 191.9 11:03:08 INFO - 2015-12-04 11:03:08,448 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,448 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,448 DEBUG : BROWSER_OUTPUT: Values: 279.0 11:03:08 INFO - 2015-12-04 11:03:08,449 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,449 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,449 DEBUG : BROWSER_OUTPUT: Values: 5154.6 11:03:08 INFO - 2015-12-04 11:03:08,449 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,449 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,449 DEBUG : BROWSER_OUTPUT: Values: 1058.2 11:03:08 INFO - 2015-12-04 11:03:08,449 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:698.81 Median:698.81 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: Values: 698.8 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: Values: 12000.0 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,450 DEBUG : BROWSER_OUTPUT: Values: 26256.4 11:03:08 INFO - 2015-12-04 11:03:08,451 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,451 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.73 Median:597.73 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,451 DEBUG : BROWSER_OUTPUT: Values: 597.7 11:03:08 INFO - 2015-12-04 11:03:08,451 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2015-12-04 11:03:08,451 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:03:08 INFO - 2015-12-04 11:03:08,451 DEBUG : BROWSER_OUTPUT: Values: 4850.2 11:03:08 INFO - 2015-12-04 11:03:08,452 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:03:08 INFO - 2015-12-04 11:03:08,452 DEBUG : BROWSER_OUTPUT: 11:03:09 INFO - 2015-12-04 11:03:09,353 INFO : Browser exited with error code: 0 11:03:09 INFO - 2015-12-04 11:03:09,365 INFO : Completed test v8_7 (00:00:40) 11:03:09 INFO - 2015-12-04 11:03:09,454 INFO : Completed test suite (00:20:18) 11:03:09 INFO - 2015-12-04 11:03:09,454 DEBUG : Working with test: dromaeo_css 11:03:09 INFO - 2015-12-04 11:03:09,454 DEBUG : Generating results file: dromaeo_css 11:03:09 INFO - 2015-12-04 11:03:09,455 DEBUG : Working with test: kraken 11:03:09 INFO - 2015-12-04 11:03:09,456 DEBUG : Generating results file: kraken 11:03:09 INFO - 2015-12-04 11:03:09,456 INFO : javascript benchmark 11:03:09 INFO - 2015-12-04 11:03:09,456 DEBUG : Working with test: v8_7 11:03:09 INFO - 2015-12-04 11:03:09,456 DEBUG : Generating results file: v8_7 11:03:09 INFO - 2015-12-04 11:03:09,456 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:03:09 INFO - 2015-12-04 11:03:09,513 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:03:09 INFO - 2015-12-04 11:03:09,513 DEBUG : process_Request line: dromaeo_css 6273.35 graph.html#tests=[[72,132,43]] 11:03:09 INFO - 2015-12-04 11:03:09,513 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:03:09 INFO - 2015-12-04 11:03:09,552 DEBUG : process_Request line: kraken 1541.50 graph.html#tests=[[232,132,43]] 11:03:09 INFO - 2015-12-04 11:03:09,552 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:03:09 INFO - 2015-12-04 11:03:09,582 DEBUG : process_Request line: v8_7 21418.24 graph.html#tests=[[230,132,43]] 11:03:09 INFO - 2015-12-04 11:03:09,583 INFO : javascript benchmark 11:03:09 INFO - 2015-12-04 11:03:09,587 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2683.745044220799, 2726.522858499762, 2759.117082533589, 2765.8755356008965, 2768.667759868816, 4609.239475486549, 4750.524947505248, 4774.40319960005, 4789.64077694173, 4799.1841386964215, 4681.0169864328445, 4681.7659117044095, 4681.882952926178, 4698.64760142989, 4705.929411058828, 4404.889877753066, 4436.556344365562, 4459.0, 4468.530804265554, 4498.955010449903, 4430.4240448741775, 4477.753723545204, 4492.124035813018, 4503.572160644733, 4510.233260345749, 4207.1375368049785, 4333.198358303724, 4419.712718673276, 4444.488883778375, 4494.213512635292, 4424.11517696462, 4473.172463094338, 4481.955180448186, 4494.168578812897, 4506.346579745951, 4124.298869192245, 4440.111977604492, 4455.2203364411425, 4463.531329210418, 4503.076869241798, 4626.560476754737, 4648.279516674921, 4649.953500464986, 4678.345031695565, 4751.809927602926, 5143.022825663112, 5163.7676304566385, 5175.249588809639, 5177.326947496801, 5216.947830521684, 5212.843614691566, 5213.348331458567, 5217.895642087137, 5218.060749065166, 5227.764750586232, 4540.77296135192, 4679.625629949596, 4683.95316046842, 4724.976375118171, 4823.686460380064, 5291.365036195682, 5293.179557168645, 5309.0, 5313.0967735485065, 5370.516653501204, 5064.392272927199, 5079.669821461667, 5087.338645976073, 5110.4634013428795, 5131.204663277198, 4913.557779799764, 5015.648904576645, 5059.139946209153, 5168.638195326291, 5184.040952423814, 5101.566366858784, 5128.282040514331, 5134.717590532482, 5140.817611949273, 5143.485651434827, 5066.088104141216, 5103.668261562986, 5105.897882042338, 5112.284280200774, 5149.819756308586, 4046.1705350403095, 4170.541240463546, 4191.036061705825, 4253.744775313491, 4286.635635970915, 3736.9626303736613, 3758.511393518825, 3761.1349389640536, 3768.811559422018, 3796.0509872531866, 4268.466441694788, 4459.531749166291, 4479.10417916418, 4484.573965473275, 4496.775161241925, 5010.64925455222, 5013.072581572421, 5020.924686129711, 5029.119904016782, 5085.593152547787, 4474.351219073216, 4479.731216127043, 4481.5070342262325, 4487.237169681162, 4525.864224073283, 4578.061497393026, 4585.12882552314, 4589.58693717567, 4595.6783025187915, 4627.699199552018, 4662.673612847136, 4773.0, 4852.296417019583, 4946.159152944008, 4974.452810190804, 5194.091034069098, 5198.402183748917, 5206.01085793698, 5213.765380557808, 5224.921626175535, 4952.380952380952, 4956.77694503741, 4957.6281778866005, 4959.13215187348, 4993.80024799004, 4811.807527698853, 4905.2151655734915, 4945.1346014448045, 5005.099082165245, 5045.697258164375, 5126.666766660155, 5142.971405718797, 5163.044836705221, 5175.301334319819, 5216.321878155815, 4766.213574760126, 5003.949960500494, 5006.224035274538, 5010.148274793221, 5017.347744793299, 4838.806447742191, 4913.48408417111, 4945.332380128781, 4995.475475075064, 5029.321041659476, 4819.927701084556, 4871.585915197248, 4923.556879880828, 4933.038057578738, 4949.554540091409, 4740.194166991689, 4840.467548569584, 5043.092243396224, 5048.949510504995, 5049.065922804293, 4831.4202295724735, 4870.391201099863, 4873.561379475864, 4898.779554919965, 4920.21276595743], "unit": "ms", "name": "dojo.html", "value": 4699.240998658103}, {"lowerIsBetter": false, "replicates": [556.5547561950439, 563.3802816901409, 573.8565358660335, 581.8341772594812, 584.1500616602842, 35920.64079359206, 36996.81501592492, 37011.25977480449, 37026.0, 37055.0, 39357.212855742866, 39794.60205397945, 39923.0, 39925.0, 40042.0, 8003.8799418008775, 8119.9188008120045, 8172.18278172184, 8174.713885014025, 8189.631466584018, 7915.881261781078, 8020.719274825382, 8067.9193208068045, 8070.354371650254, 8071.838563228732, 8013.799655008643, 8062.516249025048, 8065.112837587861, 8093.5143891366415, 8104.756857294261, 8032.678692852279, 8091.069527004411, 8092.3930705197345, 8132.552709600969, 8140.837183256332, 7847.293743563107, 7857.489263197874, 7932.524048557105, 7961.482503637303, 7962.203779622049, 37194.8140259297, 37716.62283377186, 37736.43395349072, 37762.62237377646, 37800.0, 2545.630883521879, 2599.0773275487118, 2671.4523522677805, 2753.2703833484143, 2997.370552184044, 26614.866925665443, 26746.0, 26912.850373583216, 27083.10418270722, 27434.45131097367, 3377.527146199534, 3454.5854497460464, 3465.5321531593163, 3540.0795793093725, 3571.1786289153642, 217111.0, 217916.0, 217954.0, 218623.0, 218948.0, 45023.549764501935, 52692.0, 52998.73500632472, 53026.469735302926, 53042.46957530452, 46274.30588541175, 62788.37211627916, 64124.358756411835, 64488.355116448234, 64670.353296466434, 14623.0, 14853.108813471226, 14873.405063797327, 14906.403743850342, 14978.0, 10230.897691023143, 10246.743831404274, 10262.43556604394, 10269.794604107876, 10275.02387273208, 18096.366627167987, 18479.35322263741, 18562.350317739085, 18568.0, 18607.0, 6896.7586134485055, 7118.323759242864, 7179.89230161548, 7244.529105608119, 7259.274072592804, 866.6100254885326, 899.3299991506369, 917.3761841947539, 996.0388225362415, 1014.8985101489792, 25644.743552564236, 26261.21216363474, 28162.71837281601, 28510.572341414896, 29083.0, 911.7401540561041, 958.5638534466801, 958.6596758150756, 979.0, 987.3532835992437, 12896.246778430756, 13017.804732929013, 13185.802212966813, 13206.0, 13217.73564528704, 263117.0, 265025.0, 267489.0, 267859.0, 269161.0, 44079.77960110179, 44230.0, 44428.555714443086, 44483.0, 44505.10989780186, 1209.9576514821938, 1225.7671042501895, 1235.5366737473448, 1243.4963839644959, 1246.7007918099773, 25175.49649007046, 25390.238292851245, 25451.618225726997, 25466.363340916625, 25533.87233063897, 39044.804775975936, 39462.21075578415, 39668.40497392484, 39723.60276397199, 39733.60266397415, 246560.0, 246694.0, 246843.0, 248263.0, 250032.0, 27958.161255162377, 28910.710892890802, 29545.704542955154, 29680.851595741882, 29737.702622973495, 34568.308633827684, 35423.29153416866, 35567.822160890064, 35667.64332356643, 35907.82046089753, 32359.352812944082, 32409.837950811037, 32713.672863272015, 32936.835315823264, 33316.666833332325, 32701.836490817393, 32891.0, 32908.1772955678, 32964.1758956028, 33162.0, 32484.35031299408, 32544.51183232301, 32665.673343266262, 32961.34077318488, 33044.50433243455, 28372.574411383433, 29147.562786558643, 29411.264718382212, 30129.246768830955, 30526.236844079074, 21749.238776642742, 22305.776942230368, 22847.543049138592, 23296.184633537745, 23484.0], "unit": "ms", "name": "ext.html", "value": 16711.11275717648}, {"lowerIsBetter": false, "replicates": [327.2752593830513, 330.04452111138255, 330.1136448635414, 331.81915855858557, 333.9966600333996, 14625.780613290795, 15162.241887905602, 15639.374425022985, 15988.440404585841, 16522.09128497932, 12811.551595694153, 12862.292573908431, 12865.871341286584, 13238.53665121721, 13325.600231993032, 4468.173387923236, 4555.339475776011, 4570.200214962369, 4975.353204083464, 4985.027919555688, 4915.434725006634, 4991.251312303166, 4993.475685053054, 4995.500449955011, 4996.150654388744, 3311.4867195584725, 3525.4711793230963, 4955.529224723646, 4966.155753521892, 5214.296070030536, 5129.512696293846, 5141.794328226866, 5203.609729270301, 5210.16637338026, 5215.687058776467, 4923.359963204796, 5006.224035274538, 5016.046951079284, 5033.0, 5044.495550444926, 18464.72302915444, 18606.813931860645, 18837.62324753497, 19130.330438434587, 19141.90429047846, 1703.8040625328122, 1778.662054209696, 1822.7630408047003, 1839.0345068838833, 1841.272697284565, 8279.710210142677, 8561.0, 12299.0, 12467.688307792287, 12621.368931553478, 1125.3697929159614, 1607.4373969110834, 1649.6948064607966, 1664.4507312586938, 1692.957676058096, 55125.1731224028, 57664.711676441766, 57698.423015770146, 58002.0, 58286.70856645732, 9635.13283804447, 9657.9034209657, 9724.9027509724, 9760.755981100529, 9768.609255629695, 12323.198992065487, 12364.56724014655, 12378.76212378773, 12385.876141238652, 12388.81416778749, 7257.491975561766, 7323.231060738546, 7498.250174982458, 7529.435292352986, 7537.736179233811, 7369.484136110421, 7380.483366164424, 7392.297731715478, 7406.851862962711, 7425.62871856405, 4053.4527838741983, 4066.6136717011836, 4109.239790638741, 4116.526599441043, 4118.114605359862, 1660.9086500242602, 1790.719635460652, 1790.7582476365524, 1792.793828709689, 1793.5516120969758, 349.798865652251, 349.9632538583463, 837.7068026190784, 872.2716531696104, 964.5948701545368, 8962.68630597926, 9636.0, 9771.364861283993, 9903.554340054714, 10040.748981275527, 372.7185974589168, 831.3141658131944, 860.7030574451804, 860.8880845490171, 877.1272583779181, 8383.916160838435, 8811.691590794291, 8833.0, 8921.063288354759, 8988.910110898938, 473563.0, 482968.0, 486059.0, 486857.0, 493374.0, 72989.6350518244, 73519.63240183765, 75858.24141758622, 76966.6151669238, 77112.0, 1034.896510348959, 1045.8378951262566, 1052.9578816847393, 1093.2620481175175, 1095.0, 14233.786493202817, 14283.785743213652, 14390.640233993816, 14525.92737036308, 14608.196549189472, 31910.0, 32123.0, 32665.510017349283, 32902.83548582242, 34444.65555344414, 40614.0, 41161.58838411578, 41668.0, 41997.580024200586, 46057.0, 8631.136886311318, 8640.13598640131, 8952.462852228888, 9159.450432974043, 9160.0, 10188.592456301665, 10250.794984100425, 14488.420463181776, 16371.754423683893, 16647.583810404838, 13384.130031547918, 13425.798613020617, 13743.931280343535, 13913.513027044004, 13950.232737199145, 12455.875441245471, 12791.168574042658, 12811.167274127152, 12821.743565128832, 13585.79621305701, 13236.205827650372, 13341.533046343331, 13435.596932092052, 13565.86434135646, 13910.652233693834, 8199.180081991753, 8224.300934420642, 8304.418690691593, 8337.541435221121, 8358.03882553514, 12679.112462127563, 12786.936065319614, 13018.088733788543, 13359.465621375037, 13653.863461365656], "unit": "ms", "name": "jquery.html", "value": 7980.444559644121}, {"lowerIsBetter": false, "replicates": [1498.2134379450795, 1643.983560164398, 1690.6027083635342, 1713.7857767779024, 1716.2877405876561, 5816.941830581693, 5922.526197904157, 7009.5794252344895, 7165.462590305729, 7171.390431813295, 6824.72701091957, 6991.89512157318, 7044.682989265482, 7045.964770176155, 7046.0, 2045.7647370552354, 2086.0925497408675, 2090.1325949730845, 2090.362439455965, 2093.0685844799073, 2042.6629606115048, 2085.0825636719796, 2086.113401804227, 2090.7804680508557, 2094.0, 2029.0970518119443, 2041.9387418377473, 2078.3764870538853, 2079.0540304161646, 2090.707300977864, 2015.707722380254, 2042.213747707136, 2042.4689580708973, 2043.3869839048375, 2049.385184444668, 2008.648486514854, 2032.3902829151343, 2037.6943458481198, 2039.3983774786325, 2043.7036629688612, 7029.402500787439, 7132.286771322878, 7166.355028047501, 7200.711971521133, 7210.567365958059, 3998.0604557928864, 4039.838406463767, 4076.6127217914545, 4091.652209562191, 4094.1197642507004, 2609.1129016134605, 2621.7116117227088, 2638.722934091931, 2662.8002899782596, 2673.331667083229, 796.8962986264008, 797.6171437709932, 811.4401063266328, 823.2837431434631, 826.801567623766, 9504.572294246775, 9522.761930951712, 9551.808963820684, 9563.856542151872, 9617.71146865595, 3842.366009608383, 3844.826982785781, 3880.864169754045, 3889.086064774776, 3964.960350396459, 8353.16468353172, 8372.916270837335, 8373.07896131425, 8383.748487545261, 8387.95806020966, 4123.793810309532, 4125.50493940729, 4148.191102734998, 4151.605597468296, 4157.958420415757, 3128.0615815255333, 3162.905112846618, 3713.665770080706, 3719.442083687414, 3783.4135708964604, 3480.3735327641266, 3501.142220156027, 3507.4563442666426, 3528.40017197072, 3528.6118526962014, 1112.071420364005, 1125.201107213871, 1129.13056946151, 1133.450276615857, 1136.72718547548, 1191.4042978510745, 1203.4283715235367, 1210.3585099896893, 1223.443333283354, 1231.950721971111, 6661.16735408074, 6665.333466653393, 6719.764808231688, 6747.696353664097, 6770.864582708318, 406.86166703321015, 423.2656341247932, 430.4081887404818, 430.77384373203694, 432.7338686707715, 5393.056215162409, 5410.648307859977, 5415.10650742631, 5442.809501667422, 5469.535089517356, 8321.500709957421, 8391.95804020976, 8465.238128568335, 8583.527905965107, 8590.828183436297, 8461.323094152576, 8526.87209691855, 8563.186497282748, 8584.785380365416, 8597.785055373666, 6465.4827613790785, 6507.544471887017, 6516.674166291667, 6531.575447595986, 6799.762008329685, 6443.96778016107, 6471.611703297817, 6482.35176482348, 6489.448396886318, 6509.967450162719, 7474.850502989801, 7549.547027178387, 7696.15342312334, 7744.186860379805, 7758.573278469738, 7678.424118191047, 7703.88444173349, 7824.569648669378, 7850.2542258485355, 7859.0, 4863.513648635108, 5266.605004624592, 6106.969465152646, 6163.291221509584, 6210.627362358273, 6809.795706128824, 6818.965905170442, 6841.24746277919, 6851.0, 6858.211305699909, 6166.167567378526, 6314.936850631435, 6448.838779030561, 6503.837404064936, 6520.902186467112, 6244.562880598314, 6275.937240627535, 6291.213598300213, 6326.841828954313, 6343.9365606343345, 6141.170941922784, 6152.107944347955, 6179.351168127461, 6197.876042479035, 6216.502679785697, 5647.237622920853, 5651.858703532444, 5756.971215144065, 5772.884542309214, 5779.335376431596, 5713.771449141987, 5753.654780713171, 5763.423657634203, 5782.7686892523825, 5791.160281759206], "unit": "ms", "name": "mootools.html", "value": 3965.8118485014443}, {"lowerIsBetter": false, "replicates": [273.0729174452733, 273.7700331721354, 279.10546697833433, 279.1931318489564, 279.81532188755415, 5527.088030474967, 5575.330960284767, 5596.440355964407, 5608.270924779778, 5672.17753425753, 5526.834194974157, 5539.695316757577, 5539.695316757577, 5575.804846830361, 5595.580331475136, 4199.811008504609, 4200.915981680365, 4202.600752928467, 4204.138151678913, 4205.684573656973, 4204.516480604739, 4209.116085622023, 4212.53662097169, 4214.789260536976, 4215.683823713219, 4000.6999475039343, 4161.895952601179, 4163.75017498951, 4175.603317684815, 4179.853705120321, 4095.4675892133832, 4097.282975479309, 4098.73358231717, 4102.159057393242, 4107.815148318318, 3525.1363415962996, 3526.4357702767434, 3542.1144713821545, 3552.147484603702, 3573.160307327776, 5356.866078348034, 5368.543673787733, 5372.167314066326, 5376.758045887945, 5377.46225377463, 4762.833105889079, 4781.2350023996, 4788.928166077511, 4792.880177995543, 4807.029118061578, 5710.8001219957105, 5736.254286942671, 5821.417858214187, 5834.766609335621, 5847.8245652630485, 3841.519810023747, 3854.1520865409566, 3855.1133239354826, 3855.807209639535, 3856.8264428100524, 6071.51427885768, 6109.816705498843, 6132.386761323876, 6139.324674285825, 6144.354842741493, 3985.780782056957, 3987.860424885115, 3988.960110398917, 3989.341758609855, 3990.3216453203027, 3842.711796615265, 4012.7792971386853, 4017.0760725033406, 4024.215278020816, 4045.6561192298395, 4680.789364478606, 4691.7888695008805, 4718.103560323528, 4723.504032076651, 4731.172044892199, 5806.0, 5813.273340832396, 5814.883702325929, 5819.679917604488, 5838.241028666331, 1374.8212732344932, 1398.5664444022386, 1414.8655877691604, 1415.6956254405352, 1415.801787749716, 902.1294450854956, 902.697596305245, 904.0597778310615, 915.6657819895823, 916.6150216908915, 4961.50384961501, 5040.193569028937, 5042.899142017139, 5056.848294551096, 5073.061483625541, 5983.970080149571, 5988.700564971734, 5999.220101386792, 6012.30858451275, 6021.126936594169, 5043.924341134886, 5045.697258164449, 5057.974710126426, 5061.519155680205, 5064.240363945438, 3182.2203560127455, 3230.919227019296, 3233.4664780311455, 3274.1323549259464, 3309.189248634052, 5824.301083869878, 5832.62087964281, 5838.854028649318, 5840.5035571976005, 5840.941590584125, 6314.9684251579365, 6328.208973878265, 6333.619982801047, 6343.651099189497, 6345.873082538324, 5625.54995600351, 5800.447802966765, 5803.332616749043, 5815.273090863642, 5818.156367326714, 6127.111568822406, 6133.9079913802225, 6141.109539116893, 6142.170806941006, 6143.385661433821, 5955.374685657944, 5980.970095149496, 5985.162077309267, 5985.730642121028, 5993.370696077023, 5774.797882074107, 5782.5663075268685, 5790.768369265183, 5796.62321949072, 5804.6807425592, 3921.0785465415033, 3932.07596214895, 4011.538673052636, 4039.91920161601, 4047.2310261050307, 5965.0, 6137.202163718866, 6145.600535965148, 6151.96924015377, 6153.4154255345675, 5856.472917437451, 5904.084866845646, 5906.734196961061, 5909.349971503218, 5910.231669882888, 5856.180134781049, 5889.322727886177, 5894.970525147347, 5896.439838215363, 5898.498627616701, 5623.803166889139, 5738.929672625126, 5743.368229494668, 5760.0783874579865, 5770.653760774367, 5922.496587790086, 5945.0, 5950.0, 5957.255343082114, 5959.642421454727, 5743.770249190153, 5747.827565173052, 5751.33859606134, 5754.4533269339345, 5759.683217422914], "unit": "ms", "name": "prototype.html", "value": 4305.536420927358}, {"lowerIsBetter": false, "replicates": [717.4977515738984, 737.8302990312228, 754.8075240813591, 774.2257742257741, 777.9105402878671, 11006.449677516122, 11215.60745373913, 11229.32624042557, 11244.325340479578, 11306.152038597118, 11232.438378081084, 11309.547618095286, 11348.60279890204, 11350.375729334883, 11359.1480638952, 632.1339764522611, 637.018990754238, 792.4848848248627, 798.7923139983588, 818.758466252457, 746.7498388040013, 789.4079440419686, 797.5573556676043, 800.7757827808223, 802.1377019703842, 841.2176675691604, 847.2163248994686, 849.9617517211709, 851.5529347092764, 852.722865068852, 834.8121672623641, 835.1439774231401, 835.4360806455618, 837.0081453477649, 842.1368097699846, 620.1596836286857, 623.2489849731109, 624.8968920128174, 625.8560531077877, 628.1300398947445, 11428.428578571038, 11529.135314851335, 11540.884591154148, 11547.133964952662, 11568.710782230428, 11147.442627868573, 11796.233244839059, 11992.220505667105, 12091.45588448522, 12253.759426640709, 8641.135886411308, 8723.38936274461, 8806.306978038889, 8849.867251991162, 8907.73276801697, 3181.2524056846623, 3243.189202699325, 3273.1489812648647, 3281.1305004173914, 3323.601167859848, 40968.795156024324, 41211.175776484306, 41268.0, 41286.587134128575, 41412.792936035126, 9567.043295670377, 9638.566264518113, 9648.75878103053, 9834.557444914995, 9859.605615775432, 17201.827981720024, 17271.222794974256, 17332.480025599252, 17357.3057077718, 17410.39063632767, 6132.816015519542, 6209.285932117774, 6339.270983836917, 6343.809685709344, 6437.195350581177, 3480.4779283107737, 3511.227529943408, 3524.7885126891956, 3536.1159710072484, 3570.0896271450615, 2605.0751983045748, 2653.6284920111198, 2655.1503518873774, 2663.0945478537, 2663.2542887991394, 459.1162013124721, 464.59812262392785, 465.80773042616454, 474.964377671676, 480.6971607887009, 408.02278542889616, 411.8846722917528, 422.1283050500706, 426.54785926917566, 482.91790395632825, 7156.749513766993, 7320.341169294789, 7374.115106187184, 7455.627218639046, 7461.403087752967, 442.637037629141, 454.3253268895687, 593.430306905367, 596.6479776931632, 616.1497133955113, 3522.5244591979754, 3529.435290353531, 3536.398812201932, 3604.4052731299566, 3655.1775850433974, 55353.0, 55586.72206638941, 55658.72170639121, 55801.72099139478, 55842.44157558454, 42151.57848421476, 42382.0, 42607.57392426098, 42953.140937181706, 43175.56824431715, 41832.37251441231, 42959.57040429618, 43127.784361078, 43491.565084349386, 43640.563594364285, 7166.175889772743, 7366.7053317866685, 7521.811954701177, 7548.886766698394, 7716.228377162239, 32271.0, 32277.838610806797, 32441.837790810896, 32760.50859237161, 33876.15309617181, 41598.584014159474, 41657.58342416537, 41907.7904610475, 42037.0, 42070.36894446525, 10154.593816247267, 10324.741881453023, 10407.0, 10465.372077675363, 10681.198910081619, 11481.0, 11517.308961462339, 11549.78727233662, 11829.112816538965, 11917.582884598998, 10183.185345172516, 10360.533775979948, 10363.585456581652, 10378.688639340831, 10379.11777498921, 10635.549904006906, 10787.352758834495, 10825.296355737168, 10956.12351011933, 11297.943510282395, 10928.344299342065, 11040.061594764215, 11046.944765276123, 11285.548578056785, 11428.94285528567, 9529.0, 9829.262805289774, 9846.163076138608, 9931.0, 10024.398536087858, 8549.444286121383, 8992.640294388151, 9040.63837446521, 9070.501122438329, 9092.136247056518], "unit": "ms", "name": "yui.html", "value": 5695.495729304639}], "name": "dromaeo_css", "value": 6273.345281423903}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 112.0, 112.0, 112.0, 124.0, 113.0, 110.0, 112.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [161.0, 135.0, 160.0, 171.0, 130.0, 160.0, 155.0, 139.0, 182.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 164.0, 161.0, 164.0, 166.0, 160.0, 163.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 72.0, 76.0, 72.0, 135.0, 72.0, 72.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 135.0, 94.0, 94.0, 95.0, 132.0, 94.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 151.0, 150.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.8}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 104.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 72.0, 72.0, 73.0, 72.0, 71.0, 72.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 70.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 86.0, 85.0, 84.0, 86.0, 88.0, 85.0, 84.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [131.0, 134.0, 134.0, 121.0, 123.0, 130.0, 122.0, 128.0, 125.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [158.0, 152.0, 146.0, 149.0, 147.0, 156.0, 143.0, 150.0, 154.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 72.0, 69.0, 68.0, 68.0, 72.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1541.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.6090534979424], "unit": "score", "name": "Richards", "value": 214.45965}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [698.8120195667366], "unit": "score", "name": "Earley", "value": 953.7085530000003}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [597.7286312014345], "unit": "score", "name": "Splay", "value": 136.33444300000005}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21418.240527972768}]} 11:03:09 INFO - RETURN: dromaeo_css: 6273.35 11:03:09 INFO - RETURN: kraken: 1541.50 11:03:09 INFO - RETURN: v8_7: 21418.24 11:03:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21418.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1541.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6273.35"}}} 11:03:09 INFO - Return code: 0 11:03:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:03:09 INFO - # TBPL SUCCESS # 11:03:09 INFO - Running post-action listener: _resource_record_post_action 11:03:09 INFO - Running post-run listener: _resource_record_post_run 11:03:10 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508145664; Read time: 156; Write time: 529896 11:03:10 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235937792; Read time: 0; Write time: 365732 11:03:10 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 272207872; Read time: 156; Write time: 164164 11:03:10 INFO - Running post-run listener: _upload_blobber_files 11:03:10 INFO - Blob upload gear active. 11:03:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:03:10 INFO - Copying logs to upload dir... 11:03:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.276128 ========= master_lag: 80.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 30 secs) (at 2015-12-04 11:04:31.834949) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 11:04:31.838494) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010155 build_url: 'https://queue.taskcluster.net/v1/task/Mn-SMDMEQpmzxaMof6m52w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.33 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 11:04:32.181358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 11:04:32.181686) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449254517.923172-175732419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 11:04:32.488066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 11:04:32.488415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 11:04:32.494105) ========= ========= Total master_lag: 83.37 =========