builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1449197860.98 results: success (0) buildid: 20151203181815 builduid: 890be7958bb94076832e2b59d7b9eec0 revision: 1a8e8ab6ee3dacc69e865879a4eb6739904d57b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:40.983952) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:40.984429) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:40.984722) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.009106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.009596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.023149) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.023518) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.073376) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.073853) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.074401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.074681) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 18:57:41-- 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% 220M=0s 2015-12-03 18:57:41 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187025 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.333126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.333465) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017090 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.413561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:41.413939) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a8e8ab6ee3dacc69e865879a4eb6739904d57b1 --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 1a8e8ab6ee3dacc69e865879a4eb6739904d57b1 --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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 18:57:41,560 truncating revision to first 12 chars 2015-12-03 18:57:41,560 Setting DEBUG logging. 2015-12-03 18:57:41,560 attempt 1/10 2015-12-03 18:57:41,560 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a8e8ab6ee3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 18:57:42,123 unpacking tar archive at: fx-team-1a8e8ab6ee3d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.854078 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:42.280811) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:42.281113) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:42.290861) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:42.291200) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 18:57:42.291639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-03 18:57:42.291918) ========= /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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:57:42 INFO - MultiFileLogger online at 20151203 18:57:42 in /builds/slave/test 18:57:42 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 18:57:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:57:42 INFO - {'append_to_log': False, 18:57:42 INFO - 'base_work_dir': '/builds/slave/test', 18:57:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:57:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:57:42 INFO - 'branch': 'Fx-Team-Non-PGO', 18:57:42 INFO - 'buildbot_json_path': 'buildprops.json', 18:57:42 INFO - 'config_files': ('talos/linux_config.py',), 18:57:42 INFO - 'default_actions': ('clobber', 18:57:42 INFO - 'read-buildbot-config', 18:57:42 INFO - 'download-and-extract', 18:57:42 INFO - 'populate-webroot', 18:57:42 INFO - 'create-virtualenv', 18:57:42 INFO - 'install', 18:57:42 INFO - 'run-tests'), 18:57:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:57:42 INFO - 'download_minidump_stackwalk': True, 18:57:42 INFO - 'download_symbols': 'ondemand', 18:57:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:57:42 INFO - 'tooltool.py': '/tools/tooltool.py', 18:57:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:57:42 INFO - '/tools/misc-python/virtualenv.py')}, 18:57:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:57:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:57:42 INFO - 'installer_path': 'installer.exe', 18:57:42 INFO - 'log_level': 'info', 18:57:42 INFO - 'log_name': 'talos', 18:57:42 INFO - 'log_to_console': True, 18:57:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:57:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:57:42 INFO - 'opt_config_files': (), 18:57:42 INFO - 'pip_index': False, 18:57:42 INFO - 'sps_profile': False, 18:57:42 INFO - 'sps_profile_interval': 0, 18:57:42 INFO - 'suite': 'dromaeojs-e10s', 18:57:42 INFO - 'system_bits': '64', 18:57:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:57:42 INFO - 'title': 'talos-linux64-ix-019', 18:57:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:57:42 INFO - 'use_talos_json': True, 18:57:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:57:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:57:42 INFO - 'work_dir': 'build'} 18:57:42 INFO - ##### 18:57:42 INFO - ##### Running clobber step. 18:57:42 INFO - ##### 18:57:42 INFO - Running pre-action listener: _resource_record_pre_action 18:57:42 INFO - Running main action method: clobber 18:57:42 INFO - rmtree: /builds/slave/test/build 18:57:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:57:42 INFO - Running post-action listener: _resource_record_post_action 18:57:42 INFO - ##### 18:57:42 INFO - ##### Running read-buildbot-config step. 18:57:42 INFO - ##### 18:57:42 INFO - Running pre-action listener: _resource_record_pre_action 18:57:42 INFO - Running main action method: read_buildbot_config 18:57:42 INFO - Using buildbot properties: 18:57:42 INFO - { 18:57:42 INFO - "properties": { 18:57:42 INFO - "buildnumber": 532, 18:57:42 INFO - "product": "firefox", 18:57:42 INFO - "script_repo_revision": "production", 18:57:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:57:42 INFO - "repository": "", 18:57:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:57:42 INFO - "buildid": "20151203181815", 18:57:42 INFO - "slavename": "talos-linux64-ix-019", 18:57:42 INFO - "pgo_build": "False", 18:57:42 INFO - "basedir": "/builds/slave/test", 18:57:42 INFO - "project": "", 18:57:42 INFO - "platform": "ubuntu64_hw", 18:57:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:57:42 INFO - "slavebuilddir": "test", 18:57:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:57:42 INFO - "branch": "fx-team", 18:57:42 INFO - "repo_path": "integration/fx-team", 18:57:42 INFO - "stage_platform": "linux64", 18:57:42 INFO - "builduid": "890be7958bb94076832e2b59d7b9eec0", 18:57:42 INFO - "revision": "1a8e8ab6ee3dacc69e865879a4eb6739904d57b1" 18:57:42 INFO - }, 18:57:42 INFO - "sourcestamp": { 18:57:42 INFO - "repository": "", 18:57:42 INFO - "hasPatch": false, 18:57:42 INFO - "project": "", 18:57:42 INFO - "branch": "fx-team-linux64-talos", 18:57:42 INFO - "changes": [ 18:57:42 INFO - { 18:57:42 INFO - "category": null, 18:57:42 INFO - "files": [ 18:57:42 INFO - { 18:57:42 INFO - "url": null, 18:57:42 INFO - "name": "https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:57:42 INFO - } 18:57:42 INFO - ], 18:57:42 INFO - "repository": "", 18:57:42 INFO - "rev": "1a8e8ab6ee3dacc69e865879a4eb6739904d57b1", 18:57:42 INFO - "who": "mconley@mozilla.com", 18:57:42 INFO - "when": 1449197668, 18:57:42 INFO - "number": 6742434, 18:57:42 INFO - "comments": "Bug 1226333 - Add tests for async window flushing. r=billm.", 18:57:42 INFO - "project": "", 18:57:42 INFO - "at": "Thu 03 Dec 2015 18:54:28", 18:57:42 INFO - "branch": "fx-team-linux64-talos", 18:57:42 INFO - "revlink": "", 18:57:42 INFO - "properties": [ 18:57:42 INFO - [ 18:57:42 INFO - "buildid", 18:57:42 INFO - "20151203181815", 18:57:42 INFO - "Change" 18:57:42 INFO - ], 18:57:42 INFO - [ 18:57:42 INFO - "builduid", 18:57:42 INFO - "890be7958bb94076832e2b59d7b9eec0", 18:57:42 INFO - "Change" 18:57:42 INFO - ], 18:57:42 INFO - [ 18:57:42 INFO - "pgo_build", 18:57:42 INFO - "False", 18:57:42 INFO - "Change" 18:57:42 INFO - ] 18:57:42 INFO - ], 18:57:42 INFO - "revision": "1a8e8ab6ee3dacc69e865879a4eb6739904d57b1" 18:57:42 INFO - } 18:57:42 INFO - ], 18:57:42 INFO - "revision": "1a8e8ab6ee3dacc69e865879a4eb6739904d57b1" 18:57:42 INFO - } 18:57:42 INFO - } 18:57:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:57:42 INFO - Running post-action listener: _resource_record_post_action 18:57:42 INFO - ##### 18:57:42 INFO - ##### Running download-and-extract step. 18:57:42 INFO - ##### 18:57:42 INFO - Running pre-action listener: _resource_record_pre_action 18:57:42 INFO - Running main action method: download_and_extract 18:57:42 INFO - mkdir: /builds/slave/test/build/tests 18:57:42 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')]} 18:57:42 INFO - https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/test_packages.json 18:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/test_packages.json 18:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:57:43 INFO - Downloaded 1302 bytes. 18:57:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:57:43 INFO - Using the following test package requirements: 18:57:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:57:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:57:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:43 INFO - u'jsshell-linux-x86_64.zip'], 18:57:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:57:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:57:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:57:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:57:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:57:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:57:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:57:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:57:43 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')]} 18:57:43 INFO - https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:44 INFO - Downloaded 21791680 bytes. 18:57:44 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 18:57:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:57:44 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 18:57:45 INFO - Return code: 0 18:57:45 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 18:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:45 INFO - https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:47 INFO - Downloaded 21791680 bytes. 18:57:47 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 18:57:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:57:47 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 18:57:48 INFO - Return code: 0 18:57:48 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')]} 18:57:48 INFO - https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:57:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:57:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:57:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:49 INFO - Downloaded 11132001 bytes. 18:57:49 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 18:57:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:57:49 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 18:57:49 INFO - Return code: 0 18:57: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')]} 18:57:49 INFO - https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:57:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:57:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:57:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1hN3Nj18SMOotHKYgF9CgA/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 18:57:51 INFO - Downloaded 57699448 bytes. 18:57:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:57:51 INFO - mkdir: /builds/slave/test/properties 18:57:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:57:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:57:51 INFO - Contents: 18:57:51 INFO - build_url:https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:57:51 INFO - Running post-action listener: _resource_record_post_action 18:57:51 INFO - Running post-action listener: set_extra_try_arguments 18:57:51 INFO - ##### 18:57:51 INFO - ##### Running populate-webroot step. 18:57:51 INFO - ##### 18:57:51 INFO - Running pre-action listener: _resource_record_pre_action 18:57:51 INFO - Running main action method: populate_webroot 18:57:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:57:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:57:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:57:51 INFO - '../fennec_ids.txt'], 18:57:51 INFO - 'tests': ['tcheck2']}, 18:57:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:57:51 INFO - '--tppagecycles', 18:57:51 INFO - '7'], 18:57:51 INFO - 'tests': ['tsvgm']}}, 18:57:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:57:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:57:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:57:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:57:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'tests': ['damp', 'tps']}, 18:57:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['damp', 'tps']}, 18:57:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:57:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:57:51 INFO - 'other': {'tests': ['a11yr', 18:57:51 INFO - 'ts_paint', 18:57:51 INFO - 'tpaint', 18:57:51 INFO - 'sessionrestore', 18:57:51 INFO - 'sessionrestore_no_auto_restore']}, 18:57:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['a11yr', 18:57:51 INFO - 'ts_paint', 18:57:51 INFO - 'tpaint', 18:57:51 INFO - 'sessionrestore', 18:57:51 INFO - 'sessionrestore_no_auto_restore']}, 18:57:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['a11yr', 18:57:51 INFO - 'ts_paint', 18:57:51 INFO - 'tpaint', 18:57:51 INFO - 'sessionrestore', 18:57:51 INFO - 'sessionrestore_no_auto_restore']}, 18:57:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['a11yr', 18:57:51 INFO - 'ts_paint', 18:57:51 INFO - 'tpaint', 18:57:51 INFO - 'sessionrestore', 18:57:51 INFO - 'sessionrestore_no_auto_restore']}, 18:57:51 INFO - 'other_l64': {'tests': ['a11yr', 18:57:51 INFO - 'ts_paint', 18:57:51 INFO - 'tpaint', 18:57:51 INFO - 'sessionrestore', 18:57:51 INFO - 'sessionrestore_no_auto_restore']}, 18:57:51 INFO - 'other_nol64': {'tests': ['a11yr', 18:57:51 INFO - 'ts_paint', 18:57:51 INFO - 'tpaint', 18:57:51 INFO - 'sessionrestore', 18:57:51 INFO - 'sessionrestore_no_auto_restore']}, 18:57:51 INFO - 'svgr': {'tests': ['tsvgx', 18:57:51 INFO - 'tsvgr_opacity', 18:57:51 INFO - 'tart', 18:57:51 INFO - 'tscrollx', 18:57:51 INFO - 'cart']}, 18:57:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['tsvgx', 18:57:51 INFO - 'tsvgr_opacity', 18:57:51 INFO - 'tart', 18:57:51 INFO - 'tscrollx', 18:57:51 INFO - 'cart']}, 18:57:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'tests': ['tp5o']}, 18:57:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'talos_options': ['--e10s'], 18:57:51 INFO - 'tests': ['tp5o']}, 18:57:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'talos_options': ['--xperf_path', 18:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:51 INFO - 'tests': ['tp5n']}, 18:57:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:51 INFO - 'talos_options': ['--e10s', 18:57:51 INFO - '--xperf_path', 18:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:51 INFO - 'tests': ['tp5n']}}, 18:57:51 INFO - 'talos.zip': {'path': '', 18:57:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:57:51 INFO - Running post-action listener: _resource_record_post_action 18:57:51 INFO - ##### 18:57:51 INFO - ##### Running create-virtualenv step. 18:57:51 INFO - ##### 18:57:51 INFO - Running pre-action listener: _resource_record_pre_action 18:57:51 INFO - Running main action method: create_virtualenv 18:57:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:57:51 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 18:57:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:57:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:57:51 INFO - Using real prefix '/usr' 18:57:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:57:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:57:53 INFO - Installing pip.................done. 18:57:53 INFO - Return code: 0 18:57:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:57:53 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')]} 18:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:53 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')]} 18:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:53 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 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:57:53 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 18:57:53 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 18:57:53 INFO - Using env: {'DISPLAY': ':0', 18:57:53 INFO - 'HOME': '/home/cltbld', 18:57:53 INFO - 'LANG': 'en_US.UTF-8', 18:57:53 INFO - 'LANGUAGE': 'en_US:en', 18:57:53 INFO - 'LOGNAME': 'cltbld', 18:57:53 INFO - 'MAIL': '/var/mail/cltbld', 18:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:53 INFO - 'MOZ_NO_REMOTE': '1', 18:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:53 INFO - 'NO_EM_RESTART': '1', 18:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:53 INFO - 'PWD': '/builds/slave/test', 18:57:53 INFO - 'SHELL': '/bin/bash', 18:57:53 INFO - 'SHLVL': '1', 18:57:53 INFO - 'TERM': 'linux', 18:57:53 INFO - 'TMOUT': '86400', 18:57:53 INFO - 'USER': 'cltbld', 18:57:53 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:53 INFO - '_': '/tools/buildbot/bin/python'} 18:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:54 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 18:57:54 INFO - Cleaning up... 18:57:54 INFO - Return code: 0 18:57:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:54 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 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:57:54 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 18:57:54 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 18:57:54 INFO - Using env: {'DISPLAY': ':0', 18:57:54 INFO - 'HOME': '/home/cltbld', 18:57:54 INFO - 'LANG': 'en_US.UTF-8', 18:57:54 INFO - 'LANGUAGE': 'en_US:en', 18:57:54 INFO - 'LOGNAME': 'cltbld', 18:57:54 INFO - 'MAIL': '/var/mail/cltbld', 18:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:54 INFO - 'MOZ_NO_REMOTE': '1', 18:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:54 INFO - 'NO_EM_RESTART': '1', 18:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:54 INFO - 'PWD': '/builds/slave/test', 18:57:54 INFO - 'SHELL': '/bin/bash', 18:57:54 INFO - 'SHLVL': '1', 18:57:54 INFO - 'TERM': 'linux', 18:57:54 INFO - 'TMOUT': '86400', 18:57:54 INFO - 'USER': 'cltbld', 18:57:54 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:54 INFO - '_': '/tools/buildbot/bin/python'} 18:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:54 INFO - Downloading/unpacking psutil>=0.7.1 18:57:54 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 18:57:54 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 18:57:54 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 18:57:54 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 18:57:54 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 18:57:54 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 18:57:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:56 INFO - Installing collected packages: psutil 18:57:56 INFO - Running setup.py install for psutil 18:57:56 INFO - building 'psutil._psutil_linux' extension 18:57:56 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 18:57:56 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 18:57:56 INFO - building 'psutil._psutil_posix' extension 18:57:56 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 18:57:56 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 18:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:56 INFO - Successfully installed psutil 18:57:56 INFO - Cleaning up... 18:57:56 INFO - Return code: 0 18:57:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:57:56 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')]} 18:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:56 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')]} 18:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:56 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 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:57:56 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 18:57:56 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 18:57:56 INFO - Using env: {'DISPLAY': ':0', 18:57:56 INFO - 'HOME': '/home/cltbld', 18:57:56 INFO - 'LANG': 'en_US.UTF-8', 18:57:56 INFO - 'LANGUAGE': 'en_US:en', 18:57:56 INFO - 'LOGNAME': 'cltbld', 18:57:56 INFO - 'MAIL': '/var/mail/cltbld', 18:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:56 INFO - 'MOZ_NO_REMOTE': '1', 18:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:56 INFO - 'NO_EM_RESTART': '1', 18:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:56 INFO - 'PWD': '/builds/slave/test', 18:57:56 INFO - 'SHELL': '/bin/bash', 18:57:56 INFO - 'SHLVL': '1', 18:57:56 INFO - 'TERM': 'linux', 18:57:56 INFO - 'TMOUT': '86400', 18:57:56 INFO - 'USER': 'cltbld', 18:57:56 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:56 INFO - '_': '/tools/buildbot/bin/python'} 18:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:57:56 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 18:57:56 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 18:57:56 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 18:57:56 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 18:57:56 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 18:57:56 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 18:57:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:57:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:57:58 INFO - Installing collected packages: mozsystemmonitor 18:57:58 INFO - Running setup.py install for mozsystemmonitor 18:57:58 INFO - Successfully installed mozsystemmonitor 18:57:58 INFO - Cleaning up... 18:57:58 INFO - Return code: 0 18:57:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:58 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 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:57:58 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 18:57:58 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 18:57:58 INFO - Using env: {'DISPLAY': ':0', 18:57:58 INFO - 'HOME': '/home/cltbld', 18:57:58 INFO - 'LANG': 'en_US.UTF-8', 18:57:58 INFO - 'LANGUAGE': 'en_US:en', 18:57:58 INFO - 'LOGNAME': 'cltbld', 18:57:58 INFO - 'MAIL': '/var/mail/cltbld', 18:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:58 INFO - 'MOZ_NO_REMOTE': '1', 18:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:58 INFO - 'NO_EM_RESTART': '1', 18:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:58 INFO - 'PWD': '/builds/slave/test', 18:57:58 INFO - 'SHELL': '/bin/bash', 18:57:58 INFO - 'SHLVL': '1', 18:57:58 INFO - 'TERM': 'linux', 18:57:58 INFO - 'TMOUT': '86400', 18:57:58 INFO - 'USER': 'cltbld', 18:57:58 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:58 INFO - '_': '/tools/buildbot/bin/python'} 18:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:58:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:58:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:58:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:58:00 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 18:58:00 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 18:58:00 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 18:58:00 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 18:58:00 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 18:58:00 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 18:58:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:58:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:58:01 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 18:58:01 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 18:58:01 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 18:58:01 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 18:58:01 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 18:58:01 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 18:58:01 INFO - Downloading docopt-0.6.1.tar.gz 18:58:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:58:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:58:01 INFO - Running setup.py install for blobuploader 18:58:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:58:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:58:01 INFO - Running setup.py install for requests 18:58:01 INFO - Running setup.py install for docopt 18:58:01 INFO - Successfully installed blobuploader requests docopt 18:58:01 INFO - Cleaning up... 18:58:01 INFO - Return code: 0 18:58:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:01 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 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:58:01 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 18:58:01 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 18:58:01 INFO - Using env: {'DISPLAY': ':0', 18:58:01 INFO - 'HOME': '/home/cltbld', 18:58:01 INFO - 'LANG': 'en_US.UTF-8', 18:58:01 INFO - 'LANGUAGE': 'en_US:en', 18:58:01 INFO - 'LOGNAME': 'cltbld', 18:58:01 INFO - 'MAIL': '/var/mail/cltbld', 18:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:01 INFO - 'MOZ_NO_REMOTE': '1', 18:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:01 INFO - 'NO_EM_RESTART': '1', 18:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:01 INFO - 'PWD': '/builds/slave/test', 18:58:01 INFO - 'SHELL': '/bin/bash', 18:58:01 INFO - 'SHLVL': '1', 18:58:01 INFO - 'TERM': 'linux', 18:58:01 INFO - 'TMOUT': '86400', 18:58:01 INFO - 'USER': 'cltbld', 18:58:01 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:01 INFO - '_': '/tools/buildbot/bin/python'} 18:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:58:02 INFO - Running setup.py (path:/tmp/pip-hbcU2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:58:02 INFO - Running setup.py (path:/tmp/pip-kpwjcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:58:02 INFO - Running setup.py (path:/tmp/pip-NSsO8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:58:02 INFO - Running setup.py (path:/tmp/pip-u7wmf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:58:02 INFO - Running setup.py (path:/tmp/pip-GHOQGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:58:02 INFO - Running setup.py (path:/tmp/pip-Xvmuxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:58:02 INFO - Running setup.py (path:/tmp/pip-7MFV87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:58:02 INFO - Running setup.py (path:/tmp/pip-FpINrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:58:02 INFO - Running setup.py (path:/tmp/pip-VULwAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:58:02 INFO - Running setup.py (path:/tmp/pip-3yx54S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:58:02 INFO - Running setup.py (path:/tmp/pip-fK3zjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:58:02 INFO - Running setup.py (path:/tmp/pip-WbdNCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:58:03 INFO - Running setup.py (path:/tmp/pip-KXkvdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:58:03 INFO - Running setup.py (path:/tmp/pip-amFXMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:03 INFO - Running setup.py (path:/tmp/pip-xoADF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:58:03 INFO - Running setup.py (path:/tmp/pip-YbJYGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:58:03 INFO - Running setup.py (path:/tmp/pip-wPE77J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:58:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:58:03 INFO - Running setup.py install for manifestparser 18:58:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:58:03 INFO - Running setup.py install for mozcrash 18:58:03 INFO - Running setup.py install for mozdebug 18:58:03 INFO - Running setup.py install for mozdevice 18:58:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:58:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:58:03 INFO - Running setup.py install for mozfile 18:58:03 INFO - Running setup.py install for mozhttpd 18:58:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:58:03 INFO - Running setup.py install for mozinfo 18:58:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Running setup.py install for mozInstall 18:58:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Running setup.py install for mozleak 18:58:04 INFO - Running setup.py install for mozlog 18:58:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Running setup.py install for moznetwork 18:58:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Running setup.py install for mozprocess 18:58:04 INFO - Running setup.py install for mozprofile 18:58:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Running setup.py install for mozrunner 18:58:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:58:04 INFO - Running setup.py install for mozscreenshot 18:58:04 INFO - Running setup.py install for moztest 18:58:05 INFO - Running setup.py install for mozversion 18:58:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:58:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:58:05 INFO - Cleaning up... 18:58:05 INFO - Return code: 0 18:58:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58: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')]} 18:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:05 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 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:58:05 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 18:58:05 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 18:58:05 INFO - Using env: {'DISPLAY': ':0', 18:58:05 INFO - 'HOME': '/home/cltbld', 18:58:05 INFO - 'LANG': 'en_US.UTF-8', 18:58:05 INFO - 'LANGUAGE': 'en_US:en', 18:58:05 INFO - 'LOGNAME': 'cltbld', 18:58:05 INFO - 'MAIL': '/var/mail/cltbld', 18:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:05 INFO - 'MOZ_NO_REMOTE': '1', 18:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:05 INFO - 'NO_EM_RESTART': '1', 18:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:05 INFO - 'PWD': '/builds/slave/test', 18:58:05 INFO - 'SHELL': '/bin/bash', 18:58:05 INFO - 'SHLVL': '1', 18:58:05 INFO - 'TERM': 'linux', 18:58:05 INFO - 'TMOUT': '86400', 18:58:05 INFO - 'USER': 'cltbld', 18:58:05 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:05 INFO - '_': '/tools/buildbot/bin/python'} 18:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:58:05 INFO - Running setup.py (path:/tmp/pip-Vcxvyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:58:05 INFO - Running setup.py (path:/tmp/pip-ptP_zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:58:05 INFO - Running setup.py (path:/tmp/pip-1UcC4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:58:05 INFO - Running setup.py (path:/tmp/pip-ONftyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:58:05 INFO - Running setup.py (path:/tmp/pip-Y0gk7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:58:05 INFO - Running setup.py (path:/tmp/pip-p629ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:58:05 INFO - Running setup.py (path:/tmp/pip-zVMiiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:58:05 INFO - Running setup.py (path:/tmp/pip-MzrWIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:58:05 INFO - Running setup.py (path:/tmp/pip-B7WmRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:58:05 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)) 18:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:58:05 INFO - Running setup.py (path:/tmp/pip-6NyOmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:58:06 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)) 18:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:58:06 INFO - Running setup.py (path:/tmp/pip-ZJVwqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:58:06 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)) 18:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:58:06 INFO - Running setup.py (path:/tmp/pip-f9mpZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:58:06 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)) 18:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:58:06 INFO - Running setup.py (path:/tmp/pip-hjn2ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:58:06 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)) 18:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:58:06 INFO - Running setup.py (path:/tmp/pip-LOxEM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:58:06 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)) 18:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:06 INFO - Running setup.py (path:/tmp/pip-bstM2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:06 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)) 18:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:58:06 INFO - Running setup.py (path:/tmp/pip-63ORIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:58:06 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)) 18:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:58:06 INFO - Running setup.py (path:/tmp/pip-uzWPUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:58:06 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)) 18:58:06 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)) 18:58:06 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)) 18:58:06 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)) 18:58:06 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)) 18:58:06 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)) 18:58:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:58:06 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 18:58:06 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 18:58:06 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 18:58:06 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 18:58:06 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 18:58:06 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 18:58:08 INFO - Downloading blessings-1.5.1.tar.gz 18:58:08 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 18:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:58:08 INFO - Installing collected packages: blessings 18:58:08 INFO - Running setup.py install for blessings 18:58:08 INFO - Successfully installed blessings 18:58:08 INFO - Cleaning up... 18:58:08 INFO - Return code: 0 18:58:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:08 INFO - Reading from file tmpfile_stdout 18:58:08 INFO - Current package versions: 18:58:08 INFO - argparse == 1.2.1 18:58:08 INFO - blessings == 1.5.1 18:58:08 INFO - blobuploader == 1.2.4 18:58:08 INFO - docopt == 0.6.1 18:58:08 INFO - manifestparser == 1.1 18:58:08 INFO - mozInstall == 1.12 18:58:08 INFO - mozcrash == 0.16 18:58:08 INFO - mozdebug == 0.1 18:58:08 INFO - mozdevice == 0.47 18:58:08 INFO - mozfile == 1.2 18:58:08 INFO - mozhttpd == 0.7 18:58:08 INFO - mozinfo == 0.9 18:58:08 INFO - mozleak == 0.1 18:58:08 INFO - mozlog == 3.1 18:58:08 INFO - moznetwork == 0.27 18:58:08 INFO - mozprocess == 0.22 18:58:08 INFO - mozprofile == 0.27 18:58:08 INFO - mozrunner == 6.11 18:58:08 INFO - mozscreenshot == 0.1 18:58:08 INFO - mozsystemmonitor == 0.0 18:58:08 INFO - moztest == 0.7 18:58:08 INFO - mozversion == 1.4 18:58:08 INFO - psutil == 3.1.1 18:58:08 INFO - requests == 1.2.3 18:58:08 INFO - wsgiref == 0.1.2 18:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58: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')]} 18:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:58:08 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 18:58:08 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 18:58:08 INFO - Using env: {'DISPLAY': ':0', 18:58:08 INFO - 'HOME': '/home/cltbld', 18:58:08 INFO - 'LANG': 'en_US.UTF-8', 18:58:08 INFO - 'LANGUAGE': 'en_US:en', 18:58:08 INFO - 'LOGNAME': 'cltbld', 18:58:08 INFO - 'MAIL': '/var/mail/cltbld', 18:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:08 INFO - 'MOZ_NO_REMOTE': '1', 18:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:08 INFO - 'NO_EM_RESTART': '1', 18:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:08 INFO - 'PWD': '/builds/slave/test', 18:58:08 INFO - 'SHELL': '/bin/bash', 18:58:08 INFO - 'SHLVL': '1', 18:58:08 INFO - 'TERM': 'linux', 18:58:08 INFO - 'TMOUT': '86400', 18:58:08 INFO - 'USER': 'cltbld', 18:58:08 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:08 INFO - '_': '/tools/buildbot/bin/python'} 18:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 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)) 18:58:08 INFO - Cleaning up... 18:58:08 INFO - Return code: 0 18:58:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:58: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')]} 18:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:58:08 INFO - Using env: {'DISPLAY': ':0', 18:58:08 INFO - 'HOME': '/home/cltbld', 18:58:08 INFO - 'LANG': 'en_US.UTF-8', 18:58:08 INFO - 'LANGUAGE': 'en_US:en', 18:58:08 INFO - 'LOGNAME': 'cltbld', 18:58:08 INFO - 'MAIL': '/var/mail/cltbld', 18:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:08 INFO - 'MOZ_NO_REMOTE': '1', 18:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:08 INFO - 'NO_EM_RESTART': '1', 18:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:08 INFO - 'PWD': '/builds/slave/test', 18:58:08 INFO - 'SHELL': '/bin/bash', 18:58:08 INFO - 'SHLVL': '1', 18:58:08 INFO - 'TERM': 'linux', 18:58:08 INFO - 'TMOUT': '86400', 18:58:08 INFO - 'USER': 'cltbld', 18:58:08 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:08 INFO - '_': '/tools/buildbot/bin/python'} 18:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:09 INFO - Downloading/unpacking jsonschema 18:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:58:10 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 18:58:10 INFO - Downloading/unpacking functools32 (from jsonschema) 18:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:10 INFO - Downloading functools32-3.2.3-2.tar.gz 18:58:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:58:11 INFO - warning: no files found matching '*.txt' 18:58:11 INFO - no previously-included directories found matching 'build' 18:58:11 INFO - no previously-included directories found matching 'dist' 18:58:11 INFO - no previously-included directories found matching '.git*' 18:58:11 INFO - Installing collected packages: jsonschema, functools32 18:58:11 INFO - Running setup.py install for functools32 18:58:11 INFO - warning: no files found matching '*.txt' 18:58:11 INFO - no previously-included directories found matching 'build' 18:58:11 INFO - no previously-included directories found matching 'dist' 18:58:11 INFO - no previously-included directories found matching '.git*' 18:58:11 INFO - Successfully installed jsonschema functools32 18:58:11 INFO - Cleaning up... 18:58:11 INFO - Return code: 0 18:58:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe492451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', '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 18:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:58:11 INFO - Using env: {'DISPLAY': ':0', 18:58:11 INFO - 'HOME': '/home/cltbld', 18:58:11 INFO - 'LANG': 'en_US.UTF-8', 18:58:11 INFO - 'LANGUAGE': 'en_US:en', 18:58:11 INFO - 'LOGNAME': 'cltbld', 18:58:11 INFO - 'MAIL': '/var/mail/cltbld', 18:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:11 INFO - 'MOZ_NO_REMOTE': '1', 18:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:11 INFO - 'NO_EM_RESTART': '1', 18:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:11 INFO - 'PWD': '/builds/slave/test', 18:58:11 INFO - 'SHELL': '/bin/bash', 18:58:11 INFO - 'SHLVL': '1', 18:58:11 INFO - 'TERM': 'linux', 18:58:11 INFO - 'TMOUT': '86400', 18:58:11 INFO - 'USER': 'cltbld', 18:58:11 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:11 INFO - '_': '/tools/buildbot/bin/python'} 18:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:11 INFO - Downloading/unpacking flake8 18:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:58:13 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 18:58:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:58:13 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 18:58:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:13 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 18:58:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:58:13 INFO - no previously-included directories found matching 'docs/_build' 18:58:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:58:13 INFO - Running setup.py install for pep8 18:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:58:13 INFO - no previously-included directories found matching 'docs/_build' 18:58:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:58:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:58:14 INFO - Cleaning up... 18:58:14 INFO - Return code: 0 18:58:14 INFO - Running post-action listener: _resource_record_post_action 18:58:14 INFO - Running post-action listener: _start_resource_monitoring 18:58:14 INFO - Starting resource monitoring. 18:58:14 INFO - ##### 18:58:14 INFO - ##### Running install step. 18:58:14 INFO - ##### 18:58:14 INFO - Running pre-action listener: _resource_record_pre_action 18:58:14 INFO - Running main action method: install 18:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:14 INFO - Reading from file tmpfile_stdout 18:58:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:58:14 INFO - Reading from file tmpfile_stdout 18:58:14 INFO - Output received: 18:58:14 INFO - Usage: mozinstall [options] installer 18:58:14 INFO - Options: 18:58:14 INFO - -h, --help show this help message and exit 18:58:14 INFO - -d DEST, --destination=DEST 18:58:14 INFO - Directory to install application into. [default: 18:58:14 INFO - "/builds/slave/test"] 18:58:14 INFO - --app=APP Application being installed. [default: firefox] 18:58:14 INFO - mkdir: /builds/slave/test/build/application 18:58:14 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'] 18:58:14 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 18:58:28 INFO - Reading from file tmpfile_stdout 18:58:28 INFO - Output received: 18:58:28 INFO - /builds/slave/test/build/application/firefox/firefox 18:58:28 INFO - Running post-action listener: _resource_record_post_action 18:58:28 INFO - ##### 18:58:28 INFO - ##### Running run-tests step. 18:58:28 INFO - ##### 18:58:28 INFO - Running pre-action listener: _resource_record_pre_action 18:58:28 INFO - Running main action method: run_tests 18:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:58:28 INFO - Python 2.7.3 18:58:28 INFO - Return code: 0 18:58:28 INFO - grabbing minidump binary from tooltool 18:58:28 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')]} 18:58:28 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 0x29830b0>, '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 0x2983fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2984440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:58:28 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 18:58:28 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 18:58:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:58:28 INFO - Return code: 0 18:58:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:58:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:58:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:58:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:58:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:58:29 INFO - Return code: 0 18:58:29 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/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test/build 18:58:29 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/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 18:58:29 INFO - Using env: {'DISPLAY': ':0', 18:58:29 INFO - 'HOME': '/home/cltbld', 18:58:29 INFO - 'LANG': 'en_US.UTF-8', 18:58:29 INFO - 'LANGUAGE': 'en_US:en', 18:58:29 INFO - 'LOGNAME': 'cltbld', 18:58:29 INFO - 'MAIL': '/var/mail/cltbld', 18:58:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:58:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:29 INFO - 'MOZ_NO_REMOTE': '1', 18:58:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:29 INFO - 'NO_EM_RESTART': '1', 18:58:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:29 INFO - 'PWD': '/builds/slave/test', 18:58:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:58:29 INFO - 'SHELL': '/bin/bash', 18:58:29 INFO - 'SHLVL': '1', 18:58:29 INFO - 'TERM': 'linux', 18:58:29 INFO - 'TMOUT': '86400', 18:58:29 INFO - 'USER': 'cltbld', 18:58:29 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487', 18:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:29 INFO - '_': '/tools/buildbot/bin/python'} 18:58:29 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/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 18:58:30 INFO - mozversion INFO | application_buildid: 20151203181815 18:58:30 INFO - mozversion INFO | application_changeset: 1a8e8ab6ee3dacc69e865879a4eb6739904d57b1 18:58:30 INFO - mozversion INFO | application_display_name: Nightly 18:58:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:58:30 INFO - mozversion INFO | application_name: Firefox 18:58:30 INFO - mozversion INFO | application_remotingname: firefox 18:58:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:58:30 INFO - mozversion INFO | application_vendor: Mozilla 18:58:30 INFO - mozversion INFO | application_version: 45.0a1 18:58:30 INFO - mozversion INFO | platform_buildid: 20151203181815 18:58:30 INFO - mozversion INFO | platform_changeset: 1a8e8ab6ee3dacc69e865879a4eb6739904d57b1 18:58:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:58:30 INFO - mozversion INFO | platform_version: 45.0a1 18:58:30 INFO - 2015-12-03 18:58:30,116 DEBUG : using testdate: 1449197910 18:58:30 INFO - 2015-12-03 18:58:30,116 DEBUG : actual date: 1449197910 18:58:30 INFO - 2015-12-03 18:58:30,164 INFO : starting webserver on 'localhost:41323' 18:58:30 INFO - 2015-12-03 18:58:30,165 INFO : Starting test suite talos-linux64-ix-019.e 18:58:30 INFO - 2015-12-03 18:58:30,165 INFO : Starting test dromaeo_css 18:58:30 INFO - 2015-12-03 18:58:30,166 DEBUG : operating with platform_type : linux_ 18:58:30 INFO - 2015-12-03 18:58:30,166 INFO : Initialising browser for dromaeo_css test... 18:58:30 INFO - 2015-12-03 18:58:30,179 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgpc8YK/profile http://localhost:41323/getInfo.html 18:58:35 INFO - 2015-12-03 18:58:35,195 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:58:35 INFO - 2015-12-03 18:58:35,195 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:58:35 INFO - 2015-12-03 18:58:35,195 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:58:35 INFO - 2015-12-03 18:58:35,196 DEBUG : BROWSER_OUTPUT: __metrics 18:58:35 INFO - 2015-12-03 18:58:35,324 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] 18:58:36 INFO - 2015-12-03 18:58:36,257 INFO : Browser initialized. 18:58:36 INFO - 2015-12-03 18:58:36,258 INFO : Running cycle 1/1 for dromaeo_css test... 18:58:36 INFO - 2015-12-03 18:58:36,258 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgpc8YK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:58:48 INFO - 2015-12-03 18:58:48,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 143581184 18:58:48 INFO - 2015-12-03 18:58:48,339 DEBUG : BROWSER_OUTPUT: 18:59:37 INFO - 2015-12-03 18:59:37,963 DEBUG : BROWSER_OUTPUT: 1449197977960 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] 19:01:49 INFO - 2015-12-03 19:01:49,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41323/tests/dromaeo/cssquery-ext.html) 19:01:51 INFO - 2015-12-03 19:01:51,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 146698240 19:01:51 INFO - 2015-12-03 19:01:51,121 DEBUG : BROWSER_OUTPUT: 19:04:53 INFO - 2015-12-03 19:04:53,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/dromaeo/cssquery-ext.html (next: http://localhost:41323/tests/dromaeo/cssquery-jquery.html) 19:04:53 INFO - 2015-12-03 19:04:53,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 144551936 19:04:53 INFO - 2015-12-03 19:04:53,754 DEBUG : BROWSER_OUTPUT: 19:07:55 INFO - 2015-12-03 19:07:55,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41323/tests/dromaeo/cssquery-mootools.html) 19:07:56 INFO - 2015-12-03 19:07:56,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 146190336 19:07:56 INFO - 2015-12-03 19:07:56,161 DEBUG : BROWSER_OUTPUT: 19:10:57 INFO - 2015-12-03 19:10:57,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41323/tests/dromaeo/cssquery-prototype.html) 19:10:58 INFO - 2015-12-03 19:10:58,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 144662528 19:10:58 INFO - 2015-12-03 19:10:58,467 DEBUG : BROWSER_OUTPUT: 19:14:01 INFO - 2015-12-03 19:14:01,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41323/tests/dromaeo/cssquery-yui.html) 19:14:01 INFO - 2015-12-03 19:14:01,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 145367040 19:14:01 INFO - 2015-12-03 19:14:01,756 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/dromaeo/cssquery-yui.html (next: http://localhost:41323/tests/dromaeo/cssquery-dojo.html) 19:17:04 INFO - 2015-12-03 19:17:04,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 147963904 19:17:04 INFO - 2015-12-03 19:17:04,342 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,343 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:17:04 INFO - 2015-12-03 19:17:04,343 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:17:04 INFO - 2015-12-03 19:17:04,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:17:04 INFO - 2015-12-03 19:17:04,344 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:17:04 INFO - 2015-12-03 19:17:04,347 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2651.3769264222906;2689.811713180078;2721.278861101808;2732.685741139768;2741.890324387024;4590.816367345302;4682.8126874925;4688.906221875569;4705;4722.716637001778;4629.86110416688;4658.301254811771;4715.78778954947;4844.709317440956;4889.853304400874;4287.314029755247;4388.341748737699;4451.62161216297;4472.910541789162;4497.775111244425;4274.145170965804;4349.41282926804;4360.803763830635;4421.845235416761;4454.22051141049;4205.8527951521855;4309.870703878889;4310.3534469829465;4313.633341166004;4369.038811461505;4380.956190438087;4392.1874453226255;4415.690901636886;4424.402705634762;4429.512753597101;4361.869143925687;4383.561643835623;4389.1660584488845;4399.538048504893;4427.712198707074;4460.7323560586465;4589.586937175637;4637.420322459692;4718.811247550094;4737.50256223095;5036.521530454601;5082.79668813247;5100.744962751847;5120.539151476348;5164.096283150471;5134.178531434953;5136.255242989746;5136.717480538568;5136.7671758778;5138.049460849755;4610.746408947506;4728.078024785203;4729.929051064237;4737.313089602023;4739.928901066487;5091.66904151229;5183.170692689152;5193.480651934852;5193.922091168635;5244.947550524522;4933.531314525115;4959.181735013754;4962.206047032458;5014.6991180529285;5017.297578339036;4795.544423279853;4908.828191013297;4985.725785081783;5069.6451248413;5090.898182036339;5042.168042273057;5044.9495505045215;5049;5053.393592768891;5071.518205770446;4962.528559786814;4965.478624744422;4981.626378021663;5005.174146265826;5077.1876499759865;4031.032552187454;4088.6115818997146;4154.31453810124;4168.666506679519;4250.404943307939;3672.192117734094;3689.5756987946193;3690.686291665185;3719.08882323827;3754.267917756066;4434.5343738907595;4442.400275962704;4447.421835161473;4447.866564003085;4489.079738653568;4854.126257273654;4956.405231372259;5009.699418034929;5085.262636917626;5149.382074151126;4396.758178300224;4439.378487011821;4446.421965144576;4448.7108337957925;4453.3320001999955;4255.276602977439;4516.187086324493;4530.546945305443;4535;4579.74811385377;4750.548697873696;4756.21522448799;4823.1800593898415;4833.854984350475;4876.171050921423;5133.1786914095055;5190.97404512975;5198.792048318025;5202;5246.527812496894;4635.374224479787;4741.122892264942;4902.7058376497525;4914.238293064581;4961.42943561495;4861.1006963711825;4912.238603016538;4930.6055515557955;4938.925916111333;4939.185034469272;5118.539331460186;5162.870928226825;5168.173092305213;5170.43125256229;5204.765785539584;4748.335233067304;4844.61243100544;4864.902701945871;4972.950270497248;4974.776135073858;4944.728039957837;4952.380952380952;4961.727105009115;4963.429205641398;4973.825916092919;4833.9274910875665;4857.635677324285;4870.245112007645;4870.738104158861;4917.655764096479;4720.480747117883;4841.467438581823;4855.393075865517;4986.252062190701;5046.29351890743;4866.975665121652;4881.414230292387;4893.975530122327;4906.545532087957;4935.358403407534 19:17:04 INFO - 2015-12-03 19:17:04,348 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.3392513796289;571.7712914834066;579.6058680097534;579.9768009279629;583.0467186150643;38444.42333365002;39037.21925561491;39071.609283907186;39114.21771564567;39158;41251;41880.581194188126;41903.37144942821;41955.37066943991;42035.36946945798;7789.493682910621;7856.450048496607;7932.841343173133;7936.412717456503;7944.602769861513;7818.609069546528;7879.8030049248655;7950.483218590802;7979.202079792032;7986.6805327786815;7953.72161974331;8075.434719569633;8084.312833409167;8099.2710656040945;8106.189381061876;7981.481203721769;8047.839043219103;8066.314363279128;8088.514689118613;8094.190580941918;7706.152323244439;7778.961105194495;7854.960725196394;7856.528608283521;7859.724909628136;38023.23953520942;38166;38218.61781382179;38427;38560.80719596384;2907.578401131845;2953.808002479832;2985.2835319523374;3367.0572239772905;3641.708663306929;28772.856135719398;28846;28846.134615961553;29169.270768230752;29428.411431771245;3274.0505253476463;3308.4871844864083;3321.933561328784;3384.644612315696;3400.4049291373913;217162;217403;217422;218496;218526;51440;52642.47357526452;56445.71777141088;63606.363936360045;65387.673061634385;59863.401365986654;59974;60102.398976010554;60254;60535.39464605298;13145;13220.471181152838;13247.602571922858;13322.533711320057;13371.732565348639;9509.191718703849;9602.375845570015;9620.95189524062;9638.373505722106;9672.129508344282;19830.810151390964;19972.400827975183;20240.898795505927;20295.695564566544;20369;7357.926420735831;7521;7542.170361260367;7629.465937384441;7647.732329368446;822.6503735912213;864.822711344173;907.464595888429;911.129870973219;1011.0597144655541;26506.337341566228;26672;26807.195784126117;26891.865540672563;27036.86481567619;964.744342749172;985.8324084905584;995.4525011243787;1011.079917275276;1088.1349327284827;13721.931390342985;13908.791368129487;13909.14133514561;14110.85889141116;14138.434462621586;278893;287283;288733;289006;289142;47465;47776.52223477721;47791.981841906796;47798.5220147801;47808.28287575689;1196.174639498743;1212.1636071110904;1213.4236237786981;1232.7411243638758;1236.6537369536545;25636.743632564183;25752.356191095372;26151.738482614932;26162;26456.603150952367;42011;42529.57470425256;42533;42691.57308426876;42772;263502;265101;265366;265397;265600;29873.551896721132;30483.847580761954;30778.846105769328;30881.301528416152;30963;40219.3967090488;40325.596744033355;40744.59255407408;41214.79392603018;41263.381049283686;34080;34112.317753645286;34647.30705385929;35435.11412214612;35759.46360804538;35611.64388356187;40693;40890.38664419977;41042.79478602588;41443.7927810359;34095.65904340925;34872;34950.65049349474;34964.65035349614;35031.47452788261;34915.40887363874;35517.644823552466;36197.27605447929;36797.63202368049;36852.26295474022;28584.142475725763;28742.856285718437;29208.26979325534;29260;29345.7065429343 19:17:04 INFO - 2015-12-03 19:17:04,350 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.7614641311841;327.59869160278646;329.49093650310266;329.6176435335011;333.20031923383874;13070.346482675865;14981.400743970242;15444.150571718565;15805.60485987851;16530.09084500352;10044.849327260079;10257.12814410774;13033.34833258338;14427.927860360684;14440.205788681644;4669.789859456324;4787.521247875219;4793.90412191756;4967.379077615298;5147.716875571842;4994.225894986264;5049.520295571933;5099.974500127512;5107.795688172488;5121;4836.274558816188;4963.528464795839;4970.353853998993;5350.5452036576935;5832.737526811283;4933.7286449245275;4937.358143441365;4948.059868624968;4953.3560637117125;4960.60315174787;5037.11850426174;5087.79648814047;5095.719735414587;5103.336566246364;5108.591312694975;10998.230123891331;11212.159088068427;11342.659720208325;11920.88079119215;11932.761344773056;1830.8352248297583;1896.7913529511882;1898.0794314757331;1937.951551211231;2008.67861142218;13096.86903130966;13218.272994985273;13275.535356262484;13466.057375983588;13513.256770877599;1939.6702560564738;2018.7274717913187;2055.9177632894666;2074;2167.5014746608213;60119.39880601226;60443;60536.69731651358;61646.69176654133;62122.378776212565;15726.606834829221;15770.9246696893;15856.682866342608;15988.360465581247;16157.4344897928;23033.193838215917;23105.53788924212;23345.883270583538;23350.065997359914;23436.179733709578;7772.261635144652;7812.257835505618;7833.804154896173;7896.921030789734;8017.078036025815;6409.102725618417;6431.324710905381;6469.964805631076;6603.537752357385;6633.734650613921;7659.502132361378;7730.420218483636;7737.110232323243;7848.7645370638975;7854.567998760009;1672.6571052934119;3121.219695076231;3132.6084239470065;3158.194660361593;3186.2157191972105;811.8863359129726;848.1899785704637;848.6435697007272;903.336048004716;988.110700369673;14428.639284017774;14548.272586370851;14748.852511474748;14853.183074930766;14985.850141498446;825.7195236462787;837.8826964225013;846.7967687754895;915.7252824152861;917.9724608261763;8206.425550211547;8427.241548260687;8549.145085491402;8659.134086591417;8715.825683486422;465362;467426;471911;473675;481117;63098;69058.65470672614;73900.26099739042;74205.62897185479;74436.25563744402;1027.1372047480004;1038.2628333882876;1042.259995403257;1044.1490185498794;1059.8781140168978;13723.656908577366;14639.560813175622;14701.92649036748;14782.48261310892;14942.178180200193;30396.84801575978;30569.23576910595;32629;32812.67187328096;34078;41721.1655766889;42194.57805421906;42467;42997.570024299355;43341;8894.777630559029;8966.237869781142;9069.501177435304;9095.499747513686;9103.271738261055;12764.553240636533;16161.67676646437;16258.187090645184;16278.104704241381;16335.346586136422;13629.250391228577;13815.516456923959;13894.722105558034;14001.719965600834;14245.786313205517;13569.72860542764;13649;13711.725765484834;13777;13837.515686950908;13499;13518.324083795575;14014.579562613138;14035;14181.432742690176;8862.42394244372;8893.421927574687;8897.777555561162;8984.685536006209;8995.955020224857;9419.670311539063;12573.74852502963;13590.86409135896;13816.447342106203;14208.431662733376 19:17:04 INFO - 2015-12-03 19:17:04,353 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1491.649462376342;1658.6599747051855;1719.166204390871;1732.2637878901471;1756.6311074674322;5954.970225148868;6329.525285603575;6994.510384273103;7152.284771522845;7158.212596614375;7083.114610673666;7267.49127561071;7282.9271707282915;7294.16117146527;7299.416046716263;2074.6576814825535;2121.8302535797097;2123.925662601809;2124.1715730864976;2126.6384714598557;2148.4521447030984;2152.827773778094;2155.859869108503;2161.848670593059;2186.5189658275153;2125.362391282617;2130.1266480742897;2140.1439424230275;2143.1855894760047;2194.8024677779;2069.855110142291;2114.947126321839;2121.5650791587686;2122.3314655883423;2124.2034237161142;2122.384508492535;2157.1155826111376;2158.805707486318;2159.7732238114927;2164.6644770060507;7198.712051517985;7263.673134708951;7280.927190728078;7288.56268623879;7304.233055529146;4254.191703576342;4285.6142947134595;4296.5273819879785;4297.312430011214;4328.4156638853665;2763.5440152375036;2774.0429551804596;2789.539725945237;2791.9441611167663;2792.190264823199;878.5738916625431;891.5586784541629;897.1566727276339;899.8470260055741;926.3654396738189;9568.856467152998;9614.51927403627;9654.855177172349;9676.419414835062;9690.46702431373;4075.3683179106692;4083.91832163361;4122.670186385082;4161.979190104091;4169.541350451448;8383.95808020956;8426.620802063922;8446.746597602081;8452.450590711584;8466.322694184573;4288.292431748789;4300.225959327351;4308.569143085666;4318.417013703172;4321.178975994551;3872.728908976401;3878.146807702301;3910.765354078764;3981;4002.7398219115667;3267.970589264374;3278.09852290622;3308.1894935740897;3327.434336162858;3334.533165356852;1011.145581983223;1014.1582486536305;1017.1659239423601;1029.1406675426103;1032.4012072997643;1127.8251870960014;1143.5254369436757;1180.6694125644833;1198.2031948754154;1208.9516419343129;6882.96755486671;6885.449164066863;6904.965475172692;6906.896396554056;6914.515983881181;413.1818998383218;418.7529357678923;421.5299940566247;425.7296616648389;440.19005030743585;5214.582833373321;5225.033368826779;5225.111731005738;5234.979179060047;5243.9213411798855;8549.145085491526;8636.309095272363;8704.129587041245;8832.51421171829;8849;8497.830043399097;8647.437916535531;8654.610542525601;8655.913440865637;8716.43343182691;6345.460635846005;6355.3326900674765;6379.776707815204;6433.871322573522;6528.608283503005;6636.8717318057015;6663.733450661919;6665.733370665119;6667.599944003376;6674.299198584079;7755.302022817974;7799.610019499116;7889.684412623431;7897.802554935943;8029.397795165269;7895.802604934923;8037.156098609562;8085.070216925129;8137.511749295061;8207.179282071746;5070.112730272114;5140.254663073759;5997.3402925677265;6024.759009639565;6073.696315184311;6647.767328143492;6857.382835544825;6865.828354291183;6889.311068893071;6908.896366554606;6234.127222188807;6459.61242325462;6477.578957367756;6540.50946179048;6555.737770489127;6390.93609063922;6477.255115661571;6479.1901012373455;6546.803595892131;6561;6468.353164683682;6482.675866206765;6559.048937903882;6562.343765623399;6564.409203171737;5951.196588460502;5953.880922381615;6067.908981365194;6073.514118870391;6083.209182806384;6083.939160608337;6130.325664176848;6139.447449729546;6141.785037523665;6144.477719393902 19:17:04 INFO - 2015-12-03 19:17:04,353 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.31306429889764;295.73236221219804;303.35839699036546;304.17416713622515;305.13494243818775;5572.080606699899;5580;5580.525655319298;5591.0774722170845;5685.772569097241;5498.422665620113;5572.136318870572;5605.439456054392;5607;5617.8033768818095;4119.485064366954;4220.3036498977635;4243.681723870706;4244.342126970325;4244.745315281078;4233.428487154241;4252.213340532012;4258.063226090255;4261.957380426203;4263.509696384925;4204.117135401554;4212.599803018724;4215.283401821683;4217.072244106292;4218.4516012918275;4196.643285320752;4199.811008504594;4214.494260688722;4217.219814334358;4220.704550681454;3641.8543258269638;3641.963580364189;3645.398509245971;3650.2881938022097;3663.9267214655824;5247.370315562119;5269.789208431658;5398.703071331075;5407.783688652449;5414.810481633124;4820.4456487503685;4822.035592881438;4823.710577365369;4824.300476430933;4828.348172996635;5823.4467725566;5852.502537284336;5860.06239001762;5864.912026319608;5870.148828419898;3816.790076545789;3916.5104361954754;3918.74528155669;3936.409538569209;3951.7826519541413;6065.4844338231305;6114.510839132859;6141.170941922828;6155.261368635747;6156.322804491502;4057.208844275397;4058.6955978301744;4063.2686116499312;4066.430699702044;4073.91852162961;4107.507099148122;4113.197926404322;4114.238865809834;4119.732217405859;4123.690723195772;4692.7653617319;4769.523047695203;4782.139214941344;4782.808687652525;4796.328514008042;5814.3313518945015;5831.912521312183;5835.649861008353;5849.912251316234;5854.970725146347;1425.9429622815178;1445;1446.168453139428;1448.4857875454272;1449.2174225917886;935.3919952031098;940.8823897012874;957.5978089202551;969.1762002297991;973.4159504297365;5147.2279158126585;5155.61332900034;5156.226566015128;5160.561352285098;5174.456682048406;6052.66710330936;6067.605605635619;6105.938940610537;6113;6121.326654068049;5102.36220472441;5135.639055650256;5146.382434107856;5150.459201783834;5151.819686311036;3204.5353423753427;3252.788568743024;3300.1914530939594;3312.7846689965077;3315.7015868571943;5630.127330263816;5705.857353566194;5711;5793;5820.505257053113;6308.274548426898;6315.778947736807;6335.334789847;6336.873262534724;6348.4286414222015;5722.198892155102;5760.798372056958;5778.133280008033;5780.393058728857;5784.913226301609;6110.083487476914;6111.602745821508;6128.785492507741;6140.293866205444;6148.538859585459;5788.710564471844;6013.819585412444;6016.2479690038745;6024.277086749618;6031.5476339273855;5773.47003044202;5775.9133612995;5781.82654520365;5789.2184555086205;5799.449052340021;3983.7609743415487;4024.9798751006056;4029.093453972833;4030.717849750489;4038.1116154445976;6022.126791615104;6159.938400616115;6169.56813023084;6171.783987560414;6172.259328880563;5896.705164741831;5903.822885313448;5904.645721256738;5904.937111320004;5906.379830117776;5892.558058145571;5905.763769449346;5906.734196961061;5917.437843404869;5925.288965324189;5635.605507614428;5754.597178197486;5758.971205143947;5768.7404066817935;5782.913256301243;5931.08068249422;5951.7024148791525;5957.076653118774;5958.004068637055;5973.820785376446;5764.711764411846;5802.100674395476;5807;5811.070228763378;5813.6221145625395 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: |5;yui.html;779.7309928074814;790.2847922630018;795.6697970342308;800.9959950200248;802.8835818806272;12301.753964920696;12446.937765311171;12508.81236781449;12520.81218781719;12526.749465010695;11491.942540287308;11999.880001199985;12072.939635301833;12136.453859576319;12205.206661566992;810.4165001199127;821.4167940762036;822.9629666665014;823.9423240373176;824.3570015388007;808.3331251717327;814.7555733280022;817.0236567302077;819.2749416766175;820.3888103362973;847.9364047696416;848.8896443462341;851.8722191671237;852.2585350744861;852.7143406958645;842.9367797415157;843.7047033538274;847.478800537668;849.392684230778;850.0394554153828;622.7322251431882;627.1345543150424;628.3371043549099;628.7547856335987;630.3633330336347;12190.146689731722;12211.389430528438;12236.449359778831;12324.568640097554;12331.75336493265;11136.443177841156;11181.273217240934;11192.44037798115;11289.887101128967;11392.886071139266;8925.866112008325;8926.196642302224;9069;9217.035225195177;9275.860862087075;3264.640889502177;3268.591426071741;3285.769996100274;3313.6355000949875;3384.76306658534;34234.14414639629;34929.30141397183;38671.61328386708;38675.41986870199;39151.8042409789;8564.828703426021;8587.098354672795;8660.220580147818;8749.227364265369;8873.645054197888;16152.35390584387;16169.35322587107;16190.028598284141;16207.351705931867;16242;6095.299040610386;6177.382261773877;6252.155958945576;6258.186435763321;6277.058441233851;3415.692587667122;3453.3611281912927;3474.4614584739406;3492.6856582907662;3498.8250587470525;2746.244782684738;2756.476269508787;2764.115483045406;2770.6536682914634;2772.085211880075;491.8008206676302;495.69267054426484;502.42472369137136;503.8488453463946;505.33548383875086;564.7740903638578;599.2479438304987;612.4946918792015;626.589583822597;629.232336549409;7763.689452421952;7765.53406795594;7807.492512986638;7901.209879012053;8008.83982320362;564.7358269204008;578.0923949399403;580.5558747558122;593.6586462783916;603.7011679218728;3585.748997570145;3675.0996005978704;3697.7041836653;3733.253349330145;3751.249750050001;49154.75422622936;50784;50860.74569627128;51004.74497627488;51142.74428627833;46577.76711116423;47056.2941555877;47059.294110588366;47553.52446475491;47615.5238447618;40226.59773402228;40638.39042414366;40700.185996279906;40706.389404159556;41580.37629435561;7863.52818830872;7885.605719713876;8044.034715834137;8363.121872203574;8540.487570745776;29431.705682942895;29435.264118396353;29499.705002949697;32609.347813043132;32677.836610816794;38372.424413633256;39065.21869562536;40042;40132.1973560533;40274.79862600668;9674.467904265333;10150.441725705157;10298.330608510423;10354.430506322225;10433;10781.838272426077;10824.729381765519;10883.292585981886;11197;11258.493367798632;10280.17758579297;10347.43089130105;10465.581376744845;10484.423356715453;10620.150387969099;10224.897751022394;10314.793704126025;10371.807242167248;10389.220808439548;10474.476276186313;10180.796384072426;10215.438150901771;10408.791824163625;10429.843552346872;10579.206559507913;9114.954425227832;9130.178283954476;9206.17144457002;9510.429374237568;9602.279829012992;8978.730638080868;9126.269898408244;9184.448933064037;9301.813963720553;9343.08160212398 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,335 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: __startTimestamp1449199024342__endTimestamp 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:17:04 INFO - 2015-12-03 19:17:04,355 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:17:04 INFO - 2015-12-03 19:17:04,356 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,356 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4679.44 Median:4833.93 stddev:490.31 (10.1%) stddev-sans-first:465.29 19:17:04 INFO - 2015-12-03 19:17:04,356 DEBUG : BROWSER_OUTPUT: Values: 2651.4 2689.8 2721.3 2732.7 2741.9 4590.8 4682.8 4688.9 4705.0 4722.7 4629.9 4658.3 4715.8 4844.7 4889.9 4287.3 4388.3 4451.6 4472.9 4497.8 4274.1 4349.4 4360.8 4421.8 4454.2 4205.9 4309.9 4310.4 4313.6 4369.0 4381.0 4392.2 4415.7 4424.4 4429.5 4361.9 4383.6 4389.2 4399.5 4427.7 4460.7 4589.6 4637.4 4718.8 4737.5 5036.5 5082.8 5100.7 5120.5 5164.1 5134.2 5136.3 5136.7 5136.8 5138.0 4610.7 4728.1 4729.9 4737.3 4739.9 5091.7 5183.2 5193.5 5193.9 5244.9 4933.5 4959.2 4962.2 5014.7 5017.3 4795.5 4908.8 4985.7 5069.6 5090.9 5042.2 5044.9 5049.0 5053.4 5071.5 4962.5 4965.5 4981.6 5005.2 5077.2 4031.0 4088.6 4154.3 4168.7 4250.4 3672.2 3689.6 3690.7 3719.1 3754.3 4434.5 4442.4 4447.4 4447.9 4489.1 4854.1 4956.4 5009.7 5085.3 5149.4 4396.8 4439.4 4446.4 4448.7 4453.3 4255.3 4516.2 4530.5 4535.0 4579.7 4750.5 4756.2 4823.2 4833.9 4876.2 5133.2 5191.0 5198.8 5202.0 5246.5 4635.4 4741.1 4902.7 4914.2 4961.4 4861.1 4912.2 4930.6 4938.9 4939.2 5118.5 5162.9 5168.2 5170.4 5204.8 4748.3 4844.6 4864.9 4973.0 4974.8 4944.7 4952.4 4961.7 4963.4 4973.8 4833.9 4857.6 4870.2 4870.7 4917.7 4720.5 4841.5 4855.4 4986.3 5046.3 4867.0 4881.4 4894.0 4906.5 4935.4 19:17:04 INFO - 2015-12-03 19:17:04,356 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,356 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42749.97 Median:38192.31 stddev:67292.79 (176.2%) stddev-sans-first:67407.01 19:17:04 INFO - 2015-12-03 19:17:04,357 DEBUG : BROWSER_OUTPUT: Values: 562.3 571.8 579.6 580.0 583.0 38444.4 39037.2 39071.6 39114.2 39158.0 41251.0 41880.6 41903.4 41955.4 42035.4 7789.5 7856.5 7932.8 7936.4 7944.6 7818.6 7879.8 7950.5 7979.2 7986.7 7953.7 8075.4 8084.3 8099.3 8106.2 7981.5 8047.8 8066.3 8088.5 8094.2 7706.2 7779.0 7855.0 7856.5 7859.7 38023.2 38166.0 38218.6 38427.0 38560.8 2907.6 2953.8 2985.3 3367.1 3641.7 28772.9 28846.0 28846.1 29169.3 29428.4 3274.1 3308.5 3321.9 3384.6 3400.4 217162.0 217403.0 217422.0 218496.0 218526.0 51440.0 52642.5 56445.7 63606.4 65387.7 59863.4 59974.0 60102.4 60254.0 60535.4 13145.0 13220.5 13247.6 13322.5 13371.7 9509.2 9602.4 9621.0 9638.4 9672.1 19830.8 19972.4 20240.9 20295.7 20369.0 7357.9 7521.0 7542.2 7629.5 7647.7 822.7 864.8 907.5 911.1 1011.1 26506.3 26672.0 26807.2 26891.9 27036.9 964.7 985.8 995.5 1011.1 1088.1 13721.9 13908.8 13909.1 14110.9 14138.4 278893.0 287283.0 288733.0 289006.0 289142.0 47465.0 47776.5 47792.0 47798.5 47808.3 1196.2 1212.2 1213.4 1232.7 1236.7 25636.7 25752.4 26151.7 26162.0 26456.6 42011.0 42529.6 42533.0 42691.6 42772.0 263502.0 265101.0 265366.0 265397.0 265600.0 29873.6 30483.8 30778.8 30881.3 30963.0 40219.4 40325.6 40744.6 41214.8 41263.4 34080.0 34112.3 34647.3 35435.1 35759.5 35611.6 40693.0 40890.4 41042.8 41443.8 34095.7 34872.0 34950.7 34964.7 35031.5 34915.4 35517.6 36197.3 36797.6 36852.3 28584.1 28742.9 29208.3 29260.0 29345.7 19:17:04 INFO - 2015-12-03 19:17:04,357 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,357 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26465.45 Median:329.55 stddev:77055.42 (23381.7%) stddev-sans-first:77246.59 19:17:04 INFO - 2015-12-03 19:17:04,357 DEBUG : BROWSER_OUTPUT: Values: 326.8 327.6 329.5 329.6 333.2 13070.3 14981.4 15444.2 15805.6 16530.1 10044.8 10257.1 13033.3 14427.9 14440.2 4669.8 4787.5 4793.9 4967.4 5147.7 4994.2 5049.5 5100.0 5107.8 5121.0 4836.3 4963.5 4970.4 5350.5 5832.7 4933.7 4937.4 4948.1 4953.4 4960.6 5037.1 5087.8 5095.7 5103.3 5108.6 10998.2 11212.2 11342.7 11920.9 11932.8 1830.8 1896.8 1898.1 1938.0 2008.7 13096.9 13218.3 13275.5 13466.1 13513.3 1939.7 2018.7 2055.9 2074.0 2167.5 60119.4 60443.0 60536.7 61646.7 62122.4 15726.6 15770.9 15856.7 15988.4 16157.4 23033.2 23105.5 23345.9 23350.1 23436.2 7772.3 7812.3 7833.8 7896.9 8017.1 6409.1 6431.3 6470.0 6603.5 6633.7 7659.5 7730.4 7737.1 7848.8 7854.6 1672.7 3121.2 3132.6 3158.2 3186.2 811.9 848.2 848.6 903.3 988.1 14428.6 14548.3 14748.9 14853.2 14985.9 825.7 837.9 846.8 915.7 918.0 8206.4 8427.2 8549.1 8659.1 8715.8 465362.0 467426.0 471911.0 473675.0 481117.0 63098.0 69058.7 73900.3 74205.6 74436.3 1027.1 1038.3 1042.3 1044.1 1059.9 13723.7 14639.6 14701.9 14782.5 14942.2 30396.8 30569.2 32629.0 32812.7 34078.0 41721.2 42194.6 42467.0 42997.6 43341.0 8894.8 8966.2 9069.5 9095.5 9103.3 12764.6 16161.7 16258.2 16278.1 16335.3 13629.3 13815.5 13894.7 14001.7 14245.8 13569.7 13649.0 13711.7 13777.0 13837.5 13499.0 13518.3 14014.6 14035.0 14181.4 8862.4 8893.4 8897.8 8984.7 8996.0 9419.7 12573.7 13590.9 13816.4 14208.4 19:17:04 INFO - 2015-12-03 19:17:04,357 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,359 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5014.73 Median:6083.57 stddev:2610.29 (42.9%) stddev-sans-first:2604.18 19:17:04 INFO - 2015-12-03 19:17:04,359 DEBUG : BROWSER_OUTPUT: Values: 1491.6 1658.7 1719.2 1732.3 1756.6 5955.0 6329.5 6994.5 7152.3 7158.2 7083.1 7267.5 7282.9 7294.2 7299.4 2074.7 2121.8 2123.9 2124.2 2126.6 2148.5 2152.8 2155.9 2161.8 2186.5 2125.4 2130.1 2140.1 2143.2 2194.8 2069.9 2114.9 2121.6 2122.3 2124.2 2122.4 2157.1 2158.8 2159.8 2164.7 7198.7 7263.7 7280.9 7288.6 7304.2 4254.2 4285.6 4296.5 4297.3 4328.4 2763.5 2774.0 2789.5 2791.9 2792.2 878.6 891.6 897.2 899.8 926.4 9568.9 9614.5 9654.9 9676.4 9690.5 4075.4 4083.9 4122.7 4162.0 4169.5 8384.0 8426.6 8446.7 8452.5 8466.3 4288.3 4300.2 4308.6 4318.4 4321.2 3872.7 3878.1 3910.8 3981.0 4002.7 3268.0 3278.1 3308.2 3327.4 3334.5 1011.1 1014.2 1017.2 1029.1 1032.4 1127.8 1143.5 1180.7 1198.2 1209.0 6883.0 6885.4 6905.0 6906.9 6914.5 413.2 418.8 421.5 425.7 440.2 5214.6 5225.0 5225.1 5235.0 5243.9 8549.1 8636.3 8704.1 8832.5 8849.0 8497.8 8647.4 8654.6 8655.9 8716.4 6345.5 6355.3 6379.8 6433.9 6528.6 6636.9 6663.7 6665.7 6667.6 6674.3 7755.3 7799.6 7889.7 7897.8 8029.4 7895.8 8037.2 8085.1 8137.5 8207.2 5070.1 5140.3 5997.3 6024.8 6073.7 6647.8 6857.4 6865.8 6889.3 6908.9 6234.1 6459.6 6477.6 6540.5 6555.7 6390.9 6477.3 6479.2 6546.8 6561.0 6468.4 6482.7 6559.0 6562.3 6564.4 5951.2 5953.9 6067.9 6073.5 6083.2 6083.9 6130.3 6139.4 6141.8 6144.5 19:17:04 INFO - 2015-12-03 19:17:04,359 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,359 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4836.35 Median:5598.26 stddev:1464.71 (26.2%) stddev-sans-first:1428.56 19:17:04 INFO - 2015-12-03 19:17:04,359 DEBUG : BROWSER_OUTPUT: Values: 292.3 295.7 303.4 304.2 305.1 5572.1 5580.0 5580.5 5591.1 5685.8 5498.4 5572.1 5605.4 5607.0 5617.8 4119.5 4220.3 4243.7 4244.3 4244.7 4233.4 4252.2 4258.1 4262.0 4263.5 4204.1 4212.6 4215.3 4217.1 4218.5 4196.6 4199.8 4214.5 4217.2 4220.7 3641.9 3642.0 3645.4 3650.3 3663.9 5247.4 5269.8 5398.7 5407.8 5414.8 4820.4 4822.0 4823.7 4824.3 4828.3 5823.4 5852.5 5860.1 5864.9 5870.1 3816.8 3916.5 3918.7 3936.4 3951.8 6065.5 6114.5 6141.2 6155.3 6156.3 4057.2 4058.7 4063.3 4066.4 4073.9 4107.5 4113.2 4114.2 4119.7 4123.7 4692.8 4769.5 4782.1 4782.8 4796.3 5814.3 5831.9 5835.6 5849.9 5855.0 1425.9 1445.0 1446.2 1448.5 1449.2 935.4 940.9 957.6 969.2 973.4 5147.2 5155.6 5156.2 5160.6 5174.5 6052.7 6067.6 6105.9 6113.0 6121.3 5102.4 5135.6 5146.4 5150.5 5151.8 3204.5 3252.8 3300.2 3312.8 3315.7 5630.1 5705.9 5711.0 5793.0 5820.5 6308.3 6315.8 6335.3 6336.9 6348.4 5722.2 5760.8 5778.1 5780.4 5784.9 6110.1 6111.6 6128.8 6140.3 6148.5 5788.7 6013.8 6016.2 6024.3 6031.5 5773.5 5775.9 5781.8 5789.2 5799.4 3983.8 4025.0 4029.1 4030.7 4038.1 6022.1 6159.9 6169.6 6171.8 6172.3 5896.7 5903.8 5904.6 5904.9 5906.4 5892.6 5905.8 5906.7 5917.4 5925.3 5635.6 5754.6 5759.0 5768.7 5782.9 5931.1 5951.7 5957.1 5958.0 5973.8 5764.7 5802.1 5807.0 5811.1 5813.6 19:17:04 INFO - 2015-12-03 19:17:04,359 DEBUG : BROWSER_OUTPUT: 19:17:04 INFO - 2015-12-03 19:17:04,359 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12238.07 Median:47057.79 stddev:13866.27 (29.5%) stddev-sans-first:13878.47 19:17:04 INFO - 2015-12-03 19:17:04,360 DEBUG : BROWSER_OUTPUT: Values: 779.7 790.3 795.7 801.0 802.9 12301.8 12446.9 12508.8 12520.8 12526.7 11491.9 11999.9 12072.9 12136.5 12205.2 810.4 821.4 823.0 823.9 824.4 808.3 814.8 817.0 819.3 820.4 847.9 848.9 851.9 852.3 852.7 842.9 843.7 847.5 849.4 850.0 622.7 627.1 628.3 628.8 630.4 12190.1 12211.4 12236.4 12324.6 12331.8 11136.4 11181.3 11192.4 11289.9 11392.9 8925.9 8926.2 9069.0 9217.0 9275.9 3264.6 3268.6 3285.8 3313.6 3384.8 34234.1 34929.3 38671.6 38675.4 39151.8 8564.8 8587.1 8660.2 8749.2 8873.6 16152.4 16169.4 16190.0 16207.4 16242.0 6095.3 6177.4 6252.2 6258.2 6277.1 3415.7 3453.4 3474.5 3492.7 3498.8 2746.2 2756.5 2764.1 2770.7 2772.1 491.8 495.7 502.4 503.8 505.3 564.8 599.2 612.5 626.6 629.2 7763.7 7765.5 7807.5 7901.2 8008.8 564.7 578.1 580.6 593.7 603.7 3585.7 3675.1 3697.7 3733.3 3751.2 49154.8 50784.0 50860.7 51004.7 51142.7 46577.8 47056.3 47059.3 47553.5 47615.5 40226.6 40638.4 40700.2 40706.4 41580.4 7863.5 7885.6 8044.0 8363.1 8540.5 29431.7 29435.3 29499.7 32609.3 32677.8 38372.4 39065.2 40042.0 40132.2 40274.8 9674.5 10150.4 10298.3 10354.4 10433.0 10781.8 10824.7 10883.3 11197.0 11258.5 10280.2 10347.4 10465.6 10484.4 10620.2 10224.9 10314.8 10371.8 10389.2 10474.5 10180.8 10215.4 10408.8 10429.8 10579.2 9115.0 9130.2 9206.2 9510.4 9602.3 8978.7 9126.3 9184.4 9301.8 9343.1 19:17:04 INFO - 2015-12-03 19:17:04,360 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:17:04 INFO - 2015-12-03 19:17:04,361 DEBUG : BROWSER_OUTPUT: 19:17:05 INFO - 2015-12-03 19:17:05,053 INFO : Browser exited with error code: 0 19:17:05 INFO - 2015-12-03 19:17:05,075 INFO : Completed test dromaeo_css (00:18:34) 19:17:05 INFO - 2015-12-03 19:17:05,075 INFO : Starting test kraken 19:17:05 INFO - 2015-12-03 19:17:05,075 DEBUG : operating with platform_type : linux_ 19:17:05 INFO - 2015-12-03 19:17:05,075 INFO : Initialising browser for kraken test... 19:17:05 INFO - 2015-12-03 19:17:05,081 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIi64xA/profile http://localhost:41323/getInfo.html 19:17:09 INFO - 2015-12-03 19:17:09,813 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:17:09 INFO - 2015-12-03 19:17:09,813 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:17:09 INFO - 2015-12-03 19:17:09,813 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:17:09 INFO - 2015-12-03 19:17:09,813 DEBUG : BROWSER_OUTPUT: __metrics 19:17:09 INFO - 2015-12-03 19:17:09,942 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] 19:17:10 INFO - 2015-12-03 19:17:10,841 INFO : Browser initialized. 19:17:10 INFO - 2015-12-03 19:17:10,842 INFO : Running cycle 1/1 for kraken test... 19:17:10 INFO - 2015-12-03 19:17:10,842 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIi64xA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:17:22 INFO - 2015-12-03 19:17:22,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 142970880 19:17:22 INFO - 2015-12-03 19:17:22,885 DEBUG : BROWSER_OUTPUT: 19:17:25 INFO - 2015-12-03 19:17:25,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41323/tests/kraken/driver.html?testName=audio-beat-detection) 19:17:26 INFO - 2015-12-03 19:17:26,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 143630336 19:17:26 INFO - 2015-12-03 19:17:26,069 DEBUG : BROWSER_OUTPUT: 19:17:28 INFO - 2015-12-03 19:17:28,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41323/tests/kraken/driver.html?testName=audio-dft) 19:17:29 INFO - 2015-12-03 19:17:29,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 143802368 19:17:29 INFO - 2015-12-03 19:17:29,415 DEBUG : BROWSER_OUTPUT: 19:17:32 INFO - 2015-12-03 19:17:32,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41323/tests/kraken/driver.html?testName=audio-fft) 19:17:32 INFO - 2015-12-03 19:17:32,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 19:17:32 INFO - 2015-12-03 19:17:32,892 DEBUG : BROWSER_OUTPUT: 19:17:34 INFO - 2015-12-03 19:17:34,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41323/tests/kraken/driver.html?testName=audio-oscillator) 19:17:35 INFO - 2015-12-03 19:17:35,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 139255808 19:17:35 INFO - 2015-12-03 19:17:35,563 DEBUG : BROWSER_OUTPUT: 19:17:37 INFO - 2015-12-03 19:17:37,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41323/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:17:38 INFO - 2015-12-03 19:17:38,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 140546048 19:17:38 INFO - 2015-12-03 19:17:38,395 DEBUG : BROWSER_OUTPUT: 19:17:41 INFO - 2015-12-03 19:17:41,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41323/tests/kraken/driver.html?testName=imaging-darkroom) 19:17:42 INFO - 2015-12-03 19:17:42,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 140869632 19:17:42 INFO - 2015-12-03 19:17:42,056 DEBUG : BROWSER_OUTPUT: 19:17:45 INFO - 2015-12-03 19:17:45,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41323/tests/kraken/driver.html?testName=imaging-desaturate) 19:17:46 INFO - 2015-12-03 19:17:46,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 138407936 19:17:46 INFO - 2015-12-03 19:17:46,185 DEBUG : BROWSER_OUTPUT: 19:17:49 INFO - 2015-12-03 19:17:49,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41323/tests/kraken/driver.html?testName=json-parse-financial) 19:17:49 INFO - 2015-12-03 19:17:49,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 139591680 19:17:49 INFO - 2015-12-03 19:17:49,728 DEBUG : BROWSER_OUTPUT: 19:17:51 INFO - 2015-12-03 19:17:51,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41323/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:17:52 INFO - 2015-12-03 19:17:52,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 140255232 19:17:52 INFO - 2015-12-03 19:17:52,079 DEBUG : BROWSER_OUTPUT: 19:17:53 INFO - 2015-12-03 19:17:53,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:17:54 INFO - 2015-12-03 19:17:54,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 19:17:54 INFO - 2015-12-03 19:17:54,584 DEBUG : BROWSER_OUTPUT: 19:17:56 INFO - 2015-12-03 19:17:56,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:17:57 INFO - 2015-12-03 19:17:57,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 140279808 19:17:57 INFO - 2015-12-03 19:17:57,400 DEBUG : BROWSER_OUTPUT: 19:17:59 INFO - 2015-12-03 19:17:59,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:18:00 INFO - 2015-12-03 19:18:00,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 140906496 19:18:00 INFO - 2015-12-03 19:18:00,577 DEBUG : BROWSER_OUTPUT: 19:18:03 INFO - 2015-12-03 19:18:03,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:18:03 INFO - 2015-12-03 19:18:03,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 139952128 19:18:03 INFO - 2015-12-03 19:18:03,795 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41323/tests/kraken/driver.html?testName=ai-astar) 19:18:05 INFO - 2015-12-03 19:18:05,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 140115968 19:18:05 INFO - 2015-12-03 19:18:05,819 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,823 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:18:05 INFO - 2015-12-03 19:18:05,823 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:18:05 INFO - 2015-12-03 19:18:05,823 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:18:05 INFO - 2015-12-03 19:18:05,823 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:18:05 INFO - 2015-12-03 19:18:05,823 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;115;115;113;129;114;113;113;112 19:18:05 INFO - 2015-12-03 19:18:05,824 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;132;150;165;130;159;158;133;165;139 19:18:05 INFO - 2015-12-03 19:18:05,824 DEBUG : BROWSER_OUTPUT: |2;audio-dft;168;165;162;162;162;162;172;163;166;161 19:18:05 INFO - 2015-12-03 19:18:05,824 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;71;74;146;72;79;73;74;157 19:18:05 INFO - 2015-12-03 19:18:05,824 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;131;94;95;96;135;94;95;131 19:18:05 INFO - 2015-12-03 19:18:05,824 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;110 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;147;148;148;148;148;146;147;147 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;98;97;98;96 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;74;74;74;77;73;78;72;71 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;68;68;69;69;68;69 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;93;95;87;87;85;89;85;85;87 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;119;125;122;120;131;131;122;128;133 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;146;149;150;149;142;151;153;153;143 19:18:05 INFO - 2015-12-03 19:18:05,825 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;71;71;72;70;70;70;70;70 19:18:05 INFO - 2015-12-03 19:18:05,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:18:05 INFO - 2015-12-03 19:18:05,826 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:18:05 INFO - 2015-12-03 19:18:05,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,789 19:18:05 INFO - 2015-12-03 19:18:05,826 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:18:05 INFO - 2015-12-03 19:18:05,826 DEBUG : BROWSER_OUTPUT: __startTimestamp1449199085821__endTimestamp 19:18:05 INFO - 2015-12-03 19:18:05,826 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,827 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:18:05 INFO - 2015-12-03 19:18:05,827 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:18:05 INFO - 2015-12-03 19:18:05,827 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,828 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.60 Median:113.50 stddev:5.34 (4.7%) stddev-sans-first:5.63 19:18:05 INFO - 2015-12-03 19:18:05,828 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 115.0 115.0 113.0 129.0 114.0 113.0 113.0 112.0 19:18:05 INFO - 2015-12-03 19:18:05,828 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,828 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.90 Median:158.50 stddev:15.10 (9.5%) stddev-sans-first:14.53 19:18:05 INFO - 2015-12-03 19:18:05,828 DEBUG : BROWSER_OUTPUT: Values: 168.0 132.0 150.0 165.0 130.0 159.0 158.0 133.0 165.0 139.0 19:18:05 INFO - 2015-12-03 19:18:05,828 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,829 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.50 (2.1%) stddev-sans-first:3.44 19:18:05 INFO - 2015-12-03 19:18:05,829 DEBUG : BROWSER_OUTPUT: Values: 168.0 165.0 162.0 162.0 162.0 162.0 172.0 163.0 166.0 161.0 19:18:05 INFO - 2015-12-03 19:18:05,829 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,829 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.20 Median:73.00 stddev:33.00 (45.2%) stddev-sans-first:34.48 19:18:05 INFO - 2015-12-03 19:18:05,829 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 74.0 146.0 72.0 79.0 73.0 74.0 157.0 19:18:05 INFO - 2015-12-03 19:18:05,829 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,829 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.50 stddev:18.21 (19.3%) stddev-sans-first:18.79 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 131.0 94.0 95.0 96.0 135.0 94.0 95.0 131.0 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.73 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 147.0 148.0 148.0 148.0 148.0 146.0 147.0 147.0 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 19:18:05 INFO - 2015-12-03 19:18:05,830 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 98.0 97.0 98.0 96.0 19:18:05 INFO - 2015-12-03 19:18:05,831 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,831 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.80 Median:74.00 stddev:2.20 (3.0%) stddev-sans-first:2.24 19:18:05 INFO - 2015-12-03 19:18:05,831 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 74.0 74.0 74.0 77.0 73.0 78.0 72.0 71.0 19:18:05 INFO - 2015-12-03 19:18:05,831 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,831 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:18:05 INFO - 2015-12-03 19:18:05,831 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 68.0 68.0 69.0 69.0 68.0 69.0 19:18:05 INFO - 2015-12-03 19:18:05,831 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.00 stddev:3.78 (4.3%) stddev-sans-first:3.62 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: Values: 83.0 93.0 95.0 87.0 87.0 85.0 89.0 85.0 85.0 87.0 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:128.50 stddev:5.06 (3.9%) stddev-sans-first:5.24 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: Values: 129.0 119.0 125.0 122.0 120.0 131.0 131.0 122.0 128.0 133.0 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:149.50 stddev:5.23 (3.5%) stddev-sans-first:4.00 19:18:05 INFO - 2015-12-03 19:18:05,832 DEBUG : BROWSER_OUTPUT: Values: 137.0 146.0 149.0 150.0 149.0 142.0 151.0 153.0 153.0 143.0 19:18:05 INFO - 2015-12-03 19:18:05,833 DEBUG : BROWSER_OUTPUT: 19:18:05 INFO - 2015-12-03 19:18:05,833 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 19:18:05 INFO - 2015-12-03 19:18:05,833 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 71.0 72.0 70.0 70.0 70.0 70.0 70.0 19:18:05 INFO - 2015-12-03 19:18:05,833 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:18:05 INFO - 2015-12-03 19:18:05,833 DEBUG : BROWSER_OUTPUT: 19:18:06 INFO - 2015-12-03 19:18:06,765 INFO : Browser exited with error code: 0 19:18:06 INFO - 2015-12-03 19:18:06,813 INFO : Completed test kraken (00:01:01) 19:18:06 INFO - 2015-12-03 19:18:06,814 INFO : Starting test v8_7 19:18:06 INFO - 2015-12-03 19:18:06,814 DEBUG : operating with platform_type : linux_ 19:18:06 INFO - 2015-12-03 19:18:06,814 INFO : Initialising browser for v8_7 test... 19:18:06 INFO - 2015-12-03 19:18:06,820 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpziKJOf/profile http://localhost:41323/getInfo.html 19:18:11 INFO - 2015-12-03 19:18:11,747 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:18:11 INFO - 2015-12-03 19:18:11,747 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:18:11 INFO - 2015-12-03 19:18:11,747 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:18:11 INFO - 2015-12-03 19:18:11,747 DEBUG : BROWSER_OUTPUT: __metrics 19:18:11 INFO - 2015-12-03 19:18:11,924 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] 19:18:12 INFO - 2015-12-03 19:18:12,897 INFO : Browser initialized. 19:18:12 INFO - 2015-12-03 19:18:12,898 INFO : Running cycle 1/1 for v8_7 test... 19:18:12 INFO - 2015-12-03 19:18:12,898 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpziKJOf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:18:24 INFO - 2015-12-03 19:18:24,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 142958592 19:18:24 INFO - 2015-12-03 19:18:24,959 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41323/tests/v8_7/run.html (next: http://localhost:41323/tests/v8_7/run.html) 19:18:46 INFO - 2015-12-03 19:18:46,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 138113024 19:18:46 INFO - 2015-12-03 19:18:46,696 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,696 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |0;Richards;166.27868307283006 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.60402436773123 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1128.6681715575621 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |5;Earley;705.7163020465773 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |6;Boyer;12216.867469879518 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 19:18:46 INFO - 2015-12-03 19:18:46,697 DEBUG : BROWSER_OUTPUT: |8;Splay;637.3486297004462 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: __startTimestamp1449199126689__endTimestamp 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: Values: 166.3 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.60 Median:184.60 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: Values: 184.6 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,698 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,699 DEBUG : BROWSER_OUTPUT: Values: 279.2 19:18:46 INFO - 2015-12-03 19:18:46,699 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,699 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,699 DEBUG : BROWSER_OUTPUT: Values: 5196.9 19:18:46 INFO - 2015-12-03 19:18:46,699 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,699 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1128.67 Median:1128.67 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,699 DEBUG : BROWSER_OUTPUT: Values: 1128.7 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:705.72 Median:705.72 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: Values: 705.7 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: Values: 12216.9 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,700 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,701 DEBUG : BROWSER_OUTPUT: Values: 26153.8 19:18:46 INFO - 2015-12-03 19:18:46,701 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,701 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:637.35 Median:637.35 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,701 DEBUG : BROWSER_OUTPUT: Values: 637.3 19:18:46 INFO - 2015-12-03 19:18:46,701 DEBUG : BROWSER_OUTPUT: 19:18:46 INFO - 2015-12-03 19:18:46,701 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 19:18:46 INFO - 2015-12-03 19:18:46,701 DEBUG : BROWSER_OUTPUT: Values: 4854.4 19:18:46 INFO - 2015-12-03 19:18:46,702 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:18:46 INFO - 2015-12-03 19:18:46,702 DEBUG : BROWSER_OUTPUT: 19:18:47 INFO - 2015-12-03 19:18:47,605 INFO : Browser exited with error code: 0 19:18:47 INFO - 2015-12-03 19:18:47,622 INFO : Completed test v8_7 (00:00:40) 19:18:47 INFO - 2015-12-03 19:18:47,690 INFO : Completed test suite (00:20:17) 19:18:47 INFO - 2015-12-03 19:18:47,690 DEBUG : Working with test: dromaeo_css 19:18:47 INFO - 2015-12-03 19:18:47,690 DEBUG : Generating results file: dromaeo_css 19:18:47 INFO - 2015-12-03 19:18:47,691 DEBUG : Working with test: kraken 19:18:47 INFO - 2015-12-03 19:18:47,691 DEBUG : Generating results file: kraken 19:18:47 INFO - 2015-12-03 19:18:47,691 INFO : javascript benchmark 19:18:47 INFO - 2015-12-03 19:18:47,692 DEBUG : Working with test: v8_7 19:18:47 INFO - 2015-12-03 19:18:47,692 DEBUG : Generating results file: v8_7 19:18:47 INFO - 2015-12-03 19:18:47,692 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:18:47 INFO - 2015-12-03 19:18:47,756 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 19:18:47 INFO - 2015-12-03 19:18:47,756 DEBUG : process_Request line: dromaeo_css 6458.33 graph.html#tests=[[72,132,43]] 19:18:47 INFO - 2015-12-03 19:18:47,756 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:18:47 INFO - 2015-12-03 19:18:47,791 DEBUG : process_Request line: kraken 1551.70 graph.html#tests=[[232,132,43]] 19:18:47 INFO - 2015-12-03 19:18:47,791 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:18:47 INFO - 2015-12-03 19:18:47,826 DEBUG : process_Request line: v8_7 21135.46 graph.html#tests=[[230,132,43]] 19:18:47 INFO - 2015-12-03 19:18:47,828 INFO : javascript benchmark 19:18:47 INFO - 2015-12-03 19:18:47,831 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2651.3769264222906, 2689.811713180078, 2721.278861101808, 2732.685741139768, 2741.890324387024, 4590.816367345302, 4682.8126874925, 4688.906221875569, 4705.0, 4722.716637001778, 4629.86110416688, 4658.301254811771, 4715.78778954947, 4844.709317440956, 4889.853304400874, 4287.314029755247, 4388.341748737699, 4451.62161216297, 4472.910541789162, 4497.775111244425, 4274.145170965804, 4349.41282926804, 4360.803763830635, 4421.845235416761, 4454.22051141049, 4205.8527951521855, 4309.870703878889, 4310.3534469829465, 4313.633341166004, 4369.038811461505, 4380.956190438087, 4392.1874453226255, 4415.690901636886, 4424.402705634762, 4429.512753597101, 4361.869143925687, 4383.561643835623, 4389.1660584488845, 4399.538048504893, 4427.712198707074, 4460.7323560586465, 4589.586937175637, 4637.420322459692, 4718.811247550094, 4737.50256223095, 5036.521530454601, 5082.79668813247, 5100.744962751847, 5120.539151476348, 5164.096283150471, 5134.178531434953, 5136.255242989746, 5136.717480538568, 5136.7671758778, 5138.049460849755, 4610.746408947506, 4728.078024785203, 4729.929051064237, 4737.313089602023, 4739.928901066487, 5091.66904151229, 5183.170692689152, 5193.480651934852, 5193.922091168635, 5244.947550524522, 4933.531314525115, 4959.181735013754, 4962.206047032458, 5014.6991180529285, 5017.297578339036, 4795.544423279853, 4908.828191013297, 4985.725785081783, 5069.6451248413, 5090.898182036339, 5042.168042273057, 5044.9495505045215, 5049.0, 5053.393592768891, 5071.518205770446, 4962.528559786814, 4965.478624744422, 4981.626378021663, 5005.174146265826, 5077.1876499759865, 4031.032552187454, 4088.6115818997146, 4154.31453810124, 4168.666506679519, 4250.404943307939, 3672.192117734094, 3689.5756987946193, 3690.686291665185, 3719.08882323827, 3754.267917756066, 4434.5343738907595, 4442.400275962704, 4447.421835161473, 4447.866564003085, 4489.079738653568, 4854.126257273654, 4956.405231372259, 5009.699418034929, 5085.262636917626, 5149.382074151126, 4396.758178300224, 4439.378487011821, 4446.421965144576, 4448.7108337957925, 4453.3320001999955, 4255.276602977439, 4516.187086324493, 4530.546945305443, 4535.0, 4579.74811385377, 4750.548697873696, 4756.21522448799, 4823.1800593898415, 4833.854984350475, 4876.171050921423, 5133.1786914095055, 5190.97404512975, 5198.792048318025, 5202.0, 5246.527812496894, 4635.374224479787, 4741.122892264942, 4902.7058376497525, 4914.238293064581, 4961.42943561495, 4861.1006963711825, 4912.238603016538, 4930.6055515557955, 4938.925916111333, 4939.185034469272, 5118.539331460186, 5162.870928226825, 5168.173092305213, 5170.43125256229, 5204.765785539584, 4748.335233067304, 4844.61243100544, 4864.902701945871, 4972.950270497248, 4974.776135073858, 4944.728039957837, 4952.380952380952, 4961.727105009115, 4963.429205641398, 4973.825916092919, 4833.9274910875665, 4857.635677324285, 4870.245112007645, 4870.738104158861, 4917.655764096479, 4720.480747117883, 4841.467438581823, 4855.393075865517, 4986.252062190701, 5046.29351890743, 4866.975665121652, 4881.414230292387, 4893.975530122327, 4906.545532087957, 4935.358403407534], "unit": "ms", "name": "dojo.html", "value": 4648.872409619368}, {"lowerIsBetter": false, "replicates": [562.3392513796289, 571.7712914834066, 579.6058680097534, 579.9768009279629, 583.0467186150643, 38444.42333365002, 39037.21925561491, 39071.609283907186, 39114.21771564567, 39158.0, 41251.0, 41880.581194188126, 41903.37144942821, 41955.37066943991, 42035.36946945798, 7789.493682910621, 7856.450048496607, 7932.841343173133, 7936.412717456503, 7944.602769861513, 7818.609069546528, 7879.8030049248655, 7950.483218590802, 7979.202079792032, 7986.6805327786815, 7953.72161974331, 8075.434719569633, 8084.312833409167, 8099.2710656040945, 8106.189381061876, 7981.481203721769, 8047.839043219103, 8066.314363279128, 8088.514689118613, 8094.190580941918, 7706.152323244439, 7778.961105194495, 7854.960725196394, 7856.528608283521, 7859.724909628136, 38023.23953520942, 38166.0, 38218.61781382179, 38427.0, 38560.80719596384, 2907.578401131845, 2953.808002479832, 2985.2835319523374, 3367.0572239772905, 3641.708663306929, 28772.856135719398, 28846.0, 28846.134615961553, 29169.270768230752, 29428.411431771245, 3274.0505253476463, 3308.4871844864083, 3321.933561328784, 3384.644612315696, 3400.4049291373913, 217162.0, 217403.0, 217422.0, 218496.0, 218526.0, 51440.0, 52642.47357526452, 56445.71777141088, 63606.363936360045, 65387.673061634385, 59863.401365986654, 59974.0, 60102.398976010554, 60254.0, 60535.39464605298, 13145.0, 13220.471181152838, 13247.602571922858, 13322.533711320057, 13371.732565348639, 9509.191718703849, 9602.375845570015, 9620.95189524062, 9638.373505722106, 9672.129508344282, 19830.810151390964, 19972.400827975183, 20240.898795505927, 20295.695564566544, 20369.0, 7357.926420735831, 7521.0, 7542.170361260367, 7629.465937384441, 7647.732329368446, 822.6503735912213, 864.822711344173, 907.464595888429, 911.129870973219, 1011.0597144655541, 26506.337341566228, 26672.0, 26807.195784126117, 26891.865540672563, 27036.86481567619, 964.744342749172, 985.8324084905584, 995.4525011243787, 1011.079917275276, 1088.1349327284827, 13721.931390342985, 13908.791368129487, 13909.14133514561, 14110.85889141116, 14138.434462621586, 278893.0, 287283.0, 288733.0, 289006.0, 289142.0, 47465.0, 47776.52223477721, 47791.981841906796, 47798.5220147801, 47808.28287575689, 1196.174639498743, 1212.1636071110904, 1213.4236237786981, 1232.7411243638758, 1236.6537369536545, 25636.743632564183, 25752.356191095372, 26151.738482614932, 26162.0, 26456.603150952367, 42011.0, 42529.57470425256, 42533.0, 42691.57308426876, 42772.0, 263502.0, 265101.0, 265366.0, 265397.0, 265600.0, 29873.551896721132, 30483.847580761954, 30778.846105769328, 30881.301528416152, 30963.0, 40219.3967090488, 40325.596744033355, 40744.59255407408, 41214.79392603018, 41263.381049283686, 34080.0, 34112.317753645286, 34647.30705385929, 35435.11412214612, 35759.46360804538, 35611.64388356187, 40693.0, 40890.38664419977, 41042.79478602588, 41443.7927810359, 34095.65904340925, 34872.0, 34950.65049349474, 34964.65035349614, 35031.47452788261, 34915.40887363874, 35517.644823552466, 36197.27605447929, 36797.63202368049, 36852.26295474022, 28584.142475725763, 28742.856285718437, 29208.26979325534, 29260.0, 29345.7065429343], "unit": "ms", "name": "ext.html", "value": 17482.528141501196}, {"lowerIsBetter": false, "replicates": [326.7614641311841, 327.59869160278646, 329.49093650310266, 329.6176435335011, 333.20031923383874, 13070.346482675865, 14981.400743970242, 15444.150571718565, 15805.60485987851, 16530.09084500352, 10044.849327260079, 10257.12814410774, 13033.34833258338, 14427.927860360684, 14440.205788681644, 4669.789859456324, 4787.521247875219, 4793.90412191756, 4967.379077615298, 5147.716875571842, 4994.225894986264, 5049.520295571933, 5099.974500127512, 5107.795688172488, 5121.0, 4836.274558816188, 4963.528464795839, 4970.353853998993, 5350.5452036576935, 5832.737526811283, 4933.7286449245275, 4937.358143441365, 4948.059868624968, 4953.3560637117125, 4960.60315174787, 5037.11850426174, 5087.79648814047, 5095.719735414587, 5103.336566246364, 5108.591312694975, 10998.230123891331, 11212.159088068427, 11342.659720208325, 11920.88079119215, 11932.761344773056, 1830.8352248297583, 1896.7913529511882, 1898.0794314757331, 1937.951551211231, 2008.67861142218, 13096.86903130966, 13218.272994985273, 13275.535356262484, 13466.057375983588, 13513.256770877599, 1939.6702560564738, 2018.7274717913187, 2055.9177632894666, 2074.0, 2167.5014746608213, 60119.39880601226, 60443.0, 60536.69731651358, 61646.69176654133, 62122.378776212565, 15726.606834829221, 15770.9246696893, 15856.682866342608, 15988.360465581247, 16157.4344897928, 23033.193838215917, 23105.53788924212, 23345.883270583538, 23350.065997359914, 23436.179733709578, 7772.261635144652, 7812.257835505618, 7833.804154896173, 7896.921030789734, 8017.078036025815, 6409.102725618417, 6431.324710905381, 6469.964805631076, 6603.537752357385, 6633.734650613921, 7659.502132361378, 7730.420218483636, 7737.110232323243, 7848.7645370638975, 7854.567998760009, 1672.6571052934119, 3121.219695076231, 3132.6084239470065, 3158.194660361593, 3186.2157191972105, 811.8863359129726, 848.1899785704637, 848.6435697007272, 903.336048004716, 988.110700369673, 14428.639284017774, 14548.272586370851, 14748.852511474748, 14853.183074930766, 14985.850141498446, 825.7195236462787, 837.8826964225013, 846.7967687754895, 915.7252824152861, 917.9724608261763, 8206.425550211547, 8427.241548260687, 8549.145085491402, 8659.134086591417, 8715.825683486422, 465362.0, 467426.0, 471911.0, 473675.0, 481117.0, 63098.0, 69058.65470672614, 73900.26099739042, 74205.62897185479, 74436.25563744402, 1027.1372047480004, 1038.2628333882876, 1042.259995403257, 1044.1490185498794, 1059.8781140168978, 13723.656908577366, 14639.560813175622, 14701.92649036748, 14782.48261310892, 14942.178180200193, 30396.84801575978, 30569.23576910595, 32629.0, 32812.67187328096, 34078.0, 41721.1655766889, 42194.57805421906, 42467.0, 42997.570024299355, 43341.0, 8894.777630559029, 8966.237869781142, 9069.501177435304, 9095.499747513686, 9103.271738261055, 12764.553240636533, 16161.67676646437, 16258.187090645184, 16278.104704241381, 16335.346586136422, 13629.250391228577, 13815.516456923959, 13894.722105558034, 14001.719965600834, 14245.786313205517, 13569.72860542764, 13649.0, 13711.725765484834, 13777.0, 13837.515686950908, 13499.0, 13518.324083795575, 14014.579562613138, 14035.0, 14181.432742690176, 8862.42394244372, 8893.421927574687, 8897.777555561162, 8984.685536006209, 8995.955020224857, 9419.670311539063, 12573.74852502963, 13590.86409135896, 13816.447342106203, 14208.431662733376], "unit": "ms", "name": "jquery.html", "value": 8764.783048308713}, {"lowerIsBetter": false, "replicates": [1491.649462376342, 1658.6599747051855, 1719.166204390871, 1732.2637878901471, 1756.6311074674322, 5954.970225148868, 6329.525285603575, 6994.510384273103, 7152.284771522845, 7158.212596614375, 7083.114610673666, 7267.49127561071, 7282.9271707282915, 7294.16117146527, 7299.416046716263, 2074.6576814825535, 2121.8302535797097, 2123.925662601809, 2124.1715730864976, 2126.6384714598557, 2148.4521447030984, 2152.827773778094, 2155.859869108503, 2161.848670593059, 2186.5189658275153, 2125.362391282617, 2130.1266480742897, 2140.1439424230275, 2143.1855894760047, 2194.8024677779, 2069.855110142291, 2114.947126321839, 2121.5650791587686, 2122.3314655883423, 2124.2034237161142, 2122.384508492535, 2157.1155826111376, 2158.805707486318, 2159.7732238114927, 2164.6644770060507, 7198.712051517985, 7263.673134708951, 7280.927190728078, 7288.56268623879, 7304.233055529146, 4254.191703576342, 4285.6142947134595, 4296.5273819879785, 4297.312430011214, 4328.4156638853665, 2763.5440152375036, 2774.0429551804596, 2789.539725945237, 2791.9441611167663, 2792.190264823199, 878.5738916625431, 891.5586784541629, 897.1566727276339, 899.8470260055741, 926.3654396738189, 9568.856467152998, 9614.51927403627, 9654.855177172349, 9676.419414835062, 9690.46702431373, 4075.3683179106692, 4083.91832163361, 4122.670186385082, 4161.979190104091, 4169.541350451448, 8383.95808020956, 8426.620802063922, 8446.746597602081, 8452.450590711584, 8466.322694184573, 4288.292431748789, 4300.225959327351, 4308.569143085666, 4318.417013703172, 4321.178975994551, 3872.728908976401, 3878.146807702301, 3910.765354078764, 3981.0, 4002.7398219115667, 3267.970589264374, 3278.09852290622, 3308.1894935740897, 3327.434336162858, 3334.533165356852, 1011.145581983223, 1014.1582486536305, 1017.1659239423601, 1029.1406675426103, 1032.4012072997643, 1127.8251870960014, 1143.5254369436757, 1180.6694125644833, 1198.2031948754154, 1208.9516419343129, 6882.96755486671, 6885.449164066863, 6904.965475172692, 6906.896396554056, 6914.515983881181, 413.1818998383218, 418.7529357678923, 421.5299940566247, 425.7296616648389, 440.19005030743585, 5214.582833373321, 5225.033368826779, 5225.111731005738, 5234.979179060047, 5243.9213411798855, 8549.145085491526, 8636.309095272363, 8704.129587041245, 8832.51421171829, 8849.0, 8497.830043399097, 8647.437916535531, 8654.610542525601, 8655.913440865637, 8716.43343182691, 6345.460635846005, 6355.3326900674765, 6379.776707815204, 6433.871322573522, 6528.608283503005, 6636.8717318057015, 6663.733450661919, 6665.733370665119, 6667.599944003376, 6674.299198584079, 7755.302022817974, 7799.610019499116, 7889.684412623431, 7897.802554935943, 8029.397795165269, 7895.802604934923, 8037.156098609562, 8085.070216925129, 8137.511749295061, 8207.179282071746, 5070.112730272114, 5140.254663073759, 5997.3402925677265, 6024.759009639565, 6073.696315184311, 6647.767328143492, 6857.382835544825, 6865.828354291183, 6889.311068893071, 6908.896366554606, 6234.127222188807, 6459.61242325462, 6477.578957367756, 6540.50946179048, 6555.737770489127, 6390.93609063922, 6477.255115661571, 6479.1901012373455, 6546.803595892131, 6561.0, 6468.353164683682, 6482.675866206765, 6559.048937903882, 6562.343765623399, 6564.409203171737, 5951.196588460502, 5953.880922381615, 6067.908981365194, 6073.514118870391, 6083.209182806384, 6083.939160608337, 6130.325664176848, 6139.447449729546, 6141.785037523665, 6144.477719393902], "unit": "ms", "name": "mootools.html", "value": 4055.6151318410393}, {"lowerIsBetter": false, "replicates": [292.31306429889764, 295.73236221219804, 303.35839699036546, 304.17416713622515, 305.13494243818775, 5572.080606699899, 5580.0, 5580.525655319298, 5591.0774722170845, 5685.772569097241, 5498.422665620113, 5572.136318870572, 5605.439456054392, 5607.0, 5617.8033768818095, 4119.485064366954, 4220.3036498977635, 4243.681723870706, 4244.342126970325, 4244.745315281078, 4233.428487154241, 4252.213340532012, 4258.063226090255, 4261.957380426203, 4263.509696384925, 4204.117135401554, 4212.599803018724, 4215.283401821683, 4217.072244106292, 4218.4516012918275, 4196.643285320752, 4199.811008504594, 4214.494260688722, 4217.219814334358, 4220.704550681454, 3641.8543258269638, 3641.963580364189, 3645.398509245971, 3650.2881938022097, 3663.9267214655824, 5247.370315562119, 5269.789208431658, 5398.703071331075, 5407.783688652449, 5414.810481633124, 4820.4456487503685, 4822.035592881438, 4823.710577365369, 4824.300476430933, 4828.348172996635, 5823.4467725566, 5852.502537284336, 5860.06239001762, 5864.912026319608, 5870.148828419898, 3816.790076545789, 3916.5104361954754, 3918.74528155669, 3936.409538569209, 3951.7826519541413, 6065.4844338231305, 6114.510839132859, 6141.170941922828, 6155.261368635747, 6156.322804491502, 4057.208844275397, 4058.6955978301744, 4063.2686116499312, 4066.430699702044, 4073.91852162961, 4107.507099148122, 4113.197926404322, 4114.238865809834, 4119.732217405859, 4123.690723195772, 4692.7653617319, 4769.523047695203, 4782.139214941344, 4782.808687652525, 4796.328514008042, 5814.3313518945015, 5831.912521312183, 5835.649861008353, 5849.912251316234, 5854.970725146347, 1425.9429622815178, 1445.0, 1446.168453139428, 1448.4857875454272, 1449.2174225917886, 935.3919952031098, 940.8823897012874, 957.5978089202551, 969.1762002297991, 973.4159504297365, 5147.2279158126585, 5155.61332900034, 5156.226566015128, 5160.561352285098, 5174.456682048406, 6052.66710330936, 6067.605605635619, 6105.938940610537, 6113.0, 6121.326654068049, 5102.36220472441, 5135.639055650256, 5146.382434107856, 5150.459201783834, 5151.819686311036, 3204.5353423753427, 3252.788568743024, 3300.1914530939594, 3312.7846689965077, 3315.7015868571943, 5630.127330263816, 5705.857353566194, 5711.0, 5793.0, 5820.505257053113, 6308.274548426898, 6315.778947736807, 6335.334789847, 6336.873262534724, 6348.4286414222015, 5722.198892155102, 5760.798372056958, 5778.133280008033, 5780.393058728857, 5784.913226301609, 6110.083487476914, 6111.602745821508, 6128.785492507741, 6140.293866205444, 6148.538859585459, 5788.710564471844, 6013.819585412444, 6016.2479690038745, 6024.277086749618, 6031.5476339273855, 5773.47003044202, 5775.9133612995, 5781.82654520365, 5789.2184555086205, 5799.449052340021, 3983.7609743415487, 4024.9798751006056, 4029.093453972833, 4030.717849750489, 4038.1116154445976, 6022.126791615104, 6159.938400616115, 6169.56813023084, 6171.783987560414, 6172.259328880563, 5896.705164741831, 5903.822885313448, 5904.645721256738, 5904.937111320004, 5906.379830117776, 5892.558058145571, 5905.763769449346, 5906.734196961061, 5917.437843404869, 5925.288965324189, 5635.605507614428, 5754.597178197486, 5758.971205143947, 5768.7404066817935, 5782.913256301243, 5931.08068249422, 5951.7024148791525, 5957.076653118774, 5958.004068637055, 5973.820785376446, 5764.711764411846, 5802.100674395476, 5807.0, 5811.070228763378, 5813.6221145625395], "unit": "ms", "name": "prototype.html", "value": 4355.604862240768}, {"lowerIsBetter": false, "replicates": [779.7309928074814, 790.2847922630018, 795.6697970342308, 800.9959950200248, 802.8835818806272, 12301.753964920696, 12446.937765311171, 12508.81236781449, 12520.81218781719, 12526.749465010695, 11491.942540287308, 11999.880001199985, 12072.939635301833, 12136.453859576319, 12205.206661566992, 810.4165001199127, 821.4167940762036, 822.9629666665014, 823.9423240373176, 824.3570015388007, 808.3331251717327, 814.7555733280022, 817.0236567302077, 819.2749416766175, 820.3888103362973, 847.9364047696416, 848.8896443462341, 851.8722191671237, 852.2585350744861, 852.7143406958645, 842.9367797415157, 843.7047033538274, 847.478800537668, 849.392684230778, 850.0394554153828, 622.7322251431882, 627.1345543150424, 628.3371043549099, 628.7547856335987, 630.3633330336347, 12190.146689731722, 12211.389430528438, 12236.449359778831, 12324.568640097554, 12331.75336493265, 11136.443177841156, 11181.273217240934, 11192.44037798115, 11289.887101128967, 11392.886071139266, 8925.866112008325, 8926.196642302224, 9069.0, 9217.035225195177, 9275.860862087075, 3264.640889502177, 3268.591426071741, 3285.769996100274, 3313.6355000949875, 3384.76306658534, 34234.14414639629, 34929.30141397183, 38671.61328386708, 38675.41986870199, 39151.8042409789, 8564.828703426021, 8587.098354672795, 8660.220580147818, 8749.227364265369, 8873.645054197888, 16152.35390584387, 16169.35322587107, 16190.028598284141, 16207.351705931867, 16242.0, 6095.299040610386, 6177.382261773877, 6252.155958945576, 6258.186435763321, 6277.058441233851, 3415.692587667122, 3453.3611281912927, 3474.4614584739406, 3492.6856582907662, 3498.8250587470525, 2746.244782684738, 2756.476269508787, 2764.115483045406, 2770.6536682914634, 2772.085211880075, 491.8008206676302, 495.69267054426484, 502.42472369137136, 503.8488453463946, 505.33548383875086, 564.7740903638578, 599.2479438304987, 612.4946918792015, 626.589583822597, 629.232336549409, 7763.689452421952, 7765.53406795594, 7807.492512986638, 7901.209879012053, 8008.83982320362, 564.7358269204008, 578.0923949399403, 580.5558747558122, 593.6586462783916, 603.7011679218728, 3585.748997570145, 3675.0996005978704, 3697.7041836653, 3733.253349330145, 3751.249750050001, 49154.75422622936, 50784.0, 50860.74569627128, 51004.74497627488, 51142.74428627833, 46577.76711116423, 47056.2941555877, 47059.294110588366, 47553.52446475491, 47615.5238447618, 40226.59773402228, 40638.39042414366, 40700.185996279906, 40706.389404159556, 41580.37629435561, 7863.52818830872, 7885.605719713876, 8044.034715834137, 8363.121872203574, 8540.487570745776, 29431.705682942895, 29435.264118396353, 29499.705002949697, 32609.347813043132, 32677.836610816794, 38372.424413633256, 39065.21869562536, 40042.0, 40132.1973560533, 40274.79862600668, 9674.467904265333, 10150.441725705157, 10298.330608510423, 10354.430506322225, 10433.0, 10781.838272426077, 10824.729381765519, 10883.292585981886, 11197.0, 11258.493367798632, 10280.17758579297, 10347.43089130105, 10465.581376744845, 10484.423356715453, 10620.150387969099, 10224.897751022394, 10314.793704126025, 10371.807242167248, 10389.220808439548, 10474.476276186313, 10180.796384072426, 10215.438150901771, 10408.791824163625, 10429.843552346872, 10579.206559507913, 9114.954425227832, 9130.178283954476, 9206.17144457002, 9510.429374237568, 9602.279829012992, 8978.730638080868, 9126.269898408244, 9184.448933064037, 9301.813963720553, 9343.08160212398], "unit": "ms", "name": "yui.html", "value": 5766.050463548597}], "name": "dromaeo_css", "value": 6458.33427419078}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 115.0, 115.0, 113.0, 129.0, 114.0, 113.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [168.0, 132.0, 150.0, 165.0, 130.0, 159.0, 158.0, 133.0, 165.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [168.0, 165.0, 162.0, 162.0, 162.0, 162.0, 172.0, 163.0, 166.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 74.0, 146.0, 72.0, 79.0, 73.0, 74.0, 157.0], "unit": "ms", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 94.0, 95.0, 96.0, 135.0, 94.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 98.0, 97.0, 98.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 74.0, 74.0, 77.0, 73.0, 78.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 93.0, 95.0, 87.0, 87.0, 85.0, 89.0, 85.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [129.0, 119.0, 125.0, 122.0, 120.0, 131.0, 131.0, 122.0, 128.0, 133.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [137.0, 146.0, 149.0, 150.0, 149.0, 142.0, 151.0, 153.0, 153.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 71.0, 72.0, 70.0, 70.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1551.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [184.60402436773123], "unit": "score", "name": "DeltaBlue", "value": 358.16120599999994}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1128.6681715575621], "unit": "score", "name": "RayTrace", "value": 655.6302539999998}, {"lowerIsBetter": false, "replicates": [705.7163020465773], "unit": "score", "name": "Earley", "value": 944.3780709999997}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [637.3486297004462], "unit": "score", "name": "Splay", "value": 127.85937899999995}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21135.461567469058}]} 19:18:47 INFO - RETURN: dromaeo_css: 6458.33 19:18:47 INFO - RETURN: kraken: 1551.70 19:18:47 INFO - RETURN: v8_7: 21135.46 19:18:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21135.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1551.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6458.33"}}} 19:18:47 INFO - Return code: 0 19:18:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:18:47 INFO - # TBPL SUCCESS # 19:18:47 INFO - Running post-action listener: _resource_record_post_action 19:18:47 INFO - Running post-run listener: _resource_record_post_run 19:18:49 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515600384; Read time: 12; Write time: 582376 19:18:49 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235024384; Read time: 0; Write time: 401956 19:18:49 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280576000; Read time: 12; Write time: 180420 19:18:49 INFO - Running post-run listener: _upload_blobber_files 19:18:49 INFO - Blob upload gear active. 19:18:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:18:49 INFO - Copying logs to upload dir... 19:18:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.677408 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-03 19:18:48.998601) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 19:18:49.002165) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010002 build_url: 'https://queue.taskcluster.net/v1/task/1hN3Nj18SMOotHKYgF9CgA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 19:18:49.057350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 19:18:49.057876) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449197860.231333-444440487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 19:18:49.108540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 19:18:49.108906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 19:18:49.109232) ========= ========= Total master_lag: 0.33 =========