builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1449322533.73 results: success (0) buildid: 20151205040640 builduid: f34627474c0e45709c5b6cc80c158429 revision: cba488c0af7031be976c19e0bc589be6f078c4db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.729447) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.729878) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.730170) ========= 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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.759545) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.759984) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.807930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.808184) ========= 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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014221 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.867403) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.867660) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.867990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:33.868319) ========= 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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-05 05:35:33-- 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% 219M=0s 2015-12-05 05:35:34 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.199583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.082725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.082993) ========= 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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.092121 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.191572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.191879) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cba488c0af7031be976c19e0bc589be6f078c4db --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 cba488c0af7031be976c19e0bc589be6f078c4db --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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-05 05:35:34,362 truncating revision to first 12 chars 2015-12-05 05:35:34,362 Setting DEBUG logging. 2015-12-05 05:35:34,362 attempt 1/10 2015-12-05 05:35:34,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cba488c0af70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-05 05:35:34,602 unpacking tar archive at: mozilla-central-cba488c0af70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549366 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.755981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.756334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.766299) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.766601) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 05:35:34.767004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-05 05:35:34.767313) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:35:35 INFO - MultiFileLogger online at 20151205 05:35:35 in /builds/slave/test 05:35:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 05:35:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:35 INFO - {'append_to_log': False, 05:35:35 INFO - 'base_work_dir': '/builds/slave/test', 05:35:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:35:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:35 INFO - 'branch': 'Firefox-Non-PGO', 05:35:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:35 INFO - 'config_files': ('talos/linux_config.py',), 05:35:35 INFO - 'default_actions': ('clobber', 05:35:35 INFO - 'read-buildbot-config', 05:35:35 INFO - 'download-and-extract', 05:35:35 INFO - 'populate-webroot', 05:35:35 INFO - 'create-virtualenv', 05:35:35 INFO - 'install', 05:35:35 INFO - 'run-tests'), 05:35:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:35 INFO - 'download_minidump_stackwalk': True, 05:35:35 INFO - 'download_symbols': 'ondemand', 05:35:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:35 INFO - 'installer_path': 'installer.exe', 05:35:35 INFO - 'log_level': 'info', 05:35:35 INFO - 'log_name': 'talos', 05:35:35 INFO - 'log_to_console': True, 05:35:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:35:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:35:35 INFO - 'opt_config_files': (), 05:35:35 INFO - 'pip_index': False, 05:35:35 INFO - 'sps_profile': False, 05:35:35 INFO - 'sps_profile_interval': 0, 05:35:35 INFO - 'suite': 'dromaeojs', 05:35:35 INFO - 'system_bits': '64', 05:35:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:35 INFO - 'title': 'talos-linux64-ix-055', 05:35:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:35 INFO - 'use_talos_json': True, 05:35:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:35 INFO - 'work_dir': 'build'} 05:35:35 INFO - ##### 05:35:35 INFO - ##### Running clobber step. 05:35:35 INFO - ##### 05:35:35 INFO - Running pre-action listener: _resource_record_pre_action 05:35:35 INFO - Running main action method: clobber 05:35:35 INFO - rmtree: /builds/slave/test/build 05:35:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:40 INFO - Running post-action listener: _resource_record_post_action 05:35:40 INFO - ##### 05:35:40 INFO - ##### Running read-buildbot-config step. 05:35:40 INFO - ##### 05:35:40 INFO - Running pre-action listener: _resource_record_pre_action 05:35:40 INFO - Running main action method: read_buildbot_config 05:35:40 INFO - Using buildbot properties: 05:35:40 INFO - { 05:35:40 INFO - "properties": { 05:35:40 INFO - "buildnumber": 338, 05:35:40 INFO - "product": "firefox", 05:35:40 INFO - "script_repo_revision": "production", 05:35:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:35:40 INFO - "repository": "", 05:35:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:35:40 INFO - "buildid": "20151205040640", 05:35:40 INFO - "slavename": "talos-linux64-ix-055", 05:35:40 INFO - "pgo_build": "False", 05:35:40 INFO - "basedir": "/builds/slave/test", 05:35:40 INFO - "project": "", 05:35:40 INFO - "platform": "ubuntu64_hw", 05:35:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:35:40 INFO - "slavebuilddir": "test", 05:35:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:35:40 INFO - "branch": "mozilla-central", 05:35:40 INFO - "repo_path": "mozilla-central", 05:35:40 INFO - "stage_platform": "linux64", 05:35:40 INFO - "builduid": "f34627474c0e45709c5b6cc80c158429", 05:35:40 INFO - "revision": "cba488c0af7031be976c19e0bc589be6f078c4db" 05:35:40 INFO - }, 05:35:40 INFO - "sourcestamp": { 05:35:40 INFO - "repository": "", 05:35:40 INFO - "hasPatch": false, 05:35:40 INFO - "project": "", 05:35:40 INFO - "branch": "mozilla-central-linux64-talos", 05:35:40 INFO - "changes": [ 05:35:40 INFO - { 05:35:40 INFO - "category": null, 05:35:40 INFO - "files": [ 05:35:40 INFO - { 05:35:40 INFO - "url": null, 05:35:40 INFO - "name": "https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:35:40 INFO - } 05:35:40 INFO - ], 05:35:40 INFO - "repository": "", 05:35:40 INFO - "rev": "cba488c0af7031be976c19e0bc589be6f078c4db", 05:35:40 INFO - "who": "ffxbld", 05:35:40 INFO - "when": 1449322470, 05:35:40 INFO - "number": 6770135, 05:35:40 INFO - "comments": "No bug, Automated HPKP preload list update from host bld-linux64-spot-049 - a=hpkp-update", 05:35:40 INFO - "project": "", 05:35:40 INFO - "at": "Sat 05 Dec 2015 05:34:30", 05:35:40 INFO - "branch": "mozilla-central-linux64-talos", 05:35:40 INFO - "revlink": "", 05:35:40 INFO - "properties": [ 05:35:40 INFO - [ 05:35:40 INFO - "buildid", 05:35:40 INFO - "20151205040640", 05:35:40 INFO - "Change" 05:35:40 INFO - ], 05:35:40 INFO - [ 05:35:40 INFO - "builduid", 05:35:40 INFO - "f34627474c0e45709c5b6cc80c158429", 05:35:40 INFO - "Change" 05:35:40 INFO - ], 05:35:40 INFO - [ 05:35:40 INFO - "pgo_build", 05:35:40 INFO - "False", 05:35:40 INFO - "Change" 05:35:40 INFO - ] 05:35:40 INFO - ], 05:35:40 INFO - "revision": "cba488c0af7031be976c19e0bc589be6f078c4db" 05:35:40 INFO - } 05:35:40 INFO - ], 05:35:40 INFO - "revision": "cba488c0af7031be976c19e0bc589be6f078c4db" 05:35:40 INFO - } 05:35:40 INFO - } 05:35:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:35:40 INFO - Running post-action listener: _resource_record_post_action 05:35:40 INFO - ##### 05:35:40 INFO - ##### Running download-and-extract step. 05:35:40 INFO - ##### 05:35:40 INFO - Running pre-action listener: _resource_record_pre_action 05:35:40 INFO - Running main action method: download_and_extract 05:35:40 INFO - mkdir: /builds/slave/test/build/tests 05:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:40 INFO - https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/test_packages.json 05:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/test_packages.json 05:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:35:43 INFO - Downloaded 1302 bytes. 05:35:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:35:43 INFO - Using the following test package requirements: 05:35:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:35:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:43 INFO - u'jsshell-linux-x86_64.zip'], 05:35:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:35:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:35:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:35:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:35:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:35:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:43 INFO - https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:48 INFO - Downloaded 21848918 bytes. 05:35:48 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 05:35:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:48 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 05:35:49 INFO - Return code: 0 05:35:49 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 05:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:49 INFO - https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:51 INFO - Downloaded 21848918 bytes. 05:35:51 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 05:35:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:51 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 05:35:52 INFO - Return code: 0 05:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:52 INFO - https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:35:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:54 INFO - Downloaded 11132001 bytes. 05:35:54 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 05:35:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:54 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 05:35:54 INFO - Return code: 0 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:54 INFO - https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4LAPVSYNS5m426DQYv3_pg/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 05:35:56 INFO - Downloaded 57699886 bytes. 05:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:56 INFO - mkdir: /builds/slave/test/properties 05:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:56 INFO - Contents: 05:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:56 INFO - Running post-action listener: _resource_record_post_action 05:35:56 INFO - Running post-action listener: set_extra_try_arguments 05:35:56 INFO - ##### 05:35:56 INFO - ##### Running populate-webroot step. 05:35:56 INFO - ##### 05:35:56 INFO - Running pre-action listener: _resource_record_pre_action 05:35:56 INFO - Running main action method: populate_webroot 05:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:35:56 INFO - '../fennec_ids.txt'], 05:35:56 INFO - 'tests': ['tcheck2']}, 05:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:56 INFO - '--tppagecycles', 05:35:56 INFO - '7'], 05:35:56 INFO - 'tests': ['tsvgm']}}, 05:35:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:35:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'tests': ['damp', 'tps']}, 05:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['damp', 'tps']}, 05:35:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:56 INFO - 'other': {'tests': ['a11yr', 05:35:56 INFO - 'ts_paint', 05:35:56 INFO - 'tpaint', 05:35:56 INFO - 'sessionrestore', 05:35:56 INFO - 'sessionrestore_no_auto_restore']}, 05:35:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['a11yr', 05:35:56 INFO - 'ts_paint', 05:35:56 INFO - 'tpaint', 05:35:56 INFO - 'sessionrestore', 05:35:56 INFO - 'sessionrestore_no_auto_restore']}, 05:35:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['a11yr', 05:35:56 INFO - 'ts_paint', 05:35:56 INFO - 'tpaint', 05:35:56 INFO - 'sessionrestore', 05:35:56 INFO - 'sessionrestore_no_auto_restore']}, 05:35:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['a11yr', 05:35:56 INFO - 'ts_paint', 05:35:56 INFO - 'tpaint', 05:35:56 INFO - 'sessionrestore', 05:35:56 INFO - 'sessionrestore_no_auto_restore']}, 05:35:56 INFO - 'other_l64': {'tests': ['a11yr', 05:35:56 INFO - 'ts_paint', 05:35:56 INFO - 'tpaint', 05:35:56 INFO - 'sessionrestore', 05:35:56 INFO - 'sessionrestore_no_auto_restore']}, 05:35:56 INFO - 'other_nol64': {'tests': ['a11yr', 05:35:56 INFO - 'ts_paint', 05:35:56 INFO - 'tpaint', 05:35:56 INFO - 'sessionrestore', 05:35:56 INFO - 'sessionrestore_no_auto_restore']}, 05:35:56 INFO - 'svgr': {'tests': ['tsvgx', 05:35:56 INFO - 'tsvgr_opacity', 05:35:56 INFO - 'tart', 05:35:56 INFO - 'tscrollx', 05:35:56 INFO - 'cart']}, 05:35:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['tsvgx', 05:35:56 INFO - 'tsvgr_opacity', 05:35:56 INFO - 'tart', 05:35:56 INFO - 'tscrollx', 05:35:56 INFO - 'cart']}, 05:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'tests': ['tp5o']}, 05:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'talos_options': ['--e10s'], 05:35:56 INFO - 'tests': ['tp5o']}, 05:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'talos_options': ['--xperf_path', 05:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:56 INFO - 'tests': ['tp5n']}, 05:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:56 INFO - 'talos_options': ['--e10s', 05:35:56 INFO - '--xperf_path', 05:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:56 INFO - 'tests': ['tp5n']}}, 05:35:56 INFO - 'talos.zip': {'path': '', 05:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:56 INFO - Running post-action listener: _resource_record_post_action 05:35:56 INFO - ##### 05:35:56 INFO - ##### Running create-virtualenv step. 05:35:56 INFO - ##### 05:35:56 INFO - Running pre-action listener: _resource_record_pre_action 05:35:56 INFO - Running main action method: create_virtualenv 05:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:56 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 05:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:56 INFO - Using real prefix '/usr' 05:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:58 INFO - Installing pip.................done. 05:35:58 INFO - Return code: 0 05:35:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:35:58 INFO - Using env: {'DISPLAY': ':0', 05:35:58 INFO - 'HOME': '/home/cltbld', 05:35:58 INFO - 'LANG': 'en_US.UTF-8', 05:35:58 INFO - 'LANGUAGE': 'en_US:en', 05:35:58 INFO - 'LOGNAME': 'cltbld', 05:35:58 INFO - 'MAIL': '/var/mail/cltbld', 05:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:58 INFO - 'MOZ_NO_REMOTE': '1', 05:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:58 INFO - 'NO_EM_RESTART': '1', 05:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:58 INFO - 'PWD': '/builds/slave/test', 05:35:58 INFO - 'SHELL': '/bin/bash', 05:35:58 INFO - 'SHLVL': '1', 05:35:58 INFO - 'TERM': 'linux', 05:35:58 INFO - 'TMOUT': '86400', 05:35:58 INFO - 'USER': 'cltbld', 05:35:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:58 INFO - '_': '/tools/buildbot/bin/python'} 05:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:58 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 05:35:58 INFO - Cleaning up... 05:35:58 INFO - Return code: 0 05:35:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:35:58 INFO - Using env: {'DISPLAY': ':0', 05:35:58 INFO - 'HOME': '/home/cltbld', 05:35:58 INFO - 'LANG': 'en_US.UTF-8', 05:35:58 INFO - 'LANGUAGE': 'en_US:en', 05:35:58 INFO - 'LOGNAME': 'cltbld', 05:35:58 INFO - 'MAIL': '/var/mail/cltbld', 05:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:58 INFO - 'MOZ_NO_REMOTE': '1', 05:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:58 INFO - 'NO_EM_RESTART': '1', 05:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:58 INFO - 'PWD': '/builds/slave/test', 05:35:58 INFO - 'SHELL': '/bin/bash', 05:35:58 INFO - 'SHLVL': '1', 05:35:58 INFO - 'TERM': 'linux', 05:35:58 INFO - 'TMOUT': '86400', 05:35:58 INFO - 'USER': 'cltbld', 05:35:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:58 INFO - '_': '/tools/buildbot/bin/python'} 05:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:59 INFO - Downloading/unpacking psutil>=0.7.1 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:36:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:36:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:00 INFO - Installing collected packages: psutil 05:36:00 INFO - Running setup.py install for psutil 05:36:00 INFO - building 'psutil._psutil_linux' extension 05:36:00 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 05:36:01 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 05:36:01 INFO - building 'psutil._psutil_posix' extension 05:36:01 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 05:36:01 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 05:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:01 INFO - Successfully installed psutil 05:36:01 INFO - Cleaning up... 05:36:01 INFO - Return code: 0 05:36:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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', '--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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:36:01 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 05:36:01 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 05:36:01 INFO - Using env: {'DISPLAY': ':0', 05:36:01 INFO - 'HOME': '/home/cltbld', 05:36:01 INFO - 'LANG': 'en_US.UTF-8', 05:36:01 INFO - 'LANGUAGE': 'en_US:en', 05:36:01 INFO - 'LOGNAME': 'cltbld', 05:36:01 INFO - 'MAIL': '/var/mail/cltbld', 05:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:01 INFO - 'MOZ_NO_REMOTE': '1', 05:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:01 INFO - 'NO_EM_RESTART': '1', 05:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:01 INFO - 'PWD': '/builds/slave/test', 05:36:01 INFO - 'SHELL': '/bin/bash', 05:36:01 INFO - 'SHLVL': '1', 05:36:01 INFO - 'TERM': 'linux', 05:36:01 INFO - 'TMOUT': '86400', 05:36:01 INFO - 'USER': 'cltbld', 05:36:01 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:01 INFO - '_': '/tools/buildbot/bin/python'} 05:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:36:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:36:03 INFO - Installing collected packages: mozsystemmonitor 05:36:03 INFO - Running setup.py install for mozsystemmonitor 05:36:03 INFO - Successfully installed mozsystemmonitor 05:36:03 INFO - Cleaning up... 05:36:03 INFO - Return code: 0 05:36:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:36:03 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 05:36:03 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 05:36:03 INFO - Using env: {'DISPLAY': ':0', 05:36:03 INFO - 'HOME': '/home/cltbld', 05:36:03 INFO - 'LANG': 'en_US.UTF-8', 05:36:03 INFO - 'LANGUAGE': 'en_US:en', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MAIL': '/var/mail/cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SHLVL': '1', 05:36:03 INFO - 'TERM': 'linux', 05:36:03 INFO - 'TMOUT': '86400', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - '_': '/tools/buildbot/bin/python'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:05 INFO - Downloading docopt-0.6.1.tar.gz 05:36:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:06 INFO - Running setup.py install for blobuploader 05:36:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:06 INFO - Running setup.py install for requests 05:36:06 INFO - Running setup.py install for docopt 05:36:06 INFO - Successfully installed blobuploader requests docopt 05:36:06 INFO - Cleaning up... 05:36:06 INFO - Return code: 0 05:36:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:06 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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:36:06 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 05:36:06 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 05:36:06 INFO - Using env: {'DISPLAY': ':0', 05:36:06 INFO - 'HOME': '/home/cltbld', 05:36:06 INFO - 'LANG': 'en_US.UTF-8', 05:36:06 INFO - 'LANGUAGE': 'en_US:en', 05:36:06 INFO - 'LOGNAME': 'cltbld', 05:36:06 INFO - 'MAIL': '/var/mail/cltbld', 05:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:06 INFO - 'MOZ_NO_REMOTE': '1', 05:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:06 INFO - 'NO_EM_RESTART': '1', 05:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:06 INFO - 'PWD': '/builds/slave/test', 05:36:06 INFO - 'SHELL': '/bin/bash', 05:36:06 INFO - 'SHLVL': '1', 05:36:06 INFO - 'TERM': 'linux', 05:36:06 INFO - 'TMOUT': '86400', 05:36:06 INFO - 'USER': 'cltbld', 05:36:06 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:06 INFO - '_': '/tools/buildbot/bin/python'} 05:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:06 INFO - Running setup.py (path:/tmp/pip-CsgA7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:06 INFO - Running setup.py (path:/tmp/pip-TBv7uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:07 INFO - Running setup.py (path:/tmp/pip-ulhlnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:07 INFO - Running setup.py (path:/tmp/pip-v_77qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:07 INFO - Running setup.py (path:/tmp/pip-tMxa0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:07 INFO - Running setup.py (path:/tmp/pip-zfnKzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:07 INFO - Running setup.py (path:/tmp/pip-6qPhmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:07 INFO - Running setup.py (path:/tmp/pip-eC9YxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:07 INFO - Running setup.py (path:/tmp/pip-ntUQdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:07 INFO - Running setup.py (path:/tmp/pip-nQ4Jk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:07 INFO - Running setup.py (path:/tmp/pip-1ogwbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:07 INFO - Running setup.py (path:/tmp/pip-BtLVrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:07 INFO - Running setup.py (path:/tmp/pip-_zcgp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:07 INFO - Running setup.py (path:/tmp/pip-89H_2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:07 INFO - Running setup.py (path:/tmp/pip-zqqoyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:07 INFO - Running setup.py (path:/tmp/pip-8uNWhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:07 INFO - Running setup.py (path:/tmp/pip-jS0TvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:08 INFO - Running setup.py install for manifestparser 05:36:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozcrash 05:36:08 INFO - Running setup.py install for mozdebug 05:36:08 INFO - Running setup.py install for mozdevice 05:36:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozfile 05:36:08 INFO - Running setup.py install for mozhttpd 05:36:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozinfo 05:36:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozInstall 05:36:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozleak 05:36:08 INFO - Running setup.py install for mozlog 05:36:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Running setup.py install for moznetwork 05:36:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Running setup.py install for mozprocess 05:36:09 INFO - Running setup.py install for mozprofile 05:36:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Running setup.py install for mozrunner 05:36:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Running setup.py install for mozscreenshot 05:36:09 INFO - Running setup.py install for moztest 05:36:09 INFO - Running setup.py install for mozversion 05:36:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:09 INFO - Cleaning up... 05:36:09 INFO - Return code: 0 05:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:09 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')]} 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:09 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')]} 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:09 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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:36:09 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 05:36:09 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 05:36:09 INFO - Using env: {'DISPLAY': ':0', 05:36:09 INFO - 'HOME': '/home/cltbld', 05:36:09 INFO - 'LANG': 'en_US.UTF-8', 05:36:09 INFO - 'LANGUAGE': 'en_US:en', 05:36:09 INFO - 'LOGNAME': 'cltbld', 05:36:09 INFO - 'MAIL': '/var/mail/cltbld', 05:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:09 INFO - 'MOZ_NO_REMOTE': '1', 05:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:09 INFO - 'NO_EM_RESTART': '1', 05:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:09 INFO - 'PWD': '/builds/slave/test', 05:36:09 INFO - 'SHELL': '/bin/bash', 05:36:09 INFO - 'SHLVL': '1', 05:36:09 INFO - 'TERM': 'linux', 05:36:09 INFO - 'TMOUT': '86400', 05:36:09 INFO - 'USER': 'cltbld', 05:36:09 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:09 INFO - '_': '/tools/buildbot/bin/python'} 05:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:10 INFO - Running setup.py (path:/tmp/pip-2b6lIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:10 INFO - Running setup.py (path:/tmp/pip-QeArXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:10 INFO - Running setup.py (path:/tmp/pip-zLCb0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:10 INFO - Running setup.py (path:/tmp/pip-pviwpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:10 INFO - Running setup.py (path:/tmp/pip-4HzNBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:10 INFO - Running setup.py (path:/tmp/pip-tMiZTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:10 INFO - Running setup.py (path:/tmp/pip-3wxllB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:10 INFO - Running setup.py (path:/tmp/pip-DBGSyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:10 INFO - Running setup.py (path:/tmp/pip-qdqvfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:10 INFO - Running setup.py (path:/tmp/pip-K5nBHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:10 INFO - Running setup.py (path:/tmp/pip-SAbnld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:10 INFO - Running setup.py (path:/tmp/pip-NLKUkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:10 INFO - Running setup.py (path:/tmp/pip-Ghu4wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:10 INFO - Running setup.py (path:/tmp/pip-2AJph9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:11 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)) 05:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:11 INFO - Running setup.py (path:/tmp/pip-fnSyY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:11 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)) 05:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:11 INFO - Running setup.py (path:/tmp/pip-TT4g6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:11 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)) 05:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:11 INFO - Running setup.py (path:/tmp/pip-nPLRc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:12 INFO - Downloading blessings-1.5.1.tar.gz 05:36:12 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 05:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:13 INFO - Installing collected packages: blessings 05:36:13 INFO - Running setup.py install for blessings 05:36:13 INFO - Successfully installed blessings 05:36:13 INFO - Cleaning up... 05:36:13 INFO - Return code: 0 05:36:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:13 INFO - Reading from file tmpfile_stdout 05:36:13 INFO - Current package versions: 05:36:13 INFO - argparse == 1.2.1 05:36:13 INFO - blessings == 1.5.1 05:36:13 INFO - blobuploader == 1.2.4 05:36:13 INFO - docopt == 0.6.1 05:36:13 INFO - manifestparser == 1.1 05:36:13 INFO - mozInstall == 1.12 05:36:13 INFO - mozcrash == 0.16 05:36:13 INFO - mozdebug == 0.1 05:36:13 INFO - mozdevice == 0.47 05:36:13 INFO - mozfile == 1.2 05:36:13 INFO - mozhttpd == 0.7 05:36:13 INFO - mozinfo == 0.9 05:36:13 INFO - mozleak == 0.1 05:36:13 INFO - mozlog == 3.1 05:36:13 INFO - moznetwork == 0.27 05:36:13 INFO - mozprocess == 0.22 05:36:13 INFO - mozprofile == 0.27 05:36:13 INFO - mozrunner == 6.11 05:36:13 INFO - mozscreenshot == 0.1 05:36:13 INFO - mozsystemmonitor == 0.0 05:36:13 INFO - moztest == 0.7 05:36:13 INFO - mozversion == 1.4 05:36:13 INFO - psutil == 3.1.1 05:36:13 INFO - requests == 1.2.3 05:36:13 INFO - wsgiref == 0.1.2 05:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:13 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')]} 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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')]} 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:36:13 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 05:36:13 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 05:36:13 INFO - Using env: {'DISPLAY': ':0', 05:36:13 INFO - 'HOME': '/home/cltbld', 05:36:13 INFO - 'LANG': 'en_US.UTF-8', 05:36:13 INFO - 'LANGUAGE': 'en_US:en', 05:36:13 INFO - 'LOGNAME': 'cltbld', 05:36:13 INFO - 'MAIL': '/var/mail/cltbld', 05:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:13 INFO - 'MOZ_NO_REMOTE': '1', 05:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:13 INFO - 'NO_EM_RESTART': '1', 05:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:13 INFO - 'PWD': '/builds/slave/test', 05:36:13 INFO - 'SHELL': '/bin/bash', 05:36:13 INFO - 'SHLVL': '1', 05:36:13 INFO - 'TERM': 'linux', 05:36:13 INFO - 'TMOUT': '86400', 05:36:13 INFO - 'USER': 'cltbld', 05:36:13 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:13 INFO - '_': '/tools/buildbot/bin/python'} 05:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 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)) 05:36:13 INFO - Cleaning up... 05:36:13 INFO - Return code: 0 05:36:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:13 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')]} 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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')]} 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:36:13 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 05:36:13 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 05:36:13 INFO - Using env: {'DISPLAY': ':0', 05:36:13 INFO - 'HOME': '/home/cltbld', 05:36:13 INFO - 'LANG': 'en_US.UTF-8', 05:36:13 INFO - 'LANGUAGE': 'en_US:en', 05:36:13 INFO - 'LOGNAME': 'cltbld', 05:36:13 INFO - 'MAIL': '/var/mail/cltbld', 05:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:13 INFO - 'MOZ_NO_REMOTE': '1', 05:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:13 INFO - 'NO_EM_RESTART': '1', 05:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:13 INFO - 'PWD': '/builds/slave/test', 05:36:13 INFO - 'SHELL': '/bin/bash', 05:36:13 INFO - 'SHLVL': '1', 05:36:13 INFO - 'TERM': 'linux', 05:36:13 INFO - 'TMOUT': '86400', 05:36:13 INFO - 'USER': 'cltbld', 05:36:13 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:13 INFO - '_': '/tools/buildbot/bin/python'} 05:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:13 INFO - Downloading/unpacking jsonschema 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:15 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 05:36:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:15 INFO - warning: no files found matching '*.txt' 05:36:15 INFO - no previously-included directories found matching 'build' 05:36:15 INFO - no previously-included directories found matching 'dist' 05:36:15 INFO - no previously-included directories found matching '.git*' 05:36:15 INFO - Installing collected packages: jsonschema, functools32 05:36:15 INFO - Running setup.py install for functools32 05:36:15 INFO - warning: no files found matching '*.txt' 05:36:15 INFO - no previously-included directories found matching 'build' 05:36:15 INFO - no previously-included directories found matching 'dist' 05:36:15 INFO - no previously-included directories found matching '.git*' 05:36:15 INFO - Successfully installed jsonschema functools32 05:36:15 INFO - Cleaning up... 05:36:15 INFO - Return code: 0 05:36:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:36:15 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')]} 05:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:15 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')]} 05:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:15 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 0x7ff1b5d01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, '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': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', '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 05:36:15 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 05:36:15 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 05:36:15 INFO - Using env: {'DISPLAY': ':0', 05:36:15 INFO - 'HOME': '/home/cltbld', 05:36:15 INFO - 'LANG': 'en_US.UTF-8', 05:36:15 INFO - 'LANGUAGE': 'en_US:en', 05:36:15 INFO - 'LOGNAME': 'cltbld', 05:36:15 INFO - 'MAIL': '/var/mail/cltbld', 05:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:15 INFO - 'MOZ_NO_REMOTE': '1', 05:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:15 INFO - 'NO_EM_RESTART': '1', 05:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:15 INFO - 'PWD': '/builds/slave/test', 05:36:15 INFO - 'SHELL': '/bin/bash', 05:36:15 INFO - 'SHLVL': '1', 05:36:15 INFO - 'TERM': 'linux', 05:36:15 INFO - 'TMOUT': '86400', 05:36:15 INFO - 'USER': 'cltbld', 05:36:15 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:15 INFO - '_': '/tools/buildbot/bin/python'} 05:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:16 INFO - Downloading/unpacking flake8 05:36:16 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 05:36:16 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 05:36:16 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 05:36:16 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 05:36:16 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 05:36:16 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 05:36:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:36:17 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 05:36:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:36:18 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 05:36:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:18 INFO - no previously-included directories found matching 'docs/_build' 05:36:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:36:18 INFO - Running setup.py install for pep8 05:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:18 INFO - no previously-included directories found matching 'docs/_build' 05:36:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:36:18 INFO - Cleaning up... 05:36:18 INFO - Return code: 0 05:36:18 INFO - Running post-action listener: _resource_record_post_action 05:36:18 INFO - Running post-action listener: _start_resource_monitoring 05:36:18 INFO - Starting resource monitoring. 05:36:18 INFO - ##### 05:36:18 INFO - ##### Running install step. 05:36:18 INFO - ##### 05:36:18 INFO - Running pre-action listener: _resource_record_pre_action 05:36:18 INFO - Running main action method: install 05:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:18 INFO - Reading from file tmpfile_stdout 05:36:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:19 INFO - Reading from file tmpfile_stdout 05:36:19 INFO - Output received: 05:36:19 INFO - Usage: mozinstall [options] installer 05:36:19 INFO - Options: 05:36:19 INFO - -h, --help show this help message and exit 05:36:19 INFO - -d DEST, --destination=DEST 05:36:19 INFO - Directory to install application into. [default: 05:36:19 INFO - "/builds/slave/test"] 05:36:19 INFO - --app=APP Application being installed. [default: firefox] 05:36:19 INFO - mkdir: /builds/slave/test/build/application 05:36:19 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'] 05:36:19 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 05:36:33 INFO - Reading from file tmpfile_stdout 05:36:33 INFO - Output received: 05:36:33 INFO - /builds/slave/test/build/application/firefox/firefox 05:36:33 INFO - Running post-action listener: _resource_record_post_action 05:36:33 INFO - ##### 05:36:33 INFO - ##### Running run-tests step. 05:36:33 INFO - ##### 05:36:33 INFO - Running pre-action listener: _resource_record_pre_action 05:36:33 INFO - Running main action method: run_tests 05:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:33 INFO - Python 2.7.3 05:36:33 INFO - Return code: 0 05:36:33 INFO - grabbing minidump binary from tooltool 05:36:33 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')]} 05:36:33 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 0x2a8e0b0>, '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 0x2a8efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:33 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 05:36:33 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 05:36:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:33 INFO - Return code: 0 05:36:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:36:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:36:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:36:34 INFO - Return code: 0 05:36:34 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test/build 05:36:34 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 05:36:34 INFO - Using env: {'DISPLAY': ':0', 05:36:34 INFO - 'HOME': '/home/cltbld', 05:36:34 INFO - 'LANG': 'en_US.UTF-8', 05:36:34 INFO - 'LANGUAGE': 'en_US:en', 05:36:34 INFO - 'LOGNAME': 'cltbld', 05:36:34 INFO - 'MAIL': '/var/mail/cltbld', 05:36:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:34 INFO - 'MOZ_NO_REMOTE': '1', 05:36:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:34 INFO - 'NO_EM_RESTART': '1', 05:36:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:34 INFO - 'PWD': '/builds/slave/test', 05:36:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:34 INFO - 'SHELL': '/bin/bash', 05:36:34 INFO - 'SHLVL': '1', 05:36:34 INFO - 'TERM': 'linux', 05:36:34 INFO - 'TMOUT': '86400', 05:36:34 INFO - 'USER': 'cltbld', 05:36:34 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563', 05:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:34 INFO - '_': '/tools/buildbot/bin/python'} 05:36:34 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 05:36:34 INFO - mozversion INFO | application_buildid: 20151205040640 05:36:34 INFO - mozversion INFO | application_changeset: cba488c0af7031be976c19e0bc589be6f078c4db 05:36:34 INFO - mozversion INFO | application_display_name: Nightly 05:36:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:34 INFO - mozversion INFO | application_name: Firefox 05:36:34 INFO - mozversion INFO | application_remotingname: firefox 05:36:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:36:34 INFO - mozversion INFO | application_vendor: Mozilla 05:36:34 INFO - mozversion INFO | application_version: 45.0a1 05:36:34 INFO - mozversion INFO | platform_buildid: 20151205040640 05:36:34 INFO - mozversion INFO | platform_changeset: cba488c0af7031be976c19e0bc589be6f078c4db 05:36:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:36:34 INFO - mozversion INFO | platform_version: 45.0a1 05:36:34 INFO - 2015-12-05 05:36:34,772 DEBUG : using testdate: 1449322594 05:36:34 INFO - 2015-12-05 05:36:34,772 DEBUG : actual date: 1449322594 05:36:34 INFO - 2015-12-05 05:36:34,781 INFO : starting webserver on 'localhost:53732' 05:36:34 INFO - 2015-12-05 05:36:34,782 INFO : Starting test suite talos-linux64-ix-055 05:36:34 INFO - 2015-12-05 05:36:34,782 INFO : Starting test dromaeo_css 05:36:34 INFO - 2015-12-05 05:36:34,782 DEBUG : operating with platform_type : linux_ 05:36:34 INFO - 2015-12-05 05:36:34,783 INFO : Initialising browser for dromaeo_css test... 05:36:34 INFO - 2015-12-05 05:36:34,792 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzeR868/profile http://localhost:53732/getInfo.html 05:36:38 INFO - 2015-12-05 05:36:38,629 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:36:38 INFO - 2015-12-05 05:36:38,629 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:36:38 INFO - 2015-12-05 05:36:38,629 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:36:38 INFO - 2015-12-05 05:36:38,629 DEBUG : BROWSER_OUTPUT: __metrics 05:36:38 INFO - 2015-12-05 05:36:38,726 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] 05:36:38 INFO - 2015-12-05 05:36:38,790 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:39 INFO - 2015-12-05 05:36:39,960 INFO : Browser initialized. 05:36:39 INFO - 2015-12-05 05:36:39,961 INFO : Running cycle 1/1 for dromaeo_css test... 05:36:39 INFO - 2015-12-05 05:36:39,961 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzeR868/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:36:51 INFO - 2015-12-05 05:36:51,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 142622720 05:36:51 INFO - 2015-12-05 05:36:51,912 DEBUG : BROWSER_OUTPUT: 05:37:42 INFO - 2015-12-05 05:37:42,611 DEBUG : BROWSER_OUTPUT: 1449322662609 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] 05:39:56 INFO - 2015-12-05 05:39:56,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53732/tests/dromaeo/cssquery-ext.html) 05:39:57 INFO - 2015-12-05 05:39:57,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 236535808 05:39:57 INFO - 2015-12-05 05:39:57,061 DEBUG : BROWSER_OUTPUT: 05:42:59 INFO - 2015-12-05 05:42:59,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/dromaeo/cssquery-ext.html (next: http://localhost:53732/tests/dromaeo/cssquery-jquery.html) 05:43:00 INFO - 2015-12-05 05:43:00,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 222797824 05:43:00 INFO - 2015-12-05 05:43:00,042 DEBUG : BROWSER_OUTPUT: 05:46:02 INFO - 2015-12-05 05:46:02,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53732/tests/dromaeo/cssquery-mootools.html) 05:46:02 INFO - 2015-12-05 05:46:02,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 209534976 05:46:02 INFO - 2015-12-05 05:46:02,672 DEBUG : BROWSER_OUTPUT: 05:49:04 INFO - 2015-12-05 05:49:04,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53732/tests/dromaeo/cssquery-prototype.html) 05:49:05 INFO - 2015-12-05 05:49:05,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 199450624 05:49:05 INFO - 2015-12-05 05:49:05,135 DEBUG : BROWSER_OUTPUT: 05:52:07 INFO - 2015-12-05 05:52:07,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53732/tests/dromaeo/cssquery-yui.html) 05:52:08 INFO - 2015-12-05 05:52:08,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 206856192 05:52:08 INFO - 2015-12-05 05:52:08,481 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/dromaeo/cssquery-yui.html (next: http://localhost:53732/tests/dromaeo/cssquery-dojo.html) 05:55:11 INFO - 2015-12-05 05:55:11,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 250798080 05:55:11 INFO - 2015-12-05 05:55:11,292 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,292 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:55:11 INFO - 2015-12-05 05:55:11,292 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:55:11 INFO - 2015-12-05 05:55:11,292 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:55:11 INFO - 2015-12-05 05:55:11,292 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:55:11 INFO - 2015-12-05 05:55:11,292 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2601.661783968084;2676.718944510825;2684.2094778988467;2694.0570800219925;2713.4166154276827;4542.863714088574;4612.907741845165;4649.744264065479;4672.859814205571;4688.789004494797;4621.58405743483;4644.930326045112;4728.385309909707;4735.3607263019485;4786.4974177711365;4288.463942007249;4296.119295544406;4299.247631664454;4308.80610372534;4313.266744653416;4110.917781644365;4297.441332626754;4303.18239534489;4349.565043495641;4359.825606975717;4216.177845320164;4233.089885674594;4249.32010878258;4299.097189590189;4308.4399028126145;4317.870463886057;4318.985038515946;4328.653707703376;4346.369776382438;4373.365861949999;4296.5273819879785;4298.914021719548;4304.203722311382;4318.028443600197;4348.9997300621035;4365.716228445141;4501.324801279834;4503.03184815263;4556.8860778480475;4651.418572678415;4966.751662416901;4967.627427942919;4968.403791545038;4974.3533340665845;5010.498950104997;4978.228374601942;4985.476524964899;4986.476419975923;5012.774425150877;5034;4447.066116115652;4546.477155127137;4548.704334218265;4550.431196100488;4625.537446255347;4972.055309491185;5063.0380227756605;5090.872728181751;5093.159628661229;5102.846914592494;4881.975590122027;4926.187179115477;4939.209726443752;4943.752812359439;4989.052080104769;4755.690880092852;5036.949630503648;5037.244413338029;5045.293658887758;5052.115879721107;4817.807287708522;4827.106985207748;4846.903061938741;4899.3385892904;4928.088303663833;4895.534924182197;4961.603071754251;4962.379702537183;4968.205087186033;5009.248612708123;3961.504811898513;4090.8977275567754;4149.419081328617;4153.813078411479;4188.6649068074485;3555.4489054196642;3591.964080359215;3610.494530765695;3614.98192509041;3640.0353906214873;4259.1268789897995;4260.046319944845;4260.765657888784;4301.161273551627;4325.307950727868;4724.622030237572;4975.378077740283;4976.651634385558;4979.950200498021;5017.67385119966;4215.283401821697;4222.746635201897;4228;4280.764557949343;4321.049369138785;4375.081232941055;4384.495782984997;4391.231534481453;4413.44831896013;4425;4493.123840851003;4730.668853180245;4731.148393289103;4738.668293219511;4747.95252047482;4898.191798353232;4916.287138364989;4940.827071052496;5030.320906677552;5033.672811267256;4737.573618374363;4744.027474367677;4757.714537127784;4779.426468823764;4783.1390349737385;4923.8276660316715;4929.112759703288;4938.061768264019;4950.554450099508;4973.801047958041;4736.668433209642;4861.65968382224;4863.90272194547;4974.054929563371;4998.87502812418;4793.065352256276;4798.064377446364;4803.78382972774;4829.879253018703;4853.854384368475;4791.592714619296;4801.087793319258;4801.255805350176;4810.302506136521;4838.491958344464;4438.178936896556;4545.113702827917;4556.521565235603;4705.458872229738;4716.64625153108;4846.612271018381;4858.392700912386;4859.416869975626;4859.829905953275;4895.485973972682;4739.194336962656;4739.47865734762;4740.739259340631;4745.928811067768;4790.137775200497 05:55:11 INFO - 2015-12-05 05:55:11,292 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.5414921558884;585.7598384662288;586.3725813379683;589.0927970924774;592.5052581094785;28132;37083.443748343765;37148.071298217525;37162.44256336157;37329.44005839908;40795.59204407955;41103.79448102755;41130.58869411305;41179.17641647165;41425;7035.753748618799;7148.85702285954;7991.800204994878;8152.918470815275;8169.060558035812;9833.16418104462;10156.390616562992;10164.034416730436;10166.59333626654;10168.288219824615;9664.081912218327;9746.415215087081;9750.317477776558;9758.560864761102;9763.267754918374;7231.819204519877;7397.889031664529;7405.1113866335845;7408.666610002563;9783.21734261261;10180.796384072351;10464.790704185949;10489.160867130688;10496.317739346918;10500;37142;37642.81178594117;37644;37675;37728.81135594332;2599.8440093594254;2643.5109504741686;2802.299425143714;3009.3830764693403;3250.382427338798;26553.601695974576;26609;26658.86670566654;26694.466110677677;27240;3195.3130077033316;3284.375968565989;3320.750943679234;3364.680355366236;3383.4079036168573;222954;223583;223963;224313.99999999837;224384;48702.26946595804;49472;52641;53029.46970530322;53060.469395305554;56383.71808140933;57190;57316.426835731945;57453.42546574564;57724.422755771906;12117.39413029345;12335.198212116184;12395.93802030984;12397.256164630151;12412;10262.897371026344;10309.432981185957;10323.638672646572;10337.431441270803;10348;17473.56316092108;17519.91240043817;17730;17733.822661773476;17804.91097544504;6915.89626155608;7109.677032656372;7128.750493732695;7171.354578087997;7214.088266609353;812.5327936436454;870.7823044238941;905.117510427328;963.3352986439335;1010.282699283517;26751.598726019125;26803.597946030826;26834.86582567114;26949.86525067362;27023.459530809272;958.1799535277752;959.4627008875052;969.6024629901707;975.3952549419264;1029.1149611334247;13655.590332290047;13927.571058274494;13928.373223204777;14085.507007254697;14223.146611203361;261847;264530;265261;265810;266438;45228.54771452309;45568.038077524856;45569.772151139696;45602.543974560496;45649;1205.73473835756;1218.8842060004285;1226.8098444741079;1237.04747344546;1247.65689435406;25211.87394063018;25896.834642440757;26319.736802631727;26477.867610661822;26562.601560976986;39844.40233396443;39969;40149.59850401458;40161.598384015786;40164.1967160661;215934;219431;246715;247236;249686;27433.588496172175;27492.862535687193;27510.587341189497;27846.3038424041;27886.860565697043;37036.25927481489;37311.44032839455;37889.43165852459;37902.24195516129;38261.808690956364;31915.36169276555;32336.868209612552;32511.51232731558;32695.346093078482;32909.50635740418;31526.369472610877;31892;32118.19704507406;32175.356492869545;32197.839010804797;31880.68119318777;32311.51532727058;32557.18607034843;32730.83634581812;32787.50818737769;27642.308942276602;29286.707132928397;29484.55773163447;29524.261893452836;29557.113286601438;23034.76965230326;23304.417389565395;23461.178858739862;23678.763212368343;23832.642510362704 05:55:11 INFO - 2015-12-05 05:55:11,293 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.96874796894303;331.88052301171587;331.96846299601543;332.39504102533397;332.6573629161963;13018.674533136653;13477.326133693325;15677.529674109766;15749.685006299882;16432.50702478926;8465.322774178067;9819;10116.595336186543;15056.623584410396;15069.92465037676;4465.419495465593;4578.496365399803;4579.633629309647;4580.564846339593;4582.152301824157;3305.4215512285373;3399.6770306820936;4835.758212089399;4963.553280204781;4991.675541089818;5121.436641969381;5123.308353372303;5137.383513978328;5146.665466744668;5150.227465880111;4898.289747986558;5057.128862320947;5123.410807757118;5124.308218390525;5277.47225277473;5051.494850514956;5051.570616497602;5059.519345662156;5062.341895553554;5064.063148317573;11558.306501609846;13344;18168.63662726738;18899.716504252447;18915.527111822175;1645.6825617131008;1653.9090350030745;1723.758673785671;1754.5964428181462;1777.8044415114457;8651.264642505395;8738.946347608307;8932;9865.260105492116;12102.636920892388;1600.7038697840937;1639.3032960991532;1649.9257533411026;1656.892302000378;1664.6670665866875;55593;57374;57639.13541296884;57896.42103578952;58472.70763646154;9527.952360238154;9808.21534277256;9901.207903367713;9946.751331216632;9983.550740216708;12540.184887982252;12653.30406827615;12657.114002019955;12714;12720.300383478998;6837.931620683729;6867.107276054181;6895.379415852597;6968.6864091115;7041.683124259421;6363.777267795697;6366.9681651591445;6425.036244563353;6438.8390290243115;6445.387688169616;4089.959100408958;4099.754014759124;4100.446439730657;4118.4440100586635;4143.627073563393;1594.4658539389202;1687.6287216812282;1689.7972243330878;1719.8022227443753;1721.7073097573443;805.6817557064927;889.9599518021705;915.9404638698463;926.6895589977433;955.6225291010012;15281.235938203044;15542.844571554366;15848.890577659453;15979.201039948188;16108.677826443405;750.4521699159535;820.7168526858225;825.0923983617972;849.762066621347;933.6312156698202;8403.873941890877;8628.741137765877;8750.562471876381;8921.286297096216;8927.10728927115;500253;504394;507507;512912;514005;66247;68741.3125868745;70534;70683.64658176676;71123.28876711166;1065.2702898514542;1073.5222825842582;1091.345192884279;1093.8632670916136;1110.5502271580024;13412.463501459832;13499.190048597116;14114.929425353219;14440.494582689555;14497.85502144965;30136.54795178118;30178.54732179063;31647.683523165393;32145.678543214268;33176.50235246425;38400.42399363956;41652;43450.782746086064;43627;45178.77410612926;8510.446820956618;8591.742247732578;8607;8630.39587228888;8706.216440520384;12188.57339993096;16106.758398624264;16399;16676.58308542296;16745.74881376805;13506.797398038841;13553.457861685421;13681.247531385869;13891.235982021086;14038.508652197124;12232.877671223174;13231;13271.46914123463;13684.726305474034;14031.36858841375;7844;13398.531051413154;13543.59369218925;13839.377228024561;13878.306084695523;8526.232639062515;8546.658133674584;8581.699640512552;8925.821483570162;8940.240079593308;10362.585496580052;12272.81590776157;12273.938630307148;12438.875611244133;12732.554360597334 05:55:11 INFO - 2015-12-05 05:55:11,293 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1281.5450515067157;1640.9671806563867;1691.4756425508094;1705.8294170582944;1749.2740512687235;5914.704264786759;6152.138700581917;7183.1739349974705;7388.519746216492;7391.445641576876;7186.10173728284;7218.1699104602985;7261.673224704901;7274.1998380178275;7275.599842008687;2038.072676931996;2077.6987336836223;2077.8649387789746;2086.6139764143604;2094.1937354118622;2074.6265672179;2108.8840113793735;2113.9958519703096;2117.2907076129513;2119.4277545062823;2044.0495169746066;2075.2217918280644;2089.456741247279;2105.5578328551023;2109.5148115933343;2070.140891530013;2101.5166511702396;2106.9578608427746;2107.0202355904503;2111.0183764549483;2057.362217712514;2067.7518697756213;2094.937151885446;2096.4968407582223;2099.3492017474478;7272.345488906024;7299.270072992711;7347.63261836906;7356.190819009905;7371.594562299071;4207.242696314662;4241.915161696779;4244.830206791725;4249.32010878258;4271.97864010681;2594.714581396045;2625.671791026122;2644.431447238853;2655.5751079827137;2707.0660622085347;861.2507118806616;865.5845194306768;881.3918396306528;884.4516399832081;899.4018977380034;9962.850557241647;9979.950100249453;9982.351147175483;9993.750156246007;9998.80002399948;3827.2154208387215;3833.501644786216;3887.280853042196;3958.366661334173;3964.2269757397607;8428.241458268785;8432.072472028072;8434.873476897852;8447.831043379098;8458.027326857491;4310.827566897289;4319.935200971988;4326.264535029052;4331.97834010828;4332.740035597874;3134.7648926330617;3217.581714377116;3813.8474461021246;3933.6066393361007;3943.2310699413338;3492.2840817632323;3523.9119022024656;3538.7876727396438;3544.91137721559;3561.074120728629;1103.365564800243;1104.8177050786692;1107.6012635451232;1113.0761467981556;1116.6650004998469;906.6464079009191;910.7313342563959;922.2207234886511;922.2990527199377;949.4350861237552;6979.162500499972;6986.44108471321;6991.475639327071;7005.859882802315;7012.088428504364;388.81725588973137;395.539196835689;400.54938194531155;402.0872619154503;403.50973567116097;5253.973730131325;5279.1817268323475;5292.576593872558;5293.655912365761;5298.258243845865;8560.828783424422;8583.871241931376;8677.132286771272;8827.426217295855;8846.823063538694;8649.394542381973;8740.912590874137;8741.650333986696;8750.343724220582;8754.606042728092;6652.767153149616;6772.950192720136;6789.321067893171;6793.694283757242;6802.285759995229;6941.236463989058;6993.230744617987;6996.895046574407;6997.615131167835;7004.789856304319;7695.846083078419;7883.7240696575345;7925.28672419485;7941.245581669732;7964.044314682275;8001.639926203218;8019.759407217793;8228.21831925966;8229.300509456763;8243.711470098518;5449.618526703092;5575.414581468887;6148.723307451265;6527.15147030883;6596.637184954873;6952.200496942916;7023.33278338557;7032.5077244592385;7037.085178926707;7039.718411263492;6389.808305750835;6642.933570664231;6668.799936001928;6678.3989440950545;6711.161104861892;6466.062420948842;6497;6518.934810651833;6532.804015879531;6637.1703537057865;6318.778842740482;6341.22445715182;6359.96820015897;6364.681765911779;6367.235931688042;5801.6519008859605;5897;5973.880522389615;5980.401959803985;5985.820425387245;5827.125931110198;5850.64896106235;5857.297124345106;5860.267466566679;5867.061270196748 05:55:11 INFO - 2015-12-05 05:55:11,296 DEBUG : BROWSER_OUTPUT: |4;prototype.html;276.61826679182724;280.14974552233963;285.1516737705327;285.29958950775847;290.1730069302487;5118.820841270556;5154.278401023859;5306.442823503535;5321.414644389119;5361.195820626903;5166.741662916858;5276.076686579852;5303.018941495817;5311.521963023327;5317.388500322464;4089.7546147231114;4094.263032654121;4095.3242714952;4096.262672718909;4096.9795151024355;3851.6726078283377;3927.6465118139363;3945.5659877413464;4092.815823287959;4102.323116685743;4029.6776257899446;4034.213328400963;4059.776712280838;4061.8375264989363;4065.918681626366;4046.7167298289132;4050.7164498485267;4052.858149964737;4056.59434056592;4061;3546.6985306249;3546.858125674996;3549.1304630365726;3550.1302180965827;3550.840212190458;5008.24876268559;5099.056674515226;5105.361829771278;5105.948940510584;5115.360579927509;4654.441467023945;4657.5575320344515;4660.813567457298;4665.673402861801;4668.836590719308;5536.667799932017;5537.501624853742;5544.168374743821;5548.611597188198;5548.6948217848;3623.8188090595363;3729.049092481427;3757.2673328700916;3842.346801043829;3850.4801851749935;5822.184894114827;5826.417358264182;5849.181114643953;5849.795257166022;5851.210086638292;3963.405489176589;3963.4451176835264;3964.1675248197625;3967.0677390813134;3980.2636512245326;4025.255327764373;4046.393041043867;4047.1096358801015;4048.190361927567;4051.6150965658217;4385.912281754347;4490.57339552742;4623.86128416148;4638.582527572535;4641.327007583882;5538;5571;5574.526165275915;5574.888502230014;5578.97210513953;1359.5513480551394;1381.8410882748612;1382.6681596416788;1382.9861701383059;1384.0380935250105;909.4406939732017;910.7222297199286;915.4964769376816;927.0312523413049;929.2055292724623;4871;4879;4884.853454396374;4886.462489126265;4890.364252647133;5757.596968212185;5761.769529218868;5767.279090113736;5768.711564421846;5769.394213607595;4865.270209468537;4865.464798872121;4876.268559716071;4877.097736918681;4887.902241955212;3019.441403340389;3068.309630333157;3095.5666206731075;3102.4570700127388;3105.7049580289836;5442.782288708487;5459.863503412446;5461.0716178248995;5462.344518657707;5466.972665136649;5887.499562537147;5890.440408161217;5893.616914900604;5894.2926848778425;5897.174395584621;5451.155070963928;5457.6452530586175;5457.808976685797;5459.454054594588;5459.781608735606;5618.69097199658;5729.828105156852;5766;5773.653580785166;5776.306843178845;5444.3194600674915;5583.385827559046;5638.661680299195;5641.915371269516;5647.3505546861;5373.086575282289;5477;5485.533729633026;5507;5507.807226747044;3860.864869729546;3863.632954869283;3869.38089905625;3870.4581358609253;3871.554771201348;5804.535637148933;5809.070548712186;5812.796552120655;5818.185454036354;5820.30156381237;5359.311816777703;5572.498475137257;5606.775728970795;5608.327000759935;5616.550675945996;5596.692181930033;5601.5238704710555;5613.775448981995;5614.382417934105;5615.213870058114;5479.917801233064;5483.698396588226;5486.588505862156;5488.341399031982;5498.532624726943;5519.69641669712;5623.803166889139;5634.126710359901;5634.211210430625;5646.71766411686;5460.726963651722;5466.180072988925;5471.179323101566;5471.50756431923;5473.534749546333 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.2482544375739;691.9689662403018;735.2573900360636;741.2032065529555;758.2114600815153;11865.466054027567;12041.217320874148;13422.798658020138;13853.307334633279;13886.722265554708;13276.734465310712;13373.063885528018;13376.799348009763;13408.32958352081;13414.329283535833;643.8905386084353;645.8062581225637;811.6023148657159;827.6358402302998;827.6854795177824;792.3700657976893;799.4284086877881;799.4324029938722;803.8030682482771;804.4650307545504;822.7284995951352;823.1932705948144;824.2828738997051;826.9875951860727;836.4521238588703;656.6257233376977;664.1432552007903;814.4583851738587;816.4611356504679;830.3523251863556;601.4586871815358;602.8914795336838;603.1676286724336;613.7575657615262;616.0482055224644;12369.752604947851;12381.442835072443;12407.44166512509;12427.565035223724;12436.253824770452;10675.893241067646;11262.887371126266;11404.600838970679;11485.712857178554;11507.252028618197;9411.388259763093;9426.764330891714;9679.467629280458;9747.074027967332;9764.414135151914;3184.5830651237775;3275.0666060172734;3276.836158192081;3281.639019707854;3286.6220384655594;40909;41614.583854161676;41654.37518437226;41705;41708.165836683096;9113.45319280832;9119.863202051974;9151.862722059175;9191.540422978958;9314.115159059878;15402.383904643913;15404.845951540341;15450.150241736588;15472.690546189013;15523.137223533022;6156.753729850756;6183.84540386485;6201.627902325875;6214;6233.625982441068;3371.174062354739;3394.5077963695126;3398.745094117951;3424.70889974355;3485.5294535237927;2547.414094758216;2579.329374362679;2579.9484010320066;2582.48350329931;2585.0435338924717;453.5260652618022;467.93916790816974;477.801712289396;478.6147151542972;480.79325889866993;548.4570275427299;577.7544543569051;592.9652755940824;611.2206936156437;627.2159800249688;7787.883181752279;8391.580420978926;8647.308215342757;8778.60496277669;9018.63925442988;608.5344711295774;618.8700372921647;624.1044101714054;632.7532262417661;636.8662580858072;3418.2821607462215;3427.2288735034917;3464.9653503465147;3513.8594456221463;3623.565172179355;53532;53706.462935370924;53725.462745372046;53814.46185538094;53928.73035634875;43808.12383752371;44152.558474415484;44318.556814432086;45034.54965450303;45115.32327015098;41396.793016034724;41607.79196104;42014.78992605017;42254.99999999938;42280.15439691189;8019.83960320802;8118.59407029658;8153.22544358285;8395.580220989048;8458;31865.840670796497;32183.67816321807;32601.836990814892;32861.50707739338;32907.17732056718;37960;39363;40517.98705032398;40675.79662101671;41087.589124109574;9371.906280937103;10007.249456290661;10036.698899033041;10143.898561014295;10171.23715721309;10533.841992369968;10722.195835312226;11366.715832103933;11553;11558.711032224262;10102.343347682377;10106.545205465918;10118.848217276895;11394.715132121763;11420.543178272776;10603.363798172135;10618.73453163677;10817.242793004414;11039;11368.261063030877;10522.31604945676;10621.946890265499;10651.680449586525;10770.838437423288;10810;9335.766605834908;9344.626214951326;9420.199283060743;9473.47895865734;9518.619255229713;8722.825543489222;8819.344241013909;8856.468611883307;9135.451872887648;9241 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,823 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: __startTimestamp1449323711285__endTimestamp 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4575.95 Median:4735.36 stddev:475.35 (10.0%) stddev-sans-first:450.87 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: Values: 2601.7 2676.7 2684.2 2694.1 2713.4 4542.9 4612.9 4649.7 4672.9 4688.8 4621.6 4644.9 4728.4 4735.4 4786.5 4288.5 4296.1 4299.2 4308.8 4313.3 4110.9 4297.4 4303.2 4349.6 4359.8 4216.2 4233.1 4249.3 4299.1 4308.4 4317.9 4319.0 4328.7 4346.4 4373.4 4296.5 4298.9 4304.2 4318.0 4349.0 4365.7 4501.3 4503.0 4556.9 4651.4 4966.8 4967.6 4968.4 4974.4 5010.5 4978.2 4985.5 4986.5 5012.8 5034.0 4447.1 4546.5 4548.7 4550.4 4625.5 4972.1 5063.0 5090.9 5093.2 5102.8 4882.0 4926.2 4939.2 4943.8 4989.1 4755.7 5036.9 5037.2 5045.3 5052.1 4817.8 4827.1 4846.9 4899.3 4928.1 4895.5 4961.6 4962.4 4968.2 5009.2 3961.5 4090.9 4149.4 4153.8 4188.7 3555.4 3592.0 3610.5 3615.0 3640.0 4259.1 4260.0 4260.8 4301.2 4325.3 4724.6 4975.4 4976.7 4980.0 5017.7 4215.3 4222.7 4228.0 4280.8 4321.0 4375.1 4384.5 4391.2 4413.4 4425.0 4493.1 4730.7 4731.1 4738.7 4748.0 4898.2 4916.3 4940.8 5030.3 5033.7 4737.6 4744.0 4757.7 4779.4 4783.1 4923.8 4929.1 4938.1 4950.6 4973.8 4736.7 4861.7 4863.9 4974.1 4998.9 4793.1 4798.1 4803.8 4829.9 4853.9 4791.6 4801.1 4801.3 4810.3 4838.5 4438.2 4545.1 4556.5 4705.5 4716.6 4846.6 4858.4 4859.4 4859.8 4895.5 4739.2 4739.5 4740.7 4745.9 4790.1 05:55:11 INFO - 2015-12-05 05:55:11,300 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40116.91 Median:17656.76 stddev:63015.11 (356.9%) stddev-sans-first:63121.88 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: Values: 556.5 585.8 586.4 589.1 592.5 28132.0 37083.4 37148.1 37162.4 37329.4 40795.6 41103.8 41130.6 41179.2 41425.0 7035.8 7148.9 7991.8 8152.9 8169.1 9833.2 10156.4 10164.0 10166.6 10168.3 9664.1 9746.4 9750.3 9758.6 9763.3 7231.8 7397.9 7405.1 7408.7 9783.2 10180.8 10464.8 10489.2 10496.3 10500.0 37142.0 37642.8 37644.0 37675.0 37728.8 2599.8 2643.5 2802.3 3009.4 3250.4 26553.6 26609.0 26658.9 26694.5 27240.0 3195.3 3284.4 3320.8 3364.7 3383.4 222954.0 223583.0 223963.0 224314.0 224384.0 48702.3 49472.0 52641.0 53029.5 53060.5 56383.7 57190.0 57316.4 57453.4 57724.4 12117.4 12335.2 12395.9 12397.3 12412.0 10262.9 10309.4 10323.6 10337.4 10348.0 17473.6 17519.9 17730.0 17733.8 17804.9 6915.9 7109.7 7128.8 7171.4 7214.1 812.5 870.8 905.1 963.3 1010.3 26751.6 26803.6 26834.9 26949.9 27023.5 958.2 959.5 969.6 975.4 1029.1 13655.6 13927.6 13928.4 14085.5 14223.1 261847.0 264530.0 265261.0 265810.0 266438.0 45228.5 45568.0 45569.8 45602.5 45649.0 1205.7 1218.9 1226.8 1237.0 1247.7 25211.9 25896.8 26319.7 26477.9 26562.6 39844.4 39969.0 40149.6 40161.6 40164.2 215934.0 219431.0 246715.0 247236.0 249686.0 27433.6 27492.9 27510.6 27846.3 27886.9 37036.3 37311.4 37889.4 37902.2 38261.8 31915.4 32336.9 32511.5 32695.3 32909.5 31526.4 31892.0 32118.2 32175.4 32197.8 31880.7 32311.5 32557.2 32730.8 32787.5 27642.3 29286.7 29484.6 29524.3 29557.1 23034.8 23304.4 23461.2 23678.8 23832.6 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26561.72 Median:22897.81 stddev:82935.35 (362.2%) stddev-sans-first:83144.61 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: Values: 329.0 331.9 332.0 332.4 332.7 13018.7 13477.3 15677.5 15749.7 16432.5 8465.3 9819.0 10116.6 15056.6 15069.9 4465.4 4578.5 4579.6 4580.6 4582.2 3305.4 3399.7 4835.8 4963.6 4991.7 5121.4 5123.3 5137.4 5146.7 5150.2 4898.3 5057.1 5123.4 5124.3 5277.5 5051.5 5051.6 5059.5 5062.3 5064.1 11558.3 13344.0 18168.6 18899.7 18915.5 1645.7 1653.9 1723.8 1754.6 1777.8 8651.3 8738.9 8932.0 9865.3 12102.6 1600.7 1639.3 1649.9 1656.9 1664.7 55593.0 57374.0 57639.1 57896.4 58472.7 9528.0 9808.2 9901.2 9946.8 9983.6 12540.2 12653.3 12657.1 12714.0 12720.3 6837.9 6867.1 6895.4 6968.7 7041.7 6363.8 6367.0 6425.0 6438.8 6445.4 4090.0 4099.8 4100.4 4118.4 4143.6 1594.5 1687.6 1689.8 1719.8 1721.7 805.7 890.0 915.9 926.7 955.6 15281.2 15542.8 15848.9 15979.2 16108.7 750.5 820.7 825.1 849.8 933.6 8403.9 8628.7 8750.6 8921.3 8927.1 500253.0 504394.0 507507.0 512912.0 514005.0 66247.0 68741.3 70534.0 70683.6 71123.3 1065.3 1073.5 1091.3 1093.9 1110.6 13412.5 13499.2 14114.9 14440.5 14497.9 30136.5 30178.5 31647.7 32145.7 33176.5 38400.4 41652.0 43450.8 43627.0 45178.8 8510.4 8591.7 8607.0 8630.4 8706.2 12188.6 16106.8 16399.0 16676.6 16745.7 13506.8 13553.5 13681.2 13891.2 14038.5 12232.9 13231.0 13271.5 13684.7 14031.4 7844.0 13398.5 13543.6 13839.4 13878.3 8526.2 8546.7 8581.7 8925.8 8940.2 10362.6 12272.8 12273.9 12438.9 12732.6 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5034.92 Median:6330.00 stddev:2680.84 (42.4%) stddev-sans-first:2673.51 05:55:11 INFO - 2015-12-05 05:55:11,301 DEBUG : BROWSER_OUTPUT: Values: 1281.5 1641.0 1691.5 1705.8 1749.3 5914.7 6152.1 7183.2 7388.5 7391.4 7186.1 7218.2 7261.7 7274.2 7275.6 2038.1 2077.7 2077.9 2086.6 2094.2 2074.6 2108.9 2114.0 2117.3 2119.4 2044.0 2075.2 2089.5 2105.6 2109.5 2070.1 2101.5 2107.0 2107.0 2111.0 2057.4 2067.8 2094.9 2096.5 2099.3 7272.3 7299.3 7347.6 7356.2 7371.6 4207.2 4241.9 4244.8 4249.3 4272.0 2594.7 2625.7 2644.4 2655.6 2707.1 861.3 865.6 881.4 884.5 899.4 9962.9 9980.0 9982.4 9993.8 9998.8 3827.2 3833.5 3887.3 3958.4 3964.2 8428.2 8432.1 8434.9 8447.8 8458.0 4310.8 4319.9 4326.3 4332.0 4332.7 3134.8 3217.6 3813.8 3933.6 3943.2 3492.3 3523.9 3538.8 3544.9 3561.1 1103.4 1104.8 1107.6 1113.1 1116.7 906.6 910.7 922.2 922.3 949.4 6979.2 6986.4 6991.5 7005.9 7012.1 388.8 395.5 400.5 402.1 403.5 5254.0 5279.2 5292.6 5293.7 5298.3 8560.8 8583.9 8677.1 8827.4 8846.8 8649.4 8740.9 8741.7 8750.3 8754.6 6652.8 6773.0 6789.3 6793.7 6802.3 6941.2 6993.2 6996.9 6997.6 7004.8 7695.8 7883.7 7925.3 7941.2 7964.0 8001.6 8019.8 8228.2 8229.3 8243.7 5449.6 5575.4 6148.7 6527.2 6596.6 6952.2 7023.3 7032.5 7037.1 7039.7 6389.8 6642.9 6668.8 6678.4 6711.2 6466.1 6497.0 6518.9 6532.8 6637.2 6318.8 6341.2 6360.0 6364.7 6367.2 5801.7 5897.0 5973.9 5980.4 5985.8 5827.1 5850.6 5857.3 5860.3 5867.1 05:55:11 INFO - 2015-12-05 05:55:11,302 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,302 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4596.57 Median:5308.98 stddev:1371.76 (25.8%) stddev-sans-first:1336.74 05:55:11 INFO - 2015-12-05 05:55:11,303 DEBUG : BROWSER_OUTPUT: Values: 276.6 280.1 285.2 285.3 290.2 5118.8 5154.3 5306.4 5321.4 5361.2 5166.7 5276.1 5303.0 5311.5 5317.4 4089.8 4094.3 4095.3 4096.3 4097.0 3851.7 3927.6 3945.6 4092.8 4102.3 4029.7 4034.2 4059.8 4061.8 4065.9 4046.7 4050.7 4052.9 4056.6 4061.0 3546.7 3546.9 3549.1 3550.1 3550.8 5008.2 5099.1 5105.4 5105.9 5115.4 4654.4 4657.6 4660.8 4665.7 4668.8 5536.7 5537.5 5544.2 5548.6 5548.7 3623.8 3729.0 3757.3 3842.3 3850.5 5822.2 5826.4 5849.2 5849.8 5851.2 3963.4 3963.4 3964.2 3967.1 3980.3 4025.3 4046.4 4047.1 4048.2 4051.6 4385.9 4490.6 4623.9 4638.6 4641.3 5538.0 5571.0 5574.5 5574.9 5579.0 1359.6 1381.8 1382.7 1383.0 1384.0 909.4 910.7 915.5 927.0 929.2 4871.0 4879.0 4884.9 4886.5 4890.4 5757.6 5761.8 5767.3 5768.7 5769.4 4865.3 4865.5 4876.3 4877.1 4887.9 3019.4 3068.3 3095.6 3102.5 3105.7 5442.8 5459.9 5461.1 5462.3 5467.0 5887.5 5890.4 5893.6 5894.3 5897.2 5451.2 5457.6 5457.8 5459.5 5459.8 5618.7 5729.8 5766.0 5773.7 5776.3 5444.3 5583.4 5638.7 5641.9 5647.4 5373.1 5477.0 5485.5 5507.0 5507.8 3860.9 3863.6 3869.4 3870.5 3871.6 5804.5 5809.1 5812.8 5818.2 5820.3 5359.3 5572.5 5606.8 5608.3 5616.6 5596.7 5601.5 5613.8 5614.4 5615.2 5479.9 5483.7 5486.6 5488.3 5498.5 5519.7 5623.8 5634.1 5634.2 5646.7 5460.7 5466.2 5471.2 5471.5 5473.5 05:55:11 INFO - 2015-12-05 05:55:11,303 DEBUG : BROWSER_OUTPUT: 05:55:11 INFO - 2015-12-05 05:55:11,303 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12551.49 Median:44235.56 stddev:14313.67 (32.4%) stddev-sans-first:14326.05 05:55:11 INFO - 2015-12-05 05:55:11,304 DEBUG : BROWSER_OUTPUT: Values: 677.2 692.0 735.3 741.2 758.2 11865.5 12041.2 13422.8 13853.3 13886.7 13276.7 13373.1 13376.8 13408.3 13414.3 643.9 645.8 811.6 827.6 827.7 792.4 799.4 799.4 803.8 804.5 822.7 823.2 824.3 827.0 836.5 656.6 664.1 814.5 816.5 830.4 601.5 602.9 603.2 613.8 616.0 12369.8 12381.4 12407.4 12427.6 12436.3 10675.9 11262.9 11404.6 11485.7 11507.3 9411.4 9426.8 9679.5 9747.1 9764.4 3184.6 3275.1 3276.8 3281.6 3286.6 40909.0 41614.6 41654.4 41705.0 41708.2 9113.5 9119.9 9151.9 9191.5 9314.1 15402.4 15404.8 15450.2 15472.7 15523.1 6156.8 6183.8 6201.6 6214.0 6233.6 3371.2 3394.5 3398.7 3424.7 3485.5 2547.4 2579.3 2579.9 2582.5 2585.0 453.5 467.9 477.8 478.6 480.8 548.5 577.8 593.0 611.2 627.2 7787.9 8391.6 8647.3 8778.6 9018.6 608.5 618.9 624.1 632.8 636.9 3418.3 3427.2 3465.0 3513.9 3623.6 53532.0 53706.5 53725.5 53814.5 53928.7 43808.1 44152.6 44318.6 45034.5 45115.3 41396.8 41607.8 42014.8 42255.0 42280.2 8019.8 8118.6 8153.2 8395.6 8458.0 31865.8 32183.7 32601.8 32861.5 32907.2 37960.0 39363.0 40518.0 40675.8 41087.6 9371.9 10007.2 10036.7 10143.9 10171.2 10533.8 10722.2 11366.7 11553.0 11558.7 10102.3 10106.5 10118.8 11394.7 11420.5 10603.4 10618.7 10817.2 11039.0 11368.3 10522.3 10621.9 10651.7 10770.8 10810.0 9335.8 9344.6 9420.2 9473.5 9518.6 8722.8 8819.3 8856.5 9135.5 9241.0 05:55:11 INFO - 2015-12-05 05:55:11,304 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:55:11 INFO - 2015-12-05 05:55:11,304 DEBUG : BROWSER_OUTPUT: 05:55:12 INFO - 2015-12-05 05:55:12,034 INFO : Browser exited with error code: 0 05:55:12 INFO - 2015-12-05 05:55:12,051 INFO : Completed test dromaeo_css (00:18:37) 05:55:12 INFO - 2015-12-05 05:55:12,051 INFO : Starting test kraken 05:55:12 INFO - 2015-12-05 05:55:12,051 DEBUG : operating with platform_type : linux_ 05:55:12 INFO - 2015-12-05 05:55:12,051 INFO : Initialising browser for kraken test... 05:55:12 INFO - 2015-12-05 05:55:12,057 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2VlmuX/profile http://localhost:53732/getInfo.html 05:55:16 INFO - 2015-12-05 05:55:16,355 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:55:16 INFO - 2015-12-05 05:55:16,355 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:55:16 INFO - 2015-12-05 05:55:16,355 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:55:16 INFO - 2015-12-05 05:55:16,355 DEBUG : BROWSER_OUTPUT: __metrics 05:55:16 INFO - 2015-12-05 05:55:16,432 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] 05:55:16 INFO - 2015-12-05 05:55:16,508 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:16 ERROR - 2015-12-05 05:55:16,515 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:55:16 INFO - 2015-12-05 05:55:16,793 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:55:17 INFO - 2015-12-05 05:55:17,477 INFO : Browser initialized. 05:55:17 INFO - 2015-12-05 05:55:17,477 INFO : Running cycle 1/1 for kraken test... 05:55:17 INFO - 2015-12-05 05:55:17,477 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2VlmuX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:55:29 INFO - 2015-12-05 05:55:29,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 140541952 05:55:29 INFO - 2015-12-05 05:55:29,447 DEBUG : BROWSER_OUTPUT: 05:55:32 INFO - 2015-12-05 05:55:32,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53732/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:32 INFO - 2015-12-05 05:55:32,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 174747648 05:55:32 INFO - 2015-12-05 05:55:32,640 DEBUG : BROWSER_OUTPUT: 05:55:35 INFO - 2015-12-05 05:55:35,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53732/tests/kraken/driver.html?testName=audio-dft) 05:55:35 INFO - 2015-12-05 05:55:35,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 163221504 05:55:35 INFO - 2015-12-05 05:55:35,964 DEBUG : BROWSER_OUTPUT: 05:55:38 INFO - 2015-12-05 05:55:38,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53732/tests/kraken/driver.html?testName=audio-fft) 05:55:39 INFO - 2015-12-05 05:55:39,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 148930560 05:55:39 INFO - 2015-12-05 05:55:39,517 DEBUG : BROWSER_OUTPUT: 05:55:41 INFO - 2015-12-05 05:55:41,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53732/tests/kraken/driver.html?testName=audio-oscillator) 05:55:42 INFO - 2015-12-05 05:55:42,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 153669632 05:55:42 INFO - 2015-12-05 05:55:42,126 DEBUG : BROWSER_OUTPUT: 05:55:44 INFO - 2015-12-05 05:55:44,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:44 INFO - 2015-12-05 05:55:44,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 155049984 05:55:44 INFO - 2015-12-05 05:55:44,965 DEBUG : BROWSER_OUTPUT: 05:55:47 INFO - 2015-12-05 05:55:47,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53732/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:48 INFO - 2015-12-05 05:55:48,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 155467776 05:55:48 INFO - 2015-12-05 05:55:48,516 DEBUG : BROWSER_OUTPUT: 05:55:51 INFO - 2015-12-05 05:55:51,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53732/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:52 INFO - 2015-12-05 05:55:52,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 155877376 05:55:52 INFO - 2015-12-05 05:55:52,491 DEBUG : BROWSER_OUTPUT: 05:55:55 INFO - 2015-12-05 05:55:55,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53732/tests/kraken/driver.html?testName=json-parse-financial) 05:55:55 INFO - 2015-12-05 05:55:55,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 155627520 05:55:55 INFO - 2015-12-05 05:55:55,893 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-12-05 05:55:57,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:58 INFO - 2015-12-05 05:55:58,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 163639296 05:55:58 INFO - 2015-12-05 05:55:58,255 DEBUG : BROWSER_OUTPUT: 05:56:00 INFO - 2015-12-05 05:56:00,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:00 INFO - 2015-12-05 05:56:00,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 164810752 05:56:00 INFO - 2015-12-05 05:56:00,739 DEBUG : BROWSER_OUTPUT: 05:56:02 INFO - 2015-12-05 05:56:02,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:03 INFO - 2015-12-05 05:56:03,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 178032640 05:56:03 INFO - 2015-12-05 05:56:03,471 DEBUG : BROWSER_OUTPUT: 05:56:05 INFO - 2015-12-05 05:56:05,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:06 INFO - 2015-12-05 05:56:06,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 183869440 05:56:06 INFO - 2015-12-05 05:56:06,584 DEBUG : BROWSER_OUTPUT: 05:56:09 INFO - 2015-12-05 05:56:09,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:09 INFO - 2015-12-05 05:56:09,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 183640064 05:56:09 INFO - 2015-12-05 05:56:09,723 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53732/tests/kraken/driver.html?testName=ai-astar) 05:56:11 INFO - 2015-12-05 05:56:11,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 242692096 05:56:11 INFO - 2015-12-05 05:56:11,714 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,715 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:11 INFO - 2015-12-05 05:56:11,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:11 INFO - 2015-12-05 05:56:11,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:11 INFO - 2015-12-05 05:56:11,716 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:11 INFO - 2015-12-05 05:56:11,716 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;113;105;111;111;110;100;110;110;100 05:56:11 INFO - 2015-12-05 05:56:11,716 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;159;169;132;157;151;129;169;129 05:56:11 INFO - 2015-12-05 05:56:11,717 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;159;162;160;159;160;159;160 05:56:11 INFO - 2015-12-05 05:56:11,717 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;82;93;74;72;74;99;90;71 05:56:11 INFO - 2015-12-05 05:56:11,717 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;103;128;94;94;95;131;94;95;130 05:56:11 INFO - 2015-12-05 05:56:11,717 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;109;109 05:56:11 INFO - 2015-12-05 05:56:11,718 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;145;146;146;147;146;146 05:56:11 INFO - 2015-12-05 05:56:11,718 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;96;95;95;95;95 05:56:11 INFO - 2015-12-05 05:56:11,718 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;71;71;70;71;81;68;69 05:56:11 INFO - 2015-12-05 05:56:11,718 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;67;68;69;68;68;70;68;68 05:56:11 INFO - 2015-12-05 05:56:11,718 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;84;83;85;84;86;84;85;84 05:56:11 INFO - 2015-12-05 05:56:11,718 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;129;122;120;125;118;121;128;122;129 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;147;143;143;135;133;150;147;143;132 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;67;68;68;68;68;68;67 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1013 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: __startTimestamp1449323771715__endTimestamp 05:56:11 INFO - 2015-12-05 05:56:11,720 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,721 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:11 INFO - 2015-12-05 05:56:11,721 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:56:11 INFO - 2015-12-05 05:56:11,721 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,721 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:4.61 (4.2%) stddev-sans-first:4.89 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: Values: 108.0 113.0 105.0 111.0 111.0 110.0 100.0 110.0 110.0 100.0 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:155.50 stddev:16.32 (10.5%) stddev-sans-first:17.16 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 159.0 169.0 132.0 157.0 151.0 129.0 169.0 129.0 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 159.0 162.0 160.0 159.0 160.0 159.0 160.0 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:78.00 stddev:10.28 (13.2%) stddev-sans-first:10.66 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 82.0 93.0 74.0 72.0 74.0 99.0 90.0 71.0 05:56:11 INFO - 2015-12-05 05:56:11,722 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:16.63 (17.7%) stddev-sans-first:17.16 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: Values: 95.0 103.0 128.0 94.0 94.0 95.0 131.0 94.0 95.0 130.0 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,723 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:56:11 INFO - 2015-12-05 05:56:11,724 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 05:56:11 INFO - 2015-12-05 05:56:11,724 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,724 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:3.58 (5.0%) stddev-sans-first:3.80 05:56:11 INFO - 2015-12-05 05:56:11,724 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 71.0 71.0 70.0 71.0 81.0 68.0 69.0 05:56:11 INFO - 2015-12-05 05:56:11,724 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,724 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 05:56:11 INFO - 2015-12-05 05:56:11,725 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 68.0 69.0 68.0 68.0 70.0 68.0 68.0 05:56:11 INFO - 2015-12-05 05:56:11,725 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,725 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 05:56:11 INFO - 2015-12-05 05:56:11,725 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 84.0 83.0 85.0 84.0 86.0 84.0 85.0 84.0 05:56:11 INFO - 2015-12-05 05:56:11,725 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,725 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.50 stddev:4.10 (3.2%) stddev-sans-first:4.12 05:56:11 INFO - 2015-12-05 05:56:11,725 DEBUG : BROWSER_OUTPUT: Values: 128.0 129.0 122.0 120.0 125.0 118.0 121.0 128.0 122.0 129.0 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:143.00 stddev:6.87 (4.8%) stddev-sans-first:6.56 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: Values: 132.0 147.0 143.0 143.0 135.0 133.0 150.0 147.0 143.0 132.0 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 67.0 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:11 INFO - 2015-12-05 05:56:11,726 DEBUG : BROWSER_OUTPUT: 05:56:12 INFO - 2015-12-05 05:56:12,634 INFO : Browser exited with error code: 0 05:56:12 INFO - 2015-12-05 05:56:12,684 INFO : Completed test kraken (00:01:00) 05:56:12 INFO - 2015-12-05 05:56:12,685 INFO : Starting test v8_7 05:56:12 INFO - 2015-12-05 05:56:12,685 DEBUG : operating with platform_type : linux_ 05:56:12 INFO - 2015-12-05 05:56:12,685 INFO : Initialising browser for v8_7 test... 05:56:12 INFO - 2015-12-05 05:56:12,691 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFYDm7z/profile http://localhost:53732/getInfo.html 05:56:16 INFO - 2015-12-05 05:56:16,768 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:56:16 INFO - 2015-12-05 05:56:16,768 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:56:16 INFO - 2015-12-05 05:56:16,768 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:56:16 INFO - 2015-12-05 05:56:16,768 DEBUG : BROWSER_OUTPUT: __metrics 05:56:16 INFO - 2015-12-05 05:56:16,869 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] 05:56:16 INFO - 2015-12-05 05:56:16,930 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:18 INFO - 2015-12-05 05:56:18,111 INFO : Browser initialized. 05:56:18 INFO - 2015-12-05 05:56:18,111 INFO : Running cycle 1/1 for v8_7 test... 05:56:18 INFO - 2015-12-05 05:56:18,112 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFYDm7z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:56:30 INFO - 2015-12-05 05:56:30,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 142151680 05:56:30 INFO - 2015-12-05 05:56:30,079 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53732/tests/v8_7/run.html (next: http://localhost:53732/tests/v8_7/run.html) 05:56:51 INFO - 2015-12-05 05:56:51,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 444669952 05:56:51 INFO - 2015-12-05 05:56:51,750 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,750 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:51 INFO - 2015-12-05 05:56:51,750 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:51 INFO - 2015-12-05 05:56:51,750 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:51 INFO - 2015-12-05 05:56:51,750 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:51 INFO - 2015-12-05 05:56:51,750 DEBUG : BROWSER_OUTPUT: |0;Richards;172.5625539257981 05:56:51 INFO - 2015-12-05 05:56:51,751 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.39117538005192 05:56:51 INFO - 2015-12-05 05:56:51,751 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 05:56:51 INFO - 2015-12-05 05:56:51,751 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 05:56:51 INFO - 2015-12-05 05:56:51,751 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 05:56:51 INFO - 2015-12-05 05:56:51,751 DEBUG : BROWSER_OUTPUT: |5;Earley;780.64012490242 05:56:51 INFO - 2015-12-05 05:56:51,751 DEBUG : BROWSER_OUTPUT: |6;Boyer;11823.529411764706 05:56:51 INFO - 2015-12-05 05:56:51,752 DEBUG : BROWSER_OUTPUT: |7;RegExp;26894.736842105263 05:56:51 INFO - 2015-12-05 05:56:51,752 DEBUG : BROWSER_OUTPUT: |8;Splay;618.4291898577612 05:56:51 INFO - 2015-12-05 05:56:51,752 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 05:56:51 INFO - 2015-12-05 05:56:51,753 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:51 INFO - 2015-12-05 05:56:51,753 DEBUG : BROWSER_OUTPUT: __startTimestamp1449323811748__endTimestamp 05:56:51 INFO - 2015-12-05 05:56:51,753 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,753 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:51 INFO - 2015-12-05 05:56:51,754 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:56:51 INFO - 2015-12-05 05:56:51,754 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,754 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.56 Median:172.56 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,754 DEBUG : BROWSER_OUTPUT: Values: 172.6 05:56:51 INFO - 2015-12-05 05:56:51,755 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,755 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.39 Median:185.39 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,755 DEBUG : BROWSER_OUTPUT: Values: 185.4 05:56:51 INFO - 2015-12-05 05:56:51,755 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,755 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,756 DEBUG : BROWSER_OUTPUT: Values: 278.4 05:56:51 INFO - 2015-12-05 05:56:51,756 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,756 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,756 DEBUG : BROWSER_OUTPUT: Values: 5128.2 05:56:51 INFO - 2015-12-05 05:56:51,756 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,756 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,757 DEBUG : BROWSER_OUTPUT: Values: 2006.0 05:56:51 INFO - 2015-12-05 05:56:51,757 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,757 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,757 DEBUG : BROWSER_OUTPUT: Values: 780.6 05:56:51 INFO - 2015-12-05 05:56:51,757 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,757 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11823.53 Median:11823.53 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,759 DEBUG : BROWSER_OUTPUT: Values: 11823.5 05:56:51 INFO - 2015-12-05 05:56:51,759 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,759 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,759 DEBUG : BROWSER_OUTPUT: Values: 26894.7 05:56:51 INFO - 2015-12-05 05:56:51,759 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,759 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.43 Median:618.43 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,760 DEBUG : BROWSER_OUTPUT: Values: 618.4 05:56:51 INFO - 2015-12-05 05:56:51,760 DEBUG : BROWSER_OUTPUT: 05:56:51 INFO - 2015-12-05 05:56:51,760 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:56:51 INFO - 2015-12-05 05:56:51,760 DEBUG : BROWSER_OUTPUT: Values: 4840.6 05:56:51 INFO - 2015-12-05 05:56:51,760 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:51 INFO - 2015-12-05 05:56:51,760 DEBUG : BROWSER_OUTPUT: 05:56:52 INFO - 2015-12-05 05:56:52,678 INFO : Browser exited with error code: 0 05:56:52 INFO - 2015-12-05 05:56:52,690 INFO : Completed test v8_7 (00:00:40) 05:56:52 INFO - 2015-12-05 05:56:52,784 INFO : Completed test suite (00:20:18) 05:56:52 INFO - 2015-12-05 05:56:52,784 DEBUG : Working with test: dromaeo_css 05:56:52 INFO - 2015-12-05 05:56:52,784 DEBUG : Generating results file: dromaeo_css 05:56:52 INFO - 2015-12-05 05:56:52,785 DEBUG : Working with test: kraken 05:56:52 INFO - 2015-12-05 05:56:52,785 DEBUG : Generating results file: kraken 05:56:52 INFO - 2015-12-05 05:56:52,786 INFO : javascript benchmark 05:56:52 INFO - 2015-12-05 05:56:52,786 DEBUG : Working with test: v8_7 05:56:52 INFO - 2015-12-05 05:56:52,786 DEBUG : Generating results file: v8_7 05:56:52 INFO - 2015-12-05 05:56:52,786 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:52 INFO - 2015-12-05 05:56:52,842 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 05:56:52 INFO - 2015-12-05 05:56:52,842 DEBUG : process_Request line: dromaeo_css 6243.81 graph.html#tests=[[72,94,35]] 05:56:52 INFO - 2015-12-05 05:56:52,842 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:52 INFO - 2015-12-05 05:56:52,959 DEBUG : process_Request line: kraken 1508.50 graph.html#tests=[[232,94,35]] 05:56:52 INFO - 2015-12-05 05:56:52,959 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:53 INFO - 2015-12-05 05:56:53,078 DEBUG : process_Request line: v8_7 19774.60 graph.html#tests=[[230,94,35]] 05:56:53 INFO - 2015-12-05 05:56:53,079 INFO : javascript benchmark 05:56:53 INFO - 2015-12-05 05:56:53,082 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2601.661783968084, 2676.718944510825, 2684.2094778988467, 2694.0570800219925, 2713.4166154276827, 4542.863714088574, 4612.907741845165, 4649.744264065479, 4672.859814205571, 4688.789004494797, 4621.58405743483, 4644.930326045112, 4728.385309909707, 4735.3607263019485, 4786.4974177711365, 4288.463942007249, 4296.119295544406, 4299.247631664454, 4308.80610372534, 4313.266744653416, 4110.917781644365, 4297.441332626754, 4303.18239534489, 4349.565043495641, 4359.825606975717, 4216.177845320164, 4233.089885674594, 4249.32010878258, 4299.097189590189, 4308.4399028126145, 4317.870463886057, 4318.985038515946, 4328.653707703376, 4346.369776382438, 4373.365861949999, 4296.5273819879785, 4298.914021719548, 4304.203722311382, 4318.028443600197, 4348.9997300621035, 4365.716228445141, 4501.324801279834, 4503.03184815263, 4556.8860778480475, 4651.418572678415, 4966.751662416901, 4967.627427942919, 4968.403791545038, 4974.3533340665845, 5010.498950104997, 4978.228374601942, 4985.476524964899, 4986.476419975923, 5012.774425150877, 5034.0, 4447.066116115652, 4546.477155127137, 4548.704334218265, 4550.431196100488, 4625.537446255347, 4972.055309491185, 5063.0380227756605, 5090.872728181751, 5093.159628661229, 5102.846914592494, 4881.975590122027, 4926.187179115477, 4939.209726443752, 4943.752812359439, 4989.052080104769, 4755.690880092852, 5036.949630503648, 5037.244413338029, 5045.293658887758, 5052.115879721107, 4817.807287708522, 4827.106985207748, 4846.903061938741, 4899.3385892904, 4928.088303663833, 4895.534924182197, 4961.603071754251, 4962.379702537183, 4968.205087186033, 5009.248612708123, 3961.504811898513, 4090.8977275567754, 4149.419081328617, 4153.813078411479, 4188.6649068074485, 3555.4489054196642, 3591.964080359215, 3610.494530765695, 3614.98192509041, 3640.0353906214873, 4259.1268789897995, 4260.046319944845, 4260.765657888784, 4301.161273551627, 4325.307950727868, 4724.622030237572, 4975.378077740283, 4976.651634385558, 4979.950200498021, 5017.67385119966, 4215.283401821697, 4222.746635201897, 4228.0, 4280.764557949343, 4321.049369138785, 4375.081232941055, 4384.495782984997, 4391.231534481453, 4413.44831896013, 4425.0, 4493.123840851003, 4730.668853180245, 4731.148393289103, 4738.668293219511, 4747.95252047482, 4898.191798353232, 4916.287138364989, 4940.827071052496, 5030.320906677552, 5033.672811267256, 4737.573618374363, 4744.027474367677, 4757.714537127784, 4779.426468823764, 4783.1390349737385, 4923.8276660316715, 4929.112759703288, 4938.061768264019, 4950.554450099508, 4973.801047958041, 4736.668433209642, 4861.65968382224, 4863.90272194547, 4974.054929563371, 4998.87502812418, 4793.065352256276, 4798.064377446364, 4803.78382972774, 4829.879253018703, 4853.854384368475, 4791.592714619296, 4801.087793319258, 4801.255805350176, 4810.302506136521, 4838.491958344464, 4438.178936896556, 4545.113702827917, 4556.521565235603, 4705.458872229738, 4716.64625153108, 4846.612271018381, 4858.392700912386, 4859.416869975626, 4859.829905953275, 4895.485973972682, 4739.194336962656, 4739.47865734762, 4740.739259340631, 4745.928811067768, 4790.137775200497], "unit": "ms", "name": "dojo.html", "value": 4546.633557915482}, {"lowerIsBetter": false, "replicates": [556.5414921558884, 585.7598384662288, 586.3725813379683, 589.0927970924774, 592.5052581094785, 28132.0, 37083.443748343765, 37148.071298217525, 37162.44256336157, 37329.44005839908, 40795.59204407955, 41103.79448102755, 41130.58869411305, 41179.17641647165, 41425.0, 7035.753748618799, 7148.85702285954, 7991.800204994878, 8152.918470815275, 8169.060558035812, 9833.16418104462, 10156.390616562992, 10164.034416730436, 10166.59333626654, 10168.288219824615, 9664.081912218327, 9746.415215087081, 9750.317477776558, 9758.560864761102, 9763.267754918374, 7231.819204519877, 7397.889031664529, 7405.1113866335845, 7408.666610002563, 9783.21734261261, 10180.796384072351, 10464.790704185949, 10489.160867130688, 10496.317739346918, 10500.0, 37142.0, 37642.81178594117, 37644.0, 37675.0, 37728.81135594332, 2599.8440093594254, 2643.5109504741686, 2802.299425143714, 3009.3830764693403, 3250.382427338798, 26553.601695974576, 26609.0, 26658.86670566654, 26694.466110677677, 27240.0, 3195.3130077033316, 3284.375968565989, 3320.750943679234, 3364.680355366236, 3383.4079036168573, 222954.0, 223583.0, 223963.0, 224313.99999999837, 224384.0, 48702.26946595804, 49472.0, 52641.0, 53029.46970530322, 53060.469395305554, 56383.71808140933, 57190.0, 57316.426835731945, 57453.42546574564, 57724.422755771906, 12117.39413029345, 12335.198212116184, 12395.93802030984, 12397.256164630151, 12412.0, 10262.897371026344, 10309.432981185957, 10323.638672646572, 10337.431441270803, 10348.0, 17473.56316092108, 17519.91240043817, 17730.0, 17733.822661773476, 17804.91097544504, 6915.89626155608, 7109.677032656372, 7128.750493732695, 7171.354578087997, 7214.088266609353, 812.5327936436454, 870.7823044238941, 905.117510427328, 963.3352986439335, 1010.282699283517, 26751.598726019125, 26803.597946030826, 26834.86582567114, 26949.86525067362, 27023.459530809272, 958.1799535277752, 959.4627008875052, 969.6024629901707, 975.3952549419264, 1029.1149611334247, 13655.590332290047, 13927.571058274494, 13928.373223204777, 14085.507007254697, 14223.146611203361, 261847.0, 264530.0, 265261.0, 265810.0, 266438.0, 45228.54771452309, 45568.038077524856, 45569.772151139696, 45602.543974560496, 45649.0, 1205.73473835756, 1218.8842060004285, 1226.8098444741079, 1237.04747344546, 1247.65689435406, 25211.87394063018, 25896.834642440757, 26319.736802631727, 26477.867610661822, 26562.601560976986, 39844.40233396443, 39969.0, 40149.59850401458, 40161.598384015786, 40164.1967160661, 215934.0, 219431.0, 246715.0, 247236.0, 249686.0, 27433.588496172175, 27492.862535687193, 27510.587341189497, 27846.3038424041, 27886.860565697043, 37036.25927481489, 37311.44032839455, 37889.43165852459, 37902.24195516129, 38261.808690956364, 31915.36169276555, 32336.868209612552, 32511.51232731558, 32695.346093078482, 32909.50635740418, 31526.369472610877, 31892.0, 32118.19704507406, 32175.356492869545, 32197.839010804797, 31880.68119318777, 32311.51532727058, 32557.18607034843, 32730.83634581812, 32787.50818737769, 27642.308942276602, 29286.707132928397, 29484.55773163447, 29524.261893452836, 29557.113286601438, 23034.76965230326, 23304.417389565395, 23461.178858739862, 23678.763212368343, 23832.642510362704], "unit": "ms", "name": "ext.html", "value": 16882.505509024813}, {"lowerIsBetter": false, "replicates": [328.96874796894303, 331.88052301171587, 331.96846299601543, 332.39504102533397, 332.6573629161963, 13018.674533136653, 13477.326133693325, 15677.529674109766, 15749.685006299882, 16432.50702478926, 8465.322774178067, 9819.0, 10116.595336186543, 15056.623584410396, 15069.92465037676, 4465.419495465593, 4578.496365399803, 4579.633629309647, 4580.564846339593, 4582.152301824157, 3305.4215512285373, 3399.6770306820936, 4835.758212089399, 4963.553280204781, 4991.675541089818, 5121.436641969381, 5123.308353372303, 5137.383513978328, 5146.665466744668, 5150.227465880111, 4898.289747986558, 5057.128862320947, 5123.410807757118, 5124.308218390525, 5277.47225277473, 5051.494850514956, 5051.570616497602, 5059.519345662156, 5062.341895553554, 5064.063148317573, 11558.306501609846, 13344.0, 18168.63662726738, 18899.716504252447, 18915.527111822175, 1645.6825617131008, 1653.9090350030745, 1723.758673785671, 1754.5964428181462, 1777.8044415114457, 8651.264642505395, 8738.946347608307, 8932.0, 9865.260105492116, 12102.636920892388, 1600.7038697840937, 1639.3032960991532, 1649.9257533411026, 1656.892302000378, 1664.6670665866875, 55593.0, 57374.0, 57639.13541296884, 57896.42103578952, 58472.70763646154, 9527.952360238154, 9808.21534277256, 9901.207903367713, 9946.751331216632, 9983.550740216708, 12540.184887982252, 12653.30406827615, 12657.114002019955, 12714.0, 12720.300383478998, 6837.931620683729, 6867.107276054181, 6895.379415852597, 6968.6864091115, 7041.683124259421, 6363.777267795697, 6366.9681651591445, 6425.036244563353, 6438.8390290243115, 6445.387688169616, 4089.959100408958, 4099.754014759124, 4100.446439730657, 4118.4440100586635, 4143.627073563393, 1594.4658539389202, 1687.6287216812282, 1689.7972243330878, 1719.8022227443753, 1721.7073097573443, 805.6817557064927, 889.9599518021705, 915.9404638698463, 926.6895589977433, 955.6225291010012, 15281.235938203044, 15542.844571554366, 15848.890577659453, 15979.201039948188, 16108.677826443405, 750.4521699159535, 820.7168526858225, 825.0923983617972, 849.762066621347, 933.6312156698202, 8403.873941890877, 8628.741137765877, 8750.562471876381, 8921.286297096216, 8927.10728927115, 500253.0, 504394.0, 507507.0, 512912.0, 514005.0, 66247.0, 68741.3125868745, 70534.0, 70683.64658176676, 71123.28876711166, 1065.2702898514542, 1073.5222825842582, 1091.345192884279, 1093.8632670916136, 1110.5502271580024, 13412.463501459832, 13499.190048597116, 14114.929425353219, 14440.494582689555, 14497.85502144965, 30136.54795178118, 30178.54732179063, 31647.683523165393, 32145.678543214268, 33176.50235246425, 38400.42399363956, 41652.0, 43450.782746086064, 43627.0, 45178.77410612926, 8510.446820956618, 8591.742247732578, 8607.0, 8630.39587228888, 8706.216440520384, 12188.57339993096, 16106.758398624264, 16399.0, 16676.58308542296, 16745.74881376805, 13506.797398038841, 13553.457861685421, 13681.247531385869, 13891.235982021086, 14038.508652197124, 12232.877671223174, 13231.0, 13271.46914123463, 13684.726305474034, 14031.36858841375, 7844.0, 13398.531051413154, 13543.59369218925, 13839.377228024561, 13878.306084695523, 8526.232639062515, 8546.658133674584, 8581.699640512552, 8925.821483570162, 8940.240079593308, 10362.585496580052, 12272.81590776157, 12273.938630307148, 12438.875611244133, 12732.554360597334], "unit": "ms", "name": "jquery.html", "value": 8013.273949211125}, {"lowerIsBetter": false, "replicates": [1281.5450515067157, 1640.9671806563867, 1691.4756425508094, 1705.8294170582944, 1749.2740512687235, 5914.704264786759, 6152.138700581917, 7183.1739349974705, 7388.519746216492, 7391.445641576876, 7186.10173728284, 7218.1699104602985, 7261.673224704901, 7274.1998380178275, 7275.599842008687, 2038.072676931996, 2077.6987336836223, 2077.8649387789746, 2086.6139764143604, 2094.1937354118622, 2074.6265672179, 2108.8840113793735, 2113.9958519703096, 2117.2907076129513, 2119.4277545062823, 2044.0495169746066, 2075.2217918280644, 2089.456741247279, 2105.5578328551023, 2109.5148115933343, 2070.140891530013, 2101.5166511702396, 2106.9578608427746, 2107.0202355904503, 2111.0183764549483, 2057.362217712514, 2067.7518697756213, 2094.937151885446, 2096.4968407582223, 2099.3492017474478, 7272.345488906024, 7299.270072992711, 7347.63261836906, 7356.190819009905, 7371.594562299071, 4207.242696314662, 4241.915161696779, 4244.830206791725, 4249.32010878258, 4271.97864010681, 2594.714581396045, 2625.671791026122, 2644.431447238853, 2655.5751079827137, 2707.0660622085347, 861.2507118806616, 865.5845194306768, 881.3918396306528, 884.4516399832081, 899.4018977380034, 9962.850557241647, 9979.950100249453, 9982.351147175483, 9993.750156246007, 9998.80002399948, 3827.2154208387215, 3833.501644786216, 3887.280853042196, 3958.366661334173, 3964.2269757397607, 8428.241458268785, 8432.072472028072, 8434.873476897852, 8447.831043379098, 8458.027326857491, 4310.827566897289, 4319.935200971988, 4326.264535029052, 4331.97834010828, 4332.740035597874, 3134.7648926330617, 3217.581714377116, 3813.8474461021246, 3933.6066393361007, 3943.2310699413338, 3492.2840817632323, 3523.9119022024656, 3538.7876727396438, 3544.91137721559, 3561.074120728629, 1103.365564800243, 1104.8177050786692, 1107.6012635451232, 1113.0761467981556, 1116.6650004998469, 906.6464079009191, 910.7313342563959, 922.2207234886511, 922.2990527199377, 949.4350861237552, 6979.162500499972, 6986.44108471321, 6991.475639327071, 7005.859882802315, 7012.088428504364, 388.81725588973137, 395.539196835689, 400.54938194531155, 402.0872619154503, 403.50973567116097, 5253.973730131325, 5279.1817268323475, 5292.576593872558, 5293.655912365761, 5298.258243845865, 8560.828783424422, 8583.871241931376, 8677.132286771272, 8827.426217295855, 8846.823063538694, 8649.394542381973, 8740.912590874137, 8741.650333986696, 8750.343724220582, 8754.606042728092, 6652.767153149616, 6772.950192720136, 6789.321067893171, 6793.694283757242, 6802.285759995229, 6941.236463989058, 6993.230744617987, 6996.895046574407, 6997.615131167835, 7004.789856304319, 7695.846083078419, 7883.7240696575345, 7925.28672419485, 7941.245581669732, 7964.044314682275, 8001.639926203218, 8019.759407217793, 8228.21831925966, 8229.300509456763, 8243.711470098518, 5449.618526703092, 5575.414581468887, 6148.723307451265, 6527.15147030883, 6596.637184954873, 6952.200496942916, 7023.33278338557, 7032.5077244592385, 7037.085178926707, 7039.718411263492, 6389.808305750835, 6642.933570664231, 6668.799936001928, 6678.3989440950545, 6711.161104861892, 6466.062420948842, 6497.0, 6518.934810651833, 6532.804015879531, 6637.1703537057865, 6318.778842740482, 6341.22445715182, 6359.96820015897, 6364.681765911779, 6367.235931688042, 5801.6519008859605, 5897.0, 5973.880522389615, 5980.401959803985, 5985.820425387245, 5827.125931110198, 5850.64896106235, 5857.297124345106, 5860.267466566679, 5867.061270196748], "unit": "ms", "name": "mootools.html", "value": 4023.6590221563174}, {"lowerIsBetter": false, "replicates": [276.61826679182724, 280.14974552233963, 285.1516737705327, 285.29958950775847, 290.1730069302487, 5118.820841270556, 5154.278401023859, 5306.442823503535, 5321.414644389119, 5361.195820626903, 5166.741662916858, 5276.076686579852, 5303.018941495817, 5311.521963023327, 5317.388500322464, 4089.7546147231114, 4094.263032654121, 4095.3242714952, 4096.262672718909, 4096.9795151024355, 3851.6726078283377, 3927.6465118139363, 3945.5659877413464, 4092.815823287959, 4102.323116685743, 4029.6776257899446, 4034.213328400963, 4059.776712280838, 4061.8375264989363, 4065.918681626366, 4046.7167298289132, 4050.7164498485267, 4052.858149964737, 4056.59434056592, 4061.0, 3546.6985306249, 3546.858125674996, 3549.1304630365726, 3550.1302180965827, 3550.840212190458, 5008.24876268559, 5099.056674515226, 5105.361829771278, 5105.948940510584, 5115.360579927509, 4654.441467023945, 4657.5575320344515, 4660.813567457298, 4665.673402861801, 4668.836590719308, 5536.667799932017, 5537.501624853742, 5544.168374743821, 5548.611597188198, 5548.6948217848, 3623.8188090595363, 3729.049092481427, 3757.2673328700916, 3842.346801043829, 3850.4801851749935, 5822.184894114827, 5826.417358264182, 5849.181114643953, 5849.795257166022, 5851.210086638292, 3963.405489176589, 3963.4451176835264, 3964.1675248197625, 3967.0677390813134, 3980.2636512245326, 4025.255327764373, 4046.393041043867, 4047.1096358801015, 4048.190361927567, 4051.6150965658217, 4385.912281754347, 4490.57339552742, 4623.86128416148, 4638.582527572535, 4641.327007583882, 5538.0, 5571.0, 5574.526165275915, 5574.888502230014, 5578.97210513953, 1359.5513480551394, 1381.8410882748612, 1382.6681596416788, 1382.9861701383059, 1384.0380935250105, 909.4406939732017, 910.7222297199286, 915.4964769376816, 927.0312523413049, 929.2055292724623, 4871.0, 4879.0, 4884.853454396374, 4886.462489126265, 4890.364252647133, 5757.596968212185, 5761.769529218868, 5767.279090113736, 5768.711564421846, 5769.394213607595, 4865.270209468537, 4865.464798872121, 4876.268559716071, 4877.097736918681, 4887.902241955212, 3019.441403340389, 3068.309630333157, 3095.5666206731075, 3102.4570700127388, 3105.7049580289836, 5442.782288708487, 5459.863503412446, 5461.0716178248995, 5462.344518657707, 5466.972665136649, 5887.499562537147, 5890.440408161217, 5893.616914900604, 5894.2926848778425, 5897.174395584621, 5451.155070963928, 5457.6452530586175, 5457.808976685797, 5459.454054594588, 5459.781608735606, 5618.69097199658, 5729.828105156852, 5766.0, 5773.653580785166, 5776.306843178845, 5444.3194600674915, 5583.385827559046, 5638.661680299195, 5641.915371269516, 5647.3505546861, 5373.086575282289, 5477.0, 5485.533729633026, 5507.0, 5507.807226747044, 3860.864869729546, 3863.632954869283, 3869.38089905625, 3870.4581358609253, 3871.554771201348, 5804.535637148933, 5809.070548712186, 5812.796552120655, 5818.185454036354, 5820.30156381237, 5359.311816777703, 5572.498475137257, 5606.775728970795, 5608.327000759935, 5616.550675945996, 5596.692181930033, 5601.5238704710555, 5613.775448981995, 5614.382417934105, 5615.213870058114, 5479.917801233064, 5483.698396588226, 5486.588505862156, 5488.341399031982, 5498.532624726943, 5519.69641669712, 5623.803166889139, 5634.126710359901, 5634.211210430625, 5646.71766411686, 5460.726963651722, 5466.180072988925, 5471.179323101566, 5471.50756431923, 5473.534749546333], "unit": "ms", "name": "prototype.html", "value": 4145.344055933726}, {"lowerIsBetter": false, "replicates": [677.2482544375739, 691.9689662403018, 735.2573900360636, 741.2032065529555, 758.2114600815153, 11865.466054027567, 12041.217320874148, 13422.798658020138, 13853.307334633279, 13886.722265554708, 13276.734465310712, 13373.063885528018, 13376.799348009763, 13408.32958352081, 13414.329283535833, 643.8905386084353, 645.8062581225637, 811.6023148657159, 827.6358402302998, 827.6854795177824, 792.3700657976893, 799.4284086877881, 799.4324029938722, 803.8030682482771, 804.4650307545504, 822.7284995951352, 823.1932705948144, 824.2828738997051, 826.9875951860727, 836.4521238588703, 656.6257233376977, 664.1432552007903, 814.4583851738587, 816.4611356504679, 830.3523251863556, 601.4586871815358, 602.8914795336838, 603.1676286724336, 613.7575657615262, 616.0482055224644, 12369.752604947851, 12381.442835072443, 12407.44166512509, 12427.565035223724, 12436.253824770452, 10675.893241067646, 11262.887371126266, 11404.600838970679, 11485.712857178554, 11507.252028618197, 9411.388259763093, 9426.764330891714, 9679.467629280458, 9747.074027967332, 9764.414135151914, 3184.5830651237775, 3275.0666060172734, 3276.836158192081, 3281.639019707854, 3286.6220384655594, 40909.0, 41614.583854161676, 41654.37518437226, 41705.0, 41708.165836683096, 9113.45319280832, 9119.863202051974, 9151.862722059175, 9191.540422978958, 9314.115159059878, 15402.383904643913, 15404.845951540341, 15450.150241736588, 15472.690546189013, 15523.137223533022, 6156.753729850756, 6183.84540386485, 6201.627902325875, 6214.0, 6233.625982441068, 3371.174062354739, 3394.5077963695126, 3398.745094117951, 3424.70889974355, 3485.5294535237927, 2547.414094758216, 2579.329374362679, 2579.9484010320066, 2582.48350329931, 2585.0435338924717, 453.5260652618022, 467.93916790816974, 477.801712289396, 478.6147151542972, 480.79325889866993, 548.4570275427299, 577.7544543569051, 592.9652755940824, 611.2206936156437, 627.2159800249688, 7787.883181752279, 8391.580420978926, 8647.308215342757, 8778.60496277669, 9018.63925442988, 608.5344711295774, 618.8700372921647, 624.1044101714054, 632.7532262417661, 636.8662580858072, 3418.2821607462215, 3427.2288735034917, 3464.9653503465147, 3513.8594456221463, 3623.565172179355, 53532.0, 53706.462935370924, 53725.462745372046, 53814.46185538094, 53928.73035634875, 43808.12383752371, 44152.558474415484, 44318.556814432086, 45034.54965450303, 45115.32327015098, 41396.793016034724, 41607.79196104, 42014.78992605017, 42254.99999999938, 42280.15439691189, 8019.83960320802, 8118.59407029658, 8153.22544358285, 8395.580220989048, 8458.0, 31865.840670796497, 32183.67816321807, 32601.836990814892, 32861.50707739338, 32907.17732056718, 37960.0, 39363.0, 40517.98705032398, 40675.79662101671, 41087.589124109574, 9371.906280937103, 10007.249456290661, 10036.698899033041, 10143.898561014295, 10171.23715721309, 10533.841992369968, 10722.195835312226, 11366.715832103933, 11553.0, 11558.711032224262, 10102.343347682377, 10106.545205465918, 10118.848217276895, 11394.715132121763, 11420.543178272776, 10603.363798172135, 10618.73453163677, 10817.242793004414, 11039.0, 11368.261063030877, 10522.31604945676, 10621.946890265499, 10651.680449586525, 10770.838437423288, 10810.0, 9335.766605834908, 9344.626214951326, 9420.199283060743, 9473.47895865734, 9518.619255229713, 8722.825543489222, 8819.344241013909, 8856.468611883307, 9135.451872887648, 9241.0], "unit": "ms", "name": "yui.html", "value": 5774.763090171913}], "name": "dromaeo_css", "value": 6243.811660754812}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 113.0, 105.0, 111.0, 111.0, 110.0, 100.0, 110.0, 110.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 159.0, 169.0, 132.0, 157.0, 151.0, 129.0, 169.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 159.0, 162.0, 160.0, 159.0, 160.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 82.0, 93.0, 74.0, 72.0, 74.0, 99.0, 90.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [95.0, 103.0, 128.0, 94.0, 94.0, 95.0, 131.0, 94.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 71.0, 71.0, 70.0, 71.0, 81.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 69.0, 68.0, 68.0, 70.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 83.0, 85.0, 84.0, 86.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [128.0, 129.0, 122.0, 120.0, 125.0, 118.0, 121.0, 128.0, 122.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [132.0, 147.0, 143.0, 143.0, 135.0, 133.0, 150.0, 147.0, 143.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1508.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.5625539257981], "unit": "score", "name": "Richards", "value": 204.57509}, {"lowerIsBetter": false, "replicates": [185.39117538005192], "unit": "score", "name": "DeltaBlue", "value": 356.6404920000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [11823.529411764706], "unit": "score", "name": "Boyer", "value": 56.36751741293535}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [618.4291898577612], "unit": "score", "name": "Splay", "value": 131.77094700000006}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19774.602399833035}]} 05:56:53 INFO - RETURN: dromaeo_css: 6243.81 05:56:53 INFO - RETURN: kraken: 1508.50 05:56:53 INFO - RETURN: v8_7: 19774.60 05:56:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19774.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1508.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6243.81"}}} 05:56:53 INFO - Return code: 0 05:56:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:56:53 ERROR - # TBPL SUCCESS # 05:56:53 INFO - Running post-action listener: _resource_record_post_action 05:56:53 INFO - Running post-run listener: _resource_record_post_run 05:56:54 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 49152; Write bytes: 508272640; Read time: 492; Write time: 429456 05:56:54 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 12288; Write bytes: 231383040; Read time: 268; Write time: 289040 05:56:54 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 36864; Write bytes: 276889600; Read time: 224; Write time: 140416 05:56:54 INFO - Running post-run listener: _upload_blobber_files 05:56:54 INFO - Blob upload gear active. 05:56:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:56:54 INFO - Copying logs to upload dir... 05:56:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.424890 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-05 05:56:54.213890) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 05:56:54.217990) ========= 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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010088 build_url: 'https://queue.taskcluster.net/v1/task/4LAPVSYNS5m426DQYv3_pg/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-05 05:56:54.271117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:56:54.271645) ========= 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=820bb6602ddf640013a48df2000001a9-1449319268.487624-910801563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 05:56:54.322187) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 05:56:54.322565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 05:56:54.323025) ========= ========= Total master_lag: 0.22 =========