builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1450079733.22 results: success (0) buildid: 20151213223232 builduid: 0b353b6734294d15879ace04bee49f0e revision: 871d92a1b0701ad79780989bf2ae335d4a19f138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.220059) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.220483) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.220766) ========= 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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006498 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.263234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.263591) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.318832) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.319089) ========= 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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004640 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.371624) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.371917) ========= 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:55:33.372292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.372576) ========= 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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-13 23:55:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 208M=0s 2015-12-13 23:55:34 (208 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149996 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.548203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.548509) ========= 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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020176 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.606918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:33.607227) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --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 mozilla-central --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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-13 23:55:35,091 truncating revision to first 12 chars 2015-12-13 23:55:35,091 Setting DEBUG logging. 2015-12-13 23:55:35,091 attempt 1/10 2015-12-13 23:55:35,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/871d92a1b070?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-13 23:55:35,334 unpacking tar archive at: mozilla-central-871d92a1b070/testing/mozharness/ program finished with exit code 0 elapsedTime=0.506910 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:34.128738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:34.129044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:34.138236) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 23:55:34.138771) ========= 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:55:34.139450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-13 23:55:34.139880) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:55:35 INFO - MultiFileLogger online at 20151213 23:55:35 in /builds/slave/test 23:55:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 23:55:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:55:35 INFO - {'append_to_log': False, 23:55:35 INFO - 'base_work_dir': '/builds/slave/test', 23:55:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:55:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:55:35 INFO - 'branch': 'Firefox-Non-PGO', 23:55:35 INFO - 'buildbot_json_path': 'buildprops.json', 23:55:35 INFO - 'config_files': ('talos/linux_config.py',), 23:55:35 INFO - 'default_actions': ('clobber', 23:55:35 INFO - 'read-buildbot-config', 23:55:35 INFO - 'download-and-extract', 23:55:35 INFO - 'populate-webroot', 23:55:35 INFO - 'create-virtualenv', 23:55:35 INFO - 'install', 23:55:35 INFO - 'run-tests'), 23:55:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:55:35 INFO - 'download_minidump_stackwalk': True, 23:55:35 INFO - 'download_symbols': 'ondemand', 23:55:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:55:35 INFO - 'tooltool.py': '/tools/tooltool.py', 23:55:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:55:35 INFO - '/tools/misc-python/virtualenv.py')}, 23:55:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:55:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:55:35 INFO - 'installer_path': 'installer.exe', 23:55:35 INFO - 'log_level': 'info', 23:55:35 INFO - 'log_name': 'talos', 23:55:35 INFO - 'log_to_console': True, 23:55:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:55:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:55:35 INFO - 'opt_config_files': (), 23:55:35 INFO - 'pip_index': False, 23:55:35 INFO - 'sps_profile': False, 23:55:35 INFO - 'sps_profile_interval': 0, 23:55:35 INFO - 'suite': 'dromaeojs-e10s', 23:55:35 INFO - 'system_bits': '64', 23:55:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:55:35 INFO - 'title': 'talos-linux64-ix-018', 23:55:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:55:35 INFO - 'use_talos_json': True, 23:55:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:55:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:55:35 INFO - 'work_dir': 'build'} 23:55:35 INFO - ##### 23:55:35 INFO - ##### Running clobber step. 23:55:35 INFO - ##### 23:55:35 INFO - Running pre-action listener: _resource_record_pre_action 23:55:35 INFO - Running main action method: clobber 23:55:35 INFO - rmtree: /builds/slave/test/build 23:55:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:55:36 INFO - Running post-action listener: _resource_record_post_action 23:55:36 INFO - ##### 23:55:36 INFO - ##### Running read-buildbot-config step. 23:55:36 INFO - ##### 23:55:36 INFO - Running pre-action listener: _resource_record_pre_action 23:55:36 INFO - Running main action method: read_buildbot_config 23:55:36 INFO - Using buildbot properties: 23:55:36 INFO - { 23:55:36 INFO - "properties": { 23:55:36 INFO - "buildnumber": 119, 23:55:36 INFO - "product": "firefox", 23:55:36 INFO - "script_repo_revision": "production", 23:55:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:55:36 INFO - "repository": "", 23:55:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 23:55:36 INFO - "buildid": "20151213223232", 23:55:36 INFO - "slavename": "talos-linux64-ix-018", 23:55:36 INFO - "pgo_build": "False", 23:55:36 INFO - "basedir": "/builds/slave/test", 23:55:36 INFO - "project": "", 23:55:36 INFO - "platform": "ubuntu64_hw", 23:55:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:55:36 INFO - "slavebuilddir": "test", 23:55:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 23:55:36 INFO - "branch": "mozilla-central", 23:55:36 INFO - "repo_path": "mozilla-central", 23:55:36 INFO - "stage_platform": "linux64", 23:55:36 INFO - "builduid": "0b353b6734294d15879ace04bee49f0e", 23:55:36 INFO - "revision": "871d92a1b0701ad79780989bf2ae335d4a19f138" 23:55:36 INFO - }, 23:55:36 INFO - "sourcestamp": { 23:55:36 INFO - "repository": "", 23:55:36 INFO - "hasPatch": false, 23:55:36 INFO - "project": "", 23:55:36 INFO - "branch": "mozilla-central-linux64-talos", 23:55:36 INFO - "changes": [ 23:55:36 INFO - { 23:55:36 INFO - "category": null, 23:55:36 INFO - "files": [ 23:55:36 INFO - { 23:55:36 INFO - "url": null, 23:55:36 INFO - "name": "https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 23:55:36 INFO - } 23:55:36 INFO - ], 23:55:36 INFO - "repository": "", 23:55:36 INFO - "rev": "871d92a1b0701ad79780989bf2ae335d4a19f138", 23:55:36 INFO - "who": "philringnalda@gmail.com", 23:55:36 INFO - "when": 1450079681, 23:55:36 INFO - "number": 7356707, 23:55:36 INFO - "comments": "Merge m-i (and a little f-t) to m-c, a=merge", 23:55:36 INFO - "project": "", 23:55:36 INFO - "at": "Sun 13 Dec 2015 23:54:41", 23:55:36 INFO - "branch": "mozilla-central-linux64-talos", 23:55:36 INFO - "revlink": "", 23:55:36 INFO - "properties": [ 23:55:36 INFO - [ 23:55:36 INFO - "buildid", 23:55:36 INFO - "20151213223232", 23:55:36 INFO - "Change" 23:55:36 INFO - ], 23:55:36 INFO - [ 23:55:36 INFO - "builduid", 23:55:36 INFO - "0b353b6734294d15879ace04bee49f0e", 23:55:36 INFO - "Change" 23:55:36 INFO - ], 23:55:36 INFO - [ 23:55:36 INFO - "pgo_build", 23:55:36 INFO - "False", 23:55:36 INFO - "Change" 23:55:36 INFO - ] 23:55:36 INFO - ], 23:55:36 INFO - "revision": "871d92a1b0701ad79780989bf2ae335d4a19f138" 23:55:36 INFO - } 23:55:36 INFO - ], 23:55:36 INFO - "revision": "871d92a1b0701ad79780989bf2ae335d4a19f138" 23:55:36 INFO - } 23:55:36 INFO - } 23:55:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 23:55:36 INFO - Running post-action listener: _resource_record_post_action 23:55:36 INFO - ##### 23:55:36 INFO - ##### Running download-and-extract step. 23:55:36 INFO - ##### 23:55:36 INFO - Running pre-action listener: _resource_record_pre_action 23:55:36 INFO - Running main action method: download_and_extract 23:55:36 INFO - mkdir: /builds/slave/test/build/tests 23:55: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:55:36 INFO - https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/test_packages.json 23:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/test_packages.json 23:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:55:36 INFO - Downloaded 1302 bytes. 23:55:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:55:36 INFO - Using the following test package requirements: 23:55:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:55:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:55:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:55:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:55:36 INFO - u'jsshell-linux-x86_64.zip'], 23:55:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:55:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:55:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:55:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:55:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:55:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:55:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:55:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:55:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:55:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 23:55:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 23:55:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:55:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:55: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:55:36 INFO - https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:38 INFO - Downloaded 21869728 bytes. 23:55:38 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:55:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:55:38 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:55:39 INFO - Return code: 0 23:55:39 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:55:39 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:55:39 INFO - https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:44 INFO - Downloaded 21869728 bytes. 23:55:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 23:55:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 23:55:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 23:55:45 INFO - Return code: 0 23:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:45 INFO - https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:46 INFO - Downloaded 11132038 bytes. 23:55: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:55:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 23:55: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:55:46 INFO - Return code: 0 23:55: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:55:46 INFO - https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:55:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:55:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:55:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NexYEK5uSr6nLGBfNrbd9A/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:55:47 INFO - Downloaded 57738144 bytes. 23:55:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:55:47 INFO - mkdir: /builds/slave/test/properties 23:55:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:55:47 INFO - Writing to file /builds/slave/test/properties/build_url 23:55:47 INFO - Contents: 23:55:47 INFO - build_url:https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 23:55:47 INFO - Running post-action listener: _resource_record_post_action 23:55:47 INFO - Running post-action listener: set_extra_try_arguments 23:55:47 INFO - ##### 23:55:47 INFO - ##### Running populate-webroot step. 23:55:47 INFO - ##### 23:55:47 INFO - Running pre-action listener: _resource_record_pre_action 23:55:47 INFO - Running main action method: populate_webroot 23:55:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:55:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:55:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:55:47 INFO - '--tppagecycles', 23:55:47 INFO - '7'], 23:55:47 INFO - 'tests': ['tsvgm']}}, 23:55:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:55:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:55:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:55:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:55:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'tests': ['damp', 'tps']}, 23:55:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['damp', 'tps']}, 23:55:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:55:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:55:47 INFO - 'other': {'tests': ['a11yr', 23:55:47 INFO - 'ts_paint', 23:55:47 INFO - 'tpaint', 23:55:47 INFO - 'sessionrestore', 23:55:47 INFO - 'sessionrestore_no_auto_restore']}, 23:55:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['a11yr', 23:55:47 INFO - 'ts_paint', 23:55:47 INFO - 'tpaint', 23:55:47 INFO - 'sessionrestore', 23:55:47 INFO - 'sessionrestore_no_auto_restore']}, 23:55:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['a11yr', 23:55:47 INFO - 'ts_paint', 23:55:47 INFO - 'tpaint', 23:55:47 INFO - 'sessionrestore', 23:55:47 INFO - 'sessionrestore_no_auto_restore']}, 23:55:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['a11yr', 23:55:47 INFO - 'ts_paint', 23:55:47 INFO - 'tpaint', 23:55:47 INFO - 'sessionrestore', 23:55:47 INFO - 'sessionrestore_no_auto_restore']}, 23:55:47 INFO - 'other_l64': {'tests': ['a11yr', 23:55:47 INFO - 'ts_paint', 23:55:47 INFO - 'tpaint', 23:55:47 INFO - 'sessionrestore', 23:55:47 INFO - 'sessionrestore_no_auto_restore']}, 23:55:47 INFO - 'other_nol64': {'tests': ['a11yr', 23:55:47 INFO - 'ts_paint', 23:55:47 INFO - 'tpaint', 23:55:47 INFO - 'sessionrestore', 23:55:47 INFO - 'sessionrestore_no_auto_restore']}, 23:55:47 INFO - 'svgr': {'tests': ['tsvgx', 23:55:47 INFO - 'tsvgr_opacity', 23:55:47 INFO - 'tart', 23:55:47 INFO - 'tscrollx', 23:55:47 INFO - 'cart']}, 23:55:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['tsvgx', 23:55:47 INFO - 'tsvgr_opacity', 23:55:47 INFO - 'tart', 23:55:47 INFO - 'tscrollx', 23:55:47 INFO - 'cart']}, 23:55:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'tests': ['tp5o']}, 23:55:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'talos_options': ['--e10s'], 23:55:47 INFO - 'tests': ['tp5o']}, 23:55:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'talos_options': ['--xperf_path', 23:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:47 INFO - 'tests': ['tp5n']}, 23:55:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:47 INFO - 'talos_options': ['--e10s', 23:55:47 INFO - '--xperf_path', 23:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:47 INFO - 'tests': ['tp5n']}}, 23:55:47 INFO - 'talos.zip': {'path': '', 23:55:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:55:47 INFO - Running post-action listener: _resource_record_post_action 23:55:47 INFO - ##### 23:55:47 INFO - ##### Running create-virtualenv step. 23:55:47 INFO - ##### 23:55:47 INFO - Running pre-action listener: _resource_record_pre_action 23:55:47 INFO - Running main action method: create_virtualenv 23:55:47 INFO - Creating virtualenv /builds/slave/test/build/venv 23:55:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:55:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:55:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:55:47 INFO - Using real prefix '/usr' 23:55:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:55:48 INFO - Installing distribute.............................................................................................................................................................................................done. 23:55:50 INFO - Installing pip.................done. 23:55:50 INFO - Return code: 0 23:55:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:55:50 INFO - Using env: {'DISPLAY': ':0', 23:55:50 INFO - 'HOME': '/home/cltbld', 23:55:50 INFO - 'LANG': 'en_US.UTF-8', 23:55:50 INFO - 'LANGUAGE': 'en_US:en', 23:55:50 INFO - 'LOGNAME': 'cltbld', 23:55:50 INFO - 'MAIL': '/var/mail/cltbld', 23:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:50 INFO - 'MOZ_NO_REMOTE': '1', 23:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:50 INFO - 'NO_EM_RESTART': '1', 23:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:50 INFO - 'PWD': '/builds/slave/test', 23:55:50 INFO - 'SHELL': '/bin/bash', 23:55:50 INFO - 'SHLVL': '1', 23:55:50 INFO - 'TERM': 'linux', 23:55:50 INFO - 'TMOUT': '86400', 23:55:50 INFO - 'USER': 'cltbld', 23:55:50 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:50 INFO - '_': '/tools/buildbot/bin/python'} 23:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:50 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:55:50 INFO - Cleaning up... 23:55:50 INFO - Return code: 0 23:55:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:55:50 INFO - Using env: {'DISPLAY': ':0', 23:55:50 INFO - 'HOME': '/home/cltbld', 23:55:50 INFO - 'LANG': 'en_US.UTF-8', 23:55:50 INFO - 'LANGUAGE': 'en_US:en', 23:55:50 INFO - 'LOGNAME': 'cltbld', 23:55:50 INFO - 'MAIL': '/var/mail/cltbld', 23:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:50 INFO - 'MOZ_NO_REMOTE': '1', 23:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:50 INFO - 'NO_EM_RESTART': '1', 23:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:50 INFO - 'PWD': '/builds/slave/test', 23:55:50 INFO - 'SHELL': '/bin/bash', 23:55:50 INFO - 'SHLVL': '1', 23:55:50 INFO - 'TERM': 'linux', 23:55:50 INFO - 'TMOUT': '86400', 23:55:50 INFO - 'USER': 'cltbld', 23:55:50 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:50 INFO - '_': '/tools/buildbot/bin/python'} 23:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:50 INFO - Downloading/unpacking psutil>=0.7.1 23:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:55:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:52 INFO - Installing collected packages: psutil 23:55:52 INFO - Running setup.py install for psutil 23:55:52 INFO - building 'psutil._psutil_linux' extension 23:55:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:55: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:55:53 INFO - building 'psutil._psutil_posix' extension 23:55: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:55: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:55:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:53 INFO - Successfully installed psutil 23:55:53 INFO - Cleaning up... 23:55:53 INFO - Return code: 0 23:55:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:55:53 INFO - Using env: {'DISPLAY': ':0', 23:55:53 INFO - 'HOME': '/home/cltbld', 23:55:53 INFO - 'LANG': 'en_US.UTF-8', 23:55:53 INFO - 'LANGUAGE': 'en_US:en', 23:55:53 INFO - 'LOGNAME': 'cltbld', 23:55:53 INFO - 'MAIL': '/var/mail/cltbld', 23:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:53 INFO - 'MOZ_NO_REMOTE': '1', 23:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:53 INFO - 'NO_EM_RESTART': '1', 23:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:53 INFO - 'PWD': '/builds/slave/test', 23:55:53 INFO - 'SHELL': '/bin/bash', 23:55:53 INFO - 'SHLVL': '1', 23:55:53 INFO - 'TERM': 'linux', 23:55:53 INFO - 'TMOUT': '86400', 23:55:53 INFO - 'USER': 'cltbld', 23:55:53 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:53 INFO - '_': '/tools/buildbot/bin/python'} 23:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:55:53 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:55:53 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:55:53 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:55:53 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:55:53 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:55:53 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:55:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:55:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:55:55 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:55:55 INFO - Installing collected packages: mozsystemmonitor 23:55:55 INFO - Running setup.py install for mozsystemmonitor 23:55:55 INFO - Successfully installed mozsystemmonitor 23:55:55 INFO - Cleaning up... 23:55:55 INFO - Return code: 0 23:55:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:55:55 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:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:55 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:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:55 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 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:55:55 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:55:55 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:55:55 INFO - Using env: {'DISPLAY': ':0', 23:55:55 INFO - 'HOME': '/home/cltbld', 23:55:55 INFO - 'LANG': 'en_US.UTF-8', 23:55:55 INFO - 'LANGUAGE': 'en_US:en', 23:55:55 INFO - 'LOGNAME': 'cltbld', 23:55:55 INFO - 'MAIL': '/var/mail/cltbld', 23:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:55 INFO - 'MOZ_NO_REMOTE': '1', 23:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:55 INFO - 'NO_EM_RESTART': '1', 23:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:55 INFO - 'PWD': '/builds/slave/test', 23:55:55 INFO - 'SHELL': '/bin/bash', 23:55:55 INFO - 'SHLVL': '1', 23:55:55 INFO - 'TERM': 'linux', 23:55:55 INFO - 'TMOUT': '86400', 23:55:55 INFO - 'USER': 'cltbld', 23:55:55 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:55 INFO - '_': '/tools/buildbot/bin/python'} 23:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 23:55:55 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:55:55 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:55:55 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:55:55 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:55:55 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:55:55 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:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 23:55:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:57 INFO - Downloading docopt-0.6.1.tar.gz 23:55:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 23:55:57 INFO - Running setup.py install for blobuploader 23:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:55:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:55:58 INFO - Running setup.py install for requests 23:55:58 INFO - Running setup.py install for docopt 23:55:58 INFO - Successfully installed blobuploader requests docopt 23:55:58 INFO - Cleaning up... 23:55:58 INFO - Return code: 0 23:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:58 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 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:55:58 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:55:58 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:55:58 INFO - Using env: {'DISPLAY': ':0', 23:55:58 INFO - 'HOME': '/home/cltbld', 23:55:58 INFO - 'LANG': 'en_US.UTF-8', 23:55:58 INFO - 'LANGUAGE': 'en_US:en', 23:55:58 INFO - 'LOGNAME': 'cltbld', 23:55:58 INFO - 'MAIL': '/var/mail/cltbld', 23:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:58 INFO - 'MOZ_NO_REMOTE': '1', 23:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:58 INFO - 'NO_EM_RESTART': '1', 23:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:58 INFO - 'PWD': '/builds/slave/test', 23:55:58 INFO - 'SHELL': '/bin/bash', 23:55:58 INFO - 'SHLVL': '1', 23:55:58 INFO - 'TERM': 'linux', 23:55:58 INFO - 'TMOUT': '86400', 23:55:58 INFO - 'USER': 'cltbld', 23:55:58 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:58 INFO - '_': '/tools/buildbot/bin/python'} 23:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:55:58 INFO - Running setup.py (path:/tmp/pip-T7TfK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:55:58 INFO - Running setup.py (path:/tmp/pip-UUXHPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:55:58 INFO - Running setup.py (path:/tmp/pip-aCfe6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:55:59 INFO - Running setup.py (path:/tmp/pip-Z2YkBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:55:59 INFO - Running setup.py (path:/tmp/pip-zoGu2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:55:59 INFO - Running setup.py (path:/tmp/pip-twci0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:55:59 INFO - Running setup.py (path:/tmp/pip-6w9UkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:55:59 INFO - Running setup.py (path:/tmp/pip-8I69TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:55:59 INFO - Running setup.py (path:/tmp/pip-P9_1vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:55:59 INFO - Running setup.py (path:/tmp/pip-VSTea4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:55:59 INFO - Running setup.py (path:/tmp/pip-sTwAQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:55:59 INFO - Running setup.py (path:/tmp/pip-75jkNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:55:59 INFO - Running setup.py (path:/tmp/pip-3WXD0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:55:59 INFO - Running setup.py (path:/tmp/pip-pksSqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:59 INFO - Running setup.py (path:/tmp/pip-mBg07J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:55:59 INFO - Running setup.py (path:/tmp/pip-7PhY17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:55:59 INFO - Running setup.py (path:/tmp/pip-3BVIkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:56:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:56:00 INFO - Running setup.py install for manifestparser 23:56:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Running setup.py install for mozcrash 23:56:00 INFO - Running setup.py install for mozdebug 23:56:00 INFO - Running setup.py install for mozdevice 23:56:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Running setup.py install for mozfile 23:56:00 INFO - Running setup.py install for mozhttpd 23:56:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Running setup.py install for mozinfo 23:56:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Running setup.py install for mozInstall 23:56:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:56:00 INFO - Running setup.py install for mozleak 23:56:00 INFO - Running setup.py install for mozlog 23:56:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:56:01 INFO - Running setup.py install for moznetwork 23:56:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:56:01 INFO - Running setup.py install for mozprocess 23:56:01 INFO - Running setup.py install for mozprofile 23:56:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:56:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:56:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:56:01 INFO - Running setup.py install for mozrunner 23:56:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:56:01 INFO - Running setup.py install for mozscreenshot 23:56:01 INFO - Running setup.py install for moztest 23:56:01 INFO - Running setup.py install for mozversion 23:56:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:56:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:56:01 INFO - Cleaning up... 23:56:01 INFO - Return code: 0 23:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:56:01 INFO - Using env: {'DISPLAY': ':0', 23:56:01 INFO - 'HOME': '/home/cltbld', 23:56:01 INFO - 'LANG': 'en_US.UTF-8', 23:56:01 INFO - 'LANGUAGE': 'en_US:en', 23:56:01 INFO - 'LOGNAME': 'cltbld', 23:56:01 INFO - 'MAIL': '/var/mail/cltbld', 23:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:01 INFO - 'MOZ_NO_REMOTE': '1', 23:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:01 INFO - 'NO_EM_RESTART': '1', 23:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:01 INFO - 'PWD': '/builds/slave/test', 23:56:01 INFO - 'SHELL': '/bin/bash', 23:56:01 INFO - 'SHLVL': '1', 23:56:01 INFO - 'TERM': 'linux', 23:56:01 INFO - 'TMOUT': '86400', 23:56:01 INFO - 'USER': 'cltbld', 23:56:01 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:01 INFO - '_': '/tools/buildbot/bin/python'} 23:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:56:01 INFO - Running setup.py (path:/tmp/pip-AH_C1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:56: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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:56:02 INFO - Running setup.py (path:/tmp/pip-lukETs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:56: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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:56:02 INFO - Running setup.py (path:/tmp/pip-OSEgOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:56:02 INFO - Running setup.py (path:/tmp/pip-yvjFs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:56:02 INFO - Running setup.py (path:/tmp/pip-eY7pyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:56:02 INFO - Running setup.py (path:/tmp/pip-jgpEIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:56:02 INFO - Running setup.py (path:/tmp/pip-mMr9Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:56:02 INFO - Running setup.py (path:/tmp/pip-xzxL9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:56:02 INFO - Running setup.py (path:/tmp/pip-XDdh21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:56:02 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:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:56:02 INFO - Running setup.py (path:/tmp/pip-1TImNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:56:02 INFO - Running setup.py (path:/tmp/pip-4ZnQey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:56:02 INFO - Running setup.py (path:/tmp/pip-pzih80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:56:02 INFO - Running setup.py (path:/tmp/pip-qKAKFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:56:02 INFO - Running setup.py (path:/tmp/pip-3rSMQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:56: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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:03 INFO - Running setup.py (path:/tmp/pip-XSC6Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:56: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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:56:03 INFO - Running setup.py (path:/tmp/pip-TorF1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:56: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:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:56:03 INFO - Running setup.py (path:/tmp/pip-cxNxtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:56:03 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:56:03 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:56:03 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:56:03 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:56:03 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:56:03 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:56:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:56:03 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:56:03 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:56:03 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:56:03 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:56:03 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:56:03 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:56:04 INFO - Downloading blessings-1.5.1.tar.gz 23:56:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 23:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:56:05 INFO - Installing collected packages: blessings 23:56:05 INFO - Running setup.py install for blessings 23:56:05 INFO - Successfully installed blessings 23:56:05 INFO - Cleaning up... 23:56:05 INFO - Return code: 0 23:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:56:05 INFO - Reading from file tmpfile_stdout 23:56:05 INFO - Current package versions: 23:56:05 INFO - argparse == 1.2.1 23:56:05 INFO - blessings == 1.5.1 23:56:05 INFO - blobuploader == 1.2.4 23:56:05 INFO - docopt == 0.6.1 23:56:05 INFO - manifestparser == 1.1 23:56:05 INFO - mozInstall == 1.12 23:56:05 INFO - mozcrash == 0.16 23:56:05 INFO - mozdebug == 0.1 23:56:05 INFO - mozdevice == 0.47 23:56:05 INFO - mozfile == 1.2 23:56:05 INFO - mozhttpd == 0.7 23:56:05 INFO - mozinfo == 0.9 23:56:05 INFO - mozleak == 0.1 23:56:05 INFO - mozlog == 3.1 23:56:05 INFO - moznetwork == 0.27 23:56:05 INFO - mozprocess == 0.22 23:56:05 INFO - mozprofile == 0.27 23:56:05 INFO - mozrunner == 6.11 23:56:05 INFO - mozscreenshot == 0.1 23:56:05 INFO - mozsystemmonitor == 0.0 23:56:05 INFO - moztest == 0.7 23:56:05 INFO - mozversion == 1.4 23:56:05 INFO - psutil == 3.1.1 23:56:05 INFO - requests == 1.2.3 23:56:05 INFO - wsgiref == 0.1.2 23:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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:56:05 INFO - Using env: {'DISPLAY': ':0', 23:56:05 INFO - 'HOME': '/home/cltbld', 23:56:05 INFO - 'LANG': 'en_US.UTF-8', 23:56:05 INFO - 'LANGUAGE': 'en_US:en', 23:56:05 INFO - 'LOGNAME': 'cltbld', 23:56:05 INFO - 'MAIL': '/var/mail/cltbld', 23:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:05 INFO - 'MOZ_NO_REMOTE': '1', 23:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:05 INFO - 'NO_EM_RESTART': '1', 23:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:05 INFO - 'PWD': '/builds/slave/test', 23:56:05 INFO - 'SHELL': '/bin/bash', 23:56:05 INFO - 'SHLVL': '1', 23:56:05 INFO - 'TERM': 'linux', 23:56:05 INFO - 'TMOUT': '86400', 23:56:05 INFO - 'USER': 'cltbld', 23:56:05 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:05 INFO - '_': '/tools/buildbot/bin/python'} 23:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 INFO - Cleaning up... 23:56:05 INFO - Return code: 0 23:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:56:05 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:56:05 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:56:05 INFO - Using env: {'DISPLAY': ':0', 23:56:05 INFO - 'HOME': '/home/cltbld', 23:56:05 INFO - 'LANG': 'en_US.UTF-8', 23:56:05 INFO - 'LANGUAGE': 'en_US:en', 23:56:05 INFO - 'LOGNAME': 'cltbld', 23:56:05 INFO - 'MAIL': '/var/mail/cltbld', 23:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:05 INFO - 'MOZ_NO_REMOTE': '1', 23:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:05 INFO - 'NO_EM_RESTART': '1', 23:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:05 INFO - 'PWD': '/builds/slave/test', 23:56:05 INFO - 'SHELL': '/bin/bash', 23:56:05 INFO - 'SHLVL': '1', 23:56:05 INFO - 'TERM': 'linux', 23:56:05 INFO - 'TMOUT': '86400', 23:56:05 INFO - 'USER': 'cltbld', 23:56:05 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:05 INFO - '_': '/tools/buildbot/bin/python'} 23:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:05 INFO - Downloading/unpacking jsonschema 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:56:07 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:56:07 INFO - Downloading/unpacking functools32 (from jsonschema) 23:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:07 INFO - Downloading functools32-3.2.3-2.tar.gz 23:56:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:56:07 INFO - warning: no files found matching '*.txt' 23:56:07 INFO - no previously-included directories found matching 'build' 23:56:07 INFO - no previously-included directories found matching 'dist' 23:56:07 INFO - no previously-included directories found matching '.git*' 23:56:07 INFO - Installing collected packages: jsonschema, functools32 23:56:07 INFO - Running setup.py install for functools32 23:56:07 INFO - warning: no files found matching '*.txt' 23:56:07 INFO - no previously-included directories found matching 'build' 23:56:07 INFO - no previously-included directories found matching 'dist' 23:56:07 INFO - no previously-included directories found matching '.git*' 23:56:07 INFO - Successfully installed jsonschema functools32 23:56:07 INFO - Cleaning up... 23:56:07 INFO - Return code: 0 23:56:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2d34af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, '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': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', '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:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:56:07 INFO - Using env: {'DISPLAY': ':0', 23:56:07 INFO - 'HOME': '/home/cltbld', 23:56:07 INFO - 'LANG': 'en_US.UTF-8', 23:56:07 INFO - 'LANGUAGE': 'en_US:en', 23:56:07 INFO - 'LOGNAME': 'cltbld', 23:56:07 INFO - 'MAIL': '/var/mail/cltbld', 23:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:07 INFO - 'MOZ_NO_REMOTE': '1', 23:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:07 INFO - 'NO_EM_RESTART': '1', 23:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:07 INFO - 'PWD': '/builds/slave/test', 23:56:07 INFO - 'SHELL': '/bin/bash', 23:56:07 INFO - 'SHLVL': '1', 23:56:07 INFO - 'TERM': 'linux', 23:56:07 INFO - 'TMOUT': '86400', 23:56:07 INFO - 'USER': 'cltbld', 23:56:07 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:07 INFO - '_': '/tools/buildbot/bin/python'} 23:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:08 INFO - Downloading/unpacking flake8 23:56: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:56: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:56: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:56: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:56: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:56: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:56:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:56:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 23:56:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:56: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:56:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:56: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:56: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:56: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:56: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:56: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:56: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:56: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:56:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:56: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:56: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:56: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:56: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:56: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:56: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:56:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:56:10 INFO - no previously-included directories found matching 'docs/_build' 23:56:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:56:10 INFO - Running setup.py install for pep8 23:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:56:10 INFO - no previously-included directories found matching 'docs/_build' 23:56:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:56:10 INFO - Cleaning up... 23:56:10 INFO - Return code: 0 23:56:10 INFO - Running post-action listener: _resource_record_post_action 23:56:10 INFO - Running post-action listener: _start_resource_monitoring 23:56:10 INFO - Starting resource monitoring. 23:56:10 INFO - ##### 23:56:10 INFO - ##### Running install step. 23:56:10 INFO - ##### 23:56:10 INFO - Running pre-action listener: _resource_record_pre_action 23:56:10 INFO - Running main action method: install 23:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:56:10 INFO - Reading from file tmpfile_stdout 23:56:10 INFO - Detecting whether we're running mozinstall >=1.0... 23:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:56:11 INFO - Reading from file tmpfile_stdout 23:56:11 INFO - Output received: 23:56:11 INFO - Usage: mozinstall [options] installer 23:56:11 INFO - Options: 23:56:11 INFO - -h, --help show this help message and exit 23:56:11 INFO - -d DEST, --destination=DEST 23:56:11 INFO - Directory to install application into. [default: 23:56:11 INFO - "/builds/slave/test"] 23:56:11 INFO - --app=APP Application being installed. [default: firefox] 23:56:11 INFO - mkdir: /builds/slave/test/build/application 23:56: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:56: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:56:25 INFO - Reading from file tmpfile_stdout 23:56:25 INFO - Output received: 23:56:25 INFO - /builds/slave/test/build/application/firefox/firefox 23:56:25 INFO - Running post-action listener: _resource_record_post_action 23:56:25 INFO - ##### 23:56:25 INFO - ##### Running run-tests step. 23:56:25 INFO - ##### 23:56:25 INFO - Running pre-action listener: _resource_record_pre_action 23:56:25 INFO - Running main action method: run_tests 23:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:56:25 INFO - Python 2.7.3 23:56:25 INFO - Return code: 0 23:56:25 INFO - grabbing minidump binary from tooltool 23:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:25 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 0x20a80b0>, '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 0x20a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:56:25 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:56:25 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:56:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:56:25 INFO - Return code: 0 23:56:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:56:26 INFO - Return code: 0 23:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 23:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 23:56:26 INFO - Using env: {'DISPLAY': ':0', 23:56:26 INFO - 'HOME': '/home/cltbld', 23:56:26 INFO - 'LANG': 'en_US.UTF-8', 23:56:26 INFO - 'LANGUAGE': 'en_US:en', 23:56:26 INFO - 'LOGNAME': 'cltbld', 23:56:26 INFO - 'MAIL': '/var/mail/cltbld', 23:56:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:56:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:26 INFO - 'MOZ_NO_REMOTE': '1', 23:56:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:26 INFO - 'NO_EM_RESTART': '1', 23:56:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:26 INFO - 'PWD': '/builds/slave/test', 23:56:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:56:26 INFO - 'SHELL': '/bin/bash', 23:56:26 INFO - 'SHLVL': '1', 23:56:26 INFO - 'TERM': 'linux', 23:56:26 INFO - 'TMOUT': '86400', 23:56:26 INFO - 'USER': 'cltbld', 23:56:26 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539', 23:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:26 INFO - '_': '/tools/buildbot/bin/python'} 23:56:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 23:56:26 INFO - mozversion INFO | application_buildid: 20151213223232 23:56:26 INFO - mozversion INFO | application_changeset: 871d92a1b0701ad79780989bf2ae335d4a19f138 23:56:26 INFO - mozversion INFO | application_display_name: Nightly 23:56:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:56:26 INFO - mozversion INFO | application_name: Firefox 23:56:26 INFO - mozversion INFO | application_remotingname: firefox 23:56:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 23:56:26 INFO - mozversion INFO | application_vendor: Mozilla 23:56:26 INFO - mozversion INFO | application_version: 45.0a1 23:56:26 INFO - mozversion INFO | platform_buildid: 20151213223232 23:56:26 INFO - mozversion INFO | platform_changeset: 871d92a1b0701ad79780989bf2ae335d4a19f138 23:56:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 23:56:26 INFO - mozversion INFO | platform_version: 45.0a1 23:56:26 INFO - 2015-12-13 23:56:26,889 DEBUG : using testdate: 1450079786 23:56:26 INFO - 2015-12-13 23:56:26,889 DEBUG : actual date: 1450079786 23:56:26 INFO - 2015-12-13 23:56:26,898 INFO : starting webserver on 'localhost:39446' 23:56:26 INFO - 2015-12-13 23:56:26,899 INFO : Starting test suite talos-linux64-ix-018.e 23:56:26 INFO - 2015-12-13 23:56:26,899 INFO : Starting test dromaeo_css 23:56:26 INFO - 2015-12-13 23:56:26,899 DEBUG : operating with platform_type : linux_ 23:56:26 INFO - 2015-12-13 23:56:26,900 INFO : Initialising browser for dromaeo_css test... 23:56:26 INFO - 2015-12-13 23:56:26,914 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIup7v/profile http://localhost:39446/getInfo.html 23:56:31 INFO - 2015-12-13 23:56:31,522 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:56:31 INFO - 2015-12-13 23:56:31,523 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:56:31 INFO - 2015-12-13 23:56:31,523 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:56:31 INFO - 2015-12-13 23:56:31,523 DEBUG : BROWSER_OUTPUT: __metrics 23:56:31 INFO - 2015-12-13 23:56:31,619 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:56:32 INFO - 2015-12-13 23:56:32,545 INFO : Browser initialized. 23:56:32 INFO - 2015-12-13 23:56:32,545 INFO : Running cycle 1/1 for dromaeo_css test... 23:56:32 INFO - 2015-12-13 23:56:32,546 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIup7v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:56:44 INFO - 2015-12-13 23:56:44,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 143417344 23:56:44 INFO - 2015-12-13 23:56:44,575 DEBUG : BROWSER_OUTPUT: 23:57:34 INFO - 2015-12-13 23:57:34,221 DEBUG : BROWSER_OUTPUT: 1450079854214 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:59:46 INFO - 2015-12-13 23:59:46,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39446/tests/dromaeo/cssquery-ext.html) 23:59:47 INFO - 2015-12-13 23:59:47,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 146419712 23:59:47 INFO - 2015-12-13 23:59:47,359 DEBUG : BROWSER_OUTPUT: 00:02:49 INFO - 2015-12-14 00:02:49,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/dromaeo/cssquery-ext.html (next: http://localhost:39446/tests/dromaeo/cssquery-jquery.html) 00:02:49 INFO - 2015-12-14 00:02:49,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 144556032 00:02:49 INFO - 2015-12-14 00:02:49,994 DEBUG : BROWSER_OUTPUT: 00:05:51 INFO - 2015-12-14 00:05:51,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39446/tests/dromaeo/cssquery-mootools.html) 00:05:52 INFO - 2015-12-14 00:05:52,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 142004224 00:05:52 INFO - 2015-12-14 00:05:52,357 DEBUG : BROWSER_OUTPUT: 00:08:54 INFO - 2015-12-14 00:08:54,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39446/tests/dromaeo/cssquery-prototype.html) 00:08:54 INFO - 2015-12-14 00:08:54,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 143749120 00:08:54 INFO - 2015-12-14 00:08:54,710 DEBUG : BROWSER_OUTPUT: 00:11:57 INFO - 2015-12-14 00:11:57,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39446/tests/dromaeo/cssquery-yui.html) 00:11:57 INFO - 2015-12-14 00:11:57,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 144273408 00:11:57 INFO - 2015-12-14 00:11:57,926 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/dromaeo/cssquery-yui.html (next: http://localhost:39446/tests/dromaeo/cssquery-dojo.html) 00:15:00 INFO - 2015-12-14 00:15:00,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 144515072 00:15:00 INFO - 2015-12-14 00:15:00,578 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,578 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:15:00 INFO - 2015-12-14 00:15:00,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:15:00 INFO - 2015-12-14 00:15:00,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:15:00 INFO - 2015-12-14 00:15:00,579 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:15:00 INFO - 2015-12-14 00:15:00,579 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2679.9732002679975;2730.5358089124848;2753.6833264174625;2771.7782577393823;2789.98605006975;4724.5984091352275;4789.497102804204;4824.914394261294;4880.414350277967;4908.63185261106;4783.258594917785;4788.42538895333;4788.473267940523;4797.448293446246;4800.759962001895;4414.073044660625;4444.622207112399;4493.41585593874;4510.842120525782;4583.289590113538;4530.343100250462;4540.8864778380475;4567.200739870526;4580.9770951145365;4618.261078227484;552.6316374938167;4397.9120417591785;4415.646748260131;4495.3931219285305;4536.319552067183;4483.574060464283;4512.774361281923;4515.480719717209;4515.7516336601475;4541.091781643684;4484.641228701696;4490.7530085845265;4495;4506.143832671782;4540.091981603692;4539.2737162054245;4624.560666736655;4650.581447669726;4674.579287864074;4689.20283551797;5145.897082058375;5156.381234251876;5177.042247184246;5183.3002544656365;5193.948060519384;5102.158143906251;5136.691798492065;5180.870478238036;5200.193969934666;5245.26566280721;4819.180739274297;4873.585745211662;4888.755562221874;4889.3888263967;4927.679700819435;5369.919451208235;5386.91919621206;5388.084025715638;5390.649607775482;5402.729863506809;4853.174960256765;4948.282499037691;5045.823396181116;5118.206677964921;5157.58739300855;5265.710385928811;5279.498447647467;5307.177387504943;5310.442403547572;5363.383210930715;4874.46380898101;5236.73816309183;5247;5251.081060814418;5254;5076.923846142311;5080.161773307363;5095;5095.210242412432;5127.53852153308;4302.225599392077;4321.984333681582;4324.35134729793;4347;4353.717008394444;3766.849326026983;3776.490173826553;3777.565579958285;3811.847526098925;3815.0843797488956;4327.935080973788;4426.667999899956;4462.241418958784;4534.614557762561;4578.03861189154;5222.1383471727495;5222.634415590948;5257.395399529027;5260.658057226345;5263.842084737387;4553.817847286137;4563.863084107482;4567.840125595588;4591.517890621503;4608.493065762764;4443.422355093881;4521.095780843844;4568.428946381636;4588.311753236974;4628;4959.553640172402;4974.22899450593;4994.9500504994485;4997.800087996439;5042.344495215599;4991.625628077982;5274.103402421674;5277.182036784305;5288.8413347599635;5291.074062039204;4741.786619602057;4836.685615434985;4868.561829435368;4885.5358740919555;4938.604911607134;5154.072266991978;5154.329937108152;5155.716435596079;5158.252053452304;5203.037438073969;4990.925136123034;5142;5207.3751149862255;5214.634975551675;5228.3987341454695;4926.630502712239;4974.8756281093265;4993.475685053162;5002.224655178453;5032.119379108714;5043.445221025758;5095.923561146512;5105.132127538402;5107.361579802525;5143.92284115731;4721.1501929652995;4860.416749989882;4875.146849301429;4958.776855041459;5008;5107.901801112778;5126.333576635014;5126.871828204325;5133.076046311699;5135.794568217229;4949.406071271471;4967.329410529533;4985.077760614298;5018.673786203885;5047.697138171721 00:15:00 INFO - 2015-12-14 00:15:00,580 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.7264281537823;571.8627529392948;577.6649543264907;578.7106446776609;583.3845293215658;24377.146799861985;35732.82133589331;35824.2835143297;35876.2824743505;36157.638423615754;40821.795891020505;41467;41521.792391038005;41540.792296038475;41546;7710.421718371116;7935;7948;7949.046114466272;7960.1243863175005;7893.171217022216;7968.163342849004;7974.242446967529;7977.361811055131;7980.241877021674;7912.960435197816;7990.840183196333;8002.079760827522;8006;8014.799630009238;7956.960215198916;8066.71766488173;8066.838663226732;8075.676972921076;8092.1503242159315;7838.686452541891;7962.5620590867475;7982.082060562993;8001.359891208689;8039.196080391973;36881.262374752354;36919.81540092309;37139.81430092859;37222.25555488902;37271.81364093162;2963.155500682295;3089.4593446146832;3338.4825352070466;3346.180185854457;3424.2124311408515;27628.58557121645;27805.165845024683;28033;28206.576901346496;28217.717822821713;3437.8281085945605;3440.9311813763584;3461.0828130545424;3484.721222302235;3555.768875023141;216302;216753;217130;217183;217435.99999999843;40062.39906401406;41011.7949410251;53938.46061539413;62505;64393;55602.72198639062;55709.72145139329;55830.72084639551;56076.71961640166;56156.438435615935;12776.233425994471;12830.486780528674;12940.288284144463;12949.417276222594;12950.222986620833;9681.225501959827;9785.315027948118;9801.50992450389;9801.852972205423;9871.160951319218;19288.324908628132;19529.8047019528;19640.901795490932;19686.803131968783;19737.40787776369;7737;7989.3209077229085;8079.353651707849;8092.231238032377;8095;877.5612193903048;900.6757567275776;948.5494390164616;1039.5590595130143;1090.574675876409;26597.202083937125;26998.32504187411;27057.729422705914;27216.455670886473;27361.179164624697;903.1961554216753;955.0401846144719;960.4477425480377;974.697843668465;988.4711679251566;13855.16868987864;13906.58280251594;14156.433742650384;14195.503157389649;14201.502947396792;262491;266269;266427;266915;267270;46924.296135558;47033.29450058252;47328.763356183685;47352.5264747355;47396;1178.2047118195185;1201.9819702704467;1206.927584344942;1208.848893888264;1235.4131787401093;25255.621165682896;25593.360165995255;25966;26048;26445.206643800717;41062;41078.58921410747;41493.58506415018;41564.79217603893;41583.7920810394;241123;242876;242881;242985;243034.12692857021;24589.262322130366;25231.11691090803;25267.368315792253;28496;29424.558631620115;32419.837900810344;33296.33407331888;33663.326733465685;33685.49471757975;33791.662083378855;28703.48187190518;29076.854615726785;29224.56163157597;29344.853275733483;30097.84951075318;28305.292367690974;28872.711272887;29269.70730292755;31669.208269792518;32050.67949320477;35570.64429355673;35923;36161.81919090388;36228.4565731509;36776.44835327526;27836.721632783414;27945.44109117847;29301.26746831346;29873.402531948803;29883;23197.188098416475;23256.53486930218;23378.18176363819;23575.528489429773;23577.174798881955 00:15:00 INFO - 2015-12-14 00:15:00,580 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.36615796145287;335.46995746720177;336.3894531425464;337.38427370049664;339.59248901318426;14732.70534589309;15080.245987700626;15808.367665293374;16042.83957160428;16673.24970376333;11803.409829508533;11855.7628847423;11856.940715296432;13185.538506152287;14828.629284267872;4622;4812.25410061441;4974.77613507393;4980.8505744827535;4984.077945580061;4647.790849411767;4995;5025.422076461199;5033.320501732256;5425.945740542603;5497.120460726284;5524.226608274825;5524.917126243109;5528.474794894479;5534.916976245359;5213.113770658997;5222.503862133091;5224.190250511177;5323.733813309358;5333;5122.103631864409;5127.461616530248;5129.461406552333;5137.61467889906;5155.819546315861;13794.65513362174;18530.44408667742;18921.7161742574;19063.332783352515;19075.61848763017;1826.4794533557872;1832.2213059449814;1833.9633207335778;1871.5508278013315;1872.0171909747355;8661.826763464695;9446.433214007182;10226.07965283128;11131.554737810478;13346.532871349553;1746.4149509914193;1769.752234687132;1829.1768704083215;1834.97247541287;1858.4703359542466;53596.46403535954;57217;57275.42724572743;57365.13952290719;57525.42474575285;9972.950135249423;10053.748656283651;10066.547005384775;10070.647527336509;10122.797544049077;11528.78947710495;11810.88189118115;11850.170488065753;11853.940730296466;12413.379331033593;6672.532922695462;6815.284395138439;6884.414824739853;6927.376536111774;6960.269171736894;6665.533412661067;6703.664816759143;6716.294789047178;6739.326067393222;6742.325767423218;4053.8783836484954;4087.8569250076102;4100.958990410118;4135.338345864648;4159.376093585925;1704.6846333428355;1725.6031112844116;1726.055962126535;1729.9221535030954;1742.6079132195407;797.7686470923368;895.632790555869;898.6405437824923;926.7127190570944;1005.5424781724298;15515.534533963999;16654.666906661798;16960.236789344508;17060.402885898933;17500.649987000445;885.0927799006071;896.8161526886972;898.766320756608;902.37285086864;913.8629205619077;9210.309226808016;9516.666916657883;9603.567839447242;9635;9674.661386851427;524092;525019;527011;547262;552416;71808.64095679489;75072.62463687647;75672;75778.24221757712;78087.219127808;1076.6877605494476;1088.434014312553;1094.7700982793704;1127.21095233337;1128.1257025805066;14618;14682.63293417673;14899.255037247878;15001.624959375666;15253.237338132827;27625.861870690518;29064.709352907044;30927.381452371275;33760.49359259564;34454;37666;39165.608343916196;39544;39772.801135995294;40798;8895.199432051146;8939.553022348986;9102.681406150752;9118.361714679908;9119.589618467318;10742.409167495864;11910.940445297718;15609.921950390175;15679.843201567839;17043.573910652332;13660.521881734092;13930.930345348208;14009.789853152415;14208.147511149364;14217.786733199217;13463.259520726455;13726.74279326045;13862;14228.573142805319;14354.210518421587;13336.066475346632;13435.932820335836;14224.514993826579;14419.567412977627;14792.778108328168;8919.331050171133;8924;8924.286057115545;8931.910680893108;9050.09499050116;12847.614571562868;14056.578302650527;14075;14277.64305892361;14447.49433769813 00:15:00 INFO - 2015-12-14 00:15:00,581 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1435.6339133520958;1534.8004759381279;1597.8641815445687;1658.0880515716356;1734.800497942737;6075.301340345862;6250.562460627758;7233.312835280646;7439.404847612192;7447.515911465751;7015.263397343269;7203.063601731767;7287.052683151196;7307.159676637189;7307.707691692326;2087.1964293746864;2119.4913220827043;2123.193186589094;2124.0335647280526;2124.8193903518218;2102.1381233694187;2122.246602456129;2144.131626691185;2165.5560610074895;2167.6640120781303;2111.5460176062143;2133.829293656504;2146.828253739697;2157.8273738100993;2164.0370035334204;2088.2064815370136;2107.778683238253;2109.0298462707174;2112.535242246703;2114.9365519034454;2082.500199952016;2099.6745504446835;2108.230495869012;2122.8832414217213;2123.0764617391483;7377.668004939791;7406.666699998459;7438.479306448551;7451.515651482637;7456.664450099758;4292.849750258757;4367.737935723867;4370.8033138508845;4391.27543955247;4402.163588918127;2721.9319517012036;2738.7672047875953;2774.7502724754668;2791.6231308773463;2808;855.3755758296417;856.3748463621591;861.2378045429778;868.157886849761;890.7550423633488;9773.169280611086;9773.902260977371;9781.804363912754;9793.314467987244;9805.411675299505;3906.6093390661276;3910.022494376406;3958.6635136013188;3978.204359128186;3982.880513584597;8310.168983101641;8319.126491718403;8322.250997410261;8346.374021948379;8359.456635318686;4321.935170972438;4325.480942286946;4326.329418940069;4331.696781225347;4345.065810850682;3292.456744637156;3326.4511355626532;3812.1613245086037;3956.2680904032272;3959.2081583682802;3452.102453362144;3476.8261586920553;3485.6688614581576;3498.1954150545007;3498.2653642734804;1077.8329358949375;1097.550004498152;1102.7463683352873;1105.7069876482738;1112.0991996482712;938.2728385501155;959.2086528613921;988.5847943863595;999.6401295533602;1002.5137808163036;6729.394354508117;6771.119754431991;6780.593164410151;6818.977153426927;6819.693113809891;443.15578822342843;446.22134375514935;448.15075432056074;457.9347144378875;458.4200985753025;5241.13521268994;5274.1034024215205;5292.364916210079;5310.203469479532;5331.253624492574;8477.915220847835;8534.78663033429;8679.956600216958;8727.214550690342;8850.73447796567;8655.134486551295;8657.826843463221;8671.393002489765;8696.17386348296;8704.347173961978;6891.96620506928;6968.721251149897;6984.441244700513;6984.895226571605;7018.438524917994;6942.826429339307;7014.754483593049;7040.683169257498;7062.576245425291;7083.5041547091205;7775.300222979959;8002.359811215205;8015.679372825255;8069.314108300626;8072.878906816285;7985.640646171052;8165.38759593021;8209.671613135408;8253;8272.17278272168;6137.956547386866;6405.679716014274;6445.967770161306;6485.221773387224;6604.174478190226;7014.228434872262;7015.473839462163;7017.122859642544;7059.435245180271;7071.82320441993;6486.740530378732;6597.60414375139;6601.504887133388;6610.4050635443045;6655.667216639052;6220.440160385587;6226.315105338319;6235.158253635701;6306.716197771203;6346.650934198663;6644.867102658017;6648.767293144717;6655.434288085567;6675.532712710064;6683.398494135551;5925.318588362394;5962.582619216613;5989.760409583742;6044.304904935989;6053.092036194606;6199.845003874939;6253.96873015632;6263.029230469285;6271.686415679289;6276.592021518587 00:15:00 INFO - 2015-12-14 00:15:00,582 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.8837641696155;315.5881574545219;316.6105690001298;318.1077078793982;322.5049548942371;5568.805091821787;5633.690147041911;5653.095504719236;5671.943280567193;5752.683602401867;5572.108462645967;5684.488396044355;5700.2589663343815;5707;5728.25532680752;4323.4163387942535;4343.9565604344025;4346.348047792841;4350.15172041452;4352.586504282104;4338.696291259613;4341.565843415665;4344.847930322439;4344.89137771555;4346.826126954934;4045.2516284487315;4172.144710334389;4244.83020679174;4301.913961720779;4309.913801723964;4206.72656277341;4215.978920105395;4229.936550951738;4239.8092085856215;4250.149970005996;3727.9813600932093;3729.366007778684;3730.645588669072;3732.234891847165;3735.4023356263137;5432.809851655213;5446.346438427414;5460.590455715837;5469.234307196995;5480.013597552439;4819.734914579697;4938.530839570271;4947.82682606107;4951.183054795991;4959.2809042688605;5948.048312270016;5948.613340132921;5953.672548009858;5956.702164891738;5961.254843144607;4029.798510074514;4056.2901492239034;4057.006033521806;4058.5738497457933;4065.57311482296;6133.1413602095745;6169.136320915076;6187.690615469253;6200.81397558074;6203.875922481525;4046.2716710992304;4140.751554906655;4145.834166633361;4148.23257697327;4158.168366326747;4203.957960420418;4205.936910946339;4206.053637931441;4209.663226941837;4216.051388437577;4822.807087716452;4825.420949486084;4830.492798256132;4834.226523756252;4838.612910967185;5829.183914252008;5856.033754430471;5857.7949771757785;5860.765569377262;5878.882422351529;1468.9192094434695;1487.0557196180287;1505.8720008799155;1515.3862685612344;1523.1546491697216;972.6984634763246;996.4370130876032;1007.2596641468515;1014.878214614251;1020.9489525523694;5214.348206474191;5228.686278823283;5232.529072383504;5242.423333433319;5242.9213561796605;6190.0405437157315;6200.534959878028;6204.534659900435;6209.875802483925;6236.812895613139;5170.896582068338;5236.24074509194;5242.475752424727;5248.711320877312;5302.284191634157;3363.1255873472583;3384.7799893006877;3395.575553055868;3400.982995085009;3401;5882.588218824641;5889.057750759858;5894.233749612523;5896.675682837399;5908.05471124618;6289.182406287245;6406.615603063831;6424.614523128627;6424.807255782334;6456.354364563506;5814.186013958049;5845.444682755132;5859.882802343929;5861.472467477947;5888.587798854039;6240.906386404116;6270.12218289449;6279.1209230708655;6285.151504546828;6303.621782693053;6094.542909281733;6111.602745821685;6118.20463339763;6119.510439164767;6121.938780612137;5776.191333213437;5871.412858714094;5885.411458854081;5894.410558944071;5897.410258974069;4187.162567486575;4226.112516371596;4233.941514621345;4240.300350442266;4243.93634095495;6236.095766113979;6258.593191442542;6259.6870156492905;6271.43557079865;6275.309715931336;5832.066869300891;5974.910376344272;5986.2517185351835;6025.0661147522205;6027.457528822427;5958.463738263577;6018.187544681412;6025.849353766191;6027.246594175728;6030.30651475086;5826.126081087871;5887;5893.381194974466;5894.2926848778425;5908.084246941731;5831.825045248649;6011.458968692838;6042.305134909541;6053.4551890330085;6055.788047418319;5903.822885313448;5905.40945905406;5912.46787789101;5916.881662366814;5919.911201331897 00:15:00 INFO - 2015-12-14 00:15:00,584 DEBUG : BROWSER_OUTPUT: |5;yui.html;675.7938828657259;676.8375589858435;747.2863415438258;780.235369338049;783.9647215875286;11082.889171108287;11346.659600212008;11409.771804563914;11423;11452.770944581103;11599.072074234062;11659.766804663923;13211.603651890458;13491.123077000013;13495.460181592725;798.6605692580645;812.1878121878121;813.6785969542027;813.808754942588;814.5886327404652;801.6873419366423;817.7996390884242;823.390690888741;824.2952275804191;824.5135370131621;849.0702680564772;856.5374697663254;857.130013036765;857.3612658569375;858.8711693246;839.9328053755685;841.4656692999959;841.8947631546057;844.2570537926616;846.5217152308957;625.6465097220056;630.196499463188;630.64053489511;632.8512799492115;634.0932466572799;12779.61661150167;12813;12894.484220631164;12908.87091129086;12926.806097908539;10964.506597203144;11092.889071109346;11271.605493807678;11302.208845380826;11957.760844783143;9319.580618872167;9532.714018579454;9547.61809527618;9579.712608621752;9678.17735492484;3154.5899033125775;3226.6128064632394;3251.057193413907;3262.96737032629;3331.3337332533347;41511.584884151074;41821;41990.79004604957;42012.579874201176;42172.36741448881;9236.122568355995;9405.905940940504;9432.528373581294;9537.189338906272;9595;16138.677226455406;16150.03099814015;16156.919215403848;16177.4337898173;16213.513594592181;6077.392260773976;6092.360302168208;6196.194494715748;6263.060540918807;6393.520485963571;3590.7306951978185;3655.5613326401003;3669.9907525430185;3706.925861482809;3764.5482542095124;2693.811433199657;2732.7130651281727;2736.0697362896312;2741.163944996755;2757.2279761666764;465.3461886050105;473.4295174314942;486.66663335615215;486.99756501217973;487.28126014129583;455.44435788338177;465.3415417184713;480.38510706295995;482.8599706085196;582.8251524542706;7930.484518506279;8899.777505562413;8940.15068568498;8948.418352807046;9112.726618201465;633.5090305013651;646.1696719715144;648.6108334998963;661.1174082599687;673.0476375928007;3681.650243226889;3746.6253374662315;3773.9433908491396;3823.388257878726;3872.8838134856;52145;52177.2173417399;52238.477615224125;52556.47443525592;52676.473235267156;44918;45417.31874021826;45641.543584563726;45736.54263457323;46390.5360946393;40537;40686.796566017576;40940;41916;42418.36372454416;6560.245571759308;6680.231773346128;6711.3288671132495;8100.675972961016;8475.279601233717;30920;31222.843885780425;33550.161245969044;33752.49371259384;35125.29749405049;38203.23593528169;38523.42214866835;39058.6094139055;39274.60725392824;39906;10773;11023.44882755875;11044.944775276072;11119.444027798416;11142.108631309313;11098.889011109786;11128.109751220045;11210.887891120985;11294.548218071184;11324.094072474347;10125.341852779546;10464.529096190538;10488.895111048792;10535.841962370418;10864.782704346027;10732.356058636507;10795.6221532246;10931.617393391192;10945.616903408343;11152.776944460904;9945.651902183388;10071.949640252045;10168.084872361227;10184.898151018691;10426.165906727596;9310.301727370339;9424.586312053247;9443;9443.102905223992;9458.811782326511;8737.737867863974;8967.641294348154;9110.498922559324;9161.49611771359;9571.805887978708 00:15:00 INFO - 2015-12-14 00:15:00,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:15:00 INFO - 2015-12-14 00:15:00,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:15:00 INFO - 2015-12-14 00:15:00,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,337 00:15:00 INFO - 2015-12-14 00:15:00,584 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:15:00 INFO - 2015-12-14 00:15:00,584 DEBUG : BROWSER_OUTPUT: __startTimestamp1450080900572__endTimestamp 00:15:00 INFO - 2015-12-14 00:15:00,584 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:15:00 INFO - 2015-12-14 00:15:00,585 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:15:00 INFO - 2015-12-14 00:15:00,585 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,585 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4769.76 Median:4926.63 stddev:603.10 (12.2%) stddev-sans-first:582.25 00:15:00 INFO - 2015-12-14 00:15:00,585 DEBUG : BROWSER_OUTPUT: Values: 2680.0 2730.5 2753.7 2771.8 2790.0 4724.6 4789.5 4824.9 4880.4 4908.6 4783.3 4788.4 4788.5 4797.4 4800.8 4414.1 4444.6 4493.4 4510.8 4583.3 4530.3 4540.9 4567.2 4581.0 4618.3 552.6 4397.9 4415.6 4495.4 4536.3 4483.6 4512.8 4515.5 4515.8 4541.1 4484.6 4490.8 4495.0 4506.1 4540.1 4539.3 4624.6 4650.6 4674.6 4689.2 5145.9 5156.4 5177.0 5183.3 5193.9 5102.2 5136.7 5180.9 5200.2 5245.3 4819.2 4873.6 4888.8 4889.4 4927.7 5369.9 5386.9 5388.1 5390.6 5402.7 4853.2 4948.3 5045.8 5118.2 5157.6 5265.7 5279.5 5307.2 5310.4 5363.4 4874.5 5236.7 5247.0 5251.1 5254.0 5076.9 5080.2 5095.0 5095.2 5127.5 4302.2 4322.0 4324.4 4347.0 4353.7 3766.8 3776.5 3777.6 3811.8 3815.1 4327.9 4426.7 4462.2 4534.6 4578.0 5222.1 5222.6 5257.4 5260.7 5263.8 4553.8 4563.9 4567.8 4591.5 4608.5 4443.4 4521.1 4568.4 4588.3 4628.0 4959.6 4974.2 4995.0 4997.8 5042.3 4991.6 5274.1 5277.2 5288.8 5291.1 4741.8 4836.7 4868.6 4885.5 4938.6 5154.1 5154.3 5155.7 5158.3 5203.0 4990.9 5142.0 5207.4 5214.6 5228.4 4926.6 4974.9 4993.5 5002.2 5032.1 5043.4 5095.9 5105.1 5107.4 5143.9 4721.2 4860.4 4875.1 4958.8 5008.0 5107.9 5126.3 5126.9 5133.1 5135.8 4949.4 4967.3 4985.1 5018.7 5047.7 00:15:00 INFO - 2015-12-14 00:15:00,585 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,585 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39932.36 Median:3472.90 stddev:63216.48 (1820.3%) stddev-sans-first:63324.63 00:15:00 INFO - 2015-12-14 00:15:00,586 DEBUG : BROWSER_OUTPUT: Values: 541.7 571.9 577.7 578.7 583.4 24377.1 35732.8 35824.3 35876.3 36157.6 40821.8 41467.0 41521.8 41540.8 41546.0 7710.4 7935.0 7948.0 7949.0 7960.1 7893.2 7968.2 7974.2 7977.4 7980.2 7913.0 7990.8 8002.1 8006.0 8014.8 7957.0 8066.7 8066.8 8075.7 8092.2 7838.7 7962.6 7982.1 8001.4 8039.2 36881.3 36919.8 37139.8 37222.3 37271.8 2963.2 3089.5 3338.5 3346.2 3424.2 27628.6 27805.2 28033.0 28206.6 28217.7 3437.8 3440.9 3461.1 3484.7 3555.8 216302.0 216753.0 217130.0 217183.0 217436.0 40062.4 41011.8 53938.5 62505.0 64393.0 55602.7 55709.7 55830.7 56076.7 56156.4 12776.2 12830.5 12940.3 12949.4 12950.2 9681.2 9785.3 9801.5 9801.9 9871.2 19288.3 19529.8 19640.9 19686.8 19737.4 7737.0 7989.3 8079.4 8092.2 8095.0 877.6 900.7 948.5 1039.6 1090.6 26597.2 26998.3 27057.7 27216.5 27361.2 903.2 955.0 960.4 974.7 988.5 13855.2 13906.6 14156.4 14195.5 14201.5 262491.0 266269.0 266427.0 266915.0 267270.0 46924.3 47033.3 47328.8 47352.5 47396.0 1178.2 1202.0 1206.9 1208.8 1235.4 25255.6 25593.4 25966.0 26048.0 26445.2 41062.0 41078.6 41493.6 41564.8 41583.8 241123.0 242876.0 242881.0 242985.0 243034.1 24589.3 25231.1 25267.4 28496.0 29424.6 32419.8 33296.3 33663.3 33685.5 33791.7 28703.5 29076.9 29224.6 29344.9 30097.8 28305.3 28872.7 29269.7 31669.2 32050.7 35570.6 35923.0 36161.8 36228.5 36776.4 27836.7 27945.4 29301.3 29873.4 29883.0 23197.2 23256.5 23378.2 23575.5 23577.2 00:15:00 INFO - 2015-12-14 00:15:00,586 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,586 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27714.72 Median:17050.04 stddev:87387.43 (512.5%) stddev-sans-first:87608.39 00:15:00 INFO - 2015-12-14 00:15:00,587 DEBUG : BROWSER_OUTPUT: Values: 335.4 335.5 336.4 337.4 339.6 14732.7 15080.2 15808.4 16042.8 16673.2 11803.4 11855.8 11856.9 13185.5 14828.6 4622.0 4812.3 4974.8 4980.9 4984.1 4647.8 4995.0 5025.4 5033.3 5425.9 5497.1 5524.2 5524.9 5528.5 5534.9 5213.1 5222.5 5224.2 5323.7 5333.0 5122.1 5127.5 5129.5 5137.6 5155.8 13794.7 18530.4 18921.7 19063.3 19075.6 1826.5 1832.2 1834.0 1871.6 1872.0 8661.8 9446.4 10226.1 11131.6 13346.5 1746.4 1769.8 1829.2 1835.0 1858.5 53596.5 57217.0 57275.4 57365.1 57525.4 9973.0 10053.7 10066.5 10070.6 10122.8 11528.8 11810.9 11850.2 11853.9 12413.4 6672.5 6815.3 6884.4 6927.4 6960.3 6665.5 6703.7 6716.3 6739.3 6742.3 4053.9 4087.9 4101.0 4135.3 4159.4 1704.7 1725.6 1726.1 1729.9 1742.6 797.8 895.6 898.6 926.7 1005.5 15515.5 16654.7 16960.2 17060.4 17500.6 885.1 896.8 898.8 902.4 913.9 9210.3 9516.7 9603.6 9635.0 9674.7 524092.0 525019.0 527011.0 547262.0 552416.0 71808.6 75072.6 75672.0 75778.2 78087.2 1076.7 1088.4 1094.8 1127.2 1128.1 14618.0 14682.6 14899.3 15001.6 15253.2 27625.9 29064.7 30927.4 33760.5 34454.0 37666.0 39165.6 39544.0 39772.8 40798.0 8895.2 8939.6 9102.7 9118.4 9119.6 10742.4 11910.9 15609.9 15679.8 17043.6 13660.5 13930.9 14009.8 14208.1 14217.8 13463.3 13726.7 13862.0 14228.6 14354.2 13336.1 13435.9 14224.5 14419.6 14792.8 8919.3 8924.0 8924.3 8931.9 9050.1 12847.6 14056.6 14075.0 14277.6 14447.5 00:15:00 INFO - 2015-12-14 00:15:00,587 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,587 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5072.29 Median:6274.14 stddev:2667.53 (42.5%) stddev-sans-first:2661.01 00:15:00 INFO - 2015-12-14 00:15:00,587 DEBUG : BROWSER_OUTPUT: Values: 1435.6 1534.8 1597.9 1658.1 1734.8 6075.3 6250.6 7233.3 7439.4 7447.5 7015.3 7203.1 7287.1 7307.2 7307.7 2087.2 2119.5 2123.2 2124.0 2124.8 2102.1 2122.2 2144.1 2165.6 2167.7 2111.5 2133.8 2146.8 2157.8 2164.0 2088.2 2107.8 2109.0 2112.5 2114.9 2082.5 2099.7 2108.2 2122.9 2123.1 7377.7 7406.7 7438.5 7451.5 7456.7 4292.8 4367.7 4370.8 4391.3 4402.2 2721.9 2738.8 2774.8 2791.6 2808.0 855.4 856.4 861.2 868.2 890.8 9773.2 9773.9 9781.8 9793.3 9805.4 3906.6 3910.0 3958.7 3978.2 3982.9 8310.2 8319.1 8322.3 8346.4 8359.5 4321.9 4325.5 4326.3 4331.7 4345.1 3292.5 3326.5 3812.2 3956.3 3959.2 3452.1 3476.8 3485.7 3498.2 3498.3 1077.8 1097.6 1102.7 1105.7 1112.1 938.3 959.2 988.6 999.6 1002.5 6729.4 6771.1 6780.6 6819.0 6819.7 443.2 446.2 448.2 457.9 458.4 5241.1 5274.1 5292.4 5310.2 5331.3 8477.9 8534.8 8680.0 8727.2 8850.7 8655.1 8657.8 8671.4 8696.2 8704.3 6892.0 6968.7 6984.4 6984.9 7018.4 6942.8 7014.8 7040.7 7062.6 7083.5 7775.3 8002.4 8015.7 8069.3 8072.9 7985.6 8165.4 8209.7 8253.0 8272.2 6138.0 6405.7 6446.0 6485.2 6604.2 7014.2 7015.5 7017.1 7059.4 7071.8 6486.7 6597.6 6601.5 6610.4 6655.7 6220.4 6226.3 6235.2 6306.7 6346.7 6644.9 6648.8 6655.4 6675.5 6683.4 5925.3 5962.6 5989.8 6044.3 6053.1 6199.8 6254.0 6263.0 6271.7 6276.6 00:15:00 INFO - 2015-12-14 00:15:00,588 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,589 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4926.00 Median:5643.39 stddev:1477.82 (26.2%) stddev-sans-first:1440.70 00:15:00 INFO - 2015-12-14 00:15:00,589 DEBUG : BROWSER_OUTPUT: Values: 305.9 315.6 316.6 318.1 322.5 5568.8 5633.7 5653.1 5671.9 5752.7 5572.1 5684.5 5700.3 5707.0 5728.3 4323.4 4344.0 4346.3 4350.2 4352.6 4338.7 4341.6 4344.8 4344.9 4346.8 4045.3 4172.1 4244.8 4301.9 4309.9 4206.7 4216.0 4229.9 4239.8 4250.1 3728.0 3729.4 3730.6 3732.2 3735.4 5432.8 5446.3 5460.6 5469.2 5480.0 4819.7 4938.5 4947.8 4951.2 4959.3 5948.0 5948.6 5953.7 5956.7 5961.3 4029.8 4056.3 4057.0 4058.6 4065.6 6133.1 6169.1 6187.7 6200.8 6203.9 4046.3 4140.8 4145.8 4148.2 4158.2 4204.0 4205.9 4206.1 4209.7 4216.1 4822.8 4825.4 4830.5 4834.2 4838.6 5829.2 5856.0 5857.8 5860.8 5878.9 1468.9 1487.1 1505.9 1515.4 1523.2 972.7 996.4 1007.3 1014.9 1020.9 5214.3 5228.7 5232.5 5242.4 5242.9 6190.0 6200.5 6204.5 6209.9 6236.8 5170.9 5236.2 5242.5 5248.7 5302.3 3363.1 3384.8 3395.6 3401.0 3401.0 5882.6 5889.1 5894.2 5896.7 5908.1 6289.2 6406.6 6424.6 6424.8 6456.4 5814.2 5845.4 5859.9 5861.5 5888.6 6240.9 6270.1 6279.1 6285.2 6303.6 6094.5 6111.6 6118.2 6119.5 6121.9 5776.2 5871.4 5885.4 5894.4 5897.4 4187.2 4226.1 4233.9 4240.3 4243.9 6236.1 6258.6 6259.7 6271.4 6275.3 5832.1 5974.9 5986.3 6025.1 6027.5 5958.5 6018.2 6025.8 6027.2 6030.3 5826.1 5887.0 5893.4 5894.3 5908.1 5831.8 6011.5 6042.3 6053.5 6055.8 5903.8 5905.4 5912.5 5916.9 5919.9 00:15:00 INFO - 2015-12-14 00:15:00,589 DEBUG : BROWSER_OUTPUT: 00:15:00 INFO - 2015-12-14 00:15:00,589 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12522.16 Median:22936.38 stddev:14224.66 (62.0%) stddev-sans-first:14236.74 00:15:00 INFO - 2015-12-14 00:15:00,589 DEBUG : BROWSER_OUTPUT: Values: 675.8 676.8 747.3 780.2 784.0 11082.9 11346.7 11409.8 11423.0 11452.8 11599.1 11659.8 13211.6 13491.1 13495.5 798.7 812.2 813.7 813.8 814.6 801.7 817.8 823.4 824.3 824.5 849.1 856.5 857.1 857.4 858.9 839.9 841.5 841.9 844.3 846.5 625.6 630.2 630.6 632.9 634.1 12779.6 12813.0 12894.5 12908.9 12926.8 10964.5 11092.9 11271.6 11302.2 11957.8 9319.6 9532.7 9547.6 9579.7 9678.2 3154.6 3226.6 3251.1 3263.0 3331.3 41511.6 41821.0 41990.8 42012.6 42172.4 9236.1 9405.9 9432.5 9537.2 9595.0 16138.7 16150.0 16156.9 16177.4 16213.5 6077.4 6092.4 6196.2 6263.1 6393.5 3590.7 3655.6 3670.0 3706.9 3764.5 2693.8 2732.7 2736.1 2741.2 2757.2 465.3 473.4 486.7 487.0 487.3 455.4 465.3 480.4 482.9 582.8 7930.5 8899.8 8940.2 8948.4 9112.7 633.5 646.2 648.6 661.1 673.0 3681.7 3746.6 3773.9 3823.4 3872.9 52145.0 52177.2 52238.5 52556.5 52676.5 44918.0 45417.3 45641.5 45736.5 46390.5 40537.0 40686.8 40940.0 41916.0 42418.4 6560.2 6680.2 6711.3 8100.7 8475.3 30920.0 31222.8 33550.2 33752.5 35125.3 38203.2 38523.4 39058.6 39274.6 39906.0 10773.0 11023.4 11044.9 11119.4 11142.1 11098.9 11128.1 11210.9 11294.5 11324.1 10125.3 10464.5 10488.9 10535.8 10864.8 10732.4 10795.6 10931.6 10945.6 11152.8 9945.7 10071.9 10168.1 10184.9 10426.2 9310.3 9424.6 9443.0 9443.1 9458.8 8737.7 8967.6 9110.5 9161.5 9571.8 00:15:00 INFO - 2015-12-14 00:15:00,589 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:15:00 INFO - 2015-12-14 00:15:00,590 DEBUG : BROWSER_OUTPUT: 00:15:01 INFO - 2015-12-14 00:15:01,293 INFO : Browser exited with error code: 0 00:15:01 INFO - 2015-12-14 00:15:01,312 INFO : Completed test dromaeo_css (00:18:34) 00:15:01 INFO - 2015-12-14 00:15:01,312 INFO : Starting test kraken 00:15:01 INFO - 2015-12-14 00:15:01,312 DEBUG : operating with platform_type : linux_ 00:15:01 INFO - 2015-12-14 00:15:01,312 INFO : Initialising browser for kraken test... 00:15:01 INFO - 2015-12-14 00:15:01,318 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8guKzN/profile http://localhost:39446/getInfo.html 00:15:05 INFO - 2015-12-14 00:15:05,840 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:15:05 INFO - 2015-12-14 00:15:05,840 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:15:05 INFO - 2015-12-14 00:15:05,840 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:15:05 INFO - 2015-12-14 00:15:05,840 DEBUG : BROWSER_OUTPUT: __metrics 00:15:05 INFO - 2015-12-14 00:15:05,983 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] 00:15:06 INFO - 2015-12-14 00:15:06,857 INFO : Browser initialized. 00:15:06 INFO - 2015-12-14 00:15:06,857 INFO : Running cycle 1/1 for kraken test... 00:15:06 INFO - 2015-12-14 00:15:06,858 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8guKzN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:15:18 INFO - 2015-12-14 00:15:18,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 143831040 00:15:18 INFO - 2015-12-14 00:15:18,866 DEBUG : BROWSER_OUTPUT: 00:15:21 INFO - 2015-12-14 00:15:21,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39446/tests/kraken/driver.html?testName=audio-beat-detection) 00:15:22 INFO - 2015-12-14 00:15:22,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 143093760 00:15:22 INFO - 2015-12-14 00:15:22,076 DEBUG : BROWSER_OUTPUT: 00:15:24 INFO - 2015-12-14 00:15:24,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39446/tests/kraken/driver.html?testName=audio-dft) 00:15:25 INFO - 2015-12-14 00:15:25,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 143765504 00:15:25 INFO - 2015-12-14 00:15:25,416 DEBUG : BROWSER_OUTPUT: 00:15:28 INFO - 2015-12-14 00:15:28,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39446/tests/kraken/driver.html?testName=audio-fft) 00:15:28 INFO - 2015-12-14 00:15:28,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 138928128 00:15:28 INFO - 2015-12-14 00:15:28,916 DEBUG : BROWSER_OUTPUT: 00:15:31 INFO - 2015-12-14 00:15:31,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39446/tests/kraken/driver.html?testName=audio-oscillator) 00:15:31 INFO - 2015-12-14 00:15:31,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 00:15:31 INFO - 2015-12-14 00:15:31,593 DEBUG : BROWSER_OUTPUT: 00:15:33 INFO - 2015-12-14 00:15:33,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:15:34 INFO - 2015-12-14 00:15:34,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 140681216 00:15:34 INFO - 2015-12-14 00:15:34,423 DEBUG : BROWSER_OUTPUT: 00:15:37 INFO - 2015-12-14 00:15:37,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39446/tests/kraken/driver.html?testName=imaging-darkroom) 00:15:38 INFO - 2015-12-14 00:15:38,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 00:15:38 INFO - 2015-12-14 00:15:38,055 DEBUG : BROWSER_OUTPUT: 00:15:41 INFO - 2015-12-14 00:15:41,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39446/tests/kraken/driver.html?testName=imaging-desaturate) 00:15:42 INFO - 2015-12-14 00:15:42,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 138002432 00:15:42 INFO - 2015-12-14 00:15:42,133 DEBUG : BROWSER_OUTPUT: 00:15:44 INFO - 2015-12-14 00:15:44,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39446/tests/kraken/driver.html?testName=json-parse-financial) 00:15:45 INFO - 2015-12-14 00:15:45,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 00:15:45 INFO - 2015-12-14 00:15:45,589 DEBUG : BROWSER_OUTPUT: 00:15:47 INFO - 2015-12-14 00:15:47,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:15:47 INFO - 2015-12-14 00:15:47,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 140427264 00:15:47 INFO - 2015-12-14 00:15:47,982 DEBUG : BROWSER_OUTPUT: 00:15:49 INFO - 2015-12-14 00:15:49,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:15:50 INFO - 2015-12-14 00:15:50,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 141459456 00:15:50 INFO - 2015-12-14 00:15:50,484 DEBUG : BROWSER_OUTPUT: 00:15:52 INFO - 2015-12-14 00:15:52,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:15:53 INFO - 2015-12-14 00:15:53,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 141025280 00:15:53 INFO - 2015-12-14 00:15:53,250 DEBUG : BROWSER_OUTPUT: 00:15:55 INFO - 2015-12-14 00:15:55,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:15:56 INFO - 2015-12-14 00:15:56,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 141647872 00:15:56 INFO - 2015-12-14 00:15:56,428 DEBUG : BROWSER_OUTPUT: 00:15:59 INFO - 2015-12-14 00:15:59,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:15:59 INFO - 2015-12-14 00:15:59,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 141639680 00:15:59 INFO - 2015-12-14 00:15:59,686 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39446/tests/kraken/driver.html?testName=ai-astar) 00:16:01 INFO - 2015-12-14 00:16:01,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 141291520 00:16:01 INFO - 2015-12-14 00:16:01,682 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,685 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:16:01 INFO - 2015-12-14 00:16:01,685 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:16:01 INFO - 2015-12-14 00:16:01,685 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:16:01 INFO - 2015-12-14 00:16:01,685 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;111;113;113;113;123;112;111;113;113 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;130;153;166;131;165;159;131;170;134 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;165;163;162;165;175;166;165;163 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;73;72;149;73;79;72;73;150 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;132;95;94;94;127;93;95;131 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;113;110;110;109;110;110;110;110;111;110 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;149;152;148;147;147;148;147;147 00:16:01 INFO - 2015-12-14 00:16:01,686 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;97;96;97;96;96;95 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;74;74;82;82;73;80;77;74 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;67;67;69;68;68;68;68 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;89;86;87;85;83;88;85;92;86 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;121;121;135;127;130;136;126;130;122 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;157;162;151;162;137;140;150;148;162 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;71;70;71;70;72;70;71;70 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:16:01 INFO - 2015-12-14 00:16:01,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,790 00:16:01 INFO - 2015-12-14 00:16:01,688 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:16:01 INFO - 2015-12-14 00:16:01,688 DEBUG : BROWSER_OUTPUT: __startTimestamp1450080961683__endTimestamp 00:16:01 INFO - 2015-12-14 00:16:01,688 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,689 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:16:01 INFO - 2015-12-14 00:16:01,689 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:16:01 INFO - 2015-12-14 00:16:01,689 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,689 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:3.47 (3.1%) stddev-sans-first:3.64 00:16:01 INFO - 2015-12-14 00:16:01,689 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 113.0 113.0 113.0 123.0 112.0 111.0 113.0 113.0 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:158.00 stddev:16.32 (10.3%) stddev-sans-first:17.09 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: Values: 157.0 130.0 153.0 166.0 131.0 165.0 159.0 131.0 170.0 134.0 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.70 (2.2%) stddev-sans-first:3.90 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 165.0 163.0 162.0 165.0 175.0 166.0 165.0 163.0 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,690 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.70 Median:73.00 stddev:32.11 (44.0%) stddev-sans-first:33.49 00:16:01 INFO - 2015-12-14 00:16:01,691 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 72.0 149.0 73.0 79.0 72.0 73.0 150.0 00:16:01 INFO - 2015-12-14 00:16:01,691 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,691 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.00 stddev:17.45 (18.6%) stddev-sans-first:17.98 00:16:01 INFO - 2015-12-14 00:16:01,691 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 132.0 95.0 94.0 94.0 127.0 93.0 95.0 131.0 00:16:01 INFO - 2015-12-14 00:16:01,691 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,691 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.06 (1.0%) stddev-sans-first:0.50 00:16:01 INFO - 2015-12-14 00:16:01,692 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 00:16:01 INFO - 2015-12-14 00:16:01,692 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,692 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.56 (1.1%) stddev-sans-first:1.62 00:16:01 INFO - 2015-12-14 00:16:01,693 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 149.0 152.0 148.0 147.0 147.0 148.0 147.0 147.0 00:16:01 INFO - 2015-12-14 00:16:01,693 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,693 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 00:16:01 INFO - 2015-12-14 00:16:01,693 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 97.0 96.0 97.0 96.0 96.0 95.0 00:16:01 INFO - 2015-12-14 00:16:01,694 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,694 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.40 Median:75.50 stddev:3.60 (4.8%) stddev-sans-first:3.71 00:16:01 INFO - 2015-12-14 00:16:01,694 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 74.0 74.0 82.0 82.0 73.0 80.0 77.0 74.0 00:16:01 INFO - 2015-12-14 00:16:01,694 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,695 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 00:16:01 INFO - 2015-12-14 00:16:01,695 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 67.0 67.0 69.0 68.0 68.0 68.0 68.0 00:16:01 INFO - 2015-12-14 00:16:01,695 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,695 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.50 stddev:2.55 (2.9%) stddev-sans-first:2.64 00:16:01 INFO - 2015-12-14 00:16:01,695 DEBUG : BROWSER_OUTPUT: Values: 85.0 89.0 86.0 87.0 85.0 83.0 88.0 85.0 92.0 86.0 00:16:01 INFO - 2015-12-14 00:16:01,696 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,696 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.50 stddev:5.42 (4.2%) stddev-sans-first:5.68 00:16:01 INFO - 2015-12-14 00:16:01,696 DEBUG : BROWSER_OUTPUT: Values: 125.0 121.0 121.0 135.0 127.0 130.0 136.0 126.0 130.0 122.0 00:16:01 INFO - 2015-12-14 00:16:01,696 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,697 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:154.00 stddev:9.47 (6.1%) stddev-sans-first:9.45 00:16:01 INFO - 2015-12-14 00:16:01,697 DEBUG : BROWSER_OUTPUT: Values: 142.0 157.0 162.0 151.0 162.0 137.0 140.0 150.0 148.0 162.0 00:16:01 INFO - 2015-12-14 00:16:01,697 DEBUG : BROWSER_OUTPUT: 00:16:01 INFO - 2015-12-14 00:16:01,697 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 00:16:01 INFO - 2015-12-14 00:16:01,697 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 71.0 70.0 72.0 70.0 71.0 70.0 00:16:01 INFO - 2015-12-14 00:16:01,697 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:16:01 INFO - 2015-12-14 00:16:01,697 DEBUG : BROWSER_OUTPUT: 00:16:02 INFO - 2015-12-14 00:16:02,625 INFO : Browser exited with error code: 0 00:16:02 INFO - 2015-12-14 00:16:02,676 INFO : Completed test kraken (00:01:01) 00:16:02 INFO - 2015-12-14 00:16:02,676 INFO : Starting test v8_7 00:16:02 INFO - 2015-12-14 00:16:02,676 DEBUG : operating with platform_type : linux_ 00:16:02 INFO - 2015-12-14 00:16:02,676 INFO : Initialising browser for v8_7 test... 00:16:02 INFO - 2015-12-14 00:16:02,682 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMvSUBl/profile http://localhost:39446/getInfo.html 00:16:07 INFO - 2015-12-14 00:16:07,158 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:16:07 INFO - 2015-12-14 00:16:07,158 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:16:07 INFO - 2015-12-14 00:16:07,158 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:16:07 INFO - 2015-12-14 00:16:07,159 DEBUG : BROWSER_OUTPUT: __metrics 00:16:07 INFO - 2015-12-14 00:16:07,323 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] 00:16:08 INFO - 2015-12-14 00:16:08,269 INFO : Browser initialized. 00:16:08 INFO - 2015-12-14 00:16:08,269 INFO : Running cycle 1/1 for v8_7 test... 00:16:08 INFO - 2015-12-14 00:16:08,270 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMvSUBl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:16:20 INFO - 2015-12-14 00:16:20,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 143818752 00:16:20 INFO - 2015-12-14 00:16:20,341 DEBUG : BROWSER_OUTPUT: 00:16:41 INFO - 2015-12-14 00:16:41,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39446/tests/v8_7/run.html (next: http://localhost:39446/tests/v8_7/run.html) 00:16:42 INFO - 2015-12-14 00:16:42,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 138936320 00:16:42 INFO - 2015-12-14 00:16:42,026 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,027 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:16:42 INFO - 2015-12-14 00:16:42,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:16:42 INFO - 2015-12-14 00:16:42,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:16:42 INFO - 2015-12-14 00:16:42,027 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:16:42 INFO - 2015-12-14 00:16:42,027 DEBUG : BROWSER_OUTPUT: |0;Richards;164.79894528675015 00:16:42 INFO - 2015-12-14 00:16:42,027 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.81113394358303 00:16:42 INFO - 2015-12-14 00:16:42,027 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.2387025228722 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: |5;Earley;714.2857142857143 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: |7;RegExp;26256.410256410258 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: |8;Splay;597.1563981042653 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: __startTimestamp1450081002024__endTimestamp 00:16:42 INFO - 2015-12-14 00:16:42,028 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.80 Median:164.80 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: Values: 164.8 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.81 Median:186.81 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: Values: 186.8 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.24 Median:277.24 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,029 DEBUG : BROWSER_OUTPUT: Values: 277.2 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: Values: 5191.7 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: Values: 1060.4 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: Values: 714.3 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,030 DEBUG : BROWSER_OUTPUT: Values: 12268.3 00:16:42 INFO - 2015-12-14 00:16:42,031 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,031 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: Values: 26256.4 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.16 Median:597.16 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: Values: 597.2 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: Values: 4840.6 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:16:42 INFO - 2015-12-14 00:16:42,032 DEBUG : BROWSER_OUTPUT: 00:16:42 INFO - 2015-12-14 00:16:42,893 INFO : Browser exited with error code: 0 00:16:42 INFO - 2015-12-14 00:16:42,910 INFO : Completed test v8_7 (00:00:40) 00:16:43 INFO - 2015-12-14 00:16:43,020 INFO : Completed test suite (00:20:16) 00:16:43 INFO - 2015-12-14 00:16:43,020 DEBUG : Working with test: dromaeo_css 00:16:43 INFO - 2015-12-14 00:16:43,020 DEBUG : Generating results file: dromaeo_css 00:16:43 INFO - 2015-12-14 00:16:43,021 DEBUG : Working with test: kraken 00:16:43 INFO - 2015-12-14 00:16:43,021 DEBUG : Generating results file: kraken 00:16:43 INFO - 2015-12-14 00:16:43,021 INFO : javascript benchmark 00:16:43 INFO - 2015-12-14 00:16:43,022 DEBUG : Working with test: v8_7 00:16:43 INFO - 2015-12-14 00:16:43,022 DEBUG : Generating results file: v8_7 00:16:43 INFO - 2015-12-14 00:16:43,022 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:16:43 INFO - 2015-12-14 00:16:43,092 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 00:16:43 INFO - 2015-12-14 00:16:43,092 DEBUG : process_Request line: dromaeo_css 6413.47 graph.html#tests=[[72,94,43]] 00:16:43 INFO - 2015-12-14 00:16:43,093 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:16:43 INFO - 2015-12-14 00:16:43,137 DEBUG : process_Request line: kraken 1556.20 graph.html#tests=[[232,94,43]] 00:16:43 INFO - 2015-12-14 00:16:43,137 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:16:43 INFO - 2015-12-14 00:16:43,171 DEBUG : process_Request line: v8_7 21380.49 graph.html#tests=[[230,94,43]] 00:16:43 INFO - 2015-12-14 00:16:43,172 INFO : javascript benchmark 00:16:43 INFO - 2015-12-14 00:16:43,176 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.9732002679975, 2730.5358089124848, 2753.6833264174625, 2771.7782577393823, 2789.98605006975, 4724.5984091352275, 4789.497102804204, 4824.914394261294, 4880.414350277967, 4908.63185261106, 4783.258594917785, 4788.42538895333, 4788.473267940523, 4797.448293446246, 4800.759962001895, 4414.073044660625, 4444.622207112399, 4493.41585593874, 4510.842120525782, 4583.289590113538, 4530.343100250462, 4540.8864778380475, 4567.200739870526, 4580.9770951145365, 4618.261078227484, 552.6316374938167, 4397.9120417591785, 4415.646748260131, 4495.3931219285305, 4536.319552067183, 4483.574060464283, 4512.774361281923, 4515.480719717209, 4515.7516336601475, 4541.091781643684, 4484.641228701696, 4490.7530085845265, 4495.0, 4506.143832671782, 4540.091981603692, 4539.2737162054245, 4624.560666736655, 4650.581447669726, 4674.579287864074, 4689.20283551797, 5145.897082058375, 5156.381234251876, 5177.042247184246, 5183.3002544656365, 5193.948060519384, 5102.158143906251, 5136.691798492065, 5180.870478238036, 5200.193969934666, 5245.26566280721, 4819.180739274297, 4873.585745211662, 4888.755562221874, 4889.3888263967, 4927.679700819435, 5369.919451208235, 5386.91919621206, 5388.084025715638, 5390.649607775482, 5402.729863506809, 4853.174960256765, 4948.282499037691, 5045.823396181116, 5118.206677964921, 5157.58739300855, 5265.710385928811, 5279.498447647467, 5307.177387504943, 5310.442403547572, 5363.383210930715, 4874.46380898101, 5236.73816309183, 5247.0, 5251.081060814418, 5254.0, 5076.923846142311, 5080.161773307363, 5095.0, 5095.210242412432, 5127.53852153308, 4302.225599392077, 4321.984333681582, 4324.35134729793, 4347.0, 4353.717008394444, 3766.849326026983, 3776.490173826553, 3777.565579958285, 3811.847526098925, 3815.0843797488956, 4327.935080973788, 4426.667999899956, 4462.241418958784, 4534.614557762561, 4578.03861189154, 5222.1383471727495, 5222.634415590948, 5257.395399529027, 5260.658057226345, 5263.842084737387, 4553.817847286137, 4563.863084107482, 4567.840125595588, 4591.517890621503, 4608.493065762764, 4443.422355093881, 4521.095780843844, 4568.428946381636, 4588.311753236974, 4628.0, 4959.553640172402, 4974.22899450593, 4994.9500504994485, 4997.800087996439, 5042.344495215599, 4991.625628077982, 5274.103402421674, 5277.182036784305, 5288.8413347599635, 5291.074062039204, 4741.786619602057, 4836.685615434985, 4868.561829435368, 4885.5358740919555, 4938.604911607134, 5154.072266991978, 5154.329937108152, 5155.716435596079, 5158.252053452304, 5203.037438073969, 4990.925136123034, 5142.0, 5207.3751149862255, 5214.634975551675, 5228.3987341454695, 4926.630502712239, 4974.8756281093265, 4993.475685053162, 5002.224655178453, 5032.119379108714, 5043.445221025758, 5095.923561146512, 5105.132127538402, 5107.361579802525, 5143.92284115731, 4721.1501929652995, 4860.416749989882, 4875.146849301429, 4958.776855041459, 5008.0, 5107.901801112778, 5126.333576635014, 5126.871828204325, 5133.076046311699, 5135.794568217229, 4949.406071271471, 4967.329410529533, 4985.077760614298, 5018.673786203885, 5047.697138171721], "unit": "ms", "name": "dojo.html", "value": 4733.800795267564}, {"lowerIsBetter": false, "replicates": [541.7264281537823, 571.8627529392948, 577.6649543264907, 578.7106446776609, 583.3845293215658, 24377.146799861985, 35732.82133589331, 35824.2835143297, 35876.2824743505, 36157.638423615754, 40821.795891020505, 41467.0, 41521.792391038005, 41540.792296038475, 41546.0, 7710.421718371116, 7935.0, 7948.0, 7949.046114466272, 7960.1243863175005, 7893.171217022216, 7968.163342849004, 7974.242446967529, 7977.361811055131, 7980.241877021674, 7912.960435197816, 7990.840183196333, 8002.079760827522, 8006.0, 8014.799630009238, 7956.960215198916, 8066.71766488173, 8066.838663226732, 8075.676972921076, 8092.1503242159315, 7838.686452541891, 7962.5620590867475, 7982.082060562993, 8001.359891208689, 8039.196080391973, 36881.262374752354, 36919.81540092309, 37139.81430092859, 37222.25555488902, 37271.81364093162, 2963.155500682295, 3089.4593446146832, 3338.4825352070466, 3346.180185854457, 3424.2124311408515, 27628.58557121645, 27805.165845024683, 28033.0, 28206.576901346496, 28217.717822821713, 3437.8281085945605, 3440.9311813763584, 3461.0828130545424, 3484.721222302235, 3555.768875023141, 216302.0, 216753.0, 217130.0, 217183.0, 217435.99999999843, 40062.39906401406, 41011.7949410251, 53938.46061539413, 62505.0, 64393.0, 55602.72198639062, 55709.72145139329, 55830.72084639551, 56076.71961640166, 56156.438435615935, 12776.233425994471, 12830.486780528674, 12940.288284144463, 12949.417276222594, 12950.222986620833, 9681.225501959827, 9785.315027948118, 9801.50992450389, 9801.852972205423, 9871.160951319218, 19288.324908628132, 19529.8047019528, 19640.901795490932, 19686.803131968783, 19737.40787776369, 7737.0, 7989.3209077229085, 8079.353651707849, 8092.231238032377, 8095.0, 877.5612193903048, 900.6757567275776, 948.5494390164616, 1039.5590595130143, 1090.574675876409, 26597.202083937125, 26998.32504187411, 27057.729422705914, 27216.455670886473, 27361.179164624697, 903.1961554216753, 955.0401846144719, 960.4477425480377, 974.697843668465, 988.4711679251566, 13855.16868987864, 13906.58280251594, 14156.433742650384, 14195.503157389649, 14201.502947396792, 262491.0, 266269.0, 266427.0, 266915.0, 267270.0, 46924.296135558, 47033.29450058252, 47328.763356183685, 47352.5264747355, 47396.0, 1178.2047118195185, 1201.9819702704467, 1206.927584344942, 1208.848893888264, 1235.4131787401093, 25255.621165682896, 25593.360165995255, 25966.0, 26048.0, 26445.206643800717, 41062.0, 41078.58921410747, 41493.58506415018, 41564.79217603893, 41583.7920810394, 241123.0, 242876.0, 242881.0, 242985.0, 243034.12692857021, 24589.262322130366, 25231.11691090803, 25267.368315792253, 28496.0, 29424.558631620115, 32419.837900810344, 33296.33407331888, 33663.326733465685, 33685.49471757975, 33791.662083378855, 28703.48187190518, 29076.854615726785, 29224.56163157597, 29344.853275733483, 30097.84951075318, 28305.292367690974, 28872.711272887, 29269.70730292755, 31669.208269792518, 32050.67949320477, 35570.64429355673, 35923.0, 36161.81919090388, 36228.4565731509, 36776.44835327526, 27836.721632783414, 27945.44109117847, 29301.26746831346, 29873.402531948803, 29883.0, 23197.188098416475, 23256.53486930218, 23378.18176363819, 23575.528489429773, 23577.174798881955], "unit": "ms", "name": "ext.html", "value": 16679.26670649731}, {"lowerIsBetter": false, "replicates": [335.36615796145287, 335.46995746720177, 336.3894531425464, 337.38427370049664, 339.59248901318426, 14732.70534589309, 15080.245987700626, 15808.367665293374, 16042.83957160428, 16673.24970376333, 11803.409829508533, 11855.7628847423, 11856.940715296432, 13185.538506152287, 14828.629284267872, 4622.0, 4812.25410061441, 4974.77613507393, 4980.8505744827535, 4984.077945580061, 4647.790849411767, 4995.0, 5025.422076461199, 5033.320501732256, 5425.945740542603, 5497.120460726284, 5524.226608274825, 5524.917126243109, 5528.474794894479, 5534.916976245359, 5213.113770658997, 5222.503862133091, 5224.190250511177, 5323.733813309358, 5333.0, 5122.103631864409, 5127.461616530248, 5129.461406552333, 5137.61467889906, 5155.819546315861, 13794.65513362174, 18530.44408667742, 18921.7161742574, 19063.332783352515, 19075.61848763017, 1826.4794533557872, 1832.2213059449814, 1833.9633207335778, 1871.5508278013315, 1872.0171909747355, 8661.826763464695, 9446.433214007182, 10226.07965283128, 11131.554737810478, 13346.532871349553, 1746.4149509914193, 1769.752234687132, 1829.1768704083215, 1834.97247541287, 1858.4703359542466, 53596.46403535954, 57217.0, 57275.42724572743, 57365.13952290719, 57525.42474575285, 9972.950135249423, 10053.748656283651, 10066.547005384775, 10070.647527336509, 10122.797544049077, 11528.78947710495, 11810.88189118115, 11850.170488065753, 11853.940730296466, 12413.379331033593, 6672.532922695462, 6815.284395138439, 6884.414824739853, 6927.376536111774, 6960.269171736894, 6665.533412661067, 6703.664816759143, 6716.294789047178, 6739.326067393222, 6742.325767423218, 4053.8783836484954, 4087.8569250076102, 4100.958990410118, 4135.338345864648, 4159.376093585925, 1704.6846333428355, 1725.6031112844116, 1726.055962126535, 1729.9221535030954, 1742.6079132195407, 797.7686470923368, 895.632790555869, 898.6405437824923, 926.7127190570944, 1005.5424781724298, 15515.534533963999, 16654.666906661798, 16960.236789344508, 17060.402885898933, 17500.649987000445, 885.0927799006071, 896.8161526886972, 898.766320756608, 902.37285086864, 913.8629205619077, 9210.309226808016, 9516.666916657883, 9603.567839447242, 9635.0, 9674.661386851427, 524092.0, 525019.0, 527011.0, 547262.0, 552416.0, 71808.64095679489, 75072.62463687647, 75672.0, 75778.24221757712, 78087.219127808, 1076.6877605494476, 1088.434014312553, 1094.7700982793704, 1127.21095233337, 1128.1257025805066, 14618.0, 14682.63293417673, 14899.255037247878, 15001.624959375666, 15253.237338132827, 27625.861870690518, 29064.709352907044, 30927.381452371275, 33760.49359259564, 34454.0, 37666.0, 39165.608343916196, 39544.0, 39772.801135995294, 40798.0, 8895.199432051146, 8939.553022348986, 9102.681406150752, 9118.361714679908, 9119.589618467318, 10742.409167495864, 11910.940445297718, 15609.921950390175, 15679.843201567839, 17043.573910652332, 13660.521881734092, 13930.930345348208, 14009.789853152415, 14208.147511149364, 14217.786733199217, 13463.259520726455, 13726.74279326045, 13862.0, 14228.573142805319, 14354.210518421587, 13336.066475346632, 13435.932820335836, 14224.514993826579, 14419.567412977627, 14792.778108328168, 8919.331050171133, 8924.0, 8924.286057115545, 8931.910680893108, 9050.09499050116, 12847.614571562868, 14056.578302650527, 14075.0, 14277.64305892361, 14447.49433769813], "unit": "ms", "name": "jquery.html", "value": 8360.601720129947}, {"lowerIsBetter": false, "replicates": [1435.6339133520958, 1534.8004759381279, 1597.8641815445687, 1658.0880515716356, 1734.800497942737, 6075.301340345862, 6250.562460627758, 7233.312835280646, 7439.404847612192, 7447.515911465751, 7015.263397343269, 7203.063601731767, 7287.052683151196, 7307.159676637189, 7307.707691692326, 2087.1964293746864, 2119.4913220827043, 2123.193186589094, 2124.0335647280526, 2124.8193903518218, 2102.1381233694187, 2122.246602456129, 2144.131626691185, 2165.5560610074895, 2167.6640120781303, 2111.5460176062143, 2133.829293656504, 2146.828253739697, 2157.8273738100993, 2164.0370035334204, 2088.2064815370136, 2107.778683238253, 2109.0298462707174, 2112.535242246703, 2114.9365519034454, 2082.500199952016, 2099.6745504446835, 2108.230495869012, 2122.8832414217213, 2123.0764617391483, 7377.668004939791, 7406.666699998459, 7438.479306448551, 7451.515651482637, 7456.664450099758, 4292.849750258757, 4367.737935723867, 4370.8033138508845, 4391.27543955247, 4402.163588918127, 2721.9319517012036, 2738.7672047875953, 2774.7502724754668, 2791.6231308773463, 2808.0, 855.3755758296417, 856.3748463621591, 861.2378045429778, 868.157886849761, 890.7550423633488, 9773.169280611086, 9773.902260977371, 9781.804363912754, 9793.314467987244, 9805.411675299505, 3906.6093390661276, 3910.022494376406, 3958.6635136013188, 3978.204359128186, 3982.880513584597, 8310.168983101641, 8319.126491718403, 8322.250997410261, 8346.374021948379, 8359.456635318686, 4321.935170972438, 4325.480942286946, 4326.329418940069, 4331.696781225347, 4345.065810850682, 3292.456744637156, 3326.4511355626532, 3812.1613245086037, 3956.2680904032272, 3959.2081583682802, 3452.102453362144, 3476.8261586920553, 3485.6688614581576, 3498.1954150545007, 3498.2653642734804, 1077.8329358949375, 1097.550004498152, 1102.7463683352873, 1105.7069876482738, 1112.0991996482712, 938.2728385501155, 959.2086528613921, 988.5847943863595, 999.6401295533602, 1002.5137808163036, 6729.394354508117, 6771.119754431991, 6780.593164410151, 6818.977153426927, 6819.693113809891, 443.15578822342843, 446.22134375514935, 448.15075432056074, 457.9347144378875, 458.4200985753025, 5241.13521268994, 5274.1034024215205, 5292.364916210079, 5310.203469479532, 5331.253624492574, 8477.915220847835, 8534.78663033429, 8679.956600216958, 8727.214550690342, 8850.73447796567, 8655.134486551295, 8657.826843463221, 8671.393002489765, 8696.17386348296, 8704.347173961978, 6891.96620506928, 6968.721251149897, 6984.441244700513, 6984.895226571605, 7018.438524917994, 6942.826429339307, 7014.754483593049, 7040.683169257498, 7062.576245425291, 7083.5041547091205, 7775.300222979959, 8002.359811215205, 8015.679372825255, 8069.314108300626, 8072.878906816285, 7985.640646171052, 8165.38759593021, 8209.671613135408, 8253.0, 8272.17278272168, 6137.956547386866, 6405.679716014274, 6445.967770161306, 6485.221773387224, 6604.174478190226, 7014.228434872262, 7015.473839462163, 7017.122859642544, 7059.435245180271, 7071.82320441993, 6486.740530378732, 6597.60414375139, 6601.504887133388, 6610.4050635443045, 6655.667216639052, 6220.440160385587, 6226.315105338319, 6235.158253635701, 6306.716197771203, 6346.650934198663, 6644.867102658017, 6648.767293144717, 6655.434288085567, 6675.532712710064, 6683.398494135551, 5925.318588362394, 5962.582619216613, 5989.760409583742, 6044.304904935989, 6053.092036194606, 6199.845003874939, 6253.96873015632, 6263.029230469285, 6271.686415679289, 6276.592021518587], "unit": "ms", "name": "mootools.html", "value": 4075.0239720790823}, {"lowerIsBetter": false, "replicates": [305.8837641696155, 315.5881574545219, 316.6105690001298, 318.1077078793982, 322.5049548942371, 5568.805091821787, 5633.690147041911, 5653.095504719236, 5671.943280567193, 5752.683602401867, 5572.108462645967, 5684.488396044355, 5700.2589663343815, 5707.0, 5728.25532680752, 4323.4163387942535, 4343.9565604344025, 4346.348047792841, 4350.15172041452, 4352.586504282104, 4338.696291259613, 4341.565843415665, 4344.847930322439, 4344.89137771555, 4346.826126954934, 4045.2516284487315, 4172.144710334389, 4244.83020679174, 4301.913961720779, 4309.913801723964, 4206.72656277341, 4215.978920105395, 4229.936550951738, 4239.8092085856215, 4250.149970005996, 3727.9813600932093, 3729.366007778684, 3730.645588669072, 3732.234891847165, 3735.4023356263137, 5432.809851655213, 5446.346438427414, 5460.590455715837, 5469.234307196995, 5480.013597552439, 4819.734914579697, 4938.530839570271, 4947.82682606107, 4951.183054795991, 4959.2809042688605, 5948.048312270016, 5948.613340132921, 5953.672548009858, 5956.702164891738, 5961.254843144607, 4029.798510074514, 4056.2901492239034, 4057.006033521806, 4058.5738497457933, 4065.57311482296, 6133.1413602095745, 6169.136320915076, 6187.690615469253, 6200.81397558074, 6203.875922481525, 4046.2716710992304, 4140.751554906655, 4145.834166633361, 4148.23257697327, 4158.168366326747, 4203.957960420418, 4205.936910946339, 4206.053637931441, 4209.663226941837, 4216.051388437577, 4822.807087716452, 4825.420949486084, 4830.492798256132, 4834.226523756252, 4838.612910967185, 5829.183914252008, 5856.033754430471, 5857.7949771757785, 5860.765569377262, 5878.882422351529, 1468.9192094434695, 1487.0557196180287, 1505.8720008799155, 1515.3862685612344, 1523.1546491697216, 972.6984634763246, 996.4370130876032, 1007.2596641468515, 1014.878214614251, 1020.9489525523694, 5214.348206474191, 5228.686278823283, 5232.529072383504, 5242.423333433319, 5242.9213561796605, 6190.0405437157315, 6200.534959878028, 6204.534659900435, 6209.875802483925, 6236.812895613139, 5170.896582068338, 5236.24074509194, 5242.475752424727, 5248.711320877312, 5302.284191634157, 3363.1255873472583, 3384.7799893006877, 3395.575553055868, 3400.982995085009, 3401.0, 5882.588218824641, 5889.057750759858, 5894.233749612523, 5896.675682837399, 5908.05471124618, 6289.182406287245, 6406.615603063831, 6424.614523128627, 6424.807255782334, 6456.354364563506, 5814.186013958049, 5845.444682755132, 5859.882802343929, 5861.472467477947, 5888.587798854039, 6240.906386404116, 6270.12218289449, 6279.1209230708655, 6285.151504546828, 6303.621782693053, 6094.542909281733, 6111.602745821685, 6118.20463339763, 6119.510439164767, 6121.938780612137, 5776.191333213437, 5871.412858714094, 5885.411458854081, 5894.410558944071, 5897.410258974069, 4187.162567486575, 4226.112516371596, 4233.941514621345, 4240.300350442266, 4243.93634095495, 6236.095766113979, 6258.593191442542, 6259.6870156492905, 6271.43557079865, 6275.309715931336, 5832.066869300891, 5974.910376344272, 5986.2517185351835, 6025.0661147522205, 6027.457528822427, 5958.463738263577, 6018.187544681412, 6025.849353766191, 6027.246594175728, 6030.30651475086, 5826.126081087871, 5887.0, 5893.381194974466, 5894.2926848778425, 5908.084246941731, 5831.825045248649, 6011.458968692838, 6042.305134909541, 6053.4551890330085, 6055.788047418319, 5903.822885313448, 5905.40945905406, 5912.46787789101, 5916.881662366814, 5919.911201331897], "unit": "ms", "name": "prototype.html", "value": 4447.293330356446}, {"lowerIsBetter": false, "replicates": [675.7938828657259, 676.8375589858435, 747.2863415438258, 780.235369338049, 783.9647215875286, 11082.889171108287, 11346.659600212008, 11409.771804563914, 11423.0, 11452.770944581103, 11599.072074234062, 11659.766804663923, 13211.603651890458, 13491.123077000013, 13495.460181592725, 798.6605692580645, 812.1878121878121, 813.6785969542027, 813.808754942588, 814.5886327404652, 801.6873419366423, 817.7996390884242, 823.390690888741, 824.2952275804191, 824.5135370131621, 849.0702680564772, 856.5374697663254, 857.130013036765, 857.3612658569375, 858.8711693246, 839.9328053755685, 841.4656692999959, 841.8947631546057, 844.2570537926616, 846.5217152308957, 625.6465097220056, 630.196499463188, 630.64053489511, 632.8512799492115, 634.0932466572799, 12779.61661150167, 12813.0, 12894.484220631164, 12908.87091129086, 12926.806097908539, 10964.506597203144, 11092.889071109346, 11271.605493807678, 11302.208845380826, 11957.760844783143, 9319.580618872167, 9532.714018579454, 9547.61809527618, 9579.712608621752, 9678.17735492484, 3154.5899033125775, 3226.6128064632394, 3251.057193413907, 3262.96737032629, 3331.3337332533347, 41511.584884151074, 41821.0, 41990.79004604957, 42012.579874201176, 42172.36741448881, 9236.122568355995, 9405.905940940504, 9432.528373581294, 9537.189338906272, 9595.0, 16138.677226455406, 16150.03099814015, 16156.919215403848, 16177.4337898173, 16213.513594592181, 6077.392260773976, 6092.360302168208, 6196.194494715748, 6263.060540918807, 6393.520485963571, 3590.7306951978185, 3655.5613326401003, 3669.9907525430185, 3706.925861482809, 3764.5482542095124, 2693.811433199657, 2732.7130651281727, 2736.0697362896312, 2741.163944996755, 2757.2279761666764, 465.3461886050105, 473.4295174314942, 486.66663335615215, 486.99756501217973, 487.28126014129583, 455.44435788338177, 465.3415417184713, 480.38510706295995, 482.8599706085196, 582.8251524542706, 7930.484518506279, 8899.777505562413, 8940.15068568498, 8948.418352807046, 9112.726618201465, 633.5090305013651, 646.1696719715144, 648.6108334998963, 661.1174082599687, 673.0476375928007, 3681.650243226889, 3746.6253374662315, 3773.9433908491396, 3823.388257878726, 3872.8838134856, 52145.0, 52177.2173417399, 52238.477615224125, 52556.47443525592, 52676.473235267156, 44918.0, 45417.31874021826, 45641.543584563726, 45736.54263457323, 46390.5360946393, 40537.0, 40686.796566017576, 40940.0, 41916.0, 42418.36372454416, 6560.245571759308, 6680.231773346128, 6711.3288671132495, 8100.675972961016, 8475.279601233717, 30920.0, 31222.843885780425, 33550.161245969044, 33752.49371259384, 35125.29749405049, 38203.23593528169, 38523.42214866835, 39058.6094139055, 39274.60725392824, 39906.0, 10773.0, 11023.44882755875, 11044.944775276072, 11119.444027798416, 11142.108631309313, 11098.889011109786, 11128.109751220045, 11210.887891120985, 11294.548218071184, 11324.094072474347, 10125.341852779546, 10464.529096190538, 10488.895111048792, 10535.841962370418, 10864.782704346027, 10732.356058636507, 10795.6221532246, 10931.617393391192, 10945.616903408343, 11152.776944460904, 9945.651902183388, 10071.949640252045, 10168.084872361227, 10184.898151018691, 10426.165906727596, 9310.301727370339, 9424.586312053247, 9443.0, 9443.102905223992, 9458.811782326511, 8737.737867863974, 8967.641294348154, 9110.498922559324, 9161.49611771359, 9571.805887978708], "unit": "ms", "name": "yui.html", "value": 5816.544287720362}], "name": "dromaeo_css", "value": 6413.468413213249}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 113.0, 113.0, 113.0, 123.0, 112.0, 111.0, 113.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 153.0, 166.0, 131.0, 165.0, 159.0, 131.0, 170.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 165.0, 163.0, 162.0, 165.0, 175.0, 166.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 72.0, 149.0, 73.0, 79.0, 72.0, 73.0, 150.0], "unit": "ms", "name": "audio-fft", "value": 88.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 132.0, 95.0, 94.0, 94.0, 127.0, 93.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 149.0, 152.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 74.0, 82.0, 82.0, 73.0, 80.0, 77.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 76.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 86.0, 87.0, 85.0, 83.0, 88.0, 85.0, 92.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [125.0, 121.0, 121.0, 135.0, 127.0, 130.0, 136.0, 126.0, 130.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [142.0, 157.0, 162.0, 151.0, 162.0, 137.0, 140.0, 150.0, 148.0, 162.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 70.0, 71.0, 70.0, 72.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1556.1999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.79894528675015], "unit": "score", "name": "Richards", "value": 214.21253599999997}, {"lowerIsBetter": false, "replicates": [186.81113394358303], "unit": "score", "name": "DeltaBlue", "value": 353.92965399999986}, {"lowerIsBetter": false, "replicates": [277.2387025228722], "unit": "score", "name": "Encrypt", "value": 960.114867}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [597.1563981042653], "unit": "score", "name": "Splay", "value": 136.4650873015873}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21380.49162767343}]} 00:16:43 INFO - RETURN: dromaeo_css: 6413.47 00:16:43 INFO - RETURN: kraken: 1556.20 00:16:43 INFO - RETURN: v8_7: 21380.49 00:16:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21380.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1556.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6413.47"}}} 00:16:43 INFO - Return code: 0 00:16:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:16:43 INFO - # TBPL SUCCESS # 00:16:43 INFO - Running post-action listener: _resource_record_post_action 00:16:43 INFO - Running post-run listener: _resource_record_post_run 00:16:44 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 518529024; Read time: 0; Write time: 597988 00:16:44 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 242479104; Read time: 0; Write time: 398188 00:16:44 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 275738624; Read time: 0; Write time: 199768 00:16:44 INFO - Running post-run listener: _upload_blobber_files 00:16:44 INFO - Blob upload gear active. 00:16:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:16:44 INFO - Copying logs to upload dir... 00:16:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.825817 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-14 00:16:42.986607) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 00:16:42.989752) ========= 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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009958 build_url: 'https://queue.taskcluster.net/v1/task/NexYEK5uSr6nLGBfNrbd9A/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-14 00:16:43.040381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 00:16:43.040695) ========= 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=6d5287d839824eebc594b0c9000001d1-1450078903.261357-691740539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 00:16:43.090180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 00:16:43.090497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 00:16:43.090794) ========= ========= Total master_lag: 0.27 =========