builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1449778584.23 results: success (0) buildid: 20151210110357 builduid: 00af4b5face74d2daa6a7be6278f9423 revision: 11405af50b40d89422127e94db681710a1929b4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.234777) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.235224) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.235753) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006377 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.290236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.290604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.402933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.403235) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.474350) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.474690) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.475093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.475428) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 12:16:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-12-10 12:16:25 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.662805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.663552) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014888 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.713304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:24.713663) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11405af50b40d89422127e94db681710a1929b4a --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 11405af50b40d89422127e94db681710a1929b4a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 12:16:25,491 truncating revision to first 12 chars 2015-12-10 12:16:25,491 Setting DEBUG logging. 2015-12-10 12:16:25,491 attempt 1/10 2015-12-10 12:16:25,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11405af50b40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 12:16:25,785 unpacking tar archive at: fx-team-11405af50b40/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:25.321272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:25.321599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:25.364324) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:25.364626) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 12:16:25.365046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 12:16:25.365369) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:26 INFO - MultiFileLogger online at 20151210 12:16:26 in /builds/slave/test 12:16:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 12:16:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:26 INFO - {'append_to_log': False, 12:16:26 INFO - 'base_work_dir': '/builds/slave/test', 12:16:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:16:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:26 INFO - 'branch': 'Fx-Team-Non-PGO', 12:16:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:26 INFO - 'config_files': ('talos/linux_config.py',), 12:16:26 INFO - 'default_actions': ('clobber', 12:16:26 INFO - 'read-buildbot-config', 12:16:26 INFO - 'download-and-extract', 12:16:26 INFO - 'populate-webroot', 12:16:26 INFO - 'create-virtualenv', 12:16:26 INFO - 'install', 12:16:26 INFO - 'run-tests'), 12:16:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:26 INFO - 'download_minidump_stackwalk': True, 12:16:26 INFO - 'download_symbols': 'ondemand', 12:16:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:26 INFO - 'installer_path': 'installer.exe', 12:16:26 INFO - 'log_level': 'info', 12:16:26 INFO - 'log_name': 'talos', 12:16:26 INFO - 'log_to_console': True, 12:16:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:26 INFO - 'opt_config_files': (), 12:16:26 INFO - 'pip_index': False, 12:16:26 INFO - 'sps_profile': False, 12:16:26 INFO - 'sps_profile_interval': 0, 12:16:26 INFO - 'suite': 'dromaeojs', 12:16:26 INFO - 'system_bits': '64', 12:16:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:26 INFO - 'title': 'talos-linux64-ix-026', 12:16:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:26 INFO - 'use_talos_json': True, 12:16:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:26 INFO - 'work_dir': 'build'} 12:16:26 INFO - ##### 12:16:26 INFO - ##### Running clobber step. 12:16:26 INFO - ##### 12:16:26 INFO - Running pre-action listener: _resource_record_pre_action 12:16:26 INFO - Running main action method: clobber 12:16:26 INFO - rmtree: /builds/slave/test/build 12:16:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:26 INFO - Running post-action listener: _resource_record_post_action 12:16:26 INFO - ##### 12:16:26 INFO - ##### Running read-buildbot-config step. 12:16:26 INFO - ##### 12:16:26 INFO - Running pre-action listener: _resource_record_pre_action 12:16:26 INFO - Running main action method: read_buildbot_config 12:16:26 INFO - Using buildbot properties: 12:16:26 INFO - { 12:16:26 INFO - "properties": { 12:16:26 INFO - "buildnumber": 1189, 12:16:26 INFO - "product": "firefox", 12:16:26 INFO - "script_repo_revision": "production", 12:16:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:16:26 INFO - "repository": "", 12:16:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:16:26 INFO - "buildid": "20151210110357", 12:16:26 INFO - "slavename": "talos-linux64-ix-026", 12:16:26 INFO - "pgo_build": "False", 12:16:26 INFO - "basedir": "/builds/slave/test", 12:16:26 INFO - "project": "", 12:16:26 INFO - "platform": "ubuntu64_hw", 12:16:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:16:26 INFO - "slavebuilddir": "test", 12:16:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:16:26 INFO - "branch": "fx-team", 12:16:26 INFO - "repo_path": "integration/fx-team", 12:16:26 INFO - "stage_platform": "linux64", 12:16:26 INFO - "builduid": "00af4b5face74d2daa6a7be6278f9423", 12:16:26 INFO - "revision": "11405af50b40d89422127e94db681710a1929b4a" 12:16:26 INFO - }, 12:16:26 INFO - "sourcestamp": { 12:16:26 INFO - "repository": "", 12:16:26 INFO - "hasPatch": false, 12:16:26 INFO - "project": "", 12:16:26 INFO - "branch": "fx-team-linux64-talos", 12:16:26 INFO - "changes": [ 12:16:26 INFO - { 12:16:26 INFO - "category": null, 12:16:26 INFO - "files": [ 12:16:26 INFO - { 12:16:26 INFO - "url": null, 12:16:26 INFO - "name": "https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:16:26 INFO - } 12:16:26 INFO - ], 12:16:26 INFO - "repository": "", 12:16:26 INFO - "rev": "11405af50b40d89422127e94db681710a1929b4a", 12:16:26 INFO - "who": "mak77@bonardo.net", 12:16:26 INFO - "when": 1449778494, 12:16:26 INFO - "number": 7267794, 12:16:26 INFO - "comments": "Bug 1231661 - Relax no-multi-spaces Eslint rule. r=Mossop", 12:16:26 INFO - "project": "", 12:16:26 INFO - "at": "Thu 10 Dec 2015 12:14:54", 12:16:26 INFO - "branch": "fx-team-linux64-talos", 12:16:26 INFO - "revlink": "", 12:16:26 INFO - "properties": [ 12:16:26 INFO - [ 12:16:26 INFO - "buildid", 12:16:26 INFO - "20151210110357", 12:16:26 INFO - "Change" 12:16:26 INFO - ], 12:16:26 INFO - [ 12:16:26 INFO - "builduid", 12:16:26 INFO - "00af4b5face74d2daa6a7be6278f9423", 12:16:26 INFO - "Change" 12:16:26 INFO - ], 12:16:26 INFO - [ 12:16:26 INFO - "pgo_build", 12:16:26 INFO - "False", 12:16:26 INFO - "Change" 12:16:26 INFO - ] 12:16:26 INFO - ], 12:16:26 INFO - "revision": "11405af50b40d89422127e94db681710a1929b4a" 12:16:26 INFO - } 12:16:26 INFO - ], 12:16:26 INFO - "revision": "11405af50b40d89422127e94db681710a1929b4a" 12:16:26 INFO - } 12:16:26 INFO - } 12:16:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:16:26 INFO - Running post-action listener: _resource_record_post_action 12:16:26 INFO - ##### 12:16:26 INFO - ##### Running download-and-extract step. 12:16:26 INFO - ##### 12:16:26 INFO - Running pre-action listener: _resource_record_pre_action 12:16:26 INFO - Running main action method: download_and_extract 12:16:26 INFO - mkdir: /builds/slave/test/build/tests 12:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:26 INFO - https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/test_packages.json 12:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/test_packages.json 12:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:16:37 INFO - Downloaded 1302 bytes. 12:16:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:16:37 INFO - Using the following test package requirements: 12:16:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:37 INFO - u'jsshell-linux-x86_64.zip'], 12:16:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:37 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')]} 12:16:37 INFO - https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:41 INFO - Downloaded 21866925 bytes. 12:16:41 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 12:16:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:41 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 12:16:42 INFO - Return code: 0 12:16:42 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 12:16: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')]} 12:16:42 INFO - https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:43 INFO - Downloaded 21866925 bytes. 12:16:43 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 12:16:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:43 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 12:16:44 INFO - Return code: 0 12:16:44 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')]} 12:16:44 INFO - https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:45 INFO - Downloaded 11132038 bytes. 12:16:45 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 12:16:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:45 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 12:16:45 INFO - Return code: 0 12:16: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')]} 12:16:45 INFO - https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/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 12:16:47 INFO - Downloaded 57727339 bytes. 12:16:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:47 INFO - mkdir: /builds/slave/test/properties 12:16:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:47 INFO - Contents: 12:16:47 INFO - build_url:https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:47 INFO - Running post-action listener: _resource_record_post_action 12:16:47 INFO - Running post-action listener: set_extra_try_arguments 12:16:47 INFO - ##### 12:16:47 INFO - ##### Running populate-webroot step. 12:16:47 INFO - ##### 12:16:47 INFO - Running pre-action listener: _resource_record_pre_action 12:16:47 INFO - Running main action method: populate_webroot 12:16:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:47 INFO - '--tppagecycles', 12:16:47 INFO - '7'], 12:16:47 INFO - 'tests': ['tsvgm']}}, 12:16:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'tests': ['damp', 'tps']}, 12:16:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['damp', 'tps']}, 12:16:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:47 INFO - 'other': {'tests': ['a11yr', 12:16:47 INFO - 'ts_paint', 12:16:47 INFO - 'tpaint', 12:16:47 INFO - 'sessionrestore', 12:16:47 INFO - 'sessionrestore_no_auto_restore']}, 12:16:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['a11yr', 12:16:47 INFO - 'ts_paint', 12:16:47 INFO - 'tpaint', 12:16:47 INFO - 'sessionrestore', 12:16:47 INFO - 'sessionrestore_no_auto_restore']}, 12:16:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['a11yr', 12:16:47 INFO - 'ts_paint', 12:16:47 INFO - 'tpaint', 12:16:47 INFO - 'sessionrestore', 12:16:47 INFO - 'sessionrestore_no_auto_restore']}, 12:16:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['a11yr', 12:16:47 INFO - 'ts_paint', 12:16:47 INFO - 'tpaint', 12:16:47 INFO - 'sessionrestore', 12:16:47 INFO - 'sessionrestore_no_auto_restore']}, 12:16:47 INFO - 'other_l64': {'tests': ['a11yr', 12:16:47 INFO - 'ts_paint', 12:16:47 INFO - 'tpaint', 12:16:47 INFO - 'sessionrestore', 12:16:47 INFO - 'sessionrestore_no_auto_restore']}, 12:16:47 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:47 INFO - 'ts_paint', 12:16:47 INFO - 'tpaint', 12:16:47 INFO - 'sessionrestore', 12:16:47 INFO - 'sessionrestore_no_auto_restore']}, 12:16:47 INFO - 'svgr': {'tests': ['tsvgx', 12:16:47 INFO - 'tsvgr_opacity', 12:16:47 INFO - 'tart', 12:16:47 INFO - 'tscrollx', 12:16:47 INFO - 'cart']}, 12:16:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['tsvgx', 12:16:47 INFO - 'tsvgr_opacity', 12:16:47 INFO - 'tart', 12:16:47 INFO - 'tscrollx', 12:16:47 INFO - 'cart']}, 12:16:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'tests': ['tp5o']}, 12:16:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'talos_options': ['--e10s'], 12:16:47 INFO - 'tests': ['tp5o']}, 12:16:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'talos_options': ['--xperf_path', 12:16:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:47 INFO - 'tests': ['tp5n']}, 12:16:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:47 INFO - 'talos_options': ['--e10s', 12:16:47 INFO - '--xperf_path', 12:16:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:47 INFO - 'tests': ['tp5n']}}, 12:16:47 INFO - 'talos.zip': {'path': '', 12:16:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:47 INFO - Running post-action listener: _resource_record_post_action 12:16:47 INFO - ##### 12:16:47 INFO - ##### Running create-virtualenv step. 12:16:47 INFO - ##### 12:16:47 INFO - Running pre-action listener: _resource_record_pre_action 12:16:47 INFO - Running main action method: create_virtualenv 12:16:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:16:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:47 INFO - Using real prefix '/usr' 12:16:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:49 INFO - Installing pip.................done. 12:16:49 INFO - Return code: 0 12:16:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:49 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:16:49 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 12:16:49 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 12:16:49 INFO - Using env: {'DISPLAY': ':0', 12:16:49 INFO - 'HOME': '/home/cltbld', 12:16:49 INFO - 'LANG': 'en_US.UTF-8', 12:16:49 INFO - 'LANGUAGE': 'en_US:en', 12:16:49 INFO - 'LOGNAME': 'cltbld', 12:16:49 INFO - 'MAIL': '/var/mail/cltbld', 12:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:49 INFO - 'MOZ_NO_REMOTE': '1', 12:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:49 INFO - 'NO_EM_RESTART': '1', 12:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:49 INFO - 'PWD': '/builds/slave/test', 12:16:49 INFO - 'SHELL': '/bin/bash', 12:16:49 INFO - 'SHLVL': '1', 12:16:49 INFO - 'TERM': 'linux', 12:16:49 INFO - 'TMOUT': '86400', 12:16:49 INFO - 'USER': 'cltbld', 12:16:49 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:49 INFO - '_': '/tools/buildbot/bin/python'} 12:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:49 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 12:16:49 INFO - Cleaning up... 12:16:50 INFO - Return code: 0 12:16:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:50 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:16:50 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 12:16:50 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 12:16:50 INFO - Using env: {'DISPLAY': ':0', 12:16:50 INFO - 'HOME': '/home/cltbld', 12:16:50 INFO - 'LANG': 'en_US.UTF-8', 12:16:50 INFO - 'LANGUAGE': 'en_US:en', 12:16:50 INFO - 'LOGNAME': 'cltbld', 12:16:50 INFO - 'MAIL': '/var/mail/cltbld', 12:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:50 INFO - 'MOZ_NO_REMOTE': '1', 12:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:50 INFO - 'NO_EM_RESTART': '1', 12:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:50 INFO - 'PWD': '/builds/slave/test', 12:16:50 INFO - 'SHELL': '/bin/bash', 12:16:50 INFO - 'SHLVL': '1', 12:16:50 INFO - 'TERM': 'linux', 12:16:50 INFO - 'TMOUT': '86400', 12:16:50 INFO - 'USER': 'cltbld', 12:16:50 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:50 INFO - '_': '/tools/buildbot/bin/python'} 12:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:50 INFO - Downloading/unpacking psutil>=0.7.1 12:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:16:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:52 INFO - Installing collected packages: psutil 12:16:52 INFO - Running setup.py install for psutil 12:16:52 INFO - building 'psutil._psutil_linux' extension 12:16:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:16:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:16:52 INFO - building 'psutil._psutil_posix' extension 12:16:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:16:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:52 INFO - Successfully installed psutil 12:16:52 INFO - Cleaning up... 12:16:52 INFO - Return code: 0 12:16:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:52 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:16:52 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 12:16:52 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 12:16:52 INFO - Using env: {'DISPLAY': ':0', 12:16:52 INFO - 'HOME': '/home/cltbld', 12:16:52 INFO - 'LANG': 'en_US.UTF-8', 12:16:52 INFO - 'LANGUAGE': 'en_US:en', 12:16:52 INFO - 'LOGNAME': 'cltbld', 12:16:52 INFO - 'MAIL': '/var/mail/cltbld', 12:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:52 INFO - 'MOZ_NO_REMOTE': '1', 12:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:52 INFO - 'NO_EM_RESTART': '1', 12:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:52 INFO - 'PWD': '/builds/slave/test', 12:16:52 INFO - 'SHELL': '/bin/bash', 12:16:52 INFO - 'SHLVL': '1', 12:16:52 INFO - 'TERM': 'linux', 12:16:52 INFO - 'TMOUT': '86400', 12:16:52 INFO - 'USER': 'cltbld', 12:16:52 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:52 INFO - '_': '/tools/buildbot/bin/python'} 12:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:54 INFO - Installing collected packages: mozsystemmonitor 12:16:54 INFO - Running setup.py install for mozsystemmonitor 12:16:54 INFO - Successfully installed mozsystemmonitor 12:16:54 INFO - Cleaning up... 12:16:54 INFO - Return code: 0 12:16:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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', '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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:16: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 blobuploader==1.2.4 12:16:54 INFO - Using env: {'DISPLAY': ':0', 12:16:54 INFO - 'HOME': '/home/cltbld', 12:16:54 INFO - 'LANG': 'en_US.UTF-8', 12:16:54 INFO - 'LANGUAGE': 'en_US:en', 12:16:54 INFO - 'LOGNAME': 'cltbld', 12:16:54 INFO - 'MAIL': '/var/mail/cltbld', 12:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:54 INFO - 'MOZ_NO_REMOTE': '1', 12:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:54 INFO - 'NO_EM_RESTART': '1', 12:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:54 INFO - 'PWD': '/builds/slave/test', 12:16:54 INFO - 'SHELL': '/bin/bash', 12:16:54 INFO - 'SHLVL': '1', 12:16:54 INFO - 'TERM': 'linux', 12:16:54 INFO - 'TMOUT': '86400', 12:16:54 INFO - 'USER': 'cltbld', 12:16:54 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:54 INFO - '_': '/tools/buildbot/bin/python'} 12:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:57 INFO - Downloading docopt-0.6.1.tar.gz 12:16:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:57 INFO - Running setup.py install for blobuploader 12:16:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:57 INFO - Running setup.py install for requests 12:16:57 INFO - Running setup.py install for docopt 12:16:57 INFO - Successfully installed blobuploader requests docopt 12:16:57 INFO - Cleaning up... 12:16:57 INFO - Return code: 0 12:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:57 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')]} 12:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:57 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')]} 12:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:57 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:16:57 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 12:16:57 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 12:16:57 INFO - Using env: {'DISPLAY': ':0', 12:16:57 INFO - 'HOME': '/home/cltbld', 12:16:57 INFO - 'LANG': 'en_US.UTF-8', 12:16:57 INFO - 'LANGUAGE': 'en_US:en', 12:16:57 INFO - 'LOGNAME': 'cltbld', 12:16:57 INFO - 'MAIL': '/var/mail/cltbld', 12:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:57 INFO - 'MOZ_NO_REMOTE': '1', 12:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:57 INFO - 'NO_EM_RESTART': '1', 12:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:57 INFO - 'PWD': '/builds/slave/test', 12:16:57 INFO - 'SHELL': '/bin/bash', 12:16:57 INFO - 'SHLVL': '1', 12:16:57 INFO - 'TERM': 'linux', 12:16:57 INFO - 'TMOUT': '86400', 12:16:57 INFO - 'USER': 'cltbld', 12:16:57 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:57 INFO - '_': '/tools/buildbot/bin/python'} 12:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:58 INFO - Running setup.py (path:/tmp/pip-aRjdS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:58 INFO - Running setup.py (path:/tmp/pip-r7_q_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:58 INFO - Running setup.py (path:/tmp/pip-WTsXpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:58 INFO - Running setup.py (path:/tmp/pip-tIc8cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:58 INFO - Running setup.py (path:/tmp/pip-i8zQxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:58 INFO - Running setup.py (path:/tmp/pip-Eo1QdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:58 INFO - Running setup.py (path:/tmp/pip-FW1KV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:58 INFO - Running setup.py (path:/tmp/pip-1N9i9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:58 INFO - Running setup.py (path:/tmp/pip-hWzpFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:58 INFO - Running setup.py (path:/tmp/pip-rO5DMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:58 INFO - Running setup.py (path:/tmp/pip-mPUGcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:58 INFO - Running setup.py (path:/tmp/pip-nvWhAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:58 INFO - Running setup.py (path:/tmp/pip-1Tah8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:59 INFO - Running setup.py (path:/tmp/pip-mCN19S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:59 INFO - Running setup.py (path:/tmp/pip-olDkse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:59 INFO - Running setup.py (path:/tmp/pip-tXt8Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:59 INFO - Running setup.py (path:/tmp/pip-ZsGssq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:59 INFO - Running setup.py install for manifestparser 12:16:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:59 INFO - Running setup.py install for mozcrash 12:16:59 INFO - Running setup.py install for mozdebug 12:16:59 INFO - Running setup.py install for mozdevice 12:16:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:59 INFO - Running setup.py install for mozfile 12:16:59 INFO - Running setup.py install for mozhttpd 12:16:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:59 INFO - Running setup.py install for mozinfo 12:17:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozInstall 12:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozleak 12:17:00 INFO - Running setup.py install for mozlog 12:17:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for moznetwork 12:17:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozprocess 12:17:00 INFO - Running setup.py install for mozprofile 12:17:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozrunner 12:17:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozscreenshot 12:17:00 INFO - Running setup.py install for moztest 12:17:00 INFO - Running setup.py install for mozversion 12:17:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:01 INFO - Cleaning up... 12:17:01 INFO - Return code: 0 12:17:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:01 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:17:01 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 12:17:01 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 12:17:01 INFO - Using env: {'DISPLAY': ':0', 12:17:01 INFO - 'HOME': '/home/cltbld', 12:17:01 INFO - 'LANG': 'en_US.UTF-8', 12:17:01 INFO - 'LANGUAGE': 'en_US:en', 12:17:01 INFO - 'LOGNAME': 'cltbld', 12:17:01 INFO - 'MAIL': '/var/mail/cltbld', 12:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:01 INFO - 'MOZ_NO_REMOTE': '1', 12:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:01 INFO - 'NO_EM_RESTART': '1', 12:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:01 INFO - 'PWD': '/builds/slave/test', 12:17:01 INFO - 'SHELL': '/bin/bash', 12:17:01 INFO - 'SHLVL': '1', 12:17:01 INFO - 'TERM': 'linux', 12:17:01 INFO - 'TMOUT': '86400', 12:17:01 INFO - 'USER': 'cltbld', 12:17:01 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:01 INFO - '_': '/tools/buildbot/bin/python'} 12:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:01 INFO - Running setup.py (path:/tmp/pip-I8vDlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:01 INFO - Running setup.py (path:/tmp/pip-8G0GEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:01 INFO - Running setup.py (path:/tmp/pip-acowvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:01 INFO - Running setup.py (path:/tmp/pip-BOjOPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:01 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)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:01 INFO - Running setup.py (path:/tmp/pip-pffWtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:01 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)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:01 INFO - Running setup.py (path:/tmp/pip-H2T6qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:01 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)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:01 INFO - Running setup.py (path:/tmp/pip-s0CUAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:01 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)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:01 INFO - Running setup.py (path:/tmp/pip-uEpbur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:01 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)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:01 INFO - Running setup.py (path:/tmp/pip-PUHYs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:01 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)) 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:02 INFO - Running setup.py (path:/tmp/pip-lDig4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:02 INFO - Running setup.py (path:/tmp/pip-8Dtp8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:02 INFO - Running setup.py (path:/tmp/pip-B9gYn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:02 INFO - Running setup.py (path:/tmp/pip-SmtVZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:02 INFO - Running setup.py (path:/tmp/pip-WgxHWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:02 INFO - Running setup.py (path:/tmp/pip-vZvBgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:02 INFO - Running setup.py (path:/tmp/pip-hHfAsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:02 INFO - Running setup.py (path:/tmp/pip-tKCBxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:04 INFO - Downloading blessings-1.5.1.tar.gz 12:17:04 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 12:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:04 INFO - Installing collected packages: blessings 12:17:04 INFO - Running setup.py install for blessings 12:17:04 INFO - Successfully installed blessings 12:17:04 INFO - Cleaning up... 12:17:04 INFO - Return code: 0 12:17:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:04 INFO - Reading from file tmpfile_stdout 12:17:04 INFO - Current package versions: 12:17:04 INFO - argparse == 1.2.1 12:17:04 INFO - blessings == 1.5.1 12:17:04 INFO - blobuploader == 1.2.4 12:17:04 INFO - docopt == 0.6.1 12:17:04 INFO - manifestparser == 1.1 12:17:04 INFO - mozInstall == 1.12 12:17:04 INFO - mozcrash == 0.16 12:17:04 INFO - mozdebug == 0.1 12:17:04 INFO - mozdevice == 0.47 12:17:04 INFO - mozfile == 1.2 12:17:04 INFO - mozhttpd == 0.7 12:17:04 INFO - mozinfo == 0.9 12:17:04 INFO - mozleak == 0.1 12:17:04 INFO - mozlog == 3.1 12:17:04 INFO - moznetwork == 0.27 12:17:04 INFO - mozprocess == 0.22 12:17:04 INFO - mozprofile == 0.27 12:17:04 INFO - mozrunner == 6.11 12:17:04 INFO - mozscreenshot == 0.1 12:17:04 INFO - mozsystemmonitor == 0.0 12:17:04 INFO - moztest == 0.7 12:17:04 INFO - mozversion == 1.4 12:17:04 INFO - psutil == 3.1.1 12:17:04 INFO - requests == 1.2.3 12:17:04 INFO - wsgiref == 0.1.2 12:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:04 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')]} 12:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:04 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')]} 12:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:04 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:17:04 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 12:17:04 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 12:17:04 INFO - Using env: {'DISPLAY': ':0', 12:17:04 INFO - 'HOME': '/home/cltbld', 12:17:04 INFO - 'LANG': 'en_US.UTF-8', 12:17:04 INFO - 'LANGUAGE': 'en_US:en', 12:17:04 INFO - 'LOGNAME': 'cltbld', 12:17:04 INFO - 'MAIL': '/var/mail/cltbld', 12:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:04 INFO - 'MOZ_NO_REMOTE': '1', 12:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:04 INFO - 'NO_EM_RESTART': '1', 12:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:04 INFO - 'PWD': '/builds/slave/test', 12:17:04 INFO - 'SHELL': '/bin/bash', 12:17:04 INFO - 'SHLVL': '1', 12:17:04 INFO - 'TERM': 'linux', 12:17:04 INFO - 'TMOUT': '86400', 12:17:04 INFO - 'USER': 'cltbld', 12:17:04 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:04 INFO - '_': '/tools/buildbot/bin/python'} 12:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 INFO - Cleaning up... 12:17:04 INFO - Return code: 0 12:17:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:17:04 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')]} 12:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:04 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')]} 12:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:04 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:17:04 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 12:17:04 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 12:17:04 INFO - Using env: {'DISPLAY': ':0', 12:17:04 INFO - 'HOME': '/home/cltbld', 12:17:04 INFO - 'LANG': 'en_US.UTF-8', 12:17:04 INFO - 'LANGUAGE': 'en_US:en', 12:17:04 INFO - 'LOGNAME': 'cltbld', 12:17:04 INFO - 'MAIL': '/var/mail/cltbld', 12:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:04 INFO - 'MOZ_NO_REMOTE': '1', 12:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:04 INFO - 'NO_EM_RESTART': '1', 12:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:04 INFO - 'PWD': '/builds/slave/test', 12:17:04 INFO - 'SHELL': '/bin/bash', 12:17:04 INFO - 'SHLVL': '1', 12:17:04 INFO - 'TERM': 'linux', 12:17:04 INFO - 'TMOUT': '86400', 12:17:04 INFO - 'USER': 'cltbld', 12:17:04 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:04 INFO - '_': '/tools/buildbot/bin/python'} 12:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:05 INFO - Downloading/unpacking jsonschema 12:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:06 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 12:17:06 INFO - Downloading/unpacking functools32 (from jsonschema) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:07 INFO - warning: no files found matching '*.txt' 12:17:07 INFO - no previously-included directories found matching 'build' 12:17:07 INFO - no previously-included directories found matching 'dist' 12:17:07 INFO - no previously-included directories found matching '.git*' 12:17:07 INFO - Installing collected packages: jsonschema, functools32 12:17:07 INFO - Running setup.py install for functools32 12:17:07 INFO - warning: no files found matching '*.txt' 12:17:07 INFO - no previously-included directories found matching 'build' 12:17:07 INFO - no previously-included directories found matching 'dist' 12:17:07 INFO - no previously-included directories found matching '.git*' 12:17:07 INFO - Successfully installed jsonschema functools32 12:17:07 INFO - Cleaning up... 12:17:07 INFO - Return code: 0 12:17:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:07 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 0x7f771a617f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', '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 12:17:07 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 12:17:07 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 12:17:07 INFO - Using env: {'DISPLAY': ':0', 12:17:07 INFO - 'HOME': '/home/cltbld', 12:17:07 INFO - 'LANG': 'en_US.UTF-8', 12:17:07 INFO - 'LANGUAGE': 'en_US:en', 12:17:07 INFO - 'LOGNAME': 'cltbld', 12:17:07 INFO - 'MAIL': '/var/mail/cltbld', 12:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:07 INFO - 'MOZ_NO_REMOTE': '1', 12:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:07 INFO - 'NO_EM_RESTART': '1', 12:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:07 INFO - 'PWD': '/builds/slave/test', 12:17:07 INFO - 'SHELL': '/bin/bash', 12:17:07 INFO - 'SHLVL': '1', 12:17:07 INFO - 'TERM': 'linux', 12:17:07 INFO - 'TMOUT': '86400', 12:17:07 INFO - 'USER': 'cltbld', 12:17:07 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:07 INFO - '_': '/tools/buildbot/bin/python'} 12:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:07 INFO - Downloading/unpacking flake8 12:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:17:09 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 12:17:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:17:09 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 12:17:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:09 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 12:17:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:09 INFO - no previously-included directories found matching 'docs/_build' 12:17:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:17:09 INFO - Running setup.py install for pep8 12:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:09 INFO - no previously-included directories found matching 'docs/_build' 12:17:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:17:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:17:10 INFO - Cleaning up... 12:17:10 INFO - Return code: 0 12:17:10 INFO - Running post-action listener: _resource_record_post_action 12:17:10 INFO - Running post-action listener: _start_resource_monitoring 12:17:10 INFO - Starting resource monitoring. 12:17:10 INFO - ##### 12:17:10 INFO - ##### Running install step. 12:17:10 INFO - ##### 12:17:10 INFO - Running pre-action listener: _resource_record_pre_action 12:17:10 INFO - Running main action method: install 12:17:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:10 INFO - Reading from file tmpfile_stdout 12:17:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:10 INFO - Reading from file tmpfile_stdout 12:17:10 INFO - Output received: 12:17:10 INFO - Usage: mozinstall [options] installer 12:17:10 INFO - Options: 12:17:10 INFO - -h, --help show this help message and exit 12:17:10 INFO - -d DEST, --destination=DEST 12:17:10 INFO - Directory to install application into. [default: 12:17:10 INFO - "/builds/slave/test"] 12:17:10 INFO - --app=APP Application being installed. [default: firefox] 12:17:10 INFO - mkdir: /builds/slave/test/build/application 12:17:10 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'] 12:17:10 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 12:17:24 INFO - Reading from file tmpfile_stdout 12:17:24 INFO - Output received: 12:17:24 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:24 INFO - Running post-action listener: _resource_record_post_action 12:17:24 INFO - ##### 12:17:24 INFO - ##### Running run-tests step. 12:17:24 INFO - ##### 12:17:24 INFO - Running pre-action listener: _resource_record_pre_action 12:17:24 INFO - Running main action method: run_tests 12:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:24 INFO - Python 2.7.3 12:17:24 INFO - Return code: 0 12:17:24 INFO - grabbing minidump binary from tooltool 12:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:24 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 0x1d720b0>, '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 0x1d72fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:24 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 12:17:24 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 12:17:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:25 INFO - Return code: 0 12:17:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:17:25 INFO - Return code: 0 12:17:25 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test/build 12:17:25 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 12:17:25 INFO - Using env: {'DISPLAY': ':0', 12:17:25 INFO - 'HOME': '/home/cltbld', 12:17:25 INFO - 'LANG': 'en_US.UTF-8', 12:17:25 INFO - 'LANGUAGE': 'en_US:en', 12:17:25 INFO - 'LOGNAME': 'cltbld', 12:17:25 INFO - 'MAIL': '/var/mail/cltbld', 12:17:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:25 INFO - 'MOZ_NO_REMOTE': '1', 12:17:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:25 INFO - 'NO_EM_RESTART': '1', 12:17:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:25 INFO - 'PWD': '/builds/slave/test', 12:17:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:25 INFO - 'SHELL': '/bin/bash', 12:17:25 INFO - 'SHLVL': '1', 12:17:25 INFO - 'TERM': 'linux', 12:17:25 INFO - 'TMOUT': '86400', 12:17:25 INFO - 'USER': 'cltbld', 12:17:25 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047', 12:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:25 INFO - '_': '/tools/buildbot/bin/python'} 12:17:25 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 12:17:26 INFO - mozversion INFO | application_buildid: 20151210110357 12:17:26 INFO - mozversion INFO | application_changeset: 11405af50b40d89422127e94db681710a1929b4a 12:17:26 INFO - mozversion INFO | application_display_name: Nightly 12:17:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:26 INFO - mozversion INFO | application_name: Firefox 12:17:26 INFO - mozversion INFO | application_remotingname: firefox 12:17:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:17:26 INFO - mozversion INFO | application_vendor: Mozilla 12:17:26 INFO - mozversion INFO | application_version: 45.0a1 12:17:26 INFO - mozversion INFO | platform_buildid: 20151210110357 12:17:26 INFO - mozversion INFO | platform_changeset: 11405af50b40d89422127e94db681710a1929b4a 12:17:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:17:26 INFO - mozversion INFO | platform_version: 45.0a1 12:17:26 INFO - 2015-12-10 12:17:26,142 DEBUG : using testdate: 1449778646 12:17:26 INFO - 2015-12-10 12:17:26,143 DEBUG : actual date: 1449778646 12:17:26 INFO - 2015-12-10 12:17:26,151 INFO : starting webserver on 'localhost:49761' 12:17:26 INFO - 2015-12-10 12:17:26,151 INFO : Starting test suite talos-linux64-ix-026 12:17:26 INFO - 2015-12-10 12:17:26,151 INFO : Starting test dromaeo_css 12:17:26 INFO - 2015-12-10 12:17:26,151 DEBUG : operating with platform_type : linux_ 12:17:26 INFO - 2015-12-10 12:17:26,152 INFO : Initialising browser for dromaeo_css test... 12:17:26 INFO - 2015-12-10 12:17:26,167 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIto1Un/profile http://localhost:49761/getInfo.html 12:17:30 INFO - 2015-12-10 12:17:30,659 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:17:30 INFO - 2015-12-10 12:17:30,659 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:17:30 INFO - 2015-12-10 12:17:30,659 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:17:30 INFO - 2015-12-10 12:17:30,659 DEBUG : BROWSER_OUTPUT: __metrics 12:17:30 INFO - 2015-12-10 12:17:30,755 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] 12:17:30 INFO - 2015-12-10 12:17:30,816 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:17:31 INFO - 2015-12-10 12:17:31,888 INFO : Browser initialized. 12:17:31 INFO - 2015-12-10 12:17:31,888 INFO : Running cycle 1/1 for dromaeo_css test... 12:17:31 INFO - 2015-12-10 12:17:31,888 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIto1Un/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:43 INFO - 2015-12-10 12:17:43,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 142479360 12:17:43 INFO - 2015-12-10 12:17:43,861 DEBUG : BROWSER_OUTPUT: 12:18:35 INFO - 2015-12-10 12:18:35,140 DEBUG : BROWSER_OUTPUT: 1449778715139 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] 12:20:46 INFO - 2015-12-10 12:20:46,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49761/tests/dromaeo/cssquery-ext.html) 12:20:48 INFO - 2015-12-10 12:20:48,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 264069120 12:20:48 INFO - 2015-12-10 12:20:48,120 DEBUG : BROWSER_OUTPUT: 12:23:50 INFO - 2015-12-10 12:23:50,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/dromaeo/cssquery-ext.html (next: http://localhost:49761/tests/dromaeo/cssquery-jquery.html) 12:23:51 INFO - 2015-12-10 12:23:51,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 225341440 12:23:51 INFO - 2015-12-10 12:23:51,274 DEBUG : BROWSER_OUTPUT: 12:26:53 INFO - 2015-12-10 12:26:53,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49761/tests/dromaeo/cssquery-mootools.html) 12:26:53 INFO - 2015-12-10 12:26:53,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 222277632 12:26:53 INFO - 2015-12-10 12:26:53,902 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-12-10 12:29:55,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49761/tests/dromaeo/cssquery-prototype.html) 12:29:56 INFO - 2015-12-10 12:29:56,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 204128256 12:29:56 INFO - 2015-12-10 12:29:56,395 DEBUG : BROWSER_OUTPUT: 12:32:59 INFO - 2015-12-10 12:32:59,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49761/tests/dromaeo/cssquery-yui.html) 12:32:59 INFO - 2015-12-10 12:32:59,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 206655488 12:32:59 INFO - 2015-12-10 12:32:59,806 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/dromaeo/cssquery-yui.html (next: http://localhost:49761/tests/dromaeo/cssquery-dojo.html) 12:36:02 INFO - 2015-12-10 12:36:02,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 252329984 12:36:02 INFO - 2015-12-10 12:36:02,698 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,699 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:02 INFO - 2015-12-10 12:36:02,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:02 INFO - 2015-12-10 12:36:02,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:02 INFO - 2015-12-10 12:36:02,699 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:02 INFO - 2015-12-10 12:36:02,701 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2611.542979978504;2683.7852971762263;2691.542437785576;2700.675918889735;2714.918552443427;4422.071365013351;4565.33802598623;4625.930611040832;4665.183592871247;4693.624510039202;4607.608353289975;4624.838130665427;4692.13195558821;4704.647151463645;4742.573168414842;4316.503602085769;4325.048489332342;4325.221460137174;4325.372820940962;4362.498312694033;4201.1807697499;4411.492678341983;4413.249747542909;4467.151241264166;4471.843485478009;4180.289350810339;4228.957710422918;4243.830246790125;4273.594008569181;4289.378040184156;4223.345381465878;4237.427947227146;4246.766427846467;4265.680073994463;4308.569143085698;4119.217348703737;4212.936805947913;4214.894627634303;4234.724742891703;4238.576142385737;4438.60052595268;4503.684742068057;4523.525029871849;4540.250858608326;4561.7491037992895;4969.975150124226;5037.823676171353;5050.444451110375;5070.771815268322;5100.056489549445;4831.782569784368;4951.678140920829;5074.5432911037815;5087.313212716273;5105.106606343912;4481.170983368054;4526.185286648402;4539.614132798683;4554.43069616298;4592.954070459253;5142.254373115878;5158.509941555546;5162.793488260502;5188.403333616682;5207.453217412117;4672.509386514435;4792.329073929653;4928.186849169847;4930.309756634074;4931.827386041543;4925.605951523869;4950.158473059589;4964.60283177345;4985.451600324034;5027.069992051409;4958.380202474691;4964.578010869117;4965.0566392385335;4965.131102057126;5011.5489605935645;4695.3426520287185;4874.780634871439;4944.233643785219;4944.777485013183;5000.699958002531;4046.4941882264716;4076.510818701775;4104.91790164195;4127.814248358771;4164;3627.909302267464;3636.1455058061333;3646.85412583499;3665.8350374233223;3684.0421490412687;4120.21715873983;4221.493420789464;4303.591158839905;4308.159908817751;4335.176316499855;4894.363732714795;4914.066327397783;4982.302477653131;4984.77568509418;5017.1721665924715;4269.060806622538;4296.570342965741;4296.677749168824;4338.305871060616;4341.479022517255;4167.645750111214;4311.525732169459;4417.293233082692;4422.7346359218545;4426.336049592523;4683.625309975262;4696.1546921554445;4745.738984355756;4764.4282686077895;4799.9760001199775;5036.84889453317;5052.747362631927;5054.09026375256;5059.949400505948;5109.029284435946;4588.17412865674;4687.32033855096;4779.832705855279;4793.5685788279225;4841.225403935354;4892.437369702529;4909.705417674951;4961.42943561495;4969.403671559436;5022.949770502394;5024.57291130258;5043.36957880265;5045.394552653705;5047.873803154804;5095.363079615048;4661.440627124767;4783.808647654055;4850.490698476609;4872.878178045436;4914.533119353656;4695.929561056519;4798.47216806158;4870.050340183772;4872.512748725099;4900.215965445512;4744.169770290255;4774.618030557616;4784.880377990578;4814.518548145157;4840.685355451885;4855.34452848875;4913.484084171254;4922.704637721748;4939.950600493949;4974.452810190948;4593.701409408378;4665.510121437336;4697.7651117444675;4724.952750472451;4815.638827087912 12:36:02 INFO - 2015-12-10 12:36:02,704 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.1043187514638;577.9133130030498;588.4821357205659;600.2916558461014;600.7386786747765;27031.18906432808;35203.64796352036;35894.641053589454;35897.28205435893;35906.10234744133;38684.419733703944;39071.80464097683;39121.41317880227;39176.64940103596;39194.8040259799;6963.791086267394;7069.964650176742;7916.485428447147;8065.838683226332;8076.798080047987;10043.548040338203;10169.237307201953;10200.591976320939;10233.948830255838;10237;9971.302008859382;10087.747806304864;10089.091981721644;10097.394156350605;10098.798024039515;7197.3882220011365;7382.48322617417;10031.548580313867;10242.6415075472;10508;9899.851502227473;10020.298579099466;10041.246906482043;10045.296829221958;10047.497625118714;36607;37126.62873371286;37130;37145;37162.86812675905;2804.6914839367655;2816.112924428819;2892.117904039267;3511.8410924395143;3628.9818550907075;27545.31136721598;27718.722812771815;27827.582586261222;27913.430074694403;27941;3382.543356646846;3510.596281427643;3544.0962554548423;3546.7871927684423;3655.323765103464;222180;222376;222464;223191;223886;50346.748266259165;54681.45318546764;55073.44926550763;55084;55124.448755511934;45881.311780323325;64644.35355646384;66224.33775662181;66247.66876165588;66305.6684716583;13565.389557469938;13868.375923083284;13870.375833087535;13874.722505549833;13879;8981.685641002534;9165.725028249164;9745.756356091155;9909.306348555676;10193.23550733698;18396.724049139273;18554.907225464056;18711;18758.53103672419;18800.62398752017;7696.461247712718;7837.568933708587;7887.9605601971625;7993.762526176908;7999.240072193133;771.4753967302288;780.2431641307923;856.2978357746713;871.3073106880046;948.5067764762285;26082.73917260841;26441.86779066131;26698;26824;26835;872.3326655108847;888.6854322265438;907.2651152566442;921.7373048681094;925.1488630459993;12295.200811947196;12742.235465871892;13014.609561713163;13222.338883055809;13315.866841331463;317348;322491;322651;322710;322807;46144.3078353825;46266.30600540995;46678.29982550265;46724.29913551299;46739;1166.1487114406361;1166.6441735270655;1174.4597485156753;1176.6528873982195;1177.6996865799338;23764.521161892197;24510.97006347115;24521.386965326008;24620.261392158263;24815;36672.81663591665;37037.25925481529;37224.81387593045;37281;37285.25429491449;242144;242260;242592;243695;301319;24666.630000550365;28092.85953570219;28285;28646.283842904093;28773.712262877103;32387.838060809547;43967.340489892034;45182.32226516539;45629.77185114053;46195;32834.67165328412;33201.169970750925;33369.66630333666;33776.32447351088;33805.32389352249;29924.251893702833;36182;37119.62880371162;37780.43329350117;38925.6107438922;33496.66503335033;33540.49689254614;33716.83141584276;33771;33900.66099338975;29270.41459170847;30169.849150754108;30245.848770756886;30350;30397.632106555702;23459.41351466227;23493.882530587238;23723.644145338178;23827.761722382555;23930.52138957246 12:36:02 INFO - 2015-12-10 12:36:02,704 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.43317875736886;341.1607445683618;343.09080935520876;344.1568158012869;348.71231234231766;12125.636230913087;12433.502659893593;15009.474668386609;15044.172570508617;15715.44995925143;12409.441575129118;14527.20100394478;15399.846001539981;16114.274857631406;16116.516504504854;4881.780319885614;5020.472850350716;6070.6357618543025;6279.748810047616;6287.025511045796;4094.1197642506854;4238.554951730071;6159.291681456622;6184;6364.299927008025;6511.609303441809;6551.050097735825;6578.769743058994;6582.572132811376;6591.110200122994;5960.1953736245705;6618.106555614979;6646.401823835878;6652.334766523358;6654.168228971379;6278.940822106689;6324.494040476751;6378.138951241569;6379.362063793584;6388.073729309271;20438.79561204384;20831;21006.89496552523;21040.684389734168;21290.46773830651;1826.6803309420932;1901.6386886491662;1928.8360489358422;1940.6118776244807;1983.5437849294742;13940;13941.860581394158;14042.157470551698;14269.286535673278;14494.34775435108;1832.431946096701;1837.5222442165;1844.4651051195137;1871.6256748650324;1917.0989634871587;59371.40628593702;62371.37628623701;64315.67842160806;65567.67216163936;66249;14752.262386880613;15462.458813941457;15483.458078967407;15496.380144794082;15511.922440387725;23519;23535.7646423537;23730.762692373202;23741.40646483817;23836;8009.559474228973;8362.749117526484;8371.748847534584;8394.160583941557;8526.190011948855;7013.333733295431;7073.610951397723;7083.681234344467;7085.468589855678;7097.609631470319;7343.3390994810725;7452.4783265172;7476.813079673052;7528.736494222676;7537.266428721425;2306.815454763615;2879.29457282967;2909.3017675757665;2962.7777916655905;2991.7457016153435;793.2900054451234;801.2468279816953;815.7756616930392;820.5651004967377;901.324006994754;13610.659733506543;15167.393304267927;15478.613034674223;15917.283722232527;15943.44197953066;802.803313188261;826.2068414322318;867.6919693508839;872.6247713483264;874.1782724239195;8635.525046122399;8784.121587841293;9082.682106126385;9201.861972070425;9444.8583271251;532065;539176;540144;540603;548527;68568.6571567139;70668.64665676742;70912;71692;72142.9178562322;1049.7375656085978;1049.8477720730452;1050.3487837540622;1073.0717928991521;1075.1076606416655;14650.120992740469;14677.41290348374;14780.778288325899;14957.326920288395;15123.697526049638;32801.83599081989;32880.1779955503;32882.34235315328;33438.66561334355;33708;41348.58651413448;42088.158236835705;43703;44123;44899.326510101724;9048.592813323285;9166.312526560669;9171.862422063808;9282.303827213122;9315.767105822408;15645.921770391074;15886.285117169986;16029.519114426586;16487.505374838773;16488.752668710218;13609.455621775018;13726.313684315945;13766.294296438451;14522.273886305853;14749.705005900036;10186.694399168036;12263.816042759187;14075.648108796953;14354.066985646317;14548.563543093724;12629.68425789326;13992.09051411655;14031.158130512202;14333.56999290023;14554.690077892617;8617.655293788179;8717.738467845975;8725.825483490422;8939.418937769024;9233.815323693623;9772.511374431107;12667.429965651752;14087.506937257147;14455.566333010027;14472.34874430632 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1242.9751404971908;1636.4763275751757;1676.857467115295;1706.7695861058753;1712.1695977450934;5880.911786323203;6686.665666716663;6783.3555812197765;6818.454523638109;6821.976703494478;6893.965530172355;7122.821929451753;7124.073870396841;7124.750633727821;7128.073350464445;2013.9194432222694;2074.5954538864926;2077.106844057055;2077.27295446594;2077.8441616878717;2073.8963051847345;2112.1445814445096;2119.5654890747437;2137.187868609926;2139.3902737719754;1975.8122978317108;2032.410600925737;2056.794320567946;2059.454244625168;2060.577581595769;2080.9491206940475;2104.042660589428;2107.430993631711;2108.251570692405;2112.6302896992966;2023.423324352567;2056.5475595368994;2058;2058.742657167854;2078.4076538186696;6968.268331825136;6979.4765392595755;7039.894401583981;7043.049188359557;7062.823429414254;4064.43097966282;4149.771762553059;4159.91680166395;4175.123224122938;4177.49870015597;2608.5174242765147;2613.9346516337055;2657.8803953822126;2675;2684.221575743032;841.47828346425;851.8849955256085;852.1435956863313;864.8097418567905;865.5196366016858;9410.482423466707;9431.858522122173;9447.385919915252;9454.05459454056;9478.715638530855;3723.1250656095795;3744.5319335083113;3791.1280405506886;3897.5322961244833;3898.317794385971;8123.512589244664;8189.549574773445;8201.015878094668;8206.22040906113;8209.507429554245;4136.627703506699;4154.044569748975;4167.458230430086;4169.478815148106;4175.519815221228;3263.2983908459796;3345.882894098695;3783.810809459516;3815.6756675682877;3817.3892177251505;3482.407990641597;3494.6155922848466;3507.9649203508147;3508.614052454279;3534.6111927687934;1121.8934201250868;1123.955041798319;1144.0847322142254;1144.6394385768456;1151.8445009923553;785.1128225105595;800.1838125112469;896.7937374403924;949.7815502434479;1108.4568561405015;6655.800325990228;6741.561798483083;6749.0888730020815;6751.93248067513;6764.661766911635;998.4658207858906;1010.9898901010896;1014.7970405918845;1021.6373187518473;1028.7942411517727;5088.363954505687;5172.508611681884;5183.455737147545;5188.299579556787;5195.272661827347;8098.7165449209;8201.384896132813;8392;8434.198751118634;8573.699920502753;8371.748847534584;8393.706220282262;8412.074671786098;8477.74566762998;8480.15198480147;6564.7374105036215;6677.3656502632175;6704.631245281459;6704.765333213314;6715.664216789141;6383.202099737533;6443.774467893789;6453.096566480603;6458.418742313214;6461.418472337512;7444.255574442513;7607.353374962969;7618.961905190438;7622.733204338044;7673;7629.427792915442;7795.844083118192;7803.02462192226;7810.062792464713;7818.687252509836;6226.937730622817;6294.590851594632;6294.8111556653375;6298.937010629835;6306.180196574416;6487.675616219076;6727.327267273429;6740.0226967090475;6832.282610325844;6880.174379074543;6341.556091073765;6396.9040464394;6440.935590644033;6471.611703297817;6566.9014964774615;5478.698671573102;5855.3266374367495;6017.699115044143;6019.367966363468;6026.246719160105;6336.841578960563;6385.553011289165;6398.0402939559435;6424.229092508929;6424.38968298011;5813.331466881363;5814.5348372130975;5855;5866.266716660418;5875.20684707559;5875.970620146872;5876.647401155944;5878.353381127987;5883.794067207627;5899.144624029577 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.80279015849544;307.19668068002164;313.830531512983;317.43655012353054;320.6040539933182;5217.34783152106;5261.684298942067;5324.361076670795;5326.520613144816;5326.946730532698;5248.5276325130735;5260.579153667707;5264.263003179558;5269.604779641532;5291.947080529194;3931.4889064421727;4065.3901914712733;4160.1471698301775;4160.355144952538;4163.104932439525;4025.1949610077954;4160;4173.916521669565;4175.144095460439;4179.519355274137;4118.135191609766;4128.525219599739;4130.793460326987;4134.462519872427;4135.234981528427;3889.1638297765835;3994.141259629165;4026.355783074723;4125.381192821071;4132.566080561528;3651.7626354286886;3657.7073834093208;3659;3666.1018050577513;3670.06413364593;5049.84850454487;5075.467075957008;5095.261187127883;5098.719570423626;5115.104856650071;4690.343351930733;4736.7631618418945;4740.07568524138;4749.525047495257;4750.976245118787;5407.810726624589;5568.1647752837;5588.524975377098;5605.327360716699;5606.159076138571;3901.258760835432;3902.453656488094;3904.8047597620007;3905.023744063984;3905.886822255672;5775.653460792366;5844.970775146139;5859.121131830217;5859.882802343972;5866;3996.980015099964;3997.2804895118575;3997.620226078518;4000.6199411055904;4002.7598344099447;3835.5780864104927;3880.767153970771;3963.900902477461;4058.1072164123843;4061.1674606706147;4529.660275479352;4663.51033141522;4664.067186562701;4672.462666793363;4673.719576825333;5598.10430331145;5603.2435621191435;5610.579206559524;5612.186232996274;5619.072852979212;1418.2199790115396;1433.899627026119;1435.9138451692932;1436.0522055443566;1436.1311406599066;967.9951600241953;972.0619602084023;975.6048800235916;995.5719040812376;998.9550470228858;4888.975555122272;4904.5340692634145;4905.558499735041;4906.632002599819;4910.9932463844825;5791.131330300404;5792.855178620568;5794.913076303858;5796.5072968797285;5797.768089276382;4893;4895.975520122377;4903.092927808367;4903.8528844134735;4905.3132561441425;3026.6821983691834;3084.426942259464;3118.875244990175;3122.953155702666;3124.7500199983947;5482.862928426742;5541.33503979525;5547.195656629766;5549.916751248735;5553.639013464192;6017.69911504423;6023.45788879003;6025.126356678257;6030.728617212236;6031.819045428644;5475.917861232085;5513.338399392099;5528.778848846001;5530.889382212253;5536.529395001389;5674.4892959633835;5853.326867410302;5853.385394533512;5854.151148083419;5863.149843272617;5718.571107166896;5721.542276617944;5721.599488035798;5725.770969161187;5730.598858079894;5518.089515229942;5519.668819870821;5523.7790488380015;5526.696031718294;5530;3948.723589348833;3993.221321842213;4035.91928161441;4039.0104424416204;4043.0498832773687;5574.386817450159;5705.942940570707;5823.126531020212;5823.7379317929945;5842.561807864512;5490.752916118704;5602.915956260578;5607.07483265273;5640.520555752807;5644.407337229696;5603.187537807076;5616.6068375213345;5620.269364982526;5622.072358060874;5623.381428042994;5364.624476286623;5504.4495550444635;5507.394186639386;5508.9724551376985;5515.034868898007;5653.689047102449;5664.546836253007;5666.206731057738;5667.121596152603;5673.546116310603;5519.862003449785;5527.640703354269;5527.640703354269;5530.751116199861;5531.308586426697 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: |5;yui.html;652.2922628947595;688.6074937285746;728.3044692318834;782.9843403131938;817.1093508076195;11916.463759130838;12214.145009849313;12219.083568732336;12225.449854756534;12246.632601021962;11540.653780386601;11637.883621163806;11692.24000439973;11720.941395293034;11741.647750567476;633.3697970519339;641.0288413054227;801.6032064128265;811.3590263691676;830.0620299062051;802.1497212954258;804.7666176808748;806.753940048285;814.6049166154411;814.9837003259931;847.9194476524751;854.4189950833431;855.5850412549939;856.092541905579;856.6102423397339;659.2616269777856;668.0547025958288;845.247729520727;863.8272345530919;864.5590748718199;620.0698951572641;624.9437550620421;626.8652239768426;627.244170774216;627.704978660029;11689.298642081503;11767.94116029423;11843;11855.229410088403;11880.168388212829;10709.678709638723;11357.261777984404;11494.885051149466;11575.189736718434;11614.825777613343;8917.643294268222;9048;9146;9167.633294668205;9392.48341341226;3152.4734449133402;3200.9519857202163;3226.6289376721506;3233;3252.6259480159847;39057.21885562301;39115.60884391148;39186.21627567461;39302;39432.01419964495;8942.284617230605;9163;9388.577514011886;9554.761130971643;9704.563294651758;16167.029978201346;16251.674966500605;16265.59336016609;16272.918635406748;16286.348546058025;5917.970410147922;6048.758049678052;6130.693465326716;6268.655223962634;6453.709583068773;3371.7976921384798;3478.3738926993383;3504.2115524007404;3551;3560.416313252755;2544.0841297133015;2578.316746062295;2588.0424243029825;2590.2747230775412;2598.9480210395686;481.40546425164894;486.99756501217973;487.07455833915844;489.3491656097382;490.3968119213387;392.28408155117023;444.4022789348321;463.48553106052253;511.5805039867273;517.3558919145688;6976.965115174392;7055.400290975222;7252.818679533054;7280.526765760314;8253.174682531699;430.16762564437914;444.06967403290054;462.66225655271165;467.63758087481796;510.2881480334912;3248.8538015789345;3422.863085476603;3467.479878018267;3548.1661809474754;3587.318409502186;47126.528734712214;48159.75920120377;48402;48548;48561.5143848557;41711.582884171374;42646.36030459546;43533.782331088776;44068.55931440709;44137.33793993093;40263.79868100641;40440;40718;40960;41118;7386.15059268191;7613.809654758676;7657.34912532441;7674.577898215652;7893.644785984759;31349.8432507836;31379.05862824119;31519.684803151675;31932.6806731939;32247;36765.81617092004;39811.80094099511;40662.59337406588;40949;41037.1792564153;10034.397936123856;10092.192624590161;10105.696829095139;10114.825820131078;10181.389116653025;10901.34591924487;11429;11522;11527.07783377311;11548.249363791327;9556.808863822824;9570.234381249622;9628;10556.736081598021;10622.681319560426;10364.740881478023;10435.843462347919;10583.788324233627;10767.784644306914;10775.191860610643;9553.474558899326;9930.106290433896;9994.500274986367;10084.69745907624;10138;8261.752147435345;8600.698975535826;8622.655093796178;8837.248833848938;9156.404833685789;8644.394892357475;9090.318226133199;9117.133872282388;9150.359474836698;9234 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1052 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: __startTimestamp1449779762698__endTimestamp 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:36:02 INFO - 2015-12-10 12:36:02,708 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,709 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4593.06 Median:4696.15 stddev:488.42 (10.4%) stddev-sans-first:464.52 12:36:02 INFO - 2015-12-10 12:36:02,709 DEBUG : BROWSER_OUTPUT: Values: 2611.5 2683.8 2691.5 2700.7 2714.9 4422.1 4565.3 4625.9 4665.2 4693.6 4607.6 4624.8 4692.1 4704.6 4742.6 4316.5 4325.0 4325.2 4325.4 4362.5 4201.2 4411.5 4413.2 4467.2 4471.8 4180.3 4229.0 4243.8 4273.6 4289.4 4223.3 4237.4 4246.8 4265.7 4308.6 4119.2 4212.9 4214.9 4234.7 4238.6 4438.6 4503.7 4523.5 4540.3 4561.7 4970.0 5037.8 5050.4 5070.8 5100.1 4831.8 4951.7 5074.5 5087.3 5105.1 4481.2 4526.2 4539.6 4554.4 4593.0 5142.3 5158.5 5162.8 5188.4 5207.5 4672.5 4792.3 4928.2 4930.3 4931.8 4925.6 4950.2 4964.6 4985.5 5027.1 4958.4 4964.6 4965.1 4965.1 5011.5 4695.3 4874.8 4944.2 4944.8 5000.7 4046.5 4076.5 4104.9 4127.8 4164.0 3627.9 3636.1 3646.9 3665.8 3684.0 4120.2 4221.5 4303.6 4308.2 4335.2 4894.4 4914.1 4982.3 4984.8 5017.2 4269.1 4296.6 4296.7 4338.3 4341.5 4167.6 4311.5 4417.3 4422.7 4426.3 4683.6 4696.2 4745.7 4764.4 4800.0 5036.8 5052.7 5054.1 5059.9 5109.0 4588.2 4687.3 4779.8 4793.6 4841.2 4892.4 4909.7 4961.4 4969.4 5022.9 5024.6 5043.4 5045.4 5047.9 5095.4 4661.4 4783.8 4850.5 4872.9 4914.5 4695.9 4798.5 4870.1 4872.5 4900.2 4744.2 4774.6 4784.9 4814.5 4840.7 4855.3 4913.5 4922.7 4940.0 4974.5 4593.7 4665.5 4697.8 4725.0 4815.6 12:36:02 INFO - 2015-12-10 12:36:02,709 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,709 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42622.63 Median:33433.17 stddev:70596.13 (211.2%) stddev-sans-first:70723.51 12:36:02 INFO - 2015-12-10 12:36:02,710 DEBUG : BROWSER_OUTPUT: Values: 555.1 577.9 588.5 600.3 600.7 27031.2 35203.6 35894.6 35897.3 35906.1 38684.4 39071.8 39121.4 39176.6 39194.8 6963.8 7070.0 7916.5 8065.8 8076.8 10043.5 10169.2 10200.6 10233.9 10237.0 9971.3 10087.7 10089.1 10097.4 10098.8 7197.4 7382.5 10031.5 10242.6 10508.0 9899.9 10020.3 10041.2 10045.3 10047.5 36607.0 37126.6 37130.0 37145.0 37162.9 2804.7 2816.1 2892.1 3511.8 3629.0 27545.3 27718.7 27827.6 27913.4 27941.0 3382.5 3510.6 3544.1 3546.8 3655.3 222180.0 222376.0 222464.0 223191.0 223886.0 50346.7 54681.5 55073.4 55084.0 55124.4 45881.3 64644.4 66224.3 66247.7 66305.7 13565.4 13868.4 13870.4 13874.7 13879.0 8981.7 9165.7 9745.8 9909.3 10193.2 18396.7 18554.9 18711.0 18758.5 18800.6 7696.5 7837.6 7888.0 7993.8 7999.2 771.5 780.2 856.3 871.3 948.5 26082.7 26441.9 26698.0 26824.0 26835.0 872.3 888.7 907.3 921.7 925.1 12295.2 12742.2 13014.6 13222.3 13315.9 317348.0 322491.0 322651.0 322710.0 322807.0 46144.3 46266.3 46678.3 46724.3 46739.0 1166.1 1166.6 1174.5 1176.7 1177.7 23764.5 24511.0 24521.4 24620.3 24815.0 36672.8 37037.3 37224.8 37281.0 37285.3 242144.0 242260.0 242592.0 243695.0 301319.0 24666.6 28092.9 28285.0 28646.3 28773.7 32387.8 43967.3 45182.3 45629.8 46195.0 32834.7 33201.2 33369.7 33776.3 33805.3 29924.3 36182.0 37119.6 37780.4 38925.6 33496.7 33540.5 33716.8 33771.0 33900.7 29270.4 30169.8 30245.8 30350.0 30397.6 23459.4 23493.9 23723.6 23827.8 23930.5 12:36:02 INFO - 2015-12-10 12:36:02,710 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,710 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29010.43 Median:342.13 stddev:88027.62 (25729.6%) stddev-sans-first:88248.24 12:36:02 INFO - 2015-12-10 12:36:02,710 DEBUG : BROWSER_OUTPUT: Values: 340.4 341.2 343.1 344.2 348.7 12125.6 12433.5 15009.5 15044.2 15715.4 12409.4 14527.2 15399.8 16114.3 16116.5 4881.8 5020.5 6070.6 6279.7 6287.0 4094.1 4238.6 6159.3 6184.0 6364.3 6511.6 6551.1 6578.8 6582.6 6591.1 5960.2 6618.1 6646.4 6652.3 6654.2 6278.9 6324.5 6378.1 6379.4 6388.1 20438.8 20831.0 21006.9 21040.7 21290.5 1826.7 1901.6 1928.8 1940.6 1983.5 13940.0 13941.9 14042.2 14269.3 14494.3 1832.4 1837.5 1844.5 1871.6 1917.1 59371.4 62371.4 64315.7 65567.7 66249.0 14752.3 15462.5 15483.5 15496.4 15511.9 23519.0 23535.8 23730.8 23741.4 23836.0 8009.6 8362.7 8371.7 8394.2 8526.2 7013.3 7073.6 7083.7 7085.5 7097.6 7343.3 7452.5 7476.8 7528.7 7537.3 2306.8 2879.3 2909.3 2962.8 2991.7 793.3 801.2 815.8 820.6 901.3 13610.7 15167.4 15478.6 15917.3 15943.4 802.8 826.2 867.7 872.6 874.2 8635.5 8784.1 9082.7 9201.9 9444.9 532065.0 539176.0 540144.0 540603.0 548527.0 68568.7 70668.6 70912.0 71692.0 72142.9 1049.7 1049.8 1050.3 1073.1 1075.1 14650.1 14677.4 14780.8 14957.3 15123.7 32801.8 32880.2 32882.3 33438.7 33708.0 41348.6 42088.2 43703.0 44123.0 44899.3 9048.6 9166.3 9171.9 9282.3 9315.8 15645.9 15886.3 16029.5 16487.5 16488.8 13609.5 13726.3 13766.3 14522.3 14749.7 10186.7 12263.8 14075.6 14354.1 14548.6 12629.7 13992.1 14031.2 14333.6 14554.7 8617.7 8717.7 8725.8 8939.4 9233.8 9772.5 12667.4 14087.5 14455.6 14472.3 12:36:02 INFO - 2015-12-10 12:36:02,710 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,711 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4908.15 Median:6126.59 stddev:2527.77 (41.3%) stddev-sans-first:2519.84 12:36:02 INFO - 2015-12-10 12:36:02,711 DEBUG : BROWSER_OUTPUT: Values: 1243.0 1636.5 1676.9 1706.8 1712.2 5880.9 6686.7 6783.4 6818.5 6822.0 6894.0 7122.8 7124.1 7124.8 7128.1 2013.9 2074.6 2077.1 2077.3 2077.8 2073.9 2112.1 2119.6 2137.2 2139.4 1975.8 2032.4 2056.8 2059.5 2060.6 2080.9 2104.0 2107.4 2108.3 2112.6 2023.4 2056.5 2058.0 2058.7 2078.4 6968.3 6979.5 7039.9 7043.0 7062.8 4064.4 4149.8 4159.9 4175.1 4177.5 2608.5 2613.9 2657.9 2675.0 2684.2 841.5 851.9 852.1 864.8 865.5 9410.5 9431.9 9447.4 9454.1 9478.7 3723.1 3744.5 3791.1 3897.5 3898.3 8123.5 8189.5 8201.0 8206.2 8209.5 4136.6 4154.0 4167.5 4169.5 4175.5 3263.3 3345.9 3783.8 3815.7 3817.4 3482.4 3494.6 3508.0 3508.6 3534.6 1121.9 1124.0 1144.1 1144.6 1151.8 785.1 800.2 896.8 949.8 1108.5 6655.8 6741.6 6749.1 6751.9 6764.7 998.5 1011.0 1014.8 1021.6 1028.8 5088.4 5172.5 5183.5 5188.3 5195.3 8098.7 8201.4 8392.0 8434.2 8573.7 8371.7 8393.7 8412.1 8477.7 8480.2 6564.7 6677.4 6704.6 6704.8 6715.7 6383.2 6443.8 6453.1 6458.4 6461.4 7444.3 7607.4 7619.0 7622.7 7673.0 7629.4 7795.8 7803.0 7810.1 7818.7 6226.9 6294.6 6294.8 6298.9 6306.2 6487.7 6727.3 6740.0 6832.3 6880.2 6341.6 6396.9 6440.9 6471.6 6566.9 5478.7 5855.3 6017.7 6019.4 6026.2 6336.8 6385.6 6398.0 6424.2 6424.4 5813.3 5814.5 5855.0 5866.3 5875.2 5876.0 5876.6 5878.4 5883.8 5899.1 12:36:02 INFO - 2015-12-10 12:36:02,711 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,711 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4643.53 Median:5280.78 stddev:1368.11 (25.9%) stddev-sans-first:1332.51 12:36:02 INFO - 2015-12-10 12:36:02,712 DEBUG : BROWSER_OUTPUT: Values: 298.8 307.2 313.8 317.4 320.6 5217.3 5261.7 5324.4 5326.5 5326.9 5248.5 5260.6 5264.3 5269.6 5291.9 3931.5 4065.4 4160.1 4160.4 4163.1 4025.2 4160.0 4173.9 4175.1 4179.5 4118.1 4128.5 4130.8 4134.5 4135.2 3889.2 3994.1 4026.4 4125.4 4132.6 3651.8 3657.7 3659.0 3666.1 3670.1 5049.8 5075.5 5095.3 5098.7 5115.1 4690.3 4736.8 4740.1 4749.5 4751.0 5407.8 5568.2 5588.5 5605.3 5606.2 3901.3 3902.5 3904.8 3905.0 3905.9 5775.7 5845.0 5859.1 5859.9 5866.0 3997.0 3997.3 3997.6 4000.6 4002.8 3835.6 3880.8 3963.9 4058.1 4061.2 4529.7 4663.5 4664.1 4672.5 4673.7 5598.1 5603.2 5610.6 5612.2 5619.1 1418.2 1433.9 1435.9 1436.1 1436.1 968.0 972.1 975.6 995.6 999.0 4889.0 4904.5 4905.6 4906.6 4911.0 5791.1 5792.9 5794.9 5796.5 5797.8 4893.0 4896.0 4903.1 4903.9 4905.3 3026.7 3084.4 3118.9 3123.0 3124.8 5482.9 5541.3 5547.2 5549.9 5553.6 6017.7 6023.5 6025.1 6030.7 6031.8 5475.9 5513.3 5528.8 5530.9 5536.5 5674.5 5853.3 5853.4 5854.2 5863.1 5718.6 5721.5 5721.6 5725.8 5730.6 5518.1 5519.7 5523.8 5526.7 5530.0 3948.7 3993.2 4035.9 4039.0 4043.0 5574.4 5705.9 5823.1 5823.7 5842.6 5490.8 5602.9 5607.1 5640.5 5644.4 5603.2 5616.6 5620.3 5622.1 5623.4 5364.6 5504.4 5507.4 5509.0 5515.0 5653.7 5664.5 5666.2 5667.1 5673.5 5519.9 5527.6 5527.6 5530.8 5531.3 12:36:02 INFO - 2015-12-10 12:36:02,712 DEBUG : BROWSER_OUTPUT: 12:36:02 INFO - 2015-12-10 12:36:02,712 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12060.36 Median:22290.70 stddev:13603.69 (61.0%) stddev-sans-first:13614.87 12:36:02 INFO - 2015-12-10 12:36:02,712 DEBUG : BROWSER_OUTPUT: Values: 652.3 688.6 728.3 783.0 817.1 11916.5 12214.1 12219.1 12225.4 12246.6 11540.7 11637.9 11692.2 11720.9 11741.6 633.4 641.0 801.6 811.4 830.1 802.1 804.8 806.8 814.6 815.0 847.9 854.4 855.6 856.1 856.6 659.3 668.1 845.2 863.8 864.6 620.1 624.9 626.9 627.2 627.7 11689.3 11767.9 11843.0 11855.2 11880.2 10709.7 11357.3 11494.9 11575.2 11614.8 8917.6 9048.0 9146.0 9167.6 9392.5 3152.5 3201.0 3226.6 3233.0 3252.6 39057.2 39115.6 39186.2 39302.0 39432.0 8942.3 9163.0 9388.6 9554.8 9704.6 16167.0 16251.7 16265.6 16272.9 16286.3 5918.0 6048.8 6130.7 6268.7 6453.7 3371.8 3478.4 3504.2 3551.0 3560.4 2544.1 2578.3 2588.0 2590.3 2598.9 481.4 487.0 487.1 489.3 490.4 392.3 444.4 463.5 511.6 517.4 6977.0 7055.4 7252.8 7280.5 8253.2 430.2 444.1 462.7 467.6 510.3 3248.9 3422.9 3467.5 3548.2 3587.3 47126.5 48159.8 48402.0 48548.0 48561.5 41711.6 42646.4 43533.8 44068.6 44137.3 40263.8 40440.0 40718.0 40960.0 41118.0 7386.2 7613.8 7657.3 7674.6 7893.6 31349.8 31379.1 31519.7 31932.7 32247.0 36765.8 39811.8 40662.6 40949.0 41037.2 10034.4 10092.2 10105.7 10114.8 10181.4 10901.3 11429.0 11522.0 11527.1 11548.2 9556.8 9570.2 9628.0 10556.7 10622.7 10364.7 10435.8 10583.8 10767.8 10775.2 9553.5 9930.1 9994.5 10084.7 10138.0 8261.8 8600.7 8622.7 8837.2 9156.4 8644.4 9090.3 9117.1 9150.4 9234.0 12:36:02 INFO - 2015-12-10 12:36:02,712 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:02 INFO - 2015-12-10 12:36:02,712 DEBUG : BROWSER_OUTPUT: 12:36:03 INFO - 2015-12-10 12:36:03,457 INFO : Browser exited with error code: 0 12:36:03 INFO - 2015-12-10 12:36:03,479 INFO : Completed test dromaeo_css (00:18:37) 12:36:03 INFO - 2015-12-10 12:36:03,479 INFO : Starting test kraken 12:36:03 INFO - 2015-12-10 12:36:03,479 DEBUG : operating with platform_type : linux_ 12:36:03 INFO - 2015-12-10 12:36:03,479 INFO : Initialising browser for kraken test... 12:36:03 INFO - 2015-12-10 12:36:03,485 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIGIH0L/profile http://localhost:49761/getInfo.html 12:36:07 INFO - 2015-12-10 12:36:07,639 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:07 INFO - 2015-12-10 12:36:07,639 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:07 INFO - 2015-12-10 12:36:07,639 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:07 INFO - 2015-12-10 12:36:07,639 DEBUG : BROWSER_OUTPUT: __metrics 12:36:07 INFO - 2015-12-10 12:36:07,781 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] 12:36:07 INFO - 2015-12-10 12:36:07,837 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:08 INFO - 2015-12-10 12:36:08,955 INFO : Browser initialized. 12:36:08 INFO - 2015-12-10 12:36:08,955 INFO : Running cycle 1/1 for kraken test... 12:36:08 INFO - 2015-12-10 12:36:08,955 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIGIH0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:21 INFO - 2015-12-10 12:36:21,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 142155776 12:36:21 INFO - 2015-12-10 12:36:21,043 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-12-10 12:36:23,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49761/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:24 INFO - 2015-12-10 12:36:24,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 178315264 12:36:24 INFO - 2015-12-10 12:36:24,225 DEBUG : BROWSER_OUTPUT: 12:36:27 INFO - 2015-12-10 12:36:27,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49761/tests/kraken/driver.html?testName=audio-dft) 12:36:27 INFO - 2015-12-10 12:36:27,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 168558592 12:36:27 INFO - 2015-12-10 12:36:27,576 DEBUG : BROWSER_OUTPUT: 12:36:30 INFO - 2015-12-10 12:36:30,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49761/tests/kraken/driver.html?testName=audio-fft) 12:36:31 INFO - 2015-12-10 12:36:31,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 153112576 12:36:31 INFO - 2015-12-10 12:36:31,137 DEBUG : BROWSER_OUTPUT: 12:36:33 INFO - 2015-12-10 12:36:33,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49761/tests/kraken/driver.html?testName=audio-oscillator) 12:36:33 INFO - 2015-12-10 12:36:33,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 155652096 12:36:33 INFO - 2015-12-10 12:36:33,750 DEBUG : BROWSER_OUTPUT: 12:36:36 INFO - 2015-12-10 12:36:36,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:36:36 INFO - 2015-12-10 12:36:36,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 158224384 12:36:36 INFO - 2015-12-10 12:36:36,597 DEBUG : BROWSER_OUTPUT: 12:36:39 INFO - 2015-12-10 12:36:39,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49761/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:40 INFO - 2015-12-10 12:36:40,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 158568448 12:36:40 INFO - 2015-12-10 12:36:40,175 DEBUG : BROWSER_OUTPUT: 12:36:43 INFO - 2015-12-10 12:36:43,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49761/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:44 INFO - 2015-12-10 12:36:44,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 159625216 12:36:44 INFO - 2015-12-10 12:36:44,126 DEBUG : BROWSER_OUTPUT: 12:36:46 INFO - 2015-12-10 12:36:46,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49761/tests/kraken/driver.html?testName=json-parse-financial) 12:36:47 INFO - 2015-12-10 12:36:47,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 159424512 12:36:47 INFO - 2015-12-10 12:36:47,530 DEBUG : BROWSER_OUTPUT: 12:36:49 INFO - 2015-12-10 12:36:49,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:49 INFO - 2015-12-10 12:36:49,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 167424000 12:36:49 INFO - 2015-12-10 12:36:49,875 DEBUG : BROWSER_OUTPUT: 12:36:51 INFO - 2015-12-10 12:36:51,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:52 INFO - 2015-12-10 12:36:52,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 165564416 12:36:52 INFO - 2015-12-10 12:36:52,351 DEBUG : BROWSER_OUTPUT: 12:36:54 INFO - 2015-12-10 12:36:54,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:55 INFO - 2015-12-10 12:36:55,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 178102272 12:36:55 INFO - 2015-12-10 12:36:55,074 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-12-10 12:36:57,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:58 INFO - 2015-12-10 12:36:58,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 185929728 12:36:58 INFO - 2015-12-10 12:36:58,232 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-12-10 12:37:00,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:01 INFO - 2015-12-10 12:37:01,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 181547008 12:37:01 INFO - 2015-12-10 12:37:01,393 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49761/tests/kraken/driver.html?testName=ai-astar) 12:37:03 INFO - 2015-12-10 12:37:03,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 239955968 12:37:03 INFO - 2015-12-10 12:37:03,406 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,406 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:03 INFO - 2015-12-10 12:37:03,406 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;111;112;111;102;112;110;119 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;167;167;132;160;157;132;166;131 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;162;162;161;163;162;164;163 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;82;96;71;77;71;89;86;72 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;139;95;94;95;138;94;95;128 12:37:03 INFO - 2015-12-10 12:37:03,407 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;110;109;109;109 12:37:03 INFO - 2015-12-10 12:37:03,408 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;146;146;146;146;146;146 12:37:03 INFO - 2015-12-10 12:37:03,408 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;96;95;95;96;95 12:37:03 INFO - 2015-12-10 12:37:03,408 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;70;72;71;71;71;83;68;69 12:37:03 INFO - 2015-12-10 12:37:03,408 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;68;68;68;68;68;69;68 12:37:03 INFO - 2015-12-10 12:37:03,408 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;85;90;88;83;82;87;84;83 12:37:03 INFO - 2015-12-10 12:37:03,408 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;125;137;128;126;120;125;119;127;130 12:37:03 INFO - 2015-12-10 12:37:03,408 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;135;145;145;145;135;156;147;146;141 12:37:03 INFO - 2015-12-10 12:37:03,409 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;69;71;68;69;69;70;69;68 12:37:03 INFO - 2015-12-10 12:37:03,409 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:03 INFO - 2015-12-10 12:37:03,409 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:37:03 INFO - 2015-12-10 12:37:03,409 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 12:37:03 INFO - 2015-12-10 12:37:03,409 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:37:03 INFO - 2015-12-10 12:37:03,409 DEBUG : BROWSER_OUTPUT: __startTimestamp1449779823401__endTimestamp 12:37:03 INFO - 2015-12-10 12:37:03,409 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,411 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:03 INFO - 2015-12-10 12:37:03,411 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:37:03 INFO - 2015-12-10 12:37:03,411 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,411 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:4.52 (4.1%) stddev-sans-first:4.77 12:37:03 INFO - 2015-12-10 12:37:03,411 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 111.0 112.0 111.0 102.0 112.0 110.0 119.0 12:37:03 INFO - 2015-12-10 12:37:03,412 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,412 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:158.50 stddev:16.42 (10.4%) stddev-sans-first:17.27 12:37:03 INFO - 2015-12-10 12:37:03,412 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 167.0 167.0 132.0 160.0 157.0 132.0 166.0 131.0 12:37:03 INFO - 2015-12-10 12:37:03,412 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,412 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 162.0 162.0 161.0 163.0 162.0 164.0 163.0 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:79.50 stddev:8.75 (11.0%) stddev-sans-first:9.08 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 82.0 96.0 71.0 77.0 71.0 89.0 86.0 72.0 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:95.00 stddev:19.61 (20.6%) stddev-sans-first:20.32 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 139.0 95.0 94.0 95.0 138.0 94.0 95.0 128.0 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,413 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:71.00 stddev:4.13 (5.8%) stddev-sans-first:4.37 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 72.0 71.0 71.0 71.0 83.0 68.0 69.0 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 12:37:03 INFO - 2015-12-10 12:37:03,414 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.83 (3.3%) stddev-sans-first:2.67 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 85.0 90.0 88.0 83.0 82.0 87.0 84.0 83.0 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:126.50 stddev:5.42 (4.3%) stddev-sans-first:5.34 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: Values: 120.0 125.0 137.0 128.0 126.0 120.0 125.0 119.0 127.0 130.0 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,415 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:145.00 stddev:6.19 (4.3%) stddev-sans-first:6.43 12:37:03 INFO - 2015-12-10 12:37:03,416 DEBUG : BROWSER_OUTPUT: Values: 140.0 135.0 145.0 145.0 145.0 135.0 156.0 147.0 146.0 141.0 12:37:03 INFO - 2015-12-10 12:37:03,417 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-10 12:37:03,417 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 12:37:03 INFO - 2015-12-10 12:37:03,417 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 69.0 71.0 68.0 69.0 69.0 70.0 69.0 68.0 12:37:03 INFO - 2015-12-10 12:37:03,417 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:03 INFO - 2015-12-10 12:37:03,417 DEBUG : BROWSER_OUTPUT: 12:37:04 INFO - 2015-12-10 12:37:04,369 INFO : Browser exited with error code: 0 12:37:04 INFO - 2015-12-10 12:37:04,426 INFO : Completed test kraken (00:01:00) 12:37:04 INFO - 2015-12-10 12:37:04,426 INFO : Starting test v8_7 12:37:04 INFO - 2015-12-10 12:37:04,426 DEBUG : operating with platform_type : linux_ 12:37:04 INFO - 2015-12-10 12:37:04,426 INFO : Initialising browser for v8_7 test... 12:37:04 INFO - 2015-12-10 12:37:04,432 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzWFzmq/profile http://localhost:49761/getInfo.html 12:37:08 INFO - 2015-12-10 12:37:08,996 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:37:08 INFO - 2015-12-10 12:37:08,996 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:37:08 INFO - 2015-12-10 12:37:08,997 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:37:08 INFO - 2015-12-10 12:37:08,997 DEBUG : BROWSER_OUTPUT: __metrics 12:37:09 INFO - 2015-12-10 12:37:09,113 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] 12:37:09 INFO - 2015-12-10 12:37:09,181 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:37:09 ERROR - 2015-12-10 12:37:09,197 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 12:37:10 INFO - 2015-12-10 12:37:10,002 INFO : Browser initialized. 12:37:10 INFO - 2015-12-10 12:37:10,002 INFO : Running cycle 1/1 for v8_7 test... 12:37:10 INFO - 2015-12-10 12:37:10,002 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzWFzmq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:22 INFO - 2015-12-10 12:37:22,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 142962688 12:37:22 INFO - 2015-12-10 12:37:22,025 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49761/tests/v8_7/run.html (next: http://localhost:49761/tests/v8_7/run.html) 12:37:43 INFO - 2015-12-10 12:37:43,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 442675200 12:37:43 INFO - 2015-12-10 12:37:43,658 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,659 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:43 INFO - 2015-12-10 12:37:43,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:43 INFO - 2015-12-10 12:37:43,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:43 INFO - 2015-12-10 12:37:43,660 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:43 INFO - 2015-12-10 12:37:43,660 DEBUG : BROWSER_OUTPUT: |0;Richards;166.00265604249668 12:37:43 INFO - 2015-12-10 12:37:43,660 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.15040953090096 12:37:43 INFO - 2015-12-10 12:37:43,660 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 12:37:43 INFO - 2015-12-10 12:37:43,661 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 12:37:43 INFO - 2015-12-10 12:37:43,661 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 12:37:43 INFO - 2015-12-10 12:37:43,661 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 12:37:43 INFO - 2015-12-10 12:37:43,661 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 12:37:43 INFO - 2015-12-10 12:37:43,661 DEBUG : BROWSER_OUTPUT: |7;RegExp;27378.37837837838 12:37:43 INFO - 2015-12-10 12:37:43,661 DEBUG : BROWSER_OUTPUT: |8;Splay;610.5006105006105 12:37:43 INFO - 2015-12-10 12:37:43,662 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 12:37:43 INFO - 2015-12-10 12:37:43,662 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:43 INFO - 2015-12-10 12:37:43,662 DEBUG : BROWSER_OUTPUT: __startTimestamp1449779863658__endTimestamp 12:37:43 INFO - 2015-12-10 12:37:43,662 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,663 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:43 INFO - 2015-12-10 12:37:43,663 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:37:43 INFO - 2015-12-10 12:37:43,663 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,663 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,663 DEBUG : BROWSER_OUTPUT: Values: 166.0 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.15 Median:186.15 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: Values: 186.2 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: Values: 278.9 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,664 DEBUG : BROWSER_OUTPUT: Values: 5133.3 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: Values: 2002.0 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: Values: 787.4 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: Values: 12292.7 12:37:43 INFO - 2015-12-10 12:37:43,665 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27378.38 Median:27378.38 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: Values: 27378.4 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.50 Median:610.50 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: Values: 610.5 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: Values: 4845.4 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:43 INFO - 2015-12-10 12:37:43,666 DEBUG : BROWSER_OUTPUT: 12:37:44 INFO - 2015-12-10 12:37:44,597 INFO : Browser exited with error code: 0 12:37:44 INFO - 2015-12-10 12:37:44,614 INFO : Completed test v8_7 (00:00:40) 12:37:44 INFO - 2015-12-10 12:37:44,708 INFO : Completed test suite (00:20:18) 12:37:44 INFO - 2015-12-10 12:37:44,708 DEBUG : Working with test: dromaeo_css 12:37:44 INFO - 2015-12-10 12:37:44,709 DEBUG : Generating results file: dromaeo_css 12:37:44 INFO - 2015-12-10 12:37:44,710 DEBUG : Working with test: kraken 12:37:44 INFO - 2015-12-10 12:37:44,710 DEBUG : Generating results file: kraken 12:37:44 INFO - 2015-12-10 12:37:44,710 INFO : javascript benchmark 12:37:44 INFO - 2015-12-10 12:37:44,710 DEBUG : Working with test: v8_7 12:37:44 INFO - 2015-12-10 12:37:44,710 DEBUG : Generating results file: v8_7 12:37:44 INFO - 2015-12-10 12:37:44,711 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:44 INFO - 2015-12-10 12:37:44,763 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:37:44 INFO - 2015-12-10 12:37:44,764 DEBUG : process_Request line: dromaeo_css 6405.69 graph.html#tests=[[72,132,35]] 12:37:44 INFO - 2015-12-10 12:37:44,764 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:44 INFO - 2015-12-10 12:37:44,794 DEBUG : process_Request line: kraken 1522.00 graph.html#tests=[[232,132,35]] 12:37:44 INFO - 2015-12-10 12:37:44,794 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:44 INFO - 2015-12-10 12:37:44,830 DEBUG : process_Request line: v8_7 19737.89 graph.html#tests=[[230,132,35]] 12:37:44 INFO - 2015-12-10 12:37:44,831 INFO : javascript benchmark 12:37:44 INFO - 2015-12-10 12:37:44,835 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2611.542979978504, 2683.7852971762263, 2691.542437785576, 2700.675918889735, 2714.918552443427, 4422.071365013351, 4565.33802598623, 4625.930611040832, 4665.183592871247, 4693.624510039202, 4607.608353289975, 4624.838130665427, 4692.13195558821, 4704.647151463645, 4742.573168414842, 4316.503602085769, 4325.048489332342, 4325.221460137174, 4325.372820940962, 4362.498312694033, 4201.1807697499, 4411.492678341983, 4413.249747542909, 4467.151241264166, 4471.843485478009, 4180.289350810339, 4228.957710422918, 4243.830246790125, 4273.594008569181, 4289.378040184156, 4223.345381465878, 4237.427947227146, 4246.766427846467, 4265.680073994463, 4308.569143085698, 4119.217348703737, 4212.936805947913, 4214.894627634303, 4234.724742891703, 4238.576142385737, 4438.60052595268, 4503.684742068057, 4523.525029871849, 4540.250858608326, 4561.7491037992895, 4969.975150124226, 5037.823676171353, 5050.444451110375, 5070.771815268322, 5100.056489549445, 4831.782569784368, 4951.678140920829, 5074.5432911037815, 5087.313212716273, 5105.106606343912, 4481.170983368054, 4526.185286648402, 4539.614132798683, 4554.43069616298, 4592.954070459253, 5142.254373115878, 5158.509941555546, 5162.793488260502, 5188.403333616682, 5207.453217412117, 4672.509386514435, 4792.329073929653, 4928.186849169847, 4930.309756634074, 4931.827386041543, 4925.605951523869, 4950.158473059589, 4964.60283177345, 4985.451600324034, 5027.069992051409, 4958.380202474691, 4964.578010869117, 4965.0566392385335, 4965.131102057126, 5011.5489605935645, 4695.3426520287185, 4874.780634871439, 4944.233643785219, 4944.777485013183, 5000.699958002531, 4046.4941882264716, 4076.510818701775, 4104.91790164195, 4127.814248358771, 4164.0, 3627.909302267464, 3636.1455058061333, 3646.85412583499, 3665.8350374233223, 3684.0421490412687, 4120.21715873983, 4221.493420789464, 4303.591158839905, 4308.159908817751, 4335.176316499855, 4894.363732714795, 4914.066327397783, 4982.302477653131, 4984.77568509418, 5017.1721665924715, 4269.060806622538, 4296.570342965741, 4296.677749168824, 4338.305871060616, 4341.479022517255, 4167.645750111214, 4311.525732169459, 4417.293233082692, 4422.7346359218545, 4426.336049592523, 4683.625309975262, 4696.1546921554445, 4745.738984355756, 4764.4282686077895, 4799.9760001199775, 5036.84889453317, 5052.747362631927, 5054.09026375256, 5059.949400505948, 5109.029284435946, 4588.17412865674, 4687.32033855096, 4779.832705855279, 4793.5685788279225, 4841.225403935354, 4892.437369702529, 4909.705417674951, 4961.42943561495, 4969.403671559436, 5022.949770502394, 5024.57291130258, 5043.36957880265, 5045.394552653705, 5047.873803154804, 5095.363079615048, 4661.440627124767, 4783.808647654055, 4850.490698476609, 4872.878178045436, 4914.533119353656, 4695.929561056519, 4798.47216806158, 4870.050340183772, 4872.512748725099, 4900.215965445512, 4744.169770290255, 4774.618030557616, 4784.880377990578, 4814.518548145157, 4840.685355451885, 4855.34452848875, 4913.484084171254, 4922.704637721748, 4939.950600493949, 4974.452810190948, 4593.701409408378, 4665.510121437336, 4697.7651117444675, 4724.952750472451, 4815.638827087912], "unit": "ms", "name": "dojo.html", "value": 4562.571519021764}, {"lowerIsBetter": false, "replicates": [555.1043187514638, 577.9133130030498, 588.4821357205659, 600.2916558461014, 600.7386786747765, 27031.18906432808, 35203.64796352036, 35894.641053589454, 35897.28205435893, 35906.10234744133, 38684.419733703944, 39071.80464097683, 39121.41317880227, 39176.64940103596, 39194.8040259799, 6963.791086267394, 7069.964650176742, 7916.485428447147, 8065.838683226332, 8076.798080047987, 10043.548040338203, 10169.237307201953, 10200.591976320939, 10233.948830255838, 10237.0, 9971.302008859382, 10087.747806304864, 10089.091981721644, 10097.394156350605, 10098.798024039515, 7197.3882220011365, 7382.48322617417, 10031.548580313867, 10242.6415075472, 10508.0, 9899.851502227473, 10020.298579099466, 10041.246906482043, 10045.296829221958, 10047.497625118714, 36607.0, 37126.62873371286, 37130.0, 37145.0, 37162.86812675905, 2804.6914839367655, 2816.112924428819, 2892.117904039267, 3511.8410924395143, 3628.9818550907075, 27545.31136721598, 27718.722812771815, 27827.582586261222, 27913.430074694403, 27941.0, 3382.543356646846, 3510.596281427643, 3544.0962554548423, 3546.7871927684423, 3655.323765103464, 222180.0, 222376.0, 222464.0, 223191.0, 223886.0, 50346.748266259165, 54681.45318546764, 55073.44926550763, 55084.0, 55124.448755511934, 45881.311780323325, 64644.35355646384, 66224.33775662181, 66247.66876165588, 66305.6684716583, 13565.389557469938, 13868.375923083284, 13870.375833087535, 13874.722505549833, 13879.0, 8981.685641002534, 9165.725028249164, 9745.756356091155, 9909.306348555676, 10193.23550733698, 18396.724049139273, 18554.907225464056, 18711.0, 18758.53103672419, 18800.62398752017, 7696.461247712718, 7837.568933708587, 7887.9605601971625, 7993.762526176908, 7999.240072193133, 771.4753967302288, 780.2431641307923, 856.2978357746713, 871.3073106880046, 948.5067764762285, 26082.73917260841, 26441.86779066131, 26698.0, 26824.0, 26835.0, 872.3326655108847, 888.6854322265438, 907.2651152566442, 921.7373048681094, 925.1488630459993, 12295.200811947196, 12742.235465871892, 13014.609561713163, 13222.338883055809, 13315.866841331463, 317348.0, 322491.0, 322651.0, 322710.0, 322807.0, 46144.3078353825, 46266.30600540995, 46678.29982550265, 46724.29913551299, 46739.0, 1166.1487114406361, 1166.6441735270655, 1174.4597485156753, 1176.6528873982195, 1177.6996865799338, 23764.521161892197, 24510.97006347115, 24521.386965326008, 24620.261392158263, 24815.0, 36672.81663591665, 37037.25925481529, 37224.81387593045, 37281.0, 37285.25429491449, 242144.0, 242260.0, 242592.0, 243695.0, 301319.0, 24666.630000550365, 28092.85953570219, 28285.0, 28646.283842904093, 28773.712262877103, 32387.838060809547, 43967.340489892034, 45182.32226516539, 45629.77185114053, 46195.0, 32834.67165328412, 33201.169970750925, 33369.66630333666, 33776.32447351088, 33805.32389352249, 29924.251893702833, 36182.0, 37119.62880371162, 37780.43329350117, 38925.6107438922, 33496.66503335033, 33540.49689254614, 33716.83141584276, 33771.0, 33900.66099338975, 29270.41459170847, 30169.849150754108, 30245.848770756886, 30350.0, 30397.632106555702, 23459.41351466227, 23493.882530587238, 23723.644145338178, 23827.761722382555, 23930.52138957246], "unit": "ms", "name": "ext.html", "value": 17243.331634287184}, {"lowerIsBetter": false, "replicates": [340.43317875736886, 341.1607445683618, 343.09080935520876, 344.1568158012869, 348.71231234231766, 12125.636230913087, 12433.502659893593, 15009.474668386609, 15044.172570508617, 15715.44995925143, 12409.441575129118, 14527.20100394478, 15399.846001539981, 16114.274857631406, 16116.516504504854, 4881.780319885614, 5020.472850350716, 6070.6357618543025, 6279.748810047616, 6287.025511045796, 4094.1197642506854, 4238.554951730071, 6159.291681456622, 6184.0, 6364.299927008025, 6511.609303441809, 6551.050097735825, 6578.769743058994, 6582.572132811376, 6591.110200122994, 5960.1953736245705, 6618.106555614979, 6646.401823835878, 6652.334766523358, 6654.168228971379, 6278.940822106689, 6324.494040476751, 6378.138951241569, 6379.362063793584, 6388.073729309271, 20438.79561204384, 20831.0, 21006.89496552523, 21040.684389734168, 21290.46773830651, 1826.6803309420932, 1901.6386886491662, 1928.8360489358422, 1940.6118776244807, 1983.5437849294742, 13940.0, 13941.860581394158, 14042.157470551698, 14269.286535673278, 14494.34775435108, 1832.431946096701, 1837.5222442165, 1844.4651051195137, 1871.6256748650324, 1917.0989634871587, 59371.40628593702, 62371.37628623701, 64315.67842160806, 65567.67216163936, 66249.0, 14752.262386880613, 15462.458813941457, 15483.458078967407, 15496.380144794082, 15511.922440387725, 23519.0, 23535.7646423537, 23730.762692373202, 23741.40646483817, 23836.0, 8009.559474228973, 8362.749117526484, 8371.748847534584, 8394.160583941557, 8526.190011948855, 7013.333733295431, 7073.610951397723, 7083.681234344467, 7085.468589855678, 7097.609631470319, 7343.3390994810725, 7452.4783265172, 7476.813079673052, 7528.736494222676, 7537.266428721425, 2306.815454763615, 2879.29457282967, 2909.3017675757665, 2962.7777916655905, 2991.7457016153435, 793.2900054451234, 801.2468279816953, 815.7756616930392, 820.5651004967377, 901.324006994754, 13610.659733506543, 15167.393304267927, 15478.613034674223, 15917.283722232527, 15943.44197953066, 802.803313188261, 826.2068414322318, 867.6919693508839, 872.6247713483264, 874.1782724239195, 8635.525046122399, 8784.121587841293, 9082.682106126385, 9201.861972070425, 9444.8583271251, 532065.0, 539176.0, 540144.0, 540603.0, 548527.0, 68568.6571567139, 70668.64665676742, 70912.0, 71692.0, 72142.9178562322, 1049.7375656085978, 1049.8477720730452, 1050.3487837540622, 1073.0717928991521, 1075.1076606416655, 14650.120992740469, 14677.41290348374, 14780.778288325899, 14957.326920288395, 15123.697526049638, 32801.83599081989, 32880.1779955503, 32882.34235315328, 33438.66561334355, 33708.0, 41348.58651413448, 42088.158236835705, 43703.0, 44123.0, 44899.326510101724, 9048.592813323285, 9166.312526560669, 9171.862422063808, 9282.303827213122, 9315.767105822408, 15645.921770391074, 15886.285117169986, 16029.519114426586, 16487.505374838773, 16488.752668710218, 13609.455621775018, 13726.313684315945, 13766.294296438451, 14522.273886305853, 14749.705005900036, 10186.694399168036, 12263.816042759187, 14075.648108796953, 14354.066985646317, 14548.563543093724, 12629.68425789326, 13992.09051411655, 14031.158130512202, 14333.56999290023, 14554.690077892617, 8617.655293788179, 8717.738467845975, 8725.825483490422, 8939.418937769024, 9233.815323693623, 9772.511374431107, 12667.429965651752, 14087.506937257147, 14455.566333010027, 14472.34874430632], "unit": "ms", "name": "jquery.html", "value": 9275.44986747415}, {"lowerIsBetter": false, "replicates": [1242.9751404971908, 1636.4763275751757, 1676.857467115295, 1706.7695861058753, 1712.1695977450934, 5880.911786323203, 6686.665666716663, 6783.3555812197765, 6818.454523638109, 6821.976703494478, 6893.965530172355, 7122.821929451753, 7124.073870396841, 7124.750633727821, 7128.073350464445, 2013.9194432222694, 2074.5954538864926, 2077.106844057055, 2077.27295446594, 2077.8441616878717, 2073.8963051847345, 2112.1445814445096, 2119.5654890747437, 2137.187868609926, 2139.3902737719754, 1975.8122978317108, 2032.410600925737, 2056.794320567946, 2059.454244625168, 2060.577581595769, 2080.9491206940475, 2104.042660589428, 2107.430993631711, 2108.251570692405, 2112.6302896992966, 2023.423324352567, 2056.5475595368994, 2058.0, 2058.742657167854, 2078.4076538186696, 6968.268331825136, 6979.4765392595755, 7039.894401583981, 7043.049188359557, 7062.823429414254, 4064.43097966282, 4149.771762553059, 4159.91680166395, 4175.123224122938, 4177.49870015597, 2608.5174242765147, 2613.9346516337055, 2657.8803953822126, 2675.0, 2684.221575743032, 841.47828346425, 851.8849955256085, 852.1435956863313, 864.8097418567905, 865.5196366016858, 9410.482423466707, 9431.858522122173, 9447.385919915252, 9454.05459454056, 9478.715638530855, 3723.1250656095795, 3744.5319335083113, 3791.1280405506886, 3897.5322961244833, 3898.317794385971, 8123.512589244664, 8189.549574773445, 8201.015878094668, 8206.22040906113, 8209.507429554245, 4136.627703506699, 4154.044569748975, 4167.458230430086, 4169.478815148106, 4175.519815221228, 3263.2983908459796, 3345.882894098695, 3783.810809459516, 3815.6756675682877, 3817.3892177251505, 3482.407990641597, 3494.6155922848466, 3507.9649203508147, 3508.614052454279, 3534.6111927687934, 1121.8934201250868, 1123.955041798319, 1144.0847322142254, 1144.6394385768456, 1151.8445009923553, 785.1128225105595, 800.1838125112469, 896.7937374403924, 949.7815502434479, 1108.4568561405015, 6655.800325990228, 6741.561798483083, 6749.0888730020815, 6751.93248067513, 6764.661766911635, 998.4658207858906, 1010.9898901010896, 1014.7970405918845, 1021.6373187518473, 1028.7942411517727, 5088.363954505687, 5172.508611681884, 5183.455737147545, 5188.299579556787, 5195.272661827347, 8098.7165449209, 8201.384896132813, 8392.0, 8434.198751118634, 8573.699920502753, 8371.748847534584, 8393.706220282262, 8412.074671786098, 8477.74566762998, 8480.15198480147, 6564.7374105036215, 6677.3656502632175, 6704.631245281459, 6704.765333213314, 6715.664216789141, 6383.202099737533, 6443.774467893789, 6453.096566480603, 6458.418742313214, 6461.418472337512, 7444.255574442513, 7607.353374962969, 7618.961905190438, 7622.733204338044, 7673.0, 7629.427792915442, 7795.844083118192, 7803.02462192226, 7810.062792464713, 7818.687252509836, 6226.937730622817, 6294.590851594632, 6294.8111556653375, 6298.937010629835, 6306.180196574416, 6487.675616219076, 6727.327267273429, 6740.0226967090475, 6832.282610325844, 6880.174379074543, 6341.556091073765, 6396.9040464394, 6440.935590644033, 6471.611703297817, 6566.9014964774615, 5478.698671573102, 5855.3266374367495, 6017.699115044143, 6019.367966363468, 6026.246719160105, 6336.841578960563, 6385.553011289165, 6398.0402939559435, 6424.229092508929, 6424.38968298011, 5813.331466881363, 5814.5348372130975, 5855.0, 5866.266716660418, 5875.20684707559, 5875.970620146872, 5876.647401155944, 5878.353381127987, 5883.794067207627, 5899.144624029577], "unit": "ms", "name": "mootools.html", "value": 4039.3099175116217}, {"lowerIsBetter": false, "replicates": [298.80279015849544, 307.19668068002164, 313.830531512983, 317.43655012353054, 320.6040539933182, 5217.34783152106, 5261.684298942067, 5324.361076670795, 5326.520613144816, 5326.946730532698, 5248.5276325130735, 5260.579153667707, 5264.263003179558, 5269.604779641532, 5291.947080529194, 3931.4889064421727, 4065.3901914712733, 4160.1471698301775, 4160.355144952538, 4163.104932439525, 4025.1949610077954, 4160.0, 4173.916521669565, 4175.144095460439, 4179.519355274137, 4118.135191609766, 4128.525219599739, 4130.793460326987, 4134.462519872427, 4135.234981528427, 3889.1638297765835, 3994.141259629165, 4026.355783074723, 4125.381192821071, 4132.566080561528, 3651.7626354286886, 3657.7073834093208, 3659.0, 3666.1018050577513, 3670.06413364593, 5049.84850454487, 5075.467075957008, 5095.261187127883, 5098.719570423626, 5115.104856650071, 4690.343351930733, 4736.7631618418945, 4740.07568524138, 4749.525047495257, 4750.976245118787, 5407.810726624589, 5568.1647752837, 5588.524975377098, 5605.327360716699, 5606.159076138571, 3901.258760835432, 3902.453656488094, 3904.8047597620007, 3905.023744063984, 3905.886822255672, 5775.653460792366, 5844.970775146139, 5859.121131830217, 5859.882802343972, 5866.0, 3996.980015099964, 3997.2804895118575, 3997.620226078518, 4000.6199411055904, 4002.7598344099447, 3835.5780864104927, 3880.767153970771, 3963.900902477461, 4058.1072164123843, 4061.1674606706147, 4529.660275479352, 4663.51033141522, 4664.067186562701, 4672.462666793363, 4673.719576825333, 5598.10430331145, 5603.2435621191435, 5610.579206559524, 5612.186232996274, 5619.072852979212, 1418.2199790115396, 1433.899627026119, 1435.9138451692932, 1436.0522055443566, 1436.1311406599066, 967.9951600241953, 972.0619602084023, 975.6048800235916, 995.5719040812376, 998.9550470228858, 4888.975555122272, 4904.5340692634145, 4905.558499735041, 4906.632002599819, 4910.9932463844825, 5791.131330300404, 5792.855178620568, 5794.913076303858, 5796.5072968797285, 5797.768089276382, 4893.0, 4895.975520122377, 4903.092927808367, 4903.8528844134735, 4905.3132561441425, 3026.6821983691834, 3084.426942259464, 3118.875244990175, 3122.953155702666, 3124.7500199983947, 5482.862928426742, 5541.33503979525, 5547.195656629766, 5549.916751248735, 5553.639013464192, 6017.69911504423, 6023.45788879003, 6025.126356678257, 6030.728617212236, 6031.819045428644, 5475.917861232085, 5513.338399392099, 5528.778848846001, 5530.889382212253, 5536.529395001389, 5674.4892959633835, 5853.326867410302, 5853.385394533512, 5854.151148083419, 5863.149843272617, 5718.571107166896, 5721.542276617944, 5721.599488035798, 5725.770969161187, 5730.598858079894, 5518.089515229942, 5519.668819870821, 5523.7790488380015, 5526.696031718294, 5530.0, 3948.723589348833, 3993.221321842213, 4035.91928161441, 4039.0104424416204, 4043.0498832773687, 5574.386817450159, 5705.942940570707, 5823.126531020212, 5823.7379317929945, 5842.561807864512, 5490.752916118704, 5602.915956260578, 5607.07483265273, 5640.520555752807, 5644.407337229696, 5603.187537807076, 5616.6068375213345, 5620.269364982526, 5622.072358060874, 5623.381428042994, 5364.624476286623, 5504.4495550444635, 5507.394186639386, 5508.9724551376985, 5515.034868898007, 5653.689047102449, 5664.546836253007, 5666.206731057738, 5667.121596152603, 5673.546116310603, 5519.862003449785, 5527.640703354269, 5527.640703354269, 5530.751116199861, 5531.308586426697], "unit": "ms", "name": "prototype.html", "value": 4206.679609532005}, {"lowerIsBetter": false, "replicates": [652.2922628947595, 688.6074937285746, 728.3044692318834, 782.9843403131938, 817.1093508076195, 11916.463759130838, 12214.145009849313, 12219.083568732336, 12225.449854756534, 12246.632601021962, 11540.653780386601, 11637.883621163806, 11692.24000439973, 11720.941395293034, 11741.647750567476, 633.3697970519339, 641.0288413054227, 801.6032064128265, 811.3590263691676, 830.0620299062051, 802.1497212954258, 804.7666176808748, 806.753940048285, 814.6049166154411, 814.9837003259931, 847.9194476524751, 854.4189950833431, 855.5850412549939, 856.092541905579, 856.6102423397339, 659.2616269777856, 668.0547025958288, 845.247729520727, 863.8272345530919, 864.5590748718199, 620.0698951572641, 624.9437550620421, 626.8652239768426, 627.244170774216, 627.704978660029, 11689.298642081503, 11767.94116029423, 11843.0, 11855.229410088403, 11880.168388212829, 10709.678709638723, 11357.261777984404, 11494.885051149466, 11575.189736718434, 11614.825777613343, 8917.643294268222, 9048.0, 9146.0, 9167.633294668205, 9392.48341341226, 3152.4734449133402, 3200.9519857202163, 3226.6289376721506, 3233.0, 3252.6259480159847, 39057.21885562301, 39115.60884391148, 39186.21627567461, 39302.0, 39432.01419964495, 8942.284617230605, 9163.0, 9388.577514011886, 9554.761130971643, 9704.563294651758, 16167.029978201346, 16251.674966500605, 16265.59336016609, 16272.918635406748, 16286.348546058025, 5917.970410147922, 6048.758049678052, 6130.693465326716, 6268.655223962634, 6453.709583068773, 3371.7976921384798, 3478.3738926993383, 3504.2115524007404, 3551.0, 3560.416313252755, 2544.0841297133015, 2578.316746062295, 2588.0424243029825, 2590.2747230775412, 2598.9480210395686, 481.40546425164894, 486.99756501217973, 487.07455833915844, 489.3491656097382, 490.3968119213387, 392.28408155117023, 444.4022789348321, 463.48553106052253, 511.5805039867273, 517.3558919145688, 6976.965115174392, 7055.400290975222, 7252.818679533054, 7280.526765760314, 8253.174682531699, 430.16762564437914, 444.06967403290054, 462.66225655271165, 467.63758087481796, 510.2881480334912, 3248.8538015789345, 3422.863085476603, 3467.479878018267, 3548.1661809474754, 3587.318409502186, 47126.528734712214, 48159.75920120377, 48402.0, 48548.0, 48561.5143848557, 41711.582884171374, 42646.36030459546, 43533.782331088776, 44068.55931440709, 44137.33793993093, 40263.79868100641, 40440.0, 40718.0, 40960.0, 41118.0, 7386.15059268191, 7613.809654758676, 7657.34912532441, 7674.577898215652, 7893.644785984759, 31349.8432507836, 31379.05862824119, 31519.684803151675, 31932.6806731939, 32247.0, 36765.81617092004, 39811.80094099511, 40662.59337406588, 40949.0, 41037.1792564153, 10034.397936123856, 10092.192624590161, 10105.696829095139, 10114.825820131078, 10181.389116653025, 10901.34591924487, 11429.0, 11522.0, 11527.07783377311, 11548.249363791327, 9556.808863822824, 9570.234381249622, 9628.0, 10556.736081598021, 10622.681319560426, 10364.740881478023, 10435.843462347919, 10583.788324233627, 10767.784644306914, 10775.191860610643, 9553.474558899326, 9930.106290433896, 9994.500274986367, 10084.69745907624, 10138.0, 8261.752147435345, 8600.698975535826, 8622.655093796178, 8837.248833848938, 9156.404833685789, 8644.394892357475, 9090.318226133199, 9117.133872282388, 9150.359474836698, 9234.0], "unit": "ms", "name": "yui.html", "value": 5571.02955149098}], "name": "dromaeo_css", "value": 6405.693740482859}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 111.0, 112.0, 111.0, 102.0, 112.0, 110.0, 119.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 167.0, 167.0, 132.0, 160.0, 157.0, 132.0, 166.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 82.0, 96.0, 71.0, 77.0, 71.0, 89.0, 86.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 139.0, 95.0, 94.0, 95.0, 138.0, 94.0, 95.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 72.0, 71.0, 71.0, 71.0, 83.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 85.0, 90.0, 88.0, 83.0, 82.0, 87.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 137.0, 128.0, 126.0, 120.0, 125.0, 119.0, 127.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [140.0, 135.0, 145.0, 145.0, 145.0, 135.0, 156.0, 147.0, 146.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 69.0, 71.0, 68.0, 69.0, 69.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1522.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.00265604249668], "unit": "score", "name": "Richards", "value": 212.659248}, {"lowerIsBetter": false, "replicates": [186.15040953090096], "unit": "score", "name": "DeltaBlue", "value": 355.1858960000002}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [27378.37837837838], "unit": "score", "name": "RegExp", "value": 33.27388450148074}, {"lowerIsBetter": false, "replicates": [610.5006105006105], "unit": "score", "name": "Splay", "value": 133.48225799999997}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19737.8911905264}]} 12:37:44 INFO - RETURN: dromaeo_css: 6405.69 12:37:44 INFO - RETURN: kraken: 1522.00 12:37:44 INFO - RETURN: v8_7: 19737.89 12:37:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19737.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1522.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6405.69"}}} 12:37:44 INFO - Return code: 0 12:37:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:37:44 ERROR - # TBPL SUCCESS # 12:37:44 INFO - Running post-action listener: _resource_record_post_action 12:37:44 INFO - Running post-run listener: _resource_record_post_run 12:37:46 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506818560; Read time: 16; Write time: 400068 12:37:46 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231129088; Read time: 0; Write time: 250856 12:37:46 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275296256; Read time: 16; Write time: 149184 12:37:46 INFO - Running post-run listener: _upload_blobber_files 12:37:46 INFO - Blob upload gear active. 12:37:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:37:46 INFO - Copying logs to upload dir... 12:37:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.965086 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 12:37:45.353558) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:37:45.356934) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009929 build_url: 'https://queue.taskcluster.net/v1/task/pcFgIQLsS3a7qi7-XA2rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:37:45.408788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:37:45.409180) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1449776544.182998-1638695047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:37:45.459621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 12:37:45.459956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 12:37:45.460346) ========= ========= Total master_lag: 0.30 =========