builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1450077993.37 results: success (0) buildid: 20151213223731 builduid: a28e7ee55a4047108f3e2624a567845f revision: 871d92a1b0701ad79780989bf2ae335d4a19f138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.372743) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.373143) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.373586) ========= 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=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.402621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.402896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.418489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.418746) ========= 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=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004685 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.471949) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.472266) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.472839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.473142) ========= 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=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-13 23:26:35-- 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% 35.4M=0s 2015-12-13 23:26:35 (35.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.649999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.650297) ========= 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=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.701032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:33.701391) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 871d92a1b0701ad79780989bf2ae335d4a19f138 --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 871d92a1b0701ad79780989bf2ae335d4a19f138 --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=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-13 23:26:35,590 truncating revision to first 12 chars 2015-12-13 23:26:35,590 Setting DEBUG logging. 2015-12-13 23:26:35,590 attempt 1/10 2015-12-13 23:26:35,590 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/871d92a1b070?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-13 23:26:35,816 unpacking tar archive at: fx-team-871d92a1b070/testing/mozharness/ program finished with exit code 0 elapsedTime=0.492718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:34.206969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:34.207285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:34.215018) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:34.215352) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 23:26:34.215768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-13 23:26:34.216045) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:26:36 INFO - MultiFileLogger online at 20151213 23:26:36 in /builds/slave/test 23:26:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 23:26:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:26:36 INFO - {'append_to_log': False, 23:26:36 INFO - 'base_work_dir': '/builds/slave/test', 23:26:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:26:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:26:36 INFO - 'branch': 'Fx-Team-Non-PGO', 23:26:36 INFO - 'buildbot_json_path': 'buildprops.json', 23:26:36 INFO - 'config_files': ('talos/linux_config.py',), 23:26:36 INFO - 'default_actions': ('clobber', 23:26:36 INFO - 'read-buildbot-config', 23:26:36 INFO - 'download-and-extract', 23:26:36 INFO - 'populate-webroot', 23:26:36 INFO - 'create-virtualenv', 23:26:36 INFO - 'install', 23:26:36 INFO - 'run-tests'), 23:26:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:26:36 INFO - 'download_minidump_stackwalk': True, 23:26:36 INFO - 'download_symbols': 'ondemand', 23:26:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:26:36 INFO - 'tooltool.py': '/tools/tooltool.py', 23:26:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:26:36 INFO - '/tools/misc-python/virtualenv.py')}, 23:26:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:26:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:26:36 INFO - 'installer_path': 'installer.exe', 23:26:36 INFO - 'log_level': 'info', 23:26:36 INFO - 'log_name': 'talos', 23:26:36 INFO - 'log_to_console': True, 23:26:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:26:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:26:36 INFO - 'opt_config_files': (), 23:26:36 INFO - 'pip_index': False, 23:26:36 INFO - 'sps_profile': False, 23:26:36 INFO - 'sps_profile_interval': 0, 23:26:36 INFO - 'suite': 'dromaeojs-e10s', 23:26:36 INFO - 'system_bits': '64', 23:26:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:26:36 INFO - 'title': 'talos-linux64-ix-053', 23:26:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:26:36 INFO - 'use_talos_json': True, 23:26:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:26:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:26:36 INFO - 'work_dir': 'build'} 23:26:36 INFO - ##### 23:26:36 INFO - ##### Running clobber step. 23:26:36 INFO - ##### 23:26:36 INFO - Running pre-action listener: _resource_record_pre_action 23:26:36 INFO - Running main action method: clobber 23:26:36 INFO - rmtree: /builds/slave/test/build 23:26:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:26:36 INFO - Running post-action listener: _resource_record_post_action 23:26:36 INFO - ##### 23:26:36 INFO - ##### Running read-buildbot-config step. 23:26:36 INFO - ##### 23:26:36 INFO - Running pre-action listener: _resource_record_pre_action 23:26:36 INFO - Running main action method: read_buildbot_config 23:26:36 INFO - Using buildbot properties: 23:26:36 INFO - { 23:26:36 INFO - "properties": { 23:26:36 INFO - "buildnumber": 569, 23:26:36 INFO - "product": "firefox", 23:26:36 INFO - "script_repo_revision": "production", 23:26:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:26:36 INFO - "repository": "", 23:26:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 23:26:36 INFO - "buildid": "20151213223731", 23:26:36 INFO - "slavename": "talos-linux64-ix-053", 23:26:36 INFO - "pgo_build": "False", 23:26:36 INFO - "basedir": "/builds/slave/test", 23:26:36 INFO - "project": "", 23:26:36 INFO - "platform": "ubuntu64_hw", 23:26:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:26:36 INFO - "slavebuilddir": "test", 23:26:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:26:36 INFO - "branch": "fx-team", 23:26:36 INFO - "repo_path": "integration/fx-team", 23:26:36 INFO - "stage_platform": "linux64", 23:26:36 INFO - "builduid": "a28e7ee55a4047108f3e2624a567845f", 23:26:36 INFO - "revision": "871d92a1b0701ad79780989bf2ae335d4a19f138" 23:26:36 INFO - }, 23:26:36 INFO - "sourcestamp": { 23:26:36 INFO - "repository": "", 23:26:36 INFO - "hasPatch": false, 23:26:36 INFO - "project": "", 23:26:36 INFO - "branch": "fx-team-linux64-talos", 23:26:36 INFO - "changes": [ 23:26:36 INFO - { 23:26:36 INFO - "category": null, 23:26:36 INFO - "files": [ 23:26:36 INFO - { 23:26:36 INFO - "url": null, 23:26:36 INFO - "name": "https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 23:26:36 INFO - } 23:26:36 INFO - ], 23:26:36 INFO - "repository": "", 23:26:36 INFO - "rev": "871d92a1b0701ad79780989bf2ae335d4a19f138", 23:26:36 INFO - "who": "philringnalda@gmail.com", 23:26:36 INFO - "when": 1450077958, 23:26:36 INFO - "number": 7356641, 23:26:36 INFO - "comments": "Merge m-i (and a little f-t) to m-c, a=merge", 23:26:36 INFO - "project": "", 23:26:36 INFO - "at": "Sun 13 Dec 2015 23:25:58", 23:26:36 INFO - "branch": "fx-team-linux64-talos", 23:26:36 INFO - "revlink": "", 23:26:36 INFO - "properties": [ 23:26:36 INFO - [ 23:26:36 INFO - "buildid", 23:26:36 INFO - "20151213223731", 23:26:36 INFO - "Change" 23:26:36 INFO - ], 23:26:36 INFO - [ 23:26:36 INFO - "builduid", 23:26:36 INFO - "a28e7ee55a4047108f3e2624a567845f", 23:26:36 INFO - "Change" 23:26:36 INFO - ], 23:26:36 INFO - [ 23:26:36 INFO - "pgo_build", 23:26:36 INFO - "False", 23:26:36 INFO - "Change" 23:26:36 INFO - ] 23:26:36 INFO - ], 23:26:36 INFO - "revision": "871d92a1b0701ad79780989bf2ae335d4a19f138" 23:26:36 INFO - } 23:26:36 INFO - ], 23:26:36 INFO - "revision": "871d92a1b0701ad79780989bf2ae335d4a19f138" 23:26:36 INFO - } 23:26:36 INFO - } 23:26:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 23:26:36 INFO - Running post-action listener: _resource_record_post_action 23:26:36 INFO - ##### 23:26:36 INFO - ##### Running download-and-extract step. 23:26:36 INFO - ##### 23:26:36 INFO - Running pre-action listener: _resource_record_pre_action 23:26:36 INFO - Running main action method: download_and_extract 23:26:36 INFO - mkdir: /builds/slave/test/build/tests 23:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:26:36 INFO - https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/test_packages.json 23:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/test_packages.json 23:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:26:38 INFO - Downloaded 1302 bytes. 23:26:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:26:38 INFO - Using the following test package requirements: 23:26:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:26:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:26:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:38 INFO - u'jsshell-linux-x86_64.zip'], 23:26:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:26:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:26:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:26:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:26:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:26:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:26:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:26:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:26:38 INFO - https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:39 INFO - Downloaded 21869889 bytes. 23:26:39 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 23:26:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:26:39 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 23:26:40 INFO - Return code: 0 23:26:40 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 23:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:26:40 INFO - https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:43 INFO - Downloaded 21869889 bytes. 23:26: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 23:26:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:26: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 23:26:44 INFO - Return code: 0 23:26: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')]} 23:26:44 INFO - https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:46 INFO - Downloaded 11132038 bytes. 23:26:46 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 23:26:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:26:46 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 23:26:46 INFO - Return code: 0 23:26:46 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')]} 23:26:46 INFO - https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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 23:26:48 INFO - Downloaded 57738259 bytes. 23:26:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:26:48 INFO - mkdir: /builds/slave/test/properties 23:26:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:26:48 INFO - Writing to file /builds/slave/test/properties/build_url 23:26:48 INFO - Contents: 23:26:48 INFO - build_url:https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:26:48 INFO - Running post-action listener: _resource_record_post_action 23:26:48 INFO - Running post-action listener: set_extra_try_arguments 23:26:48 INFO - ##### 23:26:48 INFO - ##### Running populate-webroot step. 23:26:48 INFO - ##### 23:26:48 INFO - Running pre-action listener: _resource_record_pre_action 23:26:48 INFO - Running main action method: populate_webroot 23:26:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:26:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:26:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:26:48 INFO - '--tppagecycles', 23:26:48 INFO - '7'], 23:26:48 INFO - 'tests': ['tsvgm']}}, 23:26:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:26:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:26:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:26:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:26:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:26:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:26:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'tests': ['damp', 'tps']}, 23:26:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['damp', 'tps']}, 23:26:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:26:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:26:48 INFO - 'other': {'tests': ['a11yr', 23:26:48 INFO - 'ts_paint', 23:26:48 INFO - 'tpaint', 23:26:48 INFO - 'sessionrestore', 23:26:48 INFO - 'sessionrestore_no_auto_restore']}, 23:26:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['a11yr', 23:26:48 INFO - 'ts_paint', 23:26:48 INFO - 'tpaint', 23:26:48 INFO - 'sessionrestore', 23:26:48 INFO - 'sessionrestore_no_auto_restore']}, 23:26:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['a11yr', 23:26:48 INFO - 'ts_paint', 23:26:48 INFO - 'tpaint', 23:26:48 INFO - 'sessionrestore', 23:26:48 INFO - 'sessionrestore_no_auto_restore']}, 23:26:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['a11yr', 23:26:48 INFO - 'ts_paint', 23:26:48 INFO - 'tpaint', 23:26:48 INFO - 'sessionrestore', 23:26:48 INFO - 'sessionrestore_no_auto_restore']}, 23:26:48 INFO - 'other_l64': {'tests': ['a11yr', 23:26:48 INFO - 'ts_paint', 23:26:48 INFO - 'tpaint', 23:26:48 INFO - 'sessionrestore', 23:26:48 INFO - 'sessionrestore_no_auto_restore']}, 23:26:48 INFO - 'other_nol64': {'tests': ['a11yr', 23:26:48 INFO - 'ts_paint', 23:26:48 INFO - 'tpaint', 23:26:48 INFO - 'sessionrestore', 23:26:48 INFO - 'sessionrestore_no_auto_restore']}, 23:26:48 INFO - 'svgr': {'tests': ['tsvgx', 23:26:48 INFO - 'tsvgr_opacity', 23:26:48 INFO - 'tart', 23:26:48 INFO - 'tscrollx', 23:26:48 INFO - 'cart']}, 23:26:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['tsvgx', 23:26:48 INFO - 'tsvgr_opacity', 23:26:48 INFO - 'tart', 23:26:48 INFO - 'tscrollx', 23:26:48 INFO - 'cart']}, 23:26:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'tests': ['tp5o']}, 23:26:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'talos_options': ['--e10s'], 23:26:48 INFO - 'tests': ['tp5o']}, 23:26:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'talos_options': ['--xperf_path', 23:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:26:48 INFO - 'tests': ['tp5n']}, 23:26:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:26:48 INFO - 'talos_options': ['--e10s', 23:26:48 INFO - '--xperf_path', 23:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:26:48 INFO - 'tests': ['tp5n']}}, 23:26:48 INFO - 'talos.zip': {'path': '', 23:26:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:26:48 INFO - Running post-action listener: _resource_record_post_action 23:26:48 INFO - ##### 23:26:48 INFO - ##### Running create-virtualenv step. 23:26:48 INFO - ##### 23:26:48 INFO - Running pre-action listener: _resource_record_pre_action 23:26:48 INFO - Running main action method: create_virtualenv 23:26:48 INFO - Creating virtualenv /builds/slave/test/build/venv 23:26:48 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 23:26:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:26:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:26:48 INFO - Using real prefix '/usr' 23:26:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:26:49 INFO - Installing distribute.............................................................................................................................................................................................done. 23:26:51 INFO - Installing pip.................done. 23:26:51 INFO - Return code: 0 23:26:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:26:51 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')]} 23:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:51 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')]} 23:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:51 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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:26:51 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 23:26:51 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 23:26:51 INFO - Using env: {'DISPLAY': ':0', 23:26:51 INFO - 'HOME': '/home/cltbld', 23:26:51 INFO - 'LANG': 'en_US.UTF-8', 23:26:51 INFO - 'LANGUAGE': 'en_US:en', 23:26:51 INFO - 'LOGNAME': 'cltbld', 23:26:51 INFO - 'MAIL': '/var/mail/cltbld', 23:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:26:51 INFO - 'MOZ_NO_REMOTE': '1', 23:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:26:51 INFO - 'NO_EM_RESTART': '1', 23:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:26:51 INFO - 'PWD': '/builds/slave/test', 23:26:51 INFO - 'SHELL': '/bin/bash', 23:26:51 INFO - 'SHLVL': '1', 23:26:51 INFO - 'TERM': 'linux', 23:26:51 INFO - 'TMOUT': '86400', 23:26:51 INFO - 'USER': 'cltbld', 23:26:51 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:26:51 INFO - '_': '/tools/buildbot/bin/python'} 23:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:26:51 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 23:26:51 INFO - Cleaning up... 23:26:51 INFO - Return code: 0 23:26:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:26:51 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')]} 23:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:51 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')]} 23:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:51 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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:26:51 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 23:26:51 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 23:26:51 INFO - Using env: {'DISPLAY': ':0', 23:26:51 INFO - 'HOME': '/home/cltbld', 23:26:51 INFO - 'LANG': 'en_US.UTF-8', 23:26:51 INFO - 'LANGUAGE': 'en_US:en', 23:26:51 INFO - 'LOGNAME': 'cltbld', 23:26:51 INFO - 'MAIL': '/var/mail/cltbld', 23:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:26:51 INFO - 'MOZ_NO_REMOTE': '1', 23:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:26:51 INFO - 'NO_EM_RESTART': '1', 23:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:26:51 INFO - 'PWD': '/builds/slave/test', 23:26:51 INFO - 'SHELL': '/bin/bash', 23:26:51 INFO - 'SHLVL': '1', 23:26:51 INFO - 'TERM': 'linux', 23:26:51 INFO - 'TMOUT': '86400', 23:26:51 INFO - 'USER': 'cltbld', 23:26:51 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:26:51 INFO - '_': '/tools/buildbot/bin/python'} 23:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:26:51 INFO - Downloading/unpacking psutil>=0.7.1 23:26:51 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 23:26:51 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 23:26:51 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 23:26:51 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 23:26:51 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 23:26:51 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 23:26:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:26:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:26:53 INFO - Installing collected packages: psutil 23:26:53 INFO - Running setup.py install for psutil 23:26:53 INFO - building 'psutil._psutil_linux' extension 23:26:53 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 23:26:53 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 23:26:53 INFO - building 'psutil._psutil_posix' extension 23:26:53 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 23:26:53 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 23:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:26:54 INFO - Successfully installed psutil 23:26:54 INFO - Cleaning up... 23:26:54 INFO - Return code: 0 23:26:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:26: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')]} 23:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26: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')]} 23:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26: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', '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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:26: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:26: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 mozsystemmonitor==0.0.0 23:26:54 INFO - Using env: {'DISPLAY': ':0', 23:26:54 INFO - 'HOME': '/home/cltbld', 23:26:54 INFO - 'LANG': 'en_US.UTF-8', 23:26:54 INFO - 'LANGUAGE': 'en_US:en', 23:26:54 INFO - 'LOGNAME': 'cltbld', 23:26:54 INFO - 'MAIL': '/var/mail/cltbld', 23:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:26:54 INFO - 'MOZ_NO_REMOTE': '1', 23:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:26:54 INFO - 'NO_EM_RESTART': '1', 23:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:26:54 INFO - 'PWD': '/builds/slave/test', 23:26:54 INFO - 'SHELL': '/bin/bash', 23:26:54 INFO - 'SHLVL': '1', 23:26:54 INFO - 'TERM': 'linux', 23:26:54 INFO - 'TMOUT': '86400', 23:26:54 INFO - 'USER': 'cltbld', 23:26:54 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:26:54 INFO - '_': '/tools/buildbot/bin/python'} 23:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:26:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:26: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 23:26: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 23:26: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 23:26: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 23:26: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 23:26: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 23:26:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:26:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:26:56 INFO - Installing collected packages: mozsystemmonitor 23:26:56 INFO - Running setup.py install for mozsystemmonitor 23:26:56 INFO - Successfully installed mozsystemmonitor 23:26:56 INFO - Cleaning up... 23:26:56 INFO - Return code: 0 23:26:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:26:56 INFO - Using env: {'DISPLAY': ':0', 23:26:56 INFO - 'HOME': '/home/cltbld', 23:26:56 INFO - 'LANG': 'en_US.UTF-8', 23:26:56 INFO - 'LANGUAGE': 'en_US:en', 23:26:56 INFO - 'LOGNAME': 'cltbld', 23:26:56 INFO - 'MAIL': '/var/mail/cltbld', 23:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:26:56 INFO - 'MOZ_NO_REMOTE': '1', 23:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:26:56 INFO - 'NO_EM_RESTART': '1', 23:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:26:56 INFO - 'PWD': '/builds/slave/test', 23:26:56 INFO - 'SHELL': '/bin/bash', 23:26:56 INFO - 'SHLVL': '1', 23:26:56 INFO - 'TERM': 'linux', 23:26:56 INFO - 'TMOUT': '86400', 23:26:56 INFO - 'USER': 'cltbld', 23:26:56 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:26:56 INFO - '_': '/tools/buildbot/bin/python'} 23:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:26:56 INFO - Downloading/unpacking blobuploader==1.2.4 23:26: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 23:26: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 23:26: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 23:26: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 23:26: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 23:26: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 23:26:58 INFO - Downloading blobuploader-1.2.4.tar.gz 23:26:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:26:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:26:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:58 INFO - Downloading docopt-0.6.1.tar.gz 23:26:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:26:58 INFO - Installing collected packages: blobuploader, requests, docopt 23:26:58 INFO - Running setup.py install for blobuploader 23:26:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:26:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:26:58 INFO - Running setup.py install for requests 23:26:59 INFO - Running setup.py install for docopt 23:26:59 INFO - Successfully installed blobuploader requests docopt 23:26:59 INFO - Cleaning up... 23:26:59 INFO - Return code: 0 23:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:26:59 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')]} 23:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:59 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')]} 23:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:26:59 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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:26:59 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 23:26:59 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 23:26:59 INFO - Using env: {'DISPLAY': ':0', 23:26:59 INFO - 'HOME': '/home/cltbld', 23:26:59 INFO - 'LANG': 'en_US.UTF-8', 23:26:59 INFO - 'LANGUAGE': 'en_US:en', 23:26:59 INFO - 'LOGNAME': 'cltbld', 23:26:59 INFO - 'MAIL': '/var/mail/cltbld', 23:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:26:59 INFO - 'MOZ_NO_REMOTE': '1', 23:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:26:59 INFO - 'NO_EM_RESTART': '1', 23:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:26:59 INFO - 'PWD': '/builds/slave/test', 23:26:59 INFO - 'SHELL': '/bin/bash', 23:26:59 INFO - 'SHLVL': '1', 23:26:59 INFO - 'TERM': 'linux', 23:26:59 INFO - 'TMOUT': '86400', 23:26:59 INFO - 'USER': 'cltbld', 23:26:59 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:26:59 INFO - '_': '/tools/buildbot/bin/python'} 23:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:26:59 INFO - Running setup.py (path:/tmp/pip-xn85ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:26:59 INFO - Running setup.py (path:/tmp/pip-yBURI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:26:59 INFO - Running setup.py (path:/tmp/pip-Cr94kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:26:59 INFO - Running setup.py (path:/tmp/pip-yP3vPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:26:59 INFO - Running setup.py (path:/tmp/pip-EVW5HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:26:59 INFO - Running setup.py (path:/tmp/pip-I6gokV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:00 INFO - Running setup.py (path:/tmp/pip-tGYq1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:00 INFO - Running setup.py (path:/tmp/pip-FU9CLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:00 INFO - Running setup.py (path:/tmp/pip-A7BSQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:00 INFO - Running setup.py (path:/tmp/pip-_Ndo1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:00 INFO - Running setup.py (path:/tmp/pip-5aAtUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:00 INFO - Running setup.py (path:/tmp/pip-YxlojB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:00 INFO - Running setup.py (path:/tmp/pip-GdoYc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:00 INFO - Running setup.py (path:/tmp/pip-emPfE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:00 INFO - Running setup.py (path:/tmp/pip-_lMgVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:00 INFO - Running setup.py (path:/tmp/pip-a4jOCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:00 INFO - Running setup.py (path:/tmp/pip-pBmvt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:27:00 INFO - Running setup.py install for manifestparser 23:27:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:27:00 INFO - Running setup.py install for mozcrash 23:27:01 INFO - Running setup.py install for mozdebug 23:27:01 INFO - Running setup.py install for mozdevice 23:27:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Running setup.py install for mozfile 23:27:01 INFO - Running setup.py install for mozhttpd 23:27:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Running setup.py install for mozinfo 23:27:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Running setup.py install for mozInstall 23:27:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Running setup.py install for mozleak 23:27:01 INFO - Running setup.py install for mozlog 23:27:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Running setup.py install for moznetwork 23:27:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:27:01 INFO - Running setup.py install for mozprocess 23:27:02 INFO - Running setup.py install for mozprofile 23:27:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:27:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:27:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:27:02 INFO - Running setup.py install for mozrunner 23:27:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:27:02 INFO - Running setup.py install for mozscreenshot 23:27:02 INFO - Running setup.py install for moztest 23:27:02 INFO - Running setup.py install for mozversion 23:27:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:27:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:27:02 INFO - Cleaning up... 23:27:02 INFO - Return code: 0 23:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:02 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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:27:02 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 23:27:02 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 23:27:02 INFO - Using env: {'DISPLAY': ':0', 23:27:02 INFO - 'HOME': '/home/cltbld', 23:27:02 INFO - 'LANG': 'en_US.UTF-8', 23:27:02 INFO - 'LANGUAGE': 'en_US:en', 23:27:02 INFO - 'LOGNAME': 'cltbld', 23:27:02 INFO - 'MAIL': '/var/mail/cltbld', 23:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:02 INFO - 'MOZ_NO_REMOTE': '1', 23:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:02 INFO - 'NO_EM_RESTART': '1', 23:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:02 INFO - 'PWD': '/builds/slave/test', 23:27:02 INFO - 'SHELL': '/bin/bash', 23:27:02 INFO - 'SHLVL': '1', 23:27:02 INFO - 'TERM': 'linux', 23:27:02 INFO - 'TMOUT': '86400', 23:27:02 INFO - 'USER': 'cltbld', 23:27:02 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:02 INFO - '_': '/tools/buildbot/bin/python'} 23:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:27:02 INFO - Running setup.py (path:/tmp/pip-MZWY1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:27:02 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)) 23:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:27:02 INFO - Running setup.py (path:/tmp/pip-0KjlEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:27:02 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)) 23:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:27:02 INFO - Running setup.py (path:/tmp/pip-rW3x1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:27:03 INFO - Running setup.py (path:/tmp/pip-KxVx21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:27:03 INFO - Running setup.py (path:/tmp/pip-5C5k9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:27:03 INFO - Running setup.py (path:/tmp/pip-6RevTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:03 INFO - Running setup.py (path:/tmp/pip-VJHwg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:03 INFO - Running setup.py (path:/tmp/pip-58WJsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:03 INFO - Running setup.py (path:/tmp/pip-H7utzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:03 INFO - Running setup.py (path:/tmp/pip-6qj9q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:03 INFO - Running setup.py (path:/tmp/pip-pZggPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:03 INFO - Running setup.py (path:/tmp/pip-h2RFKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:03 INFO - Running setup.py (path:/tmp/pip-kXez9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:03 INFO - Running setup.py (path:/tmp/pip-3I0WOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:03 INFO - Running setup.py (path:/tmp/pip-nMyuwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:03 INFO - Running setup.py (path:/tmp/pip-xLA71o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27:03 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)) 23:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:03 INFO - Running setup.py (path:/tmp/pip-YsLcZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:04 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)) 23:27:04 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)) 23:27: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:27:04 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)) 23:27:04 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)) 23:27:04 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)) 23:27:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:27:04 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 23:27:04 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 23:27:04 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 23:27:04 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 23:27:04 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 23:27:04 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 23:27:05 INFO - Downloading blessings-1.5.1.tar.gz 23:27:05 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 23:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:27:05 INFO - Installing collected packages: blessings 23:27:05 INFO - Running setup.py install for blessings 23:27:05 INFO - Successfully installed blessings 23:27:05 INFO - Cleaning up... 23:27:05 INFO - Return code: 0 23:27:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:27:06 INFO - Reading from file tmpfile_stdout 23:27:06 INFO - Current package versions: 23:27:06 INFO - argparse == 1.2.1 23:27:06 INFO - blessings == 1.5.1 23:27:06 INFO - blobuploader == 1.2.4 23:27:06 INFO - docopt == 0.6.1 23:27:06 INFO - manifestparser == 1.1 23:27:06 INFO - mozInstall == 1.12 23:27:06 INFO - mozcrash == 0.16 23:27:06 INFO - mozdebug == 0.1 23:27:06 INFO - mozdevice == 0.47 23:27:06 INFO - mozfile == 1.2 23:27:06 INFO - mozhttpd == 0.7 23:27:06 INFO - mozinfo == 0.9 23:27:06 INFO - mozleak == 0.1 23:27:06 INFO - mozlog == 3.1 23:27:06 INFO - moznetwork == 0.27 23:27:06 INFO - mozprocess == 0.22 23:27:06 INFO - mozprofile == 0.27 23:27:06 INFO - mozrunner == 6.11 23:27:06 INFO - mozscreenshot == 0.1 23:27:06 INFO - mozsystemmonitor == 0.0 23:27:06 INFO - moztest == 0.7 23:27:06 INFO - mozversion == 1.4 23:27:06 INFO - psutil == 3.1.1 23:27:06 INFO - requests == 1.2.3 23:27:06 INFO - wsgiref == 0.1.2 23:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27:06 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')]} 23:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:06 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')]} 23:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:06 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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:27:06 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 23:27:06 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 23:27:06 INFO - Using env: {'DISPLAY': ':0', 23:27:06 INFO - 'HOME': '/home/cltbld', 23:27:06 INFO - 'LANG': 'en_US.UTF-8', 23:27:06 INFO - 'LANGUAGE': 'en_US:en', 23:27:06 INFO - 'LOGNAME': 'cltbld', 23:27:06 INFO - 'MAIL': '/var/mail/cltbld', 23:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:06 INFO - 'MOZ_NO_REMOTE': '1', 23:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:06 INFO - 'NO_EM_RESTART': '1', 23:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:06 INFO - 'PWD': '/builds/slave/test', 23:27:06 INFO - 'SHELL': '/bin/bash', 23:27:06 INFO - 'SHLVL': '1', 23:27:06 INFO - 'TERM': 'linux', 23:27:06 INFO - 'TMOUT': '86400', 23:27:06 INFO - 'USER': 'cltbld', 23:27:06 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:06 INFO - '_': '/tools/buildbot/bin/python'} 23:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:06 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)) 23:27:06 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)) 23:27:06 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)) 23:27:06 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)) 23:27:06 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)) 23:27:06 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)) 23:27:06 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)) 23:27:06 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)) 23:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:27:06 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)) 23:27:06 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)) 23:27:06 INFO - Cleaning up... 23:27:06 INFO - Return code: 0 23:27:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:27:06 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')]} 23:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:06 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')]} 23:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:06 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 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:27:06 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 23:27:06 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 23:27:06 INFO - Using env: {'DISPLAY': ':0', 23:27:06 INFO - 'HOME': '/home/cltbld', 23:27:06 INFO - 'LANG': 'en_US.UTF-8', 23:27:06 INFO - 'LANGUAGE': 'en_US:en', 23:27:06 INFO - 'LOGNAME': 'cltbld', 23:27:06 INFO - 'MAIL': '/var/mail/cltbld', 23:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:06 INFO - 'MOZ_NO_REMOTE': '1', 23:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:06 INFO - 'NO_EM_RESTART': '1', 23:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:06 INFO - 'PWD': '/builds/slave/test', 23:27:06 INFO - 'SHELL': '/bin/bash', 23:27:06 INFO - 'SHLVL': '1', 23:27:06 INFO - 'TERM': 'linux', 23:27:06 INFO - 'TMOUT': '86400', 23:27:06 INFO - 'USER': 'cltbld', 23:27:06 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:06 INFO - '_': '/tools/buildbot/bin/python'} 23:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:06 INFO - Downloading/unpacking jsonschema 23:27: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 23:27: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 23:27: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 23:27: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 23:27: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 23:27: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 23:27:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:27:08 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 23:27:08 INFO - Downloading/unpacking functools32 (from jsonschema) 23:27:08 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 23:27:08 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 23:27:08 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 23:27:08 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 23:27:08 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 23:27:08 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 23:27:08 INFO - Downloading functools32-3.2.3-2.tar.gz 23:27:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:27:08 INFO - warning: no files found matching '*.txt' 23:27:08 INFO - no previously-included directories found matching 'build' 23:27:08 INFO - no previously-included directories found matching 'dist' 23:27:08 INFO - no previously-included directories found matching '.git*' 23:27:08 INFO - Installing collected packages: jsonschema, functools32 23:27:08 INFO - Running setup.py install for functools32 23:27:08 INFO - warning: no files found matching '*.txt' 23:27:08 INFO - no previously-included directories found matching 'build' 23:27:08 INFO - no previously-included directories found matching 'dist' 23:27:08 INFO - no previously-included directories found matching '.git*' 23:27:08 INFO - Successfully installed jsonschema functools32 23:27:08 INFO - Cleaning up... 23:27:08 INFO - Return code: 0 23:27:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5febd0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, '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': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', '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 23:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:27:08 INFO - Using env: {'DISPLAY': ':0', 23:27:08 INFO - 'HOME': '/home/cltbld', 23:27:08 INFO - 'LANG': 'en_US.UTF-8', 23:27:08 INFO - 'LANGUAGE': 'en_US:en', 23:27:08 INFO - 'LOGNAME': 'cltbld', 23:27:08 INFO - 'MAIL': '/var/mail/cltbld', 23:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:08 INFO - 'MOZ_NO_REMOTE': '1', 23:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:08 INFO - 'NO_EM_RESTART': '1', 23:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:08 INFO - 'PWD': '/builds/slave/test', 23:27:08 INFO - 'SHELL': '/bin/bash', 23:27:08 INFO - 'SHLVL': '1', 23:27:08 INFO - 'TERM': 'linux', 23:27:08 INFO - 'TMOUT': '86400', 23:27:08 INFO - 'USER': 'cltbld', 23:27:08 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:08 INFO - '_': '/tools/buildbot/bin/python'} 23:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:08 INFO - Downloading/unpacking flake8 23:27:08 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 23:27:08 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 23:27:08 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 23:27:08 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 23:27:08 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 23:27:08 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 23:27:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:27:10 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 23:27:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:27:10 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 23:27:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:10 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 23:27:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:27:11 INFO - no previously-included directories found matching 'docs/_build' 23:27:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:27:11 INFO - Running setup.py install for pep8 23:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:27:11 INFO - no previously-included directories found matching 'docs/_build' 23:27:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:27:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:27:11 INFO - Cleaning up... 23:27:11 INFO - Return code: 0 23:27:11 INFO - Running post-action listener: _resource_record_post_action 23:27:11 INFO - Running post-action listener: _start_resource_monitoring 23:27:11 INFO - Starting resource monitoring. 23:27:11 INFO - ##### 23:27:11 INFO - ##### Running install step. 23:27:11 INFO - ##### 23:27:11 INFO - Running pre-action listener: _resource_record_pre_action 23:27:11 INFO - Running main action method: install 23:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:27:11 INFO - Reading from file tmpfile_stdout 23:27:11 INFO - Detecting whether we're running mozinstall >=1.0... 23:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:27:11 INFO - Reading from file tmpfile_stdout 23:27:11 INFO - Output received: 23:27:11 INFO - Usage: mozinstall [options] installer 23:27:11 INFO - Options: 23:27:11 INFO - -h, --help show this help message and exit 23:27:11 INFO - -d DEST, --destination=DEST 23:27:11 INFO - Directory to install application into. [default: 23:27:11 INFO - "/builds/slave/test"] 23:27:11 INFO - --app=APP Application being installed. [default: firefox] 23:27:11 INFO - mkdir: /builds/slave/test/build/application 23:27:11 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'] 23:27:11 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 23:27:26 INFO - Reading from file tmpfile_stdout 23:27:26 INFO - Output received: 23:27:26 INFO - /builds/slave/test/build/application/firefox/firefox 23:27:26 INFO - Running post-action listener: _resource_record_post_action 23:27:26 INFO - ##### 23:27:26 INFO - ##### Running run-tests step. 23:27:26 INFO - ##### 23:27:26 INFO - Running pre-action listener: _resource_record_pre_action 23:27:26 INFO - Running main action method: run_tests 23:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:27:26 INFO - Python 2.7.3 23:27:26 INFO - Return code: 0 23:27:26 INFO - grabbing minidump binary from tooltool 23:27: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')]} 23:27:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19630b0>, '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 0x1963fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:27:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:27:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:27:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:27:26 INFO - Return code: 0 23:27:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:27:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:27:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:27:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:27:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:27:27 INFO - Return code: 0 23:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test/build 23:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 23:27:27 INFO - Using env: {'DISPLAY': ':0', 23:27:27 INFO - 'HOME': '/home/cltbld', 23:27:27 INFO - 'LANG': 'en_US.UTF-8', 23:27:27 INFO - 'LANGUAGE': 'en_US:en', 23:27:27 INFO - 'LOGNAME': 'cltbld', 23:27:27 INFO - 'MAIL': '/var/mail/cltbld', 23:27:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:27:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:27 INFO - 'MOZ_NO_REMOTE': '1', 23:27:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:27 INFO - 'NO_EM_RESTART': '1', 23:27:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:27 INFO - 'PWD': '/builds/slave/test', 23:27:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:27:27 INFO - 'SHELL': '/bin/bash', 23:27:27 INFO - 'SHLVL': '1', 23:27:27 INFO - 'TERM': 'linux', 23:27:27 INFO - 'TMOUT': '86400', 23:27:27 INFO - 'USER': 'cltbld', 23:27:27 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450070359.379972-206212468', 23:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:27 INFO - '_': '/tools/buildbot/bin/python'} 23:27:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 23:27:27 INFO - mozversion INFO | application_buildid: 20151213223731 23:27:27 INFO - mozversion INFO | application_changeset: 871d92a1b0701ad79780989bf2ae335d4a19f138 23:27:27 INFO - mozversion INFO | application_display_name: Nightly 23:27:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:27:27 INFO - mozversion INFO | application_name: Firefox 23:27:27 INFO - mozversion INFO | application_remotingname: firefox 23:27:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 23:27:27 INFO - mozversion INFO | application_vendor: Mozilla 23:27:27 INFO - mozversion INFO | application_version: 45.0a1 23:27:27 INFO - mozversion INFO | platform_buildid: 20151213223731 23:27:27 INFO - mozversion INFO | platform_changeset: 871d92a1b0701ad79780989bf2ae335d4a19f138 23:27:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 23:27:27 INFO - mozversion INFO | platform_version: 45.0a1 23:27:27 INFO - 2015-12-13 23:27:27,522 DEBUG : using testdate: 1450078047 23:27:27 INFO - 2015-12-13 23:27:27,522 DEBUG : actual date: 1450078047 23:27:27 INFO - 2015-12-13 23:27:27,609 INFO : starting webserver on 'localhost:37187' 23:27:27 INFO - 2015-12-13 23:27:27,610 INFO : Starting test suite talos-linux64-ix-053.e 23:27:27 INFO - 2015-12-13 23:27:27,610 INFO : Starting test dromaeo_css 23:27:27 INFO - 2015-12-13 23:27:27,610 DEBUG : operating with platform_type : linux_ 23:27:27 INFO - 2015-12-13 23:27:27,611 INFO : Initialising browser for dromaeo_css test... 23:27:27 INFO - 2015-12-13 23:27:27,627 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWsyUBj/profile http://localhost:37187/getInfo.html 23:27:31 INFO - 2015-12-13 23:27:31,967 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:27:31 INFO - 2015-12-13 23:27:31,967 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:27:31 INFO - 2015-12-13 23:27:31,967 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:27:31 INFO - 2015-12-13 23:27:31,967 DEBUG : BROWSER_OUTPUT: __metrics 23:27:32 INFO - 2015-12-13 23:27:32,069 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] 23:27:32 INFO - 2015-12-13 23:27:32,973 INFO : Browser initialized. 23:27:32 INFO - 2015-12-13 23:27:32,974 INFO : Running cycle 1/1 for dromaeo_css test... 23:27:32 INFO - 2015-12-13 23:27:32,974 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWsyUBj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:27:44 INFO - 2015-12-13 23:27:44,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 143826944 23:27:44 INFO - 2015-12-13 23:27:44,918 DEBUG : BROWSER_OUTPUT: 23:28:34 INFO - 2015-12-13 23:28:34,567 DEBUG : BROWSER_OUTPUT: 1450078114560 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] 23:30:46 INFO - 2015-12-13 23:30:46,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37187/tests/dromaeo/cssquery-ext.html) 23:30:47 INFO - 2015-12-13 23:30:47,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 146247680 23:30:47 INFO - 2015-12-13 23:30:47,464 DEBUG : BROWSER_OUTPUT: 23:33:49 INFO - 2015-12-13 23:33:49,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/dromaeo/cssquery-ext.html (next: http://localhost:37187/tests/dromaeo/cssquery-jquery.html) 23:33:50 INFO - 2015-12-13 23:33:50,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 145350656 23:33:50 INFO - 2015-12-13 23:33:50,051 DEBUG : BROWSER_OUTPUT: 23:36:51 INFO - 2015-12-13 23:36:51,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37187/tests/dromaeo/cssquery-mootools.html) 23:36:52 INFO - 2015-12-13 23:36:52,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 145866752 23:36:52 INFO - 2015-12-13 23:36:52,446 DEBUG : BROWSER_OUTPUT: 23:39:54 INFO - 2015-12-13 23:39:54,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37187/tests/dromaeo/cssquery-prototype.html) 23:39:54 INFO - 2015-12-13 23:39:54,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 144396288 23:39:54 INFO - 2015-12-13 23:39:54,825 DEBUG : BROWSER_OUTPUT: 23:42:57 INFO - 2015-12-13 23:42:57,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37187/tests/dromaeo/cssquery-yui.html) 23:42:58 INFO - 2015-12-13 23:42:58,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 144420864 23:42:58 INFO - 2015-12-13 23:42:58,073 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/dromaeo/cssquery-yui.html (next: http://localhost:37187/tests/dromaeo/cssquery-dojo.html) 23:46:00 INFO - 2015-12-13 23:46:00,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 147824640 23:46:00 INFO - 2015-12-13 23:46:00,611 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:46:00 INFO - 2015-12-13 23:46:00,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:46:00 INFO - 2015-12-13 23:46:00,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:46:00 INFO - 2015-12-13 23:46:00,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:46:00 INFO - 2015-12-13 23:46:00,612 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2685.731426857314;2755.9035433759796;2785.9860700696495;2801.4817258807116;2806.817556858804;4551.544845515455;4781.235002399617;4836.153673107206;4875.829345972892;4905.460399356068;4678.85963421097;4700.083483720676;4708;4726.102040612282;4852.417709874811;4467.396901418299;4487.910241795162;4507.3689683444345;4534.229181039232;4534.546545345472;4456.732596044231;4496.6627502937245;4506.346579745935;4509.503954564995;4531.071130418273;4157.542670306264;4366.08312254427;4471.709338892994;4499.887502812423;4527.547245275463;4418.447694038246;4428.512863585003;4429.579189976947;4441.444819397575;4449.1101779644205;4193.308104162809;4393.187260356813;4419.4033805436175;4437.090396468716;4448.065906159678;4583.862484125481;4630.675852690313;4751.239801631722;4753.3582966299455;4770.189067858472;5167.509086636764;5200.401953775327;5207.9479205207845;5213.843584692465;5266.683998960075;4894.070126675921;5013.573846223076;5228.08508511009;5230.555402790767;5240.606954478391;4747.95252047482;4791.808327666924;4810.302506136591;4828.493008234155;4862.124817532878;5287.735613219324;5362.517373436332;5362.731863406814;5365.061114304981;5427.728613569306;4834.564889159992;4941.851744447672;4963.106640804617;5135.35808023997;5145.588352931756;5167.767450464738;5184.948150518447;5185.170372740344;5201.45384734605;5283.656562323436;5104.081265372194;5105.897882042338;5111.0577980367225;5121.897562048738;5150.768215430315;4881.828361193288;5021.974890125599;5029.949700503022;5105.540501354896;5193.792248310101;4272.87181384559;4279.87160385189;4291.806868690916;4294.26997410441;4316.805743741539;3792.50697409335;3799.848006079781;3808.504894363715;3819.52255968004;3828.655421012122;4258.638015768633;4322.351647252937;4353.847615333448;4437.378766972626;4476.149531588988;5166.199239117943;5175.792968281226;5179.81870634526;5180.481951804864;5203.427622961472;4245.426867372927;4432.601065904084;4439.42287502629;4444.066745983379;4475.820967161277;4455.509893911667;4456.041950980555;4537.8411755588395;4558.908821823545;4570.9314360284625;4852.514748525119;4911;4912.8771780705765;4915.705057696549;4945.233488809168;4866.270059491105;5076.873078173076;5167.405748338839;5168.405633352213;5190.8961820762615;4863;4919.581835544019;4944.653874228769;4953.801847926043;4976.576990955809;5099.158638824701;5144.408393034699;5148;5154.355705536808;5193.350831146106;4904.215325547895;5021.799128034984;5026.824061157842;5202.063628546898;5211.817586384458;4961.355023846877;4970;4997.9750101249265;5089.541941225308;5134;5002.149634562206;5008.223725322581;5010.849674509771;5016.07202667493;5053.0399224147295;4701.341812146234;4916.7541622918;4925.48282430354;4935.1856943605335;4940.8764780880765;4969;4978.1288274552535;5037.445880953165;5044.268581055653;5085.5931525477135;4949.678270912379;5016.673916195436;5022.573081288131;5028.773705183203;5071.822486212965 23:46:00 INFO - 2015-12-13 23:46:00,612 DEBUG : BROWSER_OUTPUT: |1;ext.html;579.6174524813624;580.3268208877703;588.6997631208085;590.7548367427516;624.1386886097185;34726.305473890505;35310;35445.46831797522;35490.11274718133;35510;37035.81482092592;37658.623413765854;37728.62271377286;37730.24539509215;37801.621983780155;7689.115751688558;7869.763907082796;7870;7873.212678732109;7876.960615196916;7562.924370756305;7777.650005749755;7785.1436342002335;7794.883076753853;7801.063872335328;7722.652480638385;7765.223477652246;7785.299323060924;7793.649285782153;7803.843923121534;7764.3012128908385;7823.2176782321885;7840;7853.136155022943;7862.72480463181;7491.363234125106;7502.962485187593;7579.279968402993;7585.355244804198;7616.885746713804;33724.15689607755;34158.316833663186;34240.48639270413;34249.82875085609;34259;3015.2461884528866;3058.8011779234503;3209.935801283961;3395.7622966392364;3406.5741782277214;27522.311942201606;28123.437531249467;28208.43583128326;28342.858285708644;28377.716222837713;3343.997939716886;3390.728741700683;3477.669621385964;3483.268513612119;3518.9648103518894;215492;219207;219388;220356;220764.8961755197;51193;54313.72843135759;54677.45322546803;54816;54845.72577137089;45217.773911130236;57877.13184302239;57940.71029644825;58036;58456;13972.161670299814;14043.438262469386;14092.295385230698;14242.928785356007;14260;10645.148388128931;10743.301685390425;10749.623763168407;10794.298370606042;10827.78344433107;18467.81532184688;19074.760140591094;19103.52241193981;19184.80815191858;19209.8079019208;7481.102267727799;7694;7764.844703105906;7809.140994490602;7840.098388685375;870.4777133719717;947.6067432015774;1045.7751583409604;1062.8777690565685;1071.8820929697727;25831.61252581213;25869.353266168495;26012.479750405266;26085;26212;906.8413027720254;958.2956526952685;960.078324808192;961.1205746741792;1067.9946600266949;12086.637400877988;12156.5137394505;12203.816942745865;12211.877881221251;12278.815817762741;270429;273831;274555;274726;275418;44857.775711121234;45283;45307;45532;45589;1217.2270608163703;1225.1117939493795;1233.8149277608252;1261.9684507887375;1263.6335462715892;23523;25358.873205633852;25834.612480812426;25998.35004124912;26255;36294.45558316575;36593.63406366009;36652.083697907765;36700.44949325709;36893.63106368902;204893;206215;207418;207499;207768;28363.71636283611;28487.43025139527;29354.70645293605;29609.259768505097;29609.85195074097;34184.48723269203;34703.62578888751;36837.81581092077;36846.44730328993;37019.25961480809;30636.540451893685;31223;31564.937816215686;31970.20074498156;32233.194170145933;31802.840985795847;31885;32058.67941320557;32110.357792843544;32176.678233217368;31420.371592567564;32696.83651581822;33412;33624.1593960153;33673.663263368035;25502.212124835645;28853.134405967856;29433.558496622994;29451.263718407212;29635.407291854473;22837.31488055361;22852.65721014153;22934;23304.184353547545;23324.65013024772 23:46:00 INFO - 2015-12-13 23:46:00,612 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.16064036706393;332.9583802024747;333.40653636526974;333.8764657076881;336.00709902238884;15016.774748378783;15506.922465387672;16139.919300403511;16239.756403653955;16689.49931502057;10174.949125254363;10261.948690256557;10277.743056423593;12328;13939.581812545639;4548.636109111271;4662.487126416091;4670.322803193535;4678.508756580561;4946.505349465061;5054.1913293872985;5086.499482652626;5088.92366614501;5097.057044446789;5100.974495127519;4945.851624451254;5058.848234552969;5072.74636268187;5088.745562721868;5103.030424219405;5060.645754797166;5082.466341034212;5089.618278629117;5095.159298715707;5316.680999140064;5162.457941916082;5327.840164795062;5330.653507521999;5330.92003619946;5353.063213937546;11455.312681239153;11612.477438515287;17458.388956386592;18853;18859.245630174777;1688.1812321024292;1775.6448710258;1884.105050101191;1886.4057821786093;1906.9713954290696;8990;9208.953955230249;9230.261579073725;9692.22462203022;12925.54760583375;1692.1724537499595;1738.9652206955916;1747.4146161035942;1751.5708651380367;1775.0680892531395;53717.46282537164;56645.71677141588;56759.43240567583;57349;58325;9266.44401335922;9424.764380890532;9524.90475095254;9566.091221333962;9654.27592930533;11934.104942129376;11943.104267179997;11951.701207469883;11975.760484790255;11985.28088314704;7196.676149573282;7218.602976836324;7233.45749068822;7260.092488438945;7308.853822923618;7111.217766045731;7134.964325178445;7164.355208031302;7172.784816455514;7205.639718014183;3949.3878448840474;3975.1056012397557;4004.5594984551676;4017.8392864285684;4022.7988600569856;1634.3952737486968;1736.314155908409;1791.1581556668345;1809.4481183238975;1833.697439922398;365.07089457331153;369.990750231241;378.3889019233972;384.21044753032226;759.1118391481868;9767.267454940908;10164.593416263267;10342.689719308433;10353.223508236912;10394.064534191959;892.723255790707;893.5710858787688;914.9085091490798;961.1974001708512;995.1143482300758;8880.200781929658;8958.328125390623;8961.148690874486;9179.541022948826;9272.72181834546;485607;493510;517244;517307;519232;70906;73323.63338183275;73913.26086739171;74253.25746742463;74572;1093.699232710995;1101.399737143275;1167.5855071449514;1189.4171855790773;1199.3943058755274;14987.625309366917;15063.774043389578;15096.16971066558;15127.243637817845;15350.846491535389;30697;31218.531722023734;32407.837960810044;32766.180845479055;33113.66886331202;35415.468767967985;36936.63063369332;38575.42136868005;43140.56859431491;44064.339034915145;8417.116202798617;8659.52372619512;8687.695930642398;8770.07914169003;8773.333066717303;10276.743081423025;15832.841671583137;16206.270717817491;16637.584060398585;16689.415870444474;8564.443311184754;8814.955925220333;8848.424852384574;9411;13846.169229846242;9156.8481406868;9464;9556.522173891139;9619.663311784054;9975.551100200364;9779.755506112404;9991.150752186146;10039.749006274902;10114.898851011396;10144.036316549917;14162.504312349018;14524.346404412037;14542.781858271923;14648.926755366156;14743.336549855498;15149.924250378677;15263.923680381527;15293.388264469742;15517.301721422336;15559.611009724847 23:46:00 INFO - 2015-12-13 23:46:00,613 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1516.3252352703053;1591.3793620488009;1681.470336843894;1690.6280618263986;1723.9224234909427;5963.493103086232;6043.969780151104;7068.823279418017;7595.240475952402;7618.200088990652;6845;7084.893726594105;7130.679119439625;7133.928660713391;7143.107111611049;2090.2997495838913;2123.830093592509;2128.861623994443;2140.422086036769;2140.454184183031;2065.710800487933;2105.1263725553954;2128.8935553222354;2139.6683514055267;2141.0686351437175;2145.6352420088624;2146.6028784674886;2165.7942495462908;2168.1977668262684;2190.222471022788;2121.1197353098446;2143.796339347767;2144.0994782191515;2144.1637761273114;2147.3987283560627;2078.771335153147;2176.1077958037285;2177.0638625391075;2178.1069761397907;2183.4650510624997;7286.089238845145;7310.086239220098;7366.152892417387;7366.373858222004;7383.040204773345;4250.383694364331;4327.8485253016;4334.891627709301;4361.367601697736;4361.760103194323;2661.7471340222646;2664.760171584547;2744.217897899089;2749.2164733051186;2763.1710486853863;851.3572252949045;873.7990262239657;875.9430637008574;903.0833703790657;905.5653286422554;9603.4718090505;9626.518674066268;9650.951745241298;9683.66107186245;9711.27165462593;3939.2515422070287;3943.684505239574;3991.84032638697;4009.599040095967;4013;8393.748187554384;8397.412181147261;8405.075441701409;8409.159084091541;8431.072582015973;4321.611055005064;4343.609075183249;4367.082912588392;4374.081442897027;4385.758783266951;3375.6793104655017;3451.361498122855;3833.5208098987628;3978.781167035783;3993.1414745829784;3463.7748546344405;3475.704565111994;3488.5464889564196;3499.2651543176216;3529.3294274087843;1041.1618646989245;1058.99470502647;1080.1197024425069;1094.8248280275118;1095.9178061645248;996.1035068438464;1010.8534262531891;1012.2054187462953;1013.2350075692952;1013.8377859542438;6575.046618240328;6606.141201643755;6632.204135503674;6675.899861502081;6697.665116744143;444.75538453850254;445.2497541642343;1120.456578559398;1142.268947873345;1147.8565179352581;5155.793768249303;5168;5184.585233181337;5186.740662966912;5249.317588713519;8562.357823163287;8745.518996455256;8746.781330466789;8764.474131552128;8817.897762779652;8465.534395608178;8689.869651955225;8711.823903772909;8732.607032683545;8748.168923952215;6866.862662746717;6964.4080253179045;6967.82580435483;7007.649617519103;7014.333638304251;6444.484441244783;6453.419192272718;6502.317256687979;6584.637844918576;6828.248892621708;7573.431992600466;7632.923670763222;7680.308772210527;7719.691212351443;7965.880511792444;7938.24586664266;8052.838943220986;8069.515829050276;8084.717034903751;8093.676252950052;6042.546808989256;6306.432421082125;6311.116443697794;6513.641749703812;6616.603003819786;7009.228984811769;7032;7042.964785176041;7064.540804847668;7066.187388450394;6547.1161393213215;6664.400203981471;6665.866682666417;6765.594064356154;6775.559588626724;6492.415682588589;6522.412982831568;6536.444402225864;6603.867922641424;6638.137042184485;6706.6981985811735;6748.797536073926;6756;6757.594544327356;6764.120664313805;6094.177286066324;6180;6197.225346831646;6205.689715514297;6208.689565521796;6219.471344935731;6266.874662506633;6281.246250449975;6295.905561416674;6318.147050148355 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.5074626865671;305.1592861666111;309.048131754197;313.09671597441405;313.73959613520765;5521.806736764214;5591.189277554758;5615.606907516475;5689.487946084857;5754.884902301951;5572.749226284816;5615.326160860693;5647.745851436685;5650.350209725882;5650.74571644276;4188.664906807463;4291.549387314334;4338.97830510847;4342.413774140498;4351.891202719926;4267.935980960288;4302.827886884536;4307.009387840799;4308.590683885026;4311.504177019651;4262.957370426287;4265.189613973351;4267.423897773808;4268.914621707564;4269.765162916038;4257.787110644455;4262.46719160105;4266.466691663542;4270.871873843789;4278.614924656796;3638.890833275006;3711.6659500645073;3722.181120153562;3732.1602639406187;3736.9065773355883;5236.81671141512;5335.759890804923;5383.919241211385;5388.649737767033;5399.352077750656;4874.829380971649;4876.878078048042;4893.779779909913;4893.8776530586665;4897.7795999180125;5910.763569457216;5921.378255283176;5926.348101708809;5927.8221653350465;5934.970325148347;3890.2219556088894;4017.27689015977;4022.336314508132;4023.7786921719294;4026.617471340218;6138.539609529258;6183.474404675608;6215.906761398583;6218.22272215973;6220.720067596969;4126.690498212646;4134.64855487281;4143.295639741251;4146.875593732193;4147.52303485103;4198.748075115503;4200.4959404871615;4217.557156498524;4218;4226.640735537452;4726.976365118152;4787.210110331756;4838.298446725275;4855.6115510759055;4865.70805751656;5841.474267315962;5862.589618726648;5863.970680146572;5865.589408741433;5866.501347385435;1467.5890750589851;1468.3098943496539;1469.8236211654669;1475.3950880139307;1477.4311889922458;975.1272611013104;975.2198241406846;983.7147227304001;998.3410948773919;1003.3027046202965;5106.055379754757;5114.74426278692;5118.206677964921;5121.308623335802;5131.948680513147;6072.51419886408;6109.480694141048;6129.509639228941;6141.416565426277;6141.7543298268465;5102.974485127551;5117.309163262987;5117.385913690381;5120.283160357553;5128.230765385222;3228.80627162371;3298.7031167194586;3299.7855139416342;3327.93344133116;3327.93344133116;5691.9146212806845;5810.767569297181;5812.447817457335;5813.59304848665;5835.387284335084;6354.809355719336;6356.618602883749;6381.074744162163;6384.3934826191435;6385.6487893165395;5750.741216645261;5754.251947246831;5795.1017592273265;5796.304443466811;5808.477237048602;5970.313413957277;6167.784127555514;6180.8763824722355;6189.442950134509;6192.287886892885;6014.338422773579;6021.096835474714;6033.215681961317;6038.758449661965;6054.152418661479;5793.681347525927;5811.535077193899;5819.243498345188;5829.7085145743395;5830.941690583039;4065.4918135233097;4068.4914385701786;4095.8156882939743;4106.589341065869;4107.075907920694;6048.334683184934;6156.107364432043;6161.7843375483435;6194.535409844189;6198.969005154945;5938.940610593839;5938.940610594012;5939.970300148471;5952.226210592596;5952.851178720393;5919.526437885045;5922.526197904243;5923.911141332797;5936.901673190474;5944.256967879015;5642.971785141048;5739.598228123991;5789.102689083199;5801;5814;5945.881082378241;5955.5235581154275;5962.761489540543;5967.552433567413;5973.820785376446;5823.126531020381;5834.066549352084;5834.329052159056;5842.678652673973;5843.065109582446 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: |5;yui.html;772.6098320348227;777.1994845309333;778.0585491555217;780.7111368793547;789.7670187294746;11608.361540115291;11766.882331176686;11801.881981180186;11830.29018258903;11848.111391645629;11273.887261127386;11822.58620948267;11927.284362938208;11945.223560468563;11971.940140299286;797.9281864632196;812.2811311988903;814.4543156085437;815.3355015662246;818.5497976113144;785.6071964017991;788.787027502574;791.2878409431501;792.9968589733991;793.85710572097;834.4742812028413;837.6063250272363;841.6801615386175;842.6629348260683;845.7674139611626;830.6220669595319;831.3432388413146;831.5260301628074;832.1512057701171;834.3325339728193;620.0420350558353;620.3579295429254;621.2389822467442;622.6886556721639;622.6948795090373;11049.447527623586;11121.332720036824;11142.442877856074;11146.331220126818;11205.327680339124;10816.567337306498;11137.554497820078;11323.20737548372;11786.587469438615;11795.174337796358;9456.8581471278;9511.429314241168;9513.571889265;9575.425474471484;9613.51932403377;3268.852901619409;3341.448660970937;3346.6486018967903;3350.977951724723;3417.4019546579248;38098.23803523914;38975;39276.803615982026;39386;39502;9091.727248182566;9168.724938251864;9213.861792073125;9299.256059515223;9458.52707364629;15549.844501555066;15561.766573501407;15574.221288935509;15581.922090389475;15584.610384740245;6460;6478.1578394808375;6483.384078512534;6520.445762110179;6592.24189218246;3686.870959516404;3739.121306492972;3750.868719594801;3778.6599206071587;3783.129880127531;2798.0766347105405;2814.3386304218493;2820.0411859967708;2838.1485554333617;2839.531477306263;485.24786580800327;487.1620812203076;489.9730514821719;505.7445989775214;506.94170170430135;494.7056501381672;589.6904125334233;616.2881871438495;639.8432384065934;651.1372431528245;7863.803404914923;8151;8216.712415065444;8221.54781487012;8262.215089566602;505.40867185392443;604.1149715666481;623.7286780250605;624.2259598098416;625.6433832715309;3839.1745774658584;3912.4522566840665;3912.8434862605745;3913.0413048802657;3995.161016186575;52052.47947520476;52413;52491.21263181055;52546.47453525492;52627;44998;45456.77271613687;46624.7668761654;46810;46970.53029469662;43391.349129763075;48167.75916120397;48329.27506087411;48428.27357589639;48953.510464895604;8233.83532329362;8314;8334.666613335641;8472.110428404929;8476.406651534333;31920.52119218167;32141.35717285688;32249;32808.50787238241;33172.66827331696;36646;37052.073698157765;37888.81055594704;39375;42671.1465770689;10303.742406439898;10500.317479363817;10549.841752373874;10580.259381843198;10613.628523001658;11125.388103654377;11779.88220117788;11863.644090677293;12051.698707532381;12076.939615302219;11130.888691113309;11175.273607215506;11194.216404851582;11220.214584978972;11339.943300283447;10570;10639.308444951053;10892.128629709447;11207.49566269536;11243.875612439018;10984.615538456115;11012.449377530931;11090.334579924907;11095;11114;9302.209735588714;9426.481543515172;9506.47714375716;9604.615815367308;9700.27247956392;8966.775830604287;9027.548622568976;9150.267978561833;9194.223618253069;9546.90453095488 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,325 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: __startTimestamp1450079160604__endTimestamp 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:46:00 INFO - 2015-12-13 23:46:00,615 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4751.19 Median:4905.46 stddev:498.82 (10.2%) stddev-sans-first:473.31 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: Values: 2685.7 2755.9 2786.0 2801.5 2806.8 4551.5 4781.2 4836.2 4875.8 4905.5 4678.9 4700.1 4708.0 4726.1 4852.4 4467.4 4487.9 4507.4 4534.2 4534.5 4456.7 4496.7 4506.3 4509.5 4531.1 4157.5 4366.1 4471.7 4499.9 4527.5 4418.4 4428.5 4429.6 4441.4 4449.1 4193.3 4393.2 4419.4 4437.1 4448.1 4583.9 4630.7 4751.2 4753.4 4770.2 5167.5 5200.4 5207.9 5213.8 5266.7 4894.1 5013.6 5228.1 5230.6 5240.6 4748.0 4791.8 4810.3 4828.5 4862.1 5287.7 5362.5 5362.7 5365.1 5427.7 4834.6 4941.9 4963.1 5135.4 5145.6 5167.8 5184.9 5185.2 5201.5 5283.7 5104.1 5105.9 5111.1 5121.9 5150.8 4881.8 5022.0 5029.9 5105.5 5193.8 4272.9 4279.9 4291.8 4294.3 4316.8 3792.5 3799.8 3808.5 3819.5 3828.7 4258.6 4322.4 4353.8 4437.4 4476.1 5166.2 5175.8 5179.8 5180.5 5203.4 4245.4 4432.6 4439.4 4444.1 4475.8 4455.5 4456.0 4537.8 4558.9 4570.9 4852.5 4911.0 4912.9 4915.7 4945.2 4866.3 5076.9 5167.4 5168.4 5190.9 4863.0 4919.6 4944.7 4953.8 4976.6 5099.2 5144.4 5148.0 5154.4 5193.4 4904.2 5021.8 5026.8 5202.1 5211.8 4961.4 4970.0 4998.0 5089.5 5134.0 5002.1 5008.2 5010.8 5016.1 5053.0 4701.3 4916.8 4925.5 4935.2 4940.9 4969.0 4978.1 5037.4 5044.3 5085.6 4949.7 5016.7 5022.6 5028.8 5071.8 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38990.23 Median:18484.08 stddev:61209.35 (331.1%) stddev-sans-first:61313.11 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: Values: 579.6 580.3 588.7 590.8 624.1 34726.3 35310.0 35445.5 35490.1 35510.0 37035.8 37658.6 37728.6 37730.2 37801.6 7689.1 7869.8 7870.0 7873.2 7877.0 7562.9 7777.7 7785.1 7794.9 7801.1 7722.7 7765.2 7785.3 7793.6 7803.8 7764.3 7823.2 7840.0 7853.1 7862.7 7491.4 7503.0 7579.3 7585.4 7616.9 33724.2 34158.3 34240.5 34249.8 34259.0 3015.2 3058.8 3209.9 3395.8 3406.6 27522.3 28123.4 28208.4 28342.9 28377.7 3344.0 3390.7 3477.7 3483.3 3519.0 215492.0 219207.0 219388.0 220356.0 220764.9 51193.0 54313.7 54677.5 54816.0 54845.7 45217.8 57877.1 57940.7 58036.0 58456.0 13972.2 14043.4 14092.3 14242.9 14260.0 10645.1 10743.3 10749.6 10794.3 10827.8 18467.8 19074.8 19103.5 19184.8 19209.8 7481.1 7694.0 7764.8 7809.1 7840.1 870.5 947.6 1045.8 1062.9 1071.9 25831.6 25869.4 26012.5 26085.0 26212.0 906.8 958.3 960.1 961.1 1068.0 12086.6 12156.5 12203.8 12211.9 12278.8 270429.0 273831.0 274555.0 274726.0 275418.0 44857.8 45283.0 45307.0 45532.0 45589.0 1217.2 1225.1 1233.8 1262.0 1263.6 23523.0 25358.9 25834.6 25998.4 26255.0 36294.5 36593.6 36652.1 36700.4 36893.6 204893.0 206215.0 207418.0 207499.0 207768.0 28363.7 28487.4 29354.7 29609.3 29609.9 34184.5 34703.6 36837.8 36846.4 37019.3 30636.5 31223.0 31564.9 31970.2 32233.2 31802.8 31885.0 32058.7 32110.4 32176.7 31420.4 32696.8 33412.0 33624.2 33673.7 25502.2 28853.1 29433.6 29451.3 29635.4 22837.3 22852.7 22934.0 23304.2 23324.7 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26444.35 Median:23581.68 stddev:82818.68 (351.2%) stddev-sans-first:83027.79 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: Values: 329.2 333.0 333.4 333.9 336.0 15016.8 15506.9 16139.9 16239.8 16689.5 10174.9 10261.9 10277.7 12328.0 13939.6 4548.6 4662.5 4670.3 4678.5 4946.5 5054.2 5086.5 5088.9 5097.1 5101.0 4945.9 5058.8 5072.7 5088.7 5103.0 5060.6 5082.5 5089.6 5095.2 5316.7 5162.5 5327.8 5330.7 5330.9 5353.1 11455.3 11612.5 17458.4 18853.0 18859.2 1688.2 1775.6 1884.1 1886.4 1907.0 8990.0 9209.0 9230.3 9692.2 12925.5 1692.2 1739.0 1747.4 1751.6 1775.1 53717.5 56645.7 56759.4 57349.0 58325.0 9266.4 9424.8 9524.9 9566.1 9654.3 11934.1 11943.1 11951.7 11975.8 11985.3 7196.7 7218.6 7233.5 7260.1 7308.9 7111.2 7135.0 7164.4 7172.8 7205.6 3949.4 3975.1 4004.6 4017.8 4022.8 1634.4 1736.3 1791.2 1809.4 1833.7 365.1 370.0 378.4 384.2 759.1 9767.3 10164.6 10342.7 10353.2 10394.1 892.7 893.6 914.9 961.2 995.1 8880.2 8958.3 8961.1 9179.5 9272.7 485607.0 493510.0 517244.0 517307.0 519232.0 70906.0 73323.6 73913.3 74253.3 74572.0 1093.7 1101.4 1167.6 1189.4 1199.4 14987.6 15063.8 15096.2 15127.2 15350.8 30697.0 31218.5 32407.8 32766.2 33113.7 35415.5 36936.6 38575.4 43140.6 44064.3 8417.1 8659.5 8687.7 8770.1 8773.3 10276.7 15832.8 16206.3 16637.6 16689.4 8564.4 8815.0 8848.4 9411.0 13846.2 9156.8 9464.0 9556.5 9619.7 9975.6 9779.8 9991.2 10039.7 10114.9 10144.0 14162.5 14524.3 14542.8 14648.9 14743.3 15149.9 15263.9 15293.4 15517.3 15559.6 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,617 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5068.20 Median:6301.17 stddev:2622.35 (41.6%) stddev-sans-first:2616.12 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: Values: 1516.3 1591.4 1681.5 1690.6 1723.9 5963.5 6044.0 7068.8 7595.2 7618.2 6845.0 7084.9 7130.7 7133.9 7143.1 2090.3 2123.8 2128.9 2140.4 2140.5 2065.7 2105.1 2128.9 2139.7 2141.1 2145.6 2146.6 2165.8 2168.2 2190.2 2121.1 2143.8 2144.1 2144.2 2147.4 2078.8 2176.1 2177.1 2178.1 2183.5 7286.1 7310.1 7366.2 7366.4 7383.0 4250.4 4327.8 4334.9 4361.4 4361.8 2661.7 2664.8 2744.2 2749.2 2763.2 851.4 873.8 875.9 903.1 905.6 9603.5 9626.5 9651.0 9683.7 9711.3 3939.3 3943.7 3991.8 4009.6 4013.0 8393.7 8397.4 8405.1 8409.2 8431.1 4321.6 4343.6 4367.1 4374.1 4385.8 3375.7 3451.4 3833.5 3978.8 3993.1 3463.8 3475.7 3488.5 3499.3 3529.3 1041.2 1059.0 1080.1 1094.8 1095.9 996.1 1010.9 1012.2 1013.2 1013.8 6575.0 6606.1 6632.2 6675.9 6697.7 444.8 445.2 1120.5 1142.3 1147.9 5155.8 5168.0 5184.6 5186.7 5249.3 8562.4 8745.5 8746.8 8764.5 8817.9 8465.5 8689.9 8711.8 8732.6 8748.2 6866.9 6964.4 6967.8 7007.6 7014.3 6444.5 6453.4 6502.3 6584.6 6828.2 7573.4 7632.9 7680.3 7719.7 7965.9 7938.2 8052.8 8069.5 8084.7 8093.7 6042.5 6306.4 6311.1 6513.6 6616.6 7009.2 7032.0 7043.0 7064.5 7066.2 6547.1 6664.4 6665.9 6765.6 6775.6 6492.4 6522.4 6536.4 6603.9 6638.1 6706.7 6748.8 6756.0 6757.6 6764.1 6094.2 6180.0 6197.2 6205.7 6208.7 6219.5 6266.9 6281.2 6295.9 6318.1 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4875.22 Median:5629.29 stddev:1462.50 (26.0%) stddev-sans-first:1425.68 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: Values: 298.5 305.2 309.0 313.1 313.7 5521.8 5591.2 5615.6 5689.5 5754.9 5572.7 5615.3 5647.7 5650.4 5650.7 4188.7 4291.5 4339.0 4342.4 4351.9 4267.9 4302.8 4307.0 4308.6 4311.5 4263.0 4265.2 4267.4 4268.9 4269.8 4257.8 4262.5 4266.5 4270.9 4278.6 3638.9 3711.7 3722.2 3732.2 3736.9 5236.8 5335.8 5383.9 5388.6 5399.4 4874.8 4876.9 4893.8 4893.9 4897.8 5910.8 5921.4 5926.3 5927.8 5935.0 3890.2 4017.3 4022.3 4023.8 4026.6 6138.5 6183.5 6215.9 6218.2 6220.7 4126.7 4134.6 4143.3 4146.9 4147.5 4198.7 4200.5 4217.6 4218.0 4226.6 4727.0 4787.2 4838.3 4855.6 4865.7 5841.5 5862.6 5864.0 5865.6 5866.5 1467.6 1468.3 1469.8 1475.4 1477.4 975.1 975.2 983.7 998.3 1003.3 5106.1 5114.7 5118.2 5121.3 5131.9 6072.5 6109.5 6129.5 6141.4 6141.8 5103.0 5117.3 5117.4 5120.3 5128.2 3228.8 3298.7 3299.8 3327.9 3327.9 5691.9 5810.8 5812.4 5813.6 5835.4 6354.8 6356.6 6381.1 6384.4 6385.6 5750.7 5754.3 5795.1 5796.3 5808.5 5970.3 6167.8 6180.9 6189.4 6192.3 6014.3 6021.1 6033.2 6038.8 6054.2 5793.7 5811.5 5819.2 5829.7 5830.9 4065.5 4068.5 4095.8 4106.6 4107.1 6048.3 6156.1 6161.8 6194.5 6199.0 5938.9 5938.9 5940.0 5952.2 5952.9 5919.5 5922.5 5923.9 5936.9 5944.3 5643.0 5739.6 5789.1 5801.0 5814.0 5945.9 5955.5 5962.8 5967.6 5973.8 5823.1 5834.1 5834.3 5842.7 5843.1 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12612.98 Median:47569.14 stddev:14441.24 (30.4%) stddev-sans-first:14454.38 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: Values: 772.6 777.2 778.1 780.7 789.8 11608.4 11766.9 11801.9 11830.3 11848.1 11273.9 11822.6 11927.3 11945.2 11971.9 797.9 812.3 814.5 815.3 818.5 785.6 788.8 791.3 793.0 793.9 834.5 837.6 841.7 842.7 845.8 830.6 831.3 831.5 832.2 834.3 620.0 620.4 621.2 622.7 622.7 11049.4 11121.3 11142.4 11146.3 11205.3 10816.6 11137.6 11323.2 11786.6 11795.2 9456.9 9511.4 9513.6 9575.4 9613.5 3268.9 3341.4 3346.6 3351.0 3417.4 38098.2 38975.0 39276.8 39386.0 39502.0 9091.7 9168.7 9213.9 9299.3 9458.5 15549.8 15561.8 15574.2 15581.9 15584.6 6460.0 6478.2 6483.4 6520.4 6592.2 3686.9 3739.1 3750.9 3778.7 3783.1 2798.1 2814.3 2820.0 2838.1 2839.5 485.2 487.2 490.0 505.7 506.9 494.7 589.7 616.3 639.8 651.1 7863.8 8151.0 8216.7 8221.5 8262.2 505.4 604.1 623.7 624.2 625.6 3839.2 3912.5 3912.8 3913.0 3995.2 52052.5 52413.0 52491.2 52546.5 52627.0 44998.0 45456.8 46624.8 46810.0 46970.5 43391.3 48167.8 48329.3 48428.3 48953.5 8233.8 8314.0 8334.7 8472.1 8476.4 31920.5 32141.4 32249.0 32808.5 33172.7 36646.0 37052.1 37888.8 39375.0 42671.1 10303.7 10500.3 10549.8 10580.3 10613.6 11125.4 11779.9 11863.6 12051.7 12076.9 11130.9 11175.3 11194.2 11220.2 11339.9 10570.0 10639.3 10892.1 11207.5 11243.9 10984.6 11012.4 11090.3 11095.0 11114.0 9302.2 9426.5 9506.5 9604.6 9700.3 8966.8 9027.5 9150.3 9194.2 9546.9 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:46:00 INFO - 2015-12-13 23:46:00,619 DEBUG : BROWSER_OUTPUT: 23:46:01 INFO - 2015-12-13 23:46:01,342 INFO : Browser exited with error code: 0 23:46:01 INFO - 2015-12-13 23:46:01,363 INFO : Completed test dromaeo_css (00:18:33) 23:46:01 INFO - 2015-12-13 23:46:01,363 INFO : Starting test kraken 23:46:01 INFO - 2015-12-13 23:46:01,363 DEBUG : operating with platform_type : linux_ 23:46:01 INFO - 2015-12-13 23:46:01,363 INFO : Initialising browser for kraken test... 23:46:01 INFO - 2015-12-13 23:46:01,369 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS1sClM/profile http://localhost:37187/getInfo.html 23:46:05 INFO - 2015-12-13 23:46:05,529 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:46:05 INFO - 2015-12-13 23:46:05,529 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:46:05 INFO - 2015-12-13 23:46:05,529 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:46:05 INFO - 2015-12-13 23:46:05,529 DEBUG : BROWSER_OUTPUT: __metrics 23:46:05 INFO - 2015-12-13 23:46:05,617 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] 23:46:06 INFO - 2015-12-13 23:46:06,545 INFO : Browser initialized. 23:46:06 INFO - 2015-12-13 23:46:06,546 INFO : Running cycle 1/1 for kraken test... 23:46:06 INFO - 2015-12-13 23:46:06,546 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS1sClM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:46:18 INFO - 2015-12-13 23:46:18,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 143261696 23:46:18 INFO - 2015-12-13 23:46:18,622 DEBUG : BROWSER_OUTPUT: 23:46:21 INFO - 2015-12-13 23:46:21,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37187/tests/kraken/driver.html?testName=audio-beat-detection) 23:46:21 INFO - 2015-12-13 23:46:21,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 144318464 23:46:21 INFO - 2015-12-13 23:46:21,806 DEBUG : BROWSER_OUTPUT: 23:46:24 INFO - 2015-12-13 23:46:24,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37187/tests/kraken/driver.html?testName=audio-dft) 23:46:25 INFO - 2015-12-13 23:46:25,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 143634432 23:46:25 INFO - 2015-12-13 23:46:25,156 DEBUG : BROWSER_OUTPUT: 23:46:28 INFO - 2015-12-13 23:46:28,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37187/tests/kraken/driver.html?testName=audio-fft) 23:46:28 INFO - 2015-12-13 23:46:28,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 137998336 23:46:28 INFO - 2015-12-13 23:46:28,624 DEBUG : BROWSER_OUTPUT: 23:46:30 INFO - 2015-12-13 23:46:30,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37187/tests/kraken/driver.html?testName=audio-oscillator) 23:46:31 INFO - 2015-12-13 23:46:31,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 139104256 23:46:31 INFO - 2015-12-13 23:46:31,280 DEBUG : BROWSER_OUTPUT: 23:46:33 INFO - 2015-12-13 23:46:33,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37187/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:46:34 INFO - 2015-12-13 23:46:34,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 140636160 23:46:34 INFO - 2015-12-13 23:46:34,102 DEBUG : BROWSER_OUTPUT: 23:46:37 INFO - 2015-12-13 23:46:37,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37187/tests/kraken/driver.html?testName=imaging-darkroom) 23:46:37 INFO - 2015-12-13 23:46:37,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 141242368 23:46:37 INFO - 2015-12-13 23:46:37,796 DEBUG : BROWSER_OUTPUT: 23:46:41 INFO - 2015-12-13 23:46:41,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37187/tests/kraken/driver.html?testName=imaging-desaturate) 23:46:41 INFO - 2015-12-13 23:46:41,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 138915840 23:46:41 INFO - 2015-12-13 23:46:41,877 DEBUG : BROWSER_OUTPUT: 23:46:44 INFO - 2015-12-13 23:46:44,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37187/tests/kraken/driver.html?testName=json-parse-financial) 23:46:45 INFO - 2015-12-13 23:46:45,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 23:46:45 INFO - 2015-12-13 23:46:45,356 DEBUG : BROWSER_OUTPUT: 23:46:47 INFO - 2015-12-13 23:46:47,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37187/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:46:47 INFO - 2015-12-13 23:46:47,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 140521472 23:46:47 INFO - 2015-12-13 23:46:47,681 DEBUG : BROWSER_OUTPUT: 23:46:49 INFO - 2015-12-13 23:46:49,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:46:50 INFO - 2015-12-13 23:46:50,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 139804672 23:46:50 INFO - 2015-12-13 23:46:50,185 DEBUG : BROWSER_OUTPUT: 23:46:52 INFO - 2015-12-13 23:46:52,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:46:52 INFO - 2015-12-13 23:46:52,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 140800000 23:46:52 INFO - 2015-12-13 23:46:52,919 DEBUG : BROWSER_OUTPUT: 23:46:55 INFO - 2015-12-13 23:46:55,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:46:56 INFO - 2015-12-13 23:46:56,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 140771328 23:46:56 INFO - 2015-12-13 23:46:56,096 DEBUG : BROWSER_OUTPUT: 23:46:58 INFO - 2015-12-13 23:46:58,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:46:59 INFO - 2015-12-13 23:46:59,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 140546048 23:46:59 INFO - 2015-12-13 23:46:59,292 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37187/tests/kraken/driver.html?testName=ai-astar) 23:47:01 INFO - 2015-12-13 23:47:01,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 140529664 23:47:01 INFO - 2015-12-13 23:47:01,327 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,327 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:47:01 INFO - 2015-12-13 23:47:01,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;112;111;114;124;113;112;113;112 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;130;155;163;138;151;154;145;177;134 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;164;164;162;166;164;163;165;161 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;72;138;72;78;73;72;91 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;130;95;95;94;133;95;95;136 23:47:01 INFO - 2015-12-13 23:47:01,328 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;109;110;110;110;110 23:47:01 INFO - 2015-12-13 23:47:01,329 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;149;147;148;148;148;147;149;147 23:47:01 INFO - 2015-12-13 23:47:01,329 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;95;96;95;96;96;95 23:47:01 INFO - 2015-12-13 23:47:01,329 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;71;73;71;73;72;72;80;70;72 23:47:01 INFO - 2015-12-13 23:47:01,329 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;68;68;68;69;69;68 23:47:01 INFO - 2015-12-13 23:47:01,329 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;86;94;87;84;86;86;85;84 23:47:01 INFO - 2015-12-13 23:47:01,329 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;128;123;131;131;134;124;120;126 23:47:01 INFO - 2015-12-13 23:47:01,329 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;150;151;143;141;136;148;151;147;147 23:47:01 INFO - 2015-12-13 23:47:01,330 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;73;70;71;70;69;71;70;70 23:47:01 INFO - 2015-12-13 23:47:01,330 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:47:01 INFO - 2015-12-13 23:47:01,330 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:47:01 INFO - 2015-12-13 23:47:01,330 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,784 23:47:01 INFO - 2015-12-13 23:47:01,330 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:47:01 INFO - 2015-12-13 23:47:01,330 DEBUG : BROWSER_OUTPUT: __startTimestamp1450079221322__endTimestamp 23:47:01 INFO - 2015-12-13 23:47:01,330 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,332 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:47:01 INFO - 2015-12-13 23:47:01,332 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:47:01 INFO - 2015-12-13 23:47:01,332 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,332 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.14 (3.7%) stddev-sans-first:4.38 23:47:01 INFO - 2015-12-13 23:47:01,333 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 112.0 111.0 114.0 124.0 113.0 112.0 113.0 112.0 23:47:01 INFO - 2015-12-13 23:47:01,333 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,333 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:152.50 stddev:14.01 (9.2%) stddev-sans-first:14.85 23:47:01 INFO - 2015-12-13 23:47:01,333 DEBUG : BROWSER_OUTPUT: Values: 151.0 130.0 155.0 163.0 138.0 151.0 154.0 145.0 177.0 134.0 23:47:01 INFO - 2015-12-13 23:47:01,333 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,333 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:1.51 (0.9%) stddev-sans-first:1.50 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 164.0 164.0 162.0 166.0 164.0 163.0 165.0 161.0 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:72.00 stddev:20.84 (28.9%) stddev-sans-first:21.83 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 72.0 138.0 72.0 78.0 73.0 72.0 91.0 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:18.55 (19.5%) stddev-sans-first:19.14 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 130.0 95.0 95.0 94.0 133.0 95.0 95.0 136.0 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,334 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 149.0 147.0 148.0 148.0 148.0 147.0 149.0 147.0 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.50 stddev:2.78 (3.8%) stddev-sans-first:2.92 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 73.0 71.0 73.0 72.0 72.0 80.0 70.0 72.0 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,335 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 68.0 68.0 68.0 69.0 69.0 68.0 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:3.06 (3.6%) stddev-sans-first:3.04 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 86.0 94.0 87.0 84.0 86.0 86.0 85.0 84.0 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.00 stddev:4.61 (3.6%) stddev-sans-first:4.75 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 128.0 123.0 131.0 131.0 134.0 124.0 120.0 126.0 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:147.50 stddev:5.41 (3.7%) stddev-sans-first:5.07 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: Values: 138.0 150.0 151.0 143.0 141.0 136.0 148.0 151.0 147.0 147.0 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 73.0 70.0 71.0 70.0 69.0 71.0 70.0 70.0 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:47:01 INFO - 2015-12-13 23:47:01,336 DEBUG : BROWSER_OUTPUT: 23:47:02 INFO - 2015-12-13 23:47:02,242 INFO : Browser exited with error code: 0 23:47:02 INFO - 2015-12-13 23:47:02,297 INFO : Completed test kraken (00:01:00) 23:47:02 INFO - 2015-12-13 23:47:02,297 INFO : Starting test v8_7 23:47:02 INFO - 2015-12-13 23:47:02,297 DEBUG : operating with platform_type : linux_ 23:47:02 INFO - 2015-12-13 23:47:02,297 INFO : Initialising browser for v8_7 test... 23:47:02 INFO - 2015-12-13 23:47:02,303 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdIBHy3/profile http://localhost:37187/getInfo.html 23:47:06 INFO - 2015-12-13 23:47:06,520 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:47:06 INFO - 2015-12-13 23:47:06,520 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:47:06 INFO - 2015-12-13 23:47:06,520 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:47:06 INFO - 2015-12-13 23:47:06,520 DEBUG : BROWSER_OUTPUT: __metrics 23:47:06 INFO - 2015-12-13 23:47:06,624 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] 23:47:07 INFO - 2015-12-13 23:47:07,517 INFO : Browser initialized. 23:47:07 INFO - 2015-12-13 23:47:07,518 INFO : Running cycle 1/1 for v8_7 test... 23:47:07 INFO - 2015-12-13 23:47:07,518 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdIBHy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:47:19 INFO - 2015-12-13 23:47:19,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 143122432 23:47:19 INFO - 2015-12-13 23:47:19,512 DEBUG : BROWSER_OUTPUT: 23:47:40 INFO - 2015-12-13 23:47:40,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37187/tests/v8_7/run.html (next: http://localhost:37187/tests/v8_7/run.html) 23:47:41 INFO - 2015-12-13 23:47:41,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 137871360 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: |0;Richards;166.6944490748458 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;181.32366273798732 23:47:41 INFO - 2015-12-13 23:47:41,236 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 23:47:41 INFO - 2015-12-13 23:47:41,237 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 23:47:41 INFO - 2015-12-13 23:47:41,237 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 23:47:41 INFO - 2015-12-13 23:47:41,237 DEBUG : BROWSER_OUTPUT: |5;Earley;716.3323782234957 23:47:41 INFO - 2015-12-13 23:47:41,237 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 23:47:41 INFO - 2015-12-13 23:47:41,237 DEBUG : BROWSER_OUTPUT: |7;RegExp;26473.684210526317 23:47:41 INFO - 2015-12-13 23:47:41,237 DEBUG : BROWSER_OUTPUT: |8;Splay;595.1393005334915 23:47:41 INFO - 2015-12-13 23:47:41,237 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 23:47:41 INFO - 2015-12-13 23:47:41,238 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:47:41 INFO - 2015-12-13 23:47:41,238 DEBUG : BROWSER_OUTPUT: __startTimestamp1450079261228__endTimestamp 23:47:41 INFO - 2015-12-13 23:47:41,238 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,238 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:47:41 INFO - 2015-12-13 23:47:41,239 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:47:41 INFO - 2015-12-13 23:47:41,239 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,239 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.69 Median:166.69 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,239 DEBUG : BROWSER_OUTPUT: Values: 166.7 23:47:41 INFO - 2015-12-13 23:47:41,239 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,240 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:181.32 Median:181.32 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,240 DEBUG : BROWSER_OUTPUT: Values: 181.3 23:47:41 INFO - 2015-12-13 23:47:41,240 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,240 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,241 DEBUG : BROWSER_OUTPUT: Values: 277.6 23:47:41 INFO - 2015-12-13 23:47:41,241 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,241 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,241 DEBUG : BROWSER_OUTPUT: Values: 5208.3 23:47:41 INFO - 2015-12-13 23:47:41,241 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,242 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,242 DEBUG : BROWSER_OUTPUT: Values: 1063.8 23:47:41 INFO - 2015-12-13 23:47:41,242 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,242 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,242 DEBUG : BROWSER_OUTPUT: Values: 716.3 23:47:41 INFO - 2015-12-13 23:47:41,243 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,243 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,243 DEBUG : BROWSER_OUTPUT: Values: 12280.5 23:47:41 INFO - 2015-12-13 23:47:41,243 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,244 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26473.68 Median:26473.68 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,244 DEBUG : BROWSER_OUTPUT: Values: 26473.7 23:47:41 INFO - 2015-12-13 23:47:41,244 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,244 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.14 Median:595.14 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,244 DEBUG : BROWSER_OUTPUT: Values: 595.1 23:47:41 INFO - 2015-12-13 23:47:41,245 DEBUG : BROWSER_OUTPUT: 23:47:41 INFO - 2015-12-13 23:47:41,245 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:47:41 INFO - 2015-12-13 23:47:41,245 DEBUG : BROWSER_OUTPUT: Values: 4830.9 23:47:41 INFO - 2015-12-13 23:47:41,245 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:47:41 INFO - 2015-12-13 23:47:41,245 DEBUG : BROWSER_OUTPUT: 23:47:42 INFO - 2015-12-13 23:47:42,145 INFO : Browser exited with error code: 0 23:47:42 INFO - 2015-12-13 23:47:42,162 INFO : Completed test v8_7 (00:00:39) 23:47:42 INFO - 2015-12-13 23:47:42,247 INFO : Completed test suite (00:20:14) 23:47:42 INFO - 2015-12-13 23:47:42,247 DEBUG : Working with test: dromaeo_css 23:47:42 INFO - 2015-12-13 23:47:42,247 DEBUG : Generating results file: dromaeo_css 23:47:42 INFO - 2015-12-13 23:47:42,248 DEBUG : Working with test: kraken 23:47:42 INFO - 2015-12-13 23:47:42,248 DEBUG : Generating results file: kraken 23:47:42 INFO - 2015-12-13 23:47:42,248 INFO : javascript benchmark 23:47:42 INFO - 2015-12-13 23:47:42,249 DEBUG : Working with test: v8_7 23:47:42 INFO - 2015-12-13 23:47:42,249 DEBUG : Generating results file: v8_7 23:47:42 INFO - 2015-12-13 23:47:42,249 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:47:42 INFO - 2015-12-13 23:47:42,300 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 23:47:42 INFO - 2015-12-13 23:47:42,300 DEBUG : process_Request line: dromaeo_css 6357.84 graph.html#tests=[[72,132,43]] 23:47:42 INFO - 2015-12-13 23:47:42,300 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:47:42 INFO - 2015-12-13 23:47:42,332 DEBUG : process_Request line: kraken 1536.40 graph.html#tests=[[232,132,43]] 23:47:42 INFO - 2015-12-13 23:47:42,332 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:47:42 INFO - 2015-12-13 23:47:42,363 DEBUG : process_Request line: v8_7 21389.42 graph.html#tests=[[230,132,43]] 23:47:42 INFO - 2015-12-13 23:47:42,364 INFO : javascript benchmark 23:47:42 INFO - 2015-12-13 23:47:42,368 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2685.731426857314, 2755.9035433759796, 2785.9860700696495, 2801.4817258807116, 2806.817556858804, 4551.544845515455, 4781.235002399617, 4836.153673107206, 4875.829345972892, 4905.460399356068, 4678.85963421097, 4700.083483720676, 4708.0, 4726.102040612282, 4852.417709874811, 4467.396901418299, 4487.910241795162, 4507.3689683444345, 4534.229181039232, 4534.546545345472, 4456.732596044231, 4496.6627502937245, 4506.346579745935, 4509.503954564995, 4531.071130418273, 4157.542670306264, 4366.08312254427, 4471.709338892994, 4499.887502812423, 4527.547245275463, 4418.447694038246, 4428.512863585003, 4429.579189976947, 4441.444819397575, 4449.1101779644205, 4193.308104162809, 4393.187260356813, 4419.4033805436175, 4437.090396468716, 4448.065906159678, 4583.862484125481, 4630.675852690313, 4751.239801631722, 4753.3582966299455, 4770.189067858472, 5167.509086636764, 5200.401953775327, 5207.9479205207845, 5213.843584692465, 5266.683998960075, 4894.070126675921, 5013.573846223076, 5228.08508511009, 5230.555402790767, 5240.606954478391, 4747.95252047482, 4791.808327666924, 4810.302506136591, 4828.493008234155, 4862.124817532878, 5287.735613219324, 5362.517373436332, 5362.731863406814, 5365.061114304981, 5427.728613569306, 4834.564889159992, 4941.851744447672, 4963.106640804617, 5135.35808023997, 5145.588352931756, 5167.767450464738, 5184.948150518447, 5185.170372740344, 5201.45384734605, 5283.656562323436, 5104.081265372194, 5105.897882042338, 5111.0577980367225, 5121.897562048738, 5150.768215430315, 4881.828361193288, 5021.974890125599, 5029.949700503022, 5105.540501354896, 5193.792248310101, 4272.87181384559, 4279.87160385189, 4291.806868690916, 4294.26997410441, 4316.805743741539, 3792.50697409335, 3799.848006079781, 3808.504894363715, 3819.52255968004, 3828.655421012122, 4258.638015768633, 4322.351647252937, 4353.847615333448, 4437.378766972626, 4476.149531588988, 5166.199239117943, 5175.792968281226, 5179.81870634526, 5180.481951804864, 5203.427622961472, 4245.426867372927, 4432.601065904084, 4439.42287502629, 4444.066745983379, 4475.820967161277, 4455.509893911667, 4456.041950980555, 4537.8411755588395, 4558.908821823545, 4570.9314360284625, 4852.514748525119, 4911.0, 4912.8771780705765, 4915.705057696549, 4945.233488809168, 4866.270059491105, 5076.873078173076, 5167.405748338839, 5168.405633352213, 5190.8961820762615, 4863.0, 4919.581835544019, 4944.653874228769, 4953.801847926043, 4976.576990955809, 5099.158638824701, 5144.408393034699, 5148.0, 5154.355705536808, 5193.350831146106, 4904.215325547895, 5021.799128034984, 5026.824061157842, 5202.063628546898, 5211.817586384458, 4961.355023846877, 4970.0, 4997.9750101249265, 5089.541941225308, 5134.0, 5002.149634562206, 5008.223725322581, 5010.849674509771, 5016.07202667493, 5053.0399224147295, 4701.341812146234, 4916.7541622918, 4925.48282430354, 4935.1856943605335, 4940.8764780880765, 4969.0, 4978.1288274552535, 5037.445880953165, 5044.268581055653, 5085.5931525477135, 4949.678270912379, 5016.673916195436, 5022.573081288131, 5028.773705183203, 5071.822486212965], "unit": "ms", "name": "dojo.html", "value": 4720.418628765198}, {"lowerIsBetter": false, "replicates": [579.6174524813624, 580.3268208877703, 588.6997631208085, 590.7548367427516, 624.1386886097185, 34726.305473890505, 35310.0, 35445.46831797522, 35490.11274718133, 35510.0, 37035.81482092592, 37658.623413765854, 37728.62271377286, 37730.24539509215, 37801.621983780155, 7689.115751688558, 7869.763907082796, 7870.0, 7873.212678732109, 7876.960615196916, 7562.924370756305, 7777.650005749755, 7785.1436342002335, 7794.883076753853, 7801.063872335328, 7722.652480638385, 7765.223477652246, 7785.299323060924, 7793.649285782153, 7803.843923121534, 7764.3012128908385, 7823.2176782321885, 7840.0, 7853.136155022943, 7862.72480463181, 7491.363234125106, 7502.962485187593, 7579.279968402993, 7585.355244804198, 7616.885746713804, 33724.15689607755, 34158.316833663186, 34240.48639270413, 34249.82875085609, 34259.0, 3015.2461884528866, 3058.8011779234503, 3209.935801283961, 3395.7622966392364, 3406.5741782277214, 27522.311942201606, 28123.437531249467, 28208.43583128326, 28342.858285708644, 28377.716222837713, 3343.997939716886, 3390.728741700683, 3477.669621385964, 3483.268513612119, 3518.9648103518894, 215492.0, 219207.0, 219388.0, 220356.0, 220764.8961755197, 51193.0, 54313.72843135759, 54677.45322546803, 54816.0, 54845.72577137089, 45217.773911130236, 57877.13184302239, 57940.71029644825, 58036.0, 58456.0, 13972.161670299814, 14043.438262469386, 14092.295385230698, 14242.928785356007, 14260.0, 10645.148388128931, 10743.301685390425, 10749.623763168407, 10794.298370606042, 10827.78344433107, 18467.81532184688, 19074.760140591094, 19103.52241193981, 19184.80815191858, 19209.8079019208, 7481.102267727799, 7694.0, 7764.844703105906, 7809.140994490602, 7840.098388685375, 870.4777133719717, 947.6067432015774, 1045.7751583409604, 1062.8777690565685, 1071.8820929697727, 25831.61252581213, 25869.353266168495, 26012.479750405266, 26085.0, 26212.0, 906.8413027720254, 958.2956526952685, 960.078324808192, 961.1205746741792, 1067.9946600266949, 12086.637400877988, 12156.5137394505, 12203.816942745865, 12211.877881221251, 12278.815817762741, 270429.0, 273831.0, 274555.0, 274726.0, 275418.0, 44857.775711121234, 45283.0, 45307.0, 45532.0, 45589.0, 1217.2270608163703, 1225.1117939493795, 1233.8149277608252, 1261.9684507887375, 1263.6335462715892, 23523.0, 25358.873205633852, 25834.612480812426, 25998.35004124912, 26255.0, 36294.45558316575, 36593.63406366009, 36652.083697907765, 36700.44949325709, 36893.63106368902, 204893.0, 206215.0, 207418.0, 207499.0, 207768.0, 28363.71636283611, 28487.43025139527, 29354.70645293605, 29609.259768505097, 29609.85195074097, 34184.48723269203, 34703.62578888751, 36837.81581092077, 36846.44730328993, 37019.25961480809, 30636.540451893685, 31223.0, 31564.937816215686, 31970.20074498156, 32233.194170145933, 31802.840985795847, 31885.0, 32058.67941320557, 32110.357792843544, 32176.678233217368, 31420.371592567564, 32696.83651581822, 33412.0, 33624.1593960153, 33673.663263368035, 25502.212124835645, 28853.134405967856, 29433.558496622994, 29451.263718407212, 29635.407291854473, 22837.31488055361, 22852.65721014153, 22934.0, 23304.184353547545, 23324.65013024772], "unit": "ms", "name": "ext.html", "value": 16525.249021101787}, {"lowerIsBetter": false, "replicates": [329.16064036706393, 332.9583802024747, 333.40653636526974, 333.8764657076881, 336.00709902238884, 15016.774748378783, 15506.922465387672, 16139.919300403511, 16239.756403653955, 16689.49931502057, 10174.949125254363, 10261.948690256557, 10277.743056423593, 12328.0, 13939.581812545639, 4548.636109111271, 4662.487126416091, 4670.322803193535, 4678.508756580561, 4946.505349465061, 5054.1913293872985, 5086.499482652626, 5088.92366614501, 5097.057044446789, 5100.974495127519, 4945.851624451254, 5058.848234552969, 5072.74636268187, 5088.745562721868, 5103.030424219405, 5060.645754797166, 5082.466341034212, 5089.618278629117, 5095.159298715707, 5316.680999140064, 5162.457941916082, 5327.840164795062, 5330.653507521999, 5330.92003619946, 5353.063213937546, 11455.312681239153, 11612.477438515287, 17458.388956386592, 18853.0, 18859.245630174777, 1688.1812321024292, 1775.6448710258, 1884.105050101191, 1886.4057821786093, 1906.9713954290696, 8990.0, 9208.953955230249, 9230.261579073725, 9692.22462203022, 12925.54760583375, 1692.1724537499595, 1738.9652206955916, 1747.4146161035942, 1751.5708651380367, 1775.0680892531395, 53717.46282537164, 56645.71677141588, 56759.43240567583, 57349.0, 58325.0, 9266.44401335922, 9424.764380890532, 9524.90475095254, 9566.091221333962, 9654.27592930533, 11934.104942129376, 11943.104267179997, 11951.701207469883, 11975.760484790255, 11985.28088314704, 7196.676149573282, 7218.602976836324, 7233.45749068822, 7260.092488438945, 7308.853822923618, 7111.217766045731, 7134.964325178445, 7164.355208031302, 7172.784816455514, 7205.639718014183, 3949.3878448840474, 3975.1056012397557, 4004.5594984551676, 4017.8392864285684, 4022.7988600569856, 1634.3952737486968, 1736.314155908409, 1791.1581556668345, 1809.4481183238975, 1833.697439922398, 365.07089457331153, 369.990750231241, 378.3889019233972, 384.21044753032226, 759.1118391481868, 9767.267454940908, 10164.593416263267, 10342.689719308433, 10353.223508236912, 10394.064534191959, 892.723255790707, 893.5710858787688, 914.9085091490798, 961.1974001708512, 995.1143482300758, 8880.200781929658, 8958.328125390623, 8961.148690874486, 9179.541022948826, 9272.72181834546, 485607.0, 493510.0, 517244.0, 517307.0, 519232.0, 70906.0, 73323.63338183275, 73913.26086739171, 74253.25746742463, 74572.0, 1093.699232710995, 1101.399737143275, 1167.5855071449514, 1189.4171855790773, 1199.3943058755274, 14987.625309366917, 15063.774043389578, 15096.16971066558, 15127.243637817845, 15350.846491535389, 30697.0, 31218.531722023734, 32407.837960810044, 32766.180845479055, 33113.66886331202, 35415.468767967985, 36936.63063369332, 38575.42136868005, 43140.56859431491, 44064.339034915145, 8417.116202798617, 8659.52372619512, 8687.695930642398, 8770.07914169003, 8773.333066717303, 10276.743081423025, 15832.841671583137, 16206.270717817491, 16637.584060398585, 16689.415870444474, 8564.443311184754, 8814.955925220333, 8848.424852384574, 9411.0, 13846.169229846242, 9156.8481406868, 9464.0, 9556.522173891139, 9619.663311784054, 9975.551100200364, 9779.755506112404, 9991.150752186146, 10039.749006274902, 10114.898851011396, 10144.036316549917, 14162.504312349018, 14524.346404412037, 14542.781858271923, 14648.926755366156, 14743.336549855498, 15149.924250378677, 15263.923680381527, 15293.388264469742, 15517.301721422336, 15559.611009724847], "unit": "ms", "name": "jquery.html", "value": 7899.515792415619}, {"lowerIsBetter": false, "replicates": [1516.3252352703053, 1591.3793620488009, 1681.470336843894, 1690.6280618263986, 1723.9224234909427, 5963.493103086232, 6043.969780151104, 7068.823279418017, 7595.240475952402, 7618.200088990652, 6845.0, 7084.893726594105, 7130.679119439625, 7133.928660713391, 7143.107111611049, 2090.2997495838913, 2123.830093592509, 2128.861623994443, 2140.422086036769, 2140.454184183031, 2065.710800487933, 2105.1263725553954, 2128.8935553222354, 2139.6683514055267, 2141.0686351437175, 2145.6352420088624, 2146.6028784674886, 2165.7942495462908, 2168.1977668262684, 2190.222471022788, 2121.1197353098446, 2143.796339347767, 2144.0994782191515, 2144.1637761273114, 2147.3987283560627, 2078.771335153147, 2176.1077958037285, 2177.0638625391075, 2178.1069761397907, 2183.4650510624997, 7286.089238845145, 7310.086239220098, 7366.152892417387, 7366.373858222004, 7383.040204773345, 4250.383694364331, 4327.8485253016, 4334.891627709301, 4361.367601697736, 4361.760103194323, 2661.7471340222646, 2664.760171584547, 2744.217897899089, 2749.2164733051186, 2763.1710486853863, 851.3572252949045, 873.7990262239657, 875.9430637008574, 903.0833703790657, 905.5653286422554, 9603.4718090505, 9626.518674066268, 9650.951745241298, 9683.66107186245, 9711.27165462593, 3939.2515422070287, 3943.684505239574, 3991.84032638697, 4009.599040095967, 4013.0, 8393.748187554384, 8397.412181147261, 8405.075441701409, 8409.159084091541, 8431.072582015973, 4321.611055005064, 4343.609075183249, 4367.082912588392, 4374.081442897027, 4385.758783266951, 3375.6793104655017, 3451.361498122855, 3833.5208098987628, 3978.781167035783, 3993.1414745829784, 3463.7748546344405, 3475.704565111994, 3488.5464889564196, 3499.2651543176216, 3529.3294274087843, 1041.1618646989245, 1058.99470502647, 1080.1197024425069, 1094.8248280275118, 1095.9178061645248, 996.1035068438464, 1010.8534262531891, 1012.2054187462953, 1013.2350075692952, 1013.8377859542438, 6575.046618240328, 6606.141201643755, 6632.204135503674, 6675.899861502081, 6697.665116744143, 444.75538453850254, 445.2497541642343, 1120.456578559398, 1142.268947873345, 1147.8565179352581, 5155.793768249303, 5168.0, 5184.585233181337, 5186.740662966912, 5249.317588713519, 8562.357823163287, 8745.518996455256, 8746.781330466789, 8764.474131552128, 8817.897762779652, 8465.534395608178, 8689.869651955225, 8711.823903772909, 8732.607032683545, 8748.168923952215, 6866.862662746717, 6964.4080253179045, 6967.82580435483, 7007.649617519103, 7014.333638304251, 6444.484441244783, 6453.419192272718, 6502.317256687979, 6584.637844918576, 6828.248892621708, 7573.431992600466, 7632.923670763222, 7680.308772210527, 7719.691212351443, 7965.880511792444, 7938.24586664266, 8052.838943220986, 8069.515829050276, 8084.717034903751, 8093.676252950052, 6042.546808989256, 6306.432421082125, 6311.116443697794, 6513.641749703812, 6616.603003819786, 7009.228984811769, 7032.0, 7042.964785176041, 7064.540804847668, 7066.187388450394, 6547.1161393213215, 6664.400203981471, 6665.866682666417, 6765.594064356154, 6775.559588626724, 6492.415682588589, 6522.412982831568, 6536.444402225864, 6603.867922641424, 6638.137042184485, 6706.6981985811735, 6748.797536073926, 6756.0, 6757.594544327356, 6764.120664313805, 6094.177286066324, 6180.0, 6197.225346831646, 6205.689715514297, 6208.689565521796, 6219.471344935731, 6266.874662506633, 6281.246250449975, 6295.905561416674, 6318.147050148355], "unit": "ms", "name": "mootools.html", "value": 4149.484421000733}, {"lowerIsBetter": false, "replicates": [298.5074626865671, 305.1592861666111, 309.048131754197, 313.09671597441405, 313.73959613520765, 5521.806736764214, 5591.189277554758, 5615.606907516475, 5689.487946084857, 5754.884902301951, 5572.749226284816, 5615.326160860693, 5647.745851436685, 5650.350209725882, 5650.74571644276, 4188.664906807463, 4291.549387314334, 4338.97830510847, 4342.413774140498, 4351.891202719926, 4267.935980960288, 4302.827886884536, 4307.009387840799, 4308.590683885026, 4311.504177019651, 4262.957370426287, 4265.189613973351, 4267.423897773808, 4268.914621707564, 4269.765162916038, 4257.787110644455, 4262.46719160105, 4266.466691663542, 4270.871873843789, 4278.614924656796, 3638.890833275006, 3711.6659500645073, 3722.181120153562, 3732.1602639406187, 3736.9065773355883, 5236.81671141512, 5335.759890804923, 5383.919241211385, 5388.649737767033, 5399.352077750656, 4874.829380971649, 4876.878078048042, 4893.779779909913, 4893.8776530586665, 4897.7795999180125, 5910.763569457216, 5921.378255283176, 5926.348101708809, 5927.8221653350465, 5934.970325148347, 3890.2219556088894, 4017.27689015977, 4022.336314508132, 4023.7786921719294, 4026.617471340218, 6138.539609529258, 6183.474404675608, 6215.906761398583, 6218.22272215973, 6220.720067596969, 4126.690498212646, 4134.64855487281, 4143.295639741251, 4146.875593732193, 4147.52303485103, 4198.748075115503, 4200.4959404871615, 4217.557156498524, 4218.0, 4226.640735537452, 4726.976365118152, 4787.210110331756, 4838.298446725275, 4855.6115510759055, 4865.70805751656, 5841.474267315962, 5862.589618726648, 5863.970680146572, 5865.589408741433, 5866.501347385435, 1467.5890750589851, 1468.3098943496539, 1469.8236211654669, 1475.3950880139307, 1477.4311889922458, 975.1272611013104, 975.2198241406846, 983.7147227304001, 998.3410948773919, 1003.3027046202965, 5106.055379754757, 5114.74426278692, 5118.206677964921, 5121.308623335802, 5131.948680513147, 6072.51419886408, 6109.480694141048, 6129.509639228941, 6141.416565426277, 6141.7543298268465, 5102.974485127551, 5117.309163262987, 5117.385913690381, 5120.283160357553, 5128.230765385222, 3228.80627162371, 3298.7031167194586, 3299.7855139416342, 3327.93344133116, 3327.93344133116, 5691.9146212806845, 5810.767569297181, 5812.447817457335, 5813.59304848665, 5835.387284335084, 6354.809355719336, 6356.618602883749, 6381.074744162163, 6384.3934826191435, 6385.6487893165395, 5750.741216645261, 5754.251947246831, 5795.1017592273265, 5796.304443466811, 5808.477237048602, 5970.313413957277, 6167.784127555514, 6180.8763824722355, 6189.442950134509, 6192.287886892885, 6014.338422773579, 6021.096835474714, 6033.215681961317, 6038.758449661965, 6054.152418661479, 5793.681347525927, 5811.535077193899, 5819.243498345188, 5829.7085145743395, 5830.941690583039, 4065.4918135233097, 4068.4914385701786, 4095.8156882939743, 4106.589341065869, 4107.075907920694, 6048.334683184934, 6156.107364432043, 6161.7843375483435, 6194.535409844189, 6198.969005154945, 5938.940610593839, 5938.940610594012, 5939.970300148471, 5952.226210592596, 5952.851178720393, 5919.526437885045, 5922.526197904243, 5923.911141332797, 5936.901673190474, 5944.256967879015, 5642.971785141048, 5739.598228123991, 5789.102689083199, 5801.0, 5814.0, 5945.881082378241, 5955.5235581154275, 5962.761489540543, 5967.552433567413, 5973.820785376446, 5823.126531020381, 5834.066549352084, 5834.329052159056, 5842.678652673973, 5843.065109582446], "unit": "ms", "name": "prototype.html", "value": 4398.875526453858}, {"lowerIsBetter": false, "replicates": [772.6098320348227, 777.1994845309333, 778.0585491555217, 780.7111368793547, 789.7670187294746, 11608.361540115291, 11766.882331176686, 11801.881981180186, 11830.29018258903, 11848.111391645629, 11273.887261127386, 11822.58620948267, 11927.284362938208, 11945.223560468563, 11971.940140299286, 797.9281864632196, 812.2811311988903, 814.4543156085437, 815.3355015662246, 818.5497976113144, 785.6071964017991, 788.787027502574, 791.2878409431501, 792.9968589733991, 793.85710572097, 834.4742812028413, 837.6063250272363, 841.6801615386175, 842.6629348260683, 845.7674139611626, 830.6220669595319, 831.3432388413146, 831.5260301628074, 832.1512057701171, 834.3325339728193, 620.0420350558353, 620.3579295429254, 621.2389822467442, 622.6886556721639, 622.6948795090373, 11049.447527623586, 11121.332720036824, 11142.442877856074, 11146.331220126818, 11205.327680339124, 10816.567337306498, 11137.554497820078, 11323.20737548372, 11786.587469438615, 11795.174337796358, 9456.8581471278, 9511.429314241168, 9513.571889265, 9575.425474471484, 9613.51932403377, 3268.852901619409, 3341.448660970937, 3346.6486018967903, 3350.977951724723, 3417.4019546579248, 38098.23803523914, 38975.0, 39276.803615982026, 39386.0, 39502.0, 9091.727248182566, 9168.724938251864, 9213.861792073125, 9299.256059515223, 9458.52707364629, 15549.844501555066, 15561.766573501407, 15574.221288935509, 15581.922090389475, 15584.610384740245, 6460.0, 6478.1578394808375, 6483.384078512534, 6520.445762110179, 6592.24189218246, 3686.870959516404, 3739.121306492972, 3750.868719594801, 3778.6599206071587, 3783.129880127531, 2798.0766347105405, 2814.3386304218493, 2820.0411859967708, 2838.1485554333617, 2839.531477306263, 485.24786580800327, 487.1620812203076, 489.9730514821719, 505.7445989775214, 506.94170170430135, 494.7056501381672, 589.6904125334233, 616.2881871438495, 639.8432384065934, 651.1372431528245, 7863.803404914923, 8151.0, 8216.712415065444, 8221.54781487012, 8262.215089566602, 505.40867185392443, 604.1149715666481, 623.7286780250605, 624.2259598098416, 625.6433832715309, 3839.1745774658584, 3912.4522566840665, 3912.8434862605745, 3913.0413048802657, 3995.161016186575, 52052.47947520476, 52413.0, 52491.21263181055, 52546.47453525492, 52627.0, 44998.0, 45456.77271613687, 46624.7668761654, 46810.0, 46970.53029469662, 43391.349129763075, 48167.75916120397, 48329.27506087411, 48428.27357589639, 48953.510464895604, 8233.83532329362, 8314.0, 8334.666613335641, 8472.110428404929, 8476.406651534333, 31920.52119218167, 32141.35717285688, 32249.0, 32808.50787238241, 33172.66827331696, 36646.0, 37052.073698157765, 37888.81055594704, 39375.0, 42671.1465770689, 10303.742406439898, 10500.317479363817, 10549.841752373874, 10580.259381843198, 10613.628523001658, 11125.388103654377, 11779.88220117788, 11863.644090677293, 12051.698707532381, 12076.939615302219, 11130.888691113309, 11175.273607215506, 11194.216404851582, 11220.214584978972, 11339.943300283447, 10570.0, 10639.308444951053, 10892.128629709447, 11207.49566269536, 11243.875612439018, 10984.615538456115, 11012.449377530931, 11090.334579924907, 11095.0, 11114.0, 9302.209735588714, 9426.481543515172, 9506.47714375716, 9604.615815367308, 9700.27247956392, 8966.775830604287, 9027.548622568976, 9150.267978561833, 9194.223618253069, 9546.90453095488], "unit": "ms", "name": "yui.html", "value": 5871.5471747481715}], "name": "dromaeo_css", "value": 6357.841354409308}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 112.0, 111.0, 114.0, 124.0, 113.0, 112.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 155.0, 163.0, 138.0, 151.0, 154.0, 145.0, 177.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 164.0, 164.0, 162.0, 166.0, 164.0, 163.0, 165.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 72.0, 138.0, 72.0, 78.0, 73.0, 72.0, 91.0], "unit": "ms", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 130.0, 95.0, 95.0, 94.0, 133.0, 95.0, 95.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 149.0, 147.0, 148.0, 148.0, 148.0, 147.0, 149.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 73.0, 71.0, 73.0, 72.0, 72.0, 80.0, 70.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 94.0, 87.0, 84.0, 86.0, 86.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 128.0, 123.0, 131.0, 131.0, 134.0, 124.0, 120.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [138.0, 150.0, 151.0, 143.0, 141.0, 136.0, 148.0, 151.0, 147.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 73.0, 70.0, 71.0, 70.0, 69.0, 71.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1536.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.6944490748458], "unit": "score", "name": "Richards", "value": 211.77669800000004}, {"lowerIsBetter": false, "replicates": [181.32366273798732], "unit": "score", "name": "DeltaBlue", "value": 364.64077000000003}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [26473.684210526317], "unit": "score", "name": "RegExp", "value": 34.410964214711704}, {"lowerIsBetter": false, "replicates": [595.1393005334915], "unit": "score", "name": "Splay", "value": 136.9276065737051}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21389.415011776622}]} 23:47:42 INFO - RETURN: dromaeo_css: 6357.84 23:47:42 INFO - RETURN: kraken: 1536.40 23:47:42 INFO - RETURN: v8_7: 21389.42 23:47:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21389.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1536.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6357.84"}}} 23:47:42 INFO - Return code: 0 23:47:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:47:42 INFO - # TBPL SUCCESS # 23:47:42 INFO - Running post-action listener: _resource_record_post_action 23:47:42 INFO - Running post-run listener: _resource_record_post_run 23:47:43 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516042752; Read time: 16; Write time: 408956 23:47:43 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238096384; Read time: 0; Write time: 255460 23:47:43 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277946368; Read time: 16; Write time: 153496 23:47:43 INFO - Running post-run listener: _upload_blobber_files 23:47:43 INFO - Blob upload gear active. 23:47:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:47:43 INFO - Copying logs to upload dir... 23:47:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.564146 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-13 23:47:41.795544) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:47:41.798998) ========= 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=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009975 build_url: 'https://queue.taskcluster.net/v1/task/k8F-wSTJRc6JoB7pE8xFIw/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-13 23:47:41.850813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:47:41.851259) ========= 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=919420d7ee4ef147bef0346300000385-1450070359.379972-206212468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:47:41.901459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 23:47:41.901833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 23:47:41.902177) ========= ========= Total master_lag: 0.23 =========