builder: elm_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1448963497.57 results: success (0) buildid: 20151201003341 builduid: 0978ab2e3fb641679adc1401ad43a8c4 revision: c2cd8d858ea2a9705694a2bc0d8049fa109e121a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.573489) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.574506) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.575054) ========= 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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.603548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.603908) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.636514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.636881) ========= 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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.701720) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.702012) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.702351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.702643) ========= 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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-01 01:51:37-- 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% 212M=0s 2015-12-01 01:51:37 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175473 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.891214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:37.891678) ========= 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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.141130 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:38.050812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:38.051167) ========= bash -c 'python archiver_client.py mozharness --repo projects/elm --rev c2cd8d858ea2a9705694a2bc0d8049fa109e121a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/elm --rev c2cd8d858ea2a9705694a2bc0d8049fa109e121a --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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-01 01:51:38,131 truncating revision to first 12 chars 2015-12-01 01:51:38,131 Setting DEBUG logging. 2015-12-01 01:51:38,131 attempt 1/10 2015-12-01 01:51:38,131 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/elm/c2cd8d858ea2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-01 01:51:38,366 unpacking tar archive at: elm-c2cd8d858ea2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513528 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:38.578064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:38.578491) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:38.588128) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:38.588625) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 01:51:38.589194) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 39 secs) (at 2015-12-01 01:51:38.589587) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Elm --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Elm 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', 'Elm', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Elm'] 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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:51:38 INFO - MultiFileLogger online at 20151201 01:51:38 in /builds/slave/test 01:51:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Elm --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Elm 01:51:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:51:38 INFO - {'append_to_log': False, 01:51:38 INFO - 'base_work_dir': '/builds/slave/test', 01:51:38 INFO - 'blob_upload_branch': 'Elm', 01:51:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:51:38 INFO - 'branch': 'Elm', 01:51:38 INFO - 'buildbot_json_path': 'buildprops.json', 01:51:38 INFO - 'config_files': ('talos/linux_config.py',), 01:51:38 INFO - 'default_actions': ('clobber', 01:51:38 INFO - 'read-buildbot-config', 01:51:38 INFO - 'download-and-extract', 01:51:38 INFO - 'populate-webroot', 01:51:38 INFO - 'create-virtualenv', 01:51:38 INFO - 'install', 01:51:38 INFO - 'run-tests'), 01:51:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:51:38 INFO - 'download_minidump_stackwalk': True, 01:51:38 INFO - 'download_symbols': 'ondemand', 01:51:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:51:38 INFO - 'tooltool.py': '/tools/tooltool.py', 01:51:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:51:38 INFO - '/tools/misc-python/virtualenv.py')}, 01:51:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:51:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:51:38 INFO - 'installer_path': 'installer.exe', 01:51:38 INFO - 'log_level': 'info', 01:51:38 INFO - 'log_name': 'talos', 01:51:38 INFO - 'log_to_console': True, 01:51:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:51:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:51:38 INFO - 'opt_config_files': (), 01:51:38 INFO - 'pip_index': False, 01:51:38 INFO - 'sps_profile': False, 01:51:38 INFO - 'sps_profile_interval': 0, 01:51:38 INFO - 'suite': 'dromaeojs', 01:51:38 INFO - 'system_bits': '64', 01:51:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:51:38 INFO - 'title': 'talos-linux64-ix-014', 01:51:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:51:38 INFO - 'use_talos_json': True, 01:51:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:51:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:51:38 INFO - 'work_dir': 'build'} 01:51:38 INFO - ##### 01:51:38 INFO - ##### Running clobber step. 01:51:38 INFO - ##### 01:51:38 INFO - Running pre-action listener: _resource_record_pre_action 01:51:38 INFO - Running main action method: clobber 01:51:38 INFO - rmtree: /builds/slave/test/build 01:51:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:51:39 INFO - Running post-action listener: _resource_record_post_action 01:51:39 INFO - ##### 01:51:39 INFO - ##### Running read-buildbot-config step. 01:51:39 INFO - ##### 01:51:39 INFO - Running pre-action listener: _resource_record_pre_action 01:51:39 INFO - Running main action method: read_buildbot_config 01:51:39 INFO - Using buildbot properties: 01:51:39 INFO - { 01:51:39 INFO - "properties": { 01:51:39 INFO - "buildnumber": 44, 01:51:39 INFO - "product": "firefox", 01:51:39 INFO - "script_repo_revision": "production", 01:51:39 INFO - "builddir": "elm_ubuntu64_hw_test-dromaeojs", 01:51:39 INFO - "repository": "", 01:51:39 INFO - "buildername": "Ubuntu HW 12.04 x64 elm talos dromaeojs", 01:51:39 INFO - "buildid": "20151201003341", 01:51:39 INFO - "slavename": "talos-linux64-ix-014", 01:51:39 INFO - "pgo_build": "False", 01:51:39 INFO - "basedir": "/builds/slave/test", 01:51:39 INFO - "project": "", 01:51:39 INFO - "platform": "ubuntu64_hw", 01:51:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:51:39 INFO - "slavebuilddir": "test", 01:51:39 INFO - "scheduler": "tests-elm-linux64-talos", 01:51:39 INFO - "branch": "elm", 01:51:39 INFO - "repo_path": "projects/elm", 01:51:39 INFO - "stage_platform": "linux64", 01:51:39 INFO - "builduid": "0978ab2e3fb641679adc1401ad43a8c4", 01:51:39 INFO - "revision": "c2cd8d858ea2a9705694a2bc0d8049fa109e121a" 01:51:39 INFO - }, 01:51:39 INFO - "sourcestamp": { 01:51:39 INFO - "repository": "", 01:51:39 INFO - "hasPatch": false, 01:51:39 INFO - "project": "", 01:51:39 INFO - "branch": "elm-linux64-talos", 01:51:39 INFO - "changes": [ 01:51:39 INFO - { 01:51:39 INFO - "category": null, 01:51:39 INFO - "files": [ 01:51:39 INFO - { 01:51:39 INFO - "url": null, 01:51:39 INFO - "name": "https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:51:39 INFO - } 01:51:39 INFO - ], 01:51:39 INFO - "repository": "", 01:51:39 INFO - "rev": "c2cd8d858ea2a9705694a2bc0d8049fa109e121a", 01:51:39 INFO - "who": "mh@glandium.org", 01:51:39 INFO - "when": 1448963467, 01:51:39 INFO - "number": 6725947, 01:51:39 INFO - "comments": "Merge m-c to elm. a=me", 01:51:39 INFO - "project": "", 01:51:39 INFO - "at": "Tue 01 Dec 2015 01:51:07", 01:51:39 INFO - "branch": "elm-linux64-talos", 01:51:39 INFO - "revlink": "", 01:51:39 INFO - "properties": [ 01:51:39 INFO - [ 01:51:39 INFO - "buildid", 01:51:39 INFO - "20151201003341", 01:51:39 INFO - "Change" 01:51:39 INFO - ], 01:51:39 INFO - [ 01:51:39 INFO - "builduid", 01:51:39 INFO - "0978ab2e3fb641679adc1401ad43a8c4", 01:51:39 INFO - "Change" 01:51:39 INFO - ], 01:51:39 INFO - [ 01:51:39 INFO - "pgo_build", 01:51:39 INFO - "False", 01:51:39 INFO - "Change" 01:51:39 INFO - ] 01:51:39 INFO - ], 01:51:39 INFO - "revision": "c2cd8d858ea2a9705694a2bc0d8049fa109e121a" 01:51:39 INFO - } 01:51:39 INFO - ], 01:51:39 INFO - "revision": "c2cd8d858ea2a9705694a2bc0d8049fa109e121a" 01:51:39 INFO - } 01:51:39 INFO - } 01:51:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:51:39 INFO - Running post-action listener: _resource_record_post_action 01:51:39 INFO - ##### 01:51:39 INFO - ##### Running download-and-extract step. 01:51:39 INFO - ##### 01:51:39 INFO - Running pre-action listener: _resource_record_pre_action 01:51:39 INFO - Running main action method: download_and_extract 01:51:39 INFO - mkdir: /builds/slave/test/build/tests 01:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:39 INFO - https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/test_packages.json 01:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/test_packages.json 01:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:51:40 INFO - Downloaded 1302 bytes. 01:51:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:51:40 INFO - Using the following test package requirements: 01:51:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:51:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:51:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:40 INFO - u'jsshell-linux-x86_64.zip'], 01:51:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:51:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:51:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:51:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:51:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:51:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:51:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:51:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:51:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:51: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')]} 01:51:40 INFO - https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:41 INFO - Downloaded 21516892 bytes. 01:51:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:51:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:51:42 INFO - Return code: 0 01:51:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:42 INFO - https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:44 INFO - Downloaded 21516892 bytes. 01:51:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:51:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:51:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:51:46 INFO - Return code: 0 01:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:46 INFO - https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:47 INFO - Downloaded 11131728 bytes. 01:51:47 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 01:51:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:51:47 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 01:51:47 INFO - Return code: 0 01:51:47 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')]} 01:51:47 INFO - https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3oPMh9yUTqqEkBhXqdeSPw/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 01:51:54 INFO - Downloaded 56864382 bytes. 01:51:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:51:54 INFO - mkdir: /builds/slave/test/properties 01:51:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:51:54 INFO - Writing to file /builds/slave/test/properties/build_url 01:51:54 INFO - Contents: 01:51:54 INFO - build_url:https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:51:54 INFO - Running post-action listener: _resource_record_post_action 01:51:54 INFO - Running post-action listener: set_extra_try_arguments 01:51:54 INFO - ##### 01:51:54 INFO - ##### Running populate-webroot step. 01:51:54 INFO - ##### 01:51:54 INFO - Running pre-action listener: _resource_record_pre_action 01:51:54 INFO - Running main action method: populate_webroot 01:51:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:51:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:51:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:51:54 INFO - '../fennec_ids.txt'], 01:51:54 INFO - 'tests': ['tcheck2']}, 01:51:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:51:54 INFO - '--tppagecycles', 01:51:54 INFO - '7'], 01:51:54 INFO - 'tests': ['tsvgm']}}, 01:51:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:51:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:51:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:51:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:51:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'tests': ['damp', 'tps']}, 01:51:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['damp', 'tps']}, 01:51:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:51:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:51:54 INFO - 'other': {'tests': ['a11yr', 01:51:54 INFO - 'ts_paint', 01:51:54 INFO - 'tpaint', 01:51:54 INFO - 'sessionrestore', 01:51:54 INFO - 'sessionrestore_no_auto_restore']}, 01:51:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['a11yr', 01:51:54 INFO - 'ts_paint', 01:51:54 INFO - 'tpaint', 01:51:54 INFO - 'sessionrestore', 01:51:54 INFO - 'sessionrestore_no_auto_restore']}, 01:51:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['a11yr', 01:51:54 INFO - 'ts_paint', 01:51:54 INFO - 'tpaint', 01:51:54 INFO - 'sessionrestore', 01:51:54 INFO - 'sessionrestore_no_auto_restore']}, 01:51:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['a11yr', 01:51:54 INFO - 'ts_paint', 01:51:54 INFO - 'tpaint', 01:51:54 INFO - 'sessionrestore', 01:51:54 INFO - 'sessionrestore_no_auto_restore']}, 01:51:54 INFO - 'other_l64': {'tests': ['a11yr', 01:51:54 INFO - 'ts_paint', 01:51:54 INFO - 'tpaint', 01:51:54 INFO - 'sessionrestore', 01:51:54 INFO - 'sessionrestore_no_auto_restore']}, 01:51:54 INFO - 'other_nol64': {'tests': ['a11yr', 01:51:54 INFO - 'ts_paint', 01:51:54 INFO - 'tpaint', 01:51:54 INFO - 'sessionrestore', 01:51:54 INFO - 'sessionrestore_no_auto_restore']}, 01:51:54 INFO - 'svgr': {'tests': ['tsvgx', 01:51:54 INFO - 'tsvgr_opacity', 01:51:54 INFO - 'tart', 01:51:54 INFO - 'tscrollx', 01:51:54 INFO - 'cart']}, 01:51:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['tsvgx', 01:51:54 INFO - 'tsvgr_opacity', 01:51:54 INFO - 'tart', 01:51:54 INFO - 'tscrollx', 01:51:54 INFO - 'cart']}, 01:51:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'tests': ['tp5o']}, 01:51:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'talos_options': ['--e10s'], 01:51:54 INFO - 'tests': ['tp5o']}, 01:51:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'talos_options': ['--xperf_path', 01:51:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:54 INFO - 'tests': ['tp5n']}, 01:51:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:54 INFO - 'talos_options': ['--e10s', 01:51:54 INFO - '--xperf_path', 01:51:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:54 INFO - 'tests': ['tp5n']}}, 01:51:54 INFO - 'talos.zip': {'path': '', 01:51:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:51:54 INFO - Running post-action listener: _resource_record_post_action 01:51:54 INFO - ##### 01:51:54 INFO - ##### Running create-virtualenv step. 01:51:54 INFO - ##### 01:51:54 INFO - Running pre-action listener: _resource_record_pre_action 01:51:54 INFO - Running main action method: create_virtualenv 01:51:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:51:54 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 01:51:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:51:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:51:54 INFO - Using real prefix '/usr' 01:51:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:51:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:51:57 INFO - Installing pip.................done. 01:51:57 INFO - Return code: 0 01:51:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:57 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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:51:57 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 01:51:57 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 01:51:57 INFO - Using env: {'DISPLAY': ':0', 01:51:57 INFO - 'HOME': '/home/cltbld', 01:51:57 INFO - 'LANG': 'en_US.UTF-8', 01:51:57 INFO - 'LANGUAGE': 'en_US:en', 01:51:57 INFO - 'LOGNAME': 'cltbld', 01:51:57 INFO - 'MAIL': '/var/mail/cltbld', 01:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:57 INFO - 'MOZ_NO_REMOTE': '1', 01:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:57 INFO - 'NO_EM_RESTART': '1', 01:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:57 INFO - 'PWD': '/builds/slave/test', 01:51:57 INFO - 'SHELL': '/bin/bash', 01:51:57 INFO - 'SHLVL': '1', 01:51:57 INFO - 'TERM': 'linux', 01:51:57 INFO - 'TMOUT': '86400', 01:51:57 INFO - 'USER': 'cltbld', 01:51:57 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:57 INFO - '_': '/tools/buildbot/bin/python'} 01:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:57 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 01:51:57 INFO - Cleaning up... 01:51:57 INFO - Return code: 0 01:51:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:57 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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:51:57 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 01:51:57 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 01:51:57 INFO - Using env: {'DISPLAY': ':0', 01:51:57 INFO - 'HOME': '/home/cltbld', 01:51:57 INFO - 'LANG': 'en_US.UTF-8', 01:51:57 INFO - 'LANGUAGE': 'en_US:en', 01:51:57 INFO - 'LOGNAME': 'cltbld', 01:51:57 INFO - 'MAIL': '/var/mail/cltbld', 01:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:57 INFO - 'MOZ_NO_REMOTE': '1', 01:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:57 INFO - 'NO_EM_RESTART': '1', 01:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:57 INFO - 'PWD': '/builds/slave/test', 01:51:57 INFO - 'SHELL': '/bin/bash', 01:51:57 INFO - 'SHLVL': '1', 01:51:57 INFO - 'TERM': 'linux', 01:51:57 INFO - 'TMOUT': '86400', 01:51:57 INFO - 'USER': 'cltbld', 01:51:57 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:57 INFO - '_': '/tools/buildbot/bin/python'} 01:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:57 INFO - Downloading/unpacking psutil>=0.7.1 01:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:51:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:51:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:59 INFO - Installing collected packages: psutil 01:51:59 INFO - Running setup.py install for psutil 01:51:59 INFO - building 'psutil._psutil_linux' extension 01:51:59 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 01:51:59 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 01:51:59 INFO - building 'psutil._psutil_posix' extension 01:51:59 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 01:51:59 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 01:51:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:59 INFO - Successfully installed psutil 01:51:59 INFO - Cleaning up... 01:52:00 INFO - Return code: 0 01:52:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:52:00 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')]} 01:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 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')]} 01:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:00 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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:52:00 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 01:52:00 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 01:52:00 INFO - Using env: {'DISPLAY': ':0', 01:52:00 INFO - 'HOME': '/home/cltbld', 01:52:00 INFO - 'LANG': 'en_US.UTF-8', 01:52:00 INFO - 'LANGUAGE': 'en_US:en', 01:52:00 INFO - 'LOGNAME': 'cltbld', 01:52:00 INFO - 'MAIL': '/var/mail/cltbld', 01:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:00 INFO - 'MOZ_NO_REMOTE': '1', 01:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:00 INFO - 'NO_EM_RESTART': '1', 01:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:00 INFO - 'PWD': '/builds/slave/test', 01:52:00 INFO - 'SHELL': '/bin/bash', 01:52:00 INFO - 'SHLVL': '1', 01:52:00 INFO - 'TERM': 'linux', 01:52:00 INFO - 'TMOUT': '86400', 01:52:00 INFO - 'USER': 'cltbld', 01:52:00 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:00 INFO - '_': '/tools/buildbot/bin/python'} 01:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:52:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:52:01 INFO - Installing collected packages: mozsystemmonitor 01:52:01 INFO - Running setup.py install for mozsystemmonitor 01:52:02 INFO - Successfully installed mozsystemmonitor 01:52:02 INFO - Cleaning up... 01:52:02 INFO - Return code: 0 01:52:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:52:02 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 01:52:02 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 01:52:02 INFO - Using env: {'DISPLAY': ':0', 01:52:02 INFO - 'HOME': '/home/cltbld', 01:52:02 INFO - 'LANG': 'en_US.UTF-8', 01:52:02 INFO - 'LANGUAGE': 'en_US:en', 01:52:02 INFO - 'LOGNAME': 'cltbld', 01:52:02 INFO - 'MAIL': '/var/mail/cltbld', 01:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:02 INFO - 'MOZ_NO_REMOTE': '1', 01:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:02 INFO - 'NO_EM_RESTART': '1', 01:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:02 INFO - 'PWD': '/builds/slave/test', 01:52:02 INFO - 'SHELL': '/bin/bash', 01:52:02 INFO - 'SHLVL': '1', 01:52:02 INFO - 'TERM': 'linux', 01:52:02 INFO - 'TMOUT': '86400', 01:52:02 INFO - 'USER': 'cltbld', 01:52:02 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:02 INFO - '_': '/tools/buildbot/bin/python'} 01:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:02 INFO - Downloading/unpacking blobuploader==1.2.4 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:03 INFO - Downloading blobuploader-1.2.4.tar.gz 01:52:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:52:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:52:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:04 INFO - Downloading docopt-0.6.1.tar.gz 01:52:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:52:04 INFO - Installing collected packages: blobuploader, requests, docopt 01:52:04 INFO - Running setup.py install for blobuploader 01:52:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:52:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:52:04 INFO - Running setup.py install for requests 01:52:05 INFO - Running setup.py install for docopt 01:52:05 INFO - Successfully installed blobuploader requests docopt 01:52:05 INFO - Cleaning up... 01:52:05 INFO - Return code: 0 01:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:05 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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:52:05 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 01:52:05 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 01:52:05 INFO - Using env: {'DISPLAY': ':0', 01:52:05 INFO - 'HOME': '/home/cltbld', 01:52:05 INFO - 'LANG': 'en_US.UTF-8', 01:52:05 INFO - 'LANGUAGE': 'en_US:en', 01:52:05 INFO - 'LOGNAME': 'cltbld', 01:52:05 INFO - 'MAIL': '/var/mail/cltbld', 01:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:05 INFO - 'MOZ_NO_REMOTE': '1', 01:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:05 INFO - 'NO_EM_RESTART': '1', 01:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:05 INFO - 'PWD': '/builds/slave/test', 01:52:05 INFO - 'SHELL': '/bin/bash', 01:52:05 INFO - 'SHLVL': '1', 01:52:05 INFO - 'TERM': 'linux', 01:52:05 INFO - 'TMOUT': '86400', 01:52:05 INFO - 'USER': 'cltbld', 01:52:05 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:05 INFO - '_': '/tools/buildbot/bin/python'} 01:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:52:05 INFO - Running setup.py (path:/tmp/pip-6DrQxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:52:05 INFO - Running setup.py (path:/tmp/pip-IlT4fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:52:05 INFO - Running setup.py (path:/tmp/pip-skbVeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:52:05 INFO - Running setup.py (path:/tmp/pip-rF88ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:52:05 INFO - Running setup.py (path:/tmp/pip-CaM1rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:52:05 INFO - Running setup.py (path:/tmp/pip-dyMoij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:52:05 INFO - Running setup.py (path:/tmp/pip-XmoTHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:52:06 INFO - Running setup.py (path:/tmp/pip-oljS8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:52:06 INFO - Running setup.py (path:/tmp/pip-UvGwXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:52:06 INFO - Running setup.py (path:/tmp/pip-rBM_pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:52:06 INFO - Running setup.py (path:/tmp/pip-7_4k6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:52:06 INFO - Running setup.py (path:/tmp/pip-oZSmrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:52:06 INFO - Running setup.py (path:/tmp/pip-AtfKpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:52:06 INFO - Running setup.py (path:/tmp/pip-45mrXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:06 INFO - Running setup.py (path:/tmp/pip-nQGjqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:06 INFO - Running setup.py (path:/tmp/pip-PJiCZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:06 INFO - Running setup.py (path:/tmp/pip-h4pIUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:52:06 INFO - Running setup.py install for manifestparser 01:52:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:52:06 INFO - Running setup.py install for mozcrash 01:52:06 INFO - Running setup.py install for mozdebug 01:52:07 INFO - Running setup.py install for mozdevice 01:52:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Running setup.py install for mozfile 01:52:07 INFO - Running setup.py install for mozhttpd 01:52:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Running setup.py install for mozinfo 01:52:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Running setup.py install for mozInstall 01:52:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Running setup.py install for mozleak 01:52:07 INFO - Running setup.py install for mozlog 01:52:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Running setup.py install for moznetwork 01:52:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:52:07 INFO - Running setup.py install for mozprocess 01:52:07 INFO - Running setup.py install for mozprofile 01:52:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:52:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:52:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:52:08 INFO - Running setup.py install for mozrunner 01:52:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:52:08 INFO - Running setup.py install for mozscreenshot 01:52:08 INFO - Running setup.py install for moztest 01:52:08 INFO - Running setup.py install for mozversion 01:52:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:52:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:52:08 INFO - Cleaning up... 01:52:08 INFO - Return code: 0 01:52:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 01:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 01:52:08 INFO - Using env: {'DISPLAY': ':0', 01:52:08 INFO - 'HOME': '/home/cltbld', 01:52:08 INFO - 'LANG': 'en_US.UTF-8', 01:52:08 INFO - 'LANGUAGE': 'en_US:en', 01:52:08 INFO - 'LOGNAME': 'cltbld', 01:52:08 INFO - 'MAIL': '/var/mail/cltbld', 01:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:08 INFO - 'MOZ_NO_REMOTE': '1', 01:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:08 INFO - 'NO_EM_RESTART': '1', 01:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:08 INFO - 'PWD': '/builds/slave/test', 01:52:08 INFO - 'SHELL': '/bin/bash', 01:52:08 INFO - 'SHLVL': '1', 01:52:08 INFO - 'TERM': 'linux', 01:52:08 INFO - 'TMOUT': '86400', 01:52:08 INFO - 'USER': 'cltbld', 01:52:08 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:08 INFO - '_': '/tools/buildbot/bin/python'} 01:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:52:08 INFO - Running setup.py (path:/tmp/pip-qczrV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:52:08 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)) 01:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:52:08 INFO - Running setup.py (path:/tmp/pip-INgAx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:52:08 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)) 01:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:52:08 INFO - Running setup.py (path:/tmp/pip-J24elj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:52:08 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)) 01:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:52:08 INFO - Running setup.py (path:/tmp/pip-dygBI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:52:09 INFO - Running setup.py (path:/tmp/pip-khWZeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:52:09 INFO - Running setup.py (path:/tmp/pip-4yCCvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:52:09 INFO - Running setup.py (path:/tmp/pip-Rhyf_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:52:09 INFO - Running setup.py (path:/tmp/pip-UfVSXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:52:09 INFO - Running setup.py (path:/tmp/pip-WknNdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:52:09 INFO - Running setup.py (path:/tmp/pip-bxfJZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:52:09 INFO - Running setup.py (path:/tmp/pip-8Htx01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:52:09 INFO - Running setup.py (path:/tmp/pip-CNisy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:52:09 INFO - Running setup.py (path:/tmp/pip-aTsPSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:52:09 INFO - Running setup.py (path:/tmp/pip-NZKc4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:09 INFO - Running setup.py (path:/tmp/pip-ldOw_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:09 INFO - Running setup.py (path:/tmp/pip-yTkYMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:09 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)) 01:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:09 INFO - Running setup.py (path:/tmp/pip-dgysVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:10 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)) 01:52:10 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)) 01:52:10 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)) 01:52:10 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)) 01:52:10 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)) 01:52:10 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)) 01:52:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:11 INFO - Downloading blessings-1.5.1.tar.gz 01:52:11 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 01:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:11 INFO - Installing collected packages: blessings 01:52:11 INFO - Running setup.py install for blessings 01:52:11 INFO - Successfully installed blessings 01:52:11 INFO - Cleaning up... 01:52:11 INFO - Return code: 0 01:52:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:12 INFO - Reading from file tmpfile_stdout 01:52:12 INFO - Current package versions: 01:52:12 INFO - argparse == 1.2.1 01:52:12 INFO - blessings == 1.5.1 01:52:12 INFO - blobuploader == 1.2.4 01:52:12 INFO - docopt == 0.6.1 01:52:12 INFO - manifestparser == 1.1 01:52:12 INFO - mozInstall == 1.12 01:52:12 INFO - mozcrash == 0.16 01:52:12 INFO - mozdebug == 0.1 01:52:12 INFO - mozdevice == 0.47 01:52:12 INFO - mozfile == 1.2 01:52:12 INFO - mozhttpd == 0.7 01:52:12 INFO - mozinfo == 0.9 01:52:12 INFO - mozleak == 0.1 01:52:12 INFO - mozlog == 3.1 01:52:12 INFO - moznetwork == 0.27 01:52:12 INFO - mozprocess == 0.22 01:52:12 INFO - mozprofile == 0.27 01:52:12 INFO - mozrunner == 6.11 01:52:12 INFO - mozscreenshot == 0.1 01:52:12 INFO - mozsystemmonitor == 0.0 01:52:12 INFO - moztest == 0.7 01:52:12 INFO - mozversion == 1.4 01:52:12 INFO - psutil == 3.1.1 01:52:12 INFO - requests == 1.2.3 01:52:12 INFO - wsgiref == 0.1.2 01:52:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:12 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')]} 01:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:12 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')]} 01:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:12 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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:52:12 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 01:52:12 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 01:52:12 INFO - Using env: {'DISPLAY': ':0', 01:52:12 INFO - 'HOME': '/home/cltbld', 01:52:12 INFO - 'LANG': 'en_US.UTF-8', 01:52:12 INFO - 'LANGUAGE': 'en_US:en', 01:52:12 INFO - 'LOGNAME': 'cltbld', 01:52:12 INFO - 'MAIL': '/var/mail/cltbld', 01:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:12 INFO - 'MOZ_NO_REMOTE': '1', 01:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:12 INFO - 'NO_EM_RESTART': '1', 01:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:12 INFO - 'PWD': '/builds/slave/test', 01:52:12 INFO - 'SHELL': '/bin/bash', 01:52:12 INFO - 'SHLVL': '1', 01:52:12 INFO - 'TERM': 'linux', 01:52:12 INFO - 'TMOUT': '86400', 01:52:12 INFO - 'USER': 'cltbld', 01:52:12 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:12 INFO - '_': '/tools/buildbot/bin/python'} 01:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 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)) 01:52:12 INFO - Cleaning up... 01:52:12 INFO - Return code: 0 01:52:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:52:12 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')]} 01:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:12 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')]} 01:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:12 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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:52:12 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 01:52:12 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 01:52:12 INFO - Using env: {'DISPLAY': ':0', 01:52:12 INFO - 'HOME': '/home/cltbld', 01:52:12 INFO - 'LANG': 'en_US.UTF-8', 01:52:12 INFO - 'LANGUAGE': 'en_US:en', 01:52:12 INFO - 'LOGNAME': 'cltbld', 01:52:12 INFO - 'MAIL': '/var/mail/cltbld', 01:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:12 INFO - 'MOZ_NO_REMOTE': '1', 01:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:12 INFO - 'NO_EM_RESTART': '1', 01:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:12 INFO - 'PWD': '/builds/slave/test', 01:52:12 INFO - 'SHELL': '/bin/bash', 01:52:12 INFO - 'SHLVL': '1', 01:52:12 INFO - 'TERM': 'linux', 01:52:12 INFO - 'TMOUT': '86400', 01:52:12 INFO - 'USER': 'cltbld', 01:52:12 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:12 INFO - '_': '/tools/buildbot/bin/python'} 01:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:12 INFO - Downloading/unpacking jsonschema 01:52:12 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 01:52:12 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 01:52:12 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 01:52:12 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 01:52:12 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 01:52:12 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 01:52:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:14 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 01:52:14 INFO - Downloading/unpacking functools32 (from jsonschema) 01:52:14 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 01:52:14 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 01:52:14 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 01:52:14 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 01:52:14 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 01:52:14 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 01:52:14 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:14 INFO - warning: no files found matching '*.txt' 01:52:14 INFO - no previously-included directories found matching 'build' 01:52:14 INFO - no previously-included directories found matching 'dist' 01:52:14 INFO - no previously-included directories found matching '.git*' 01:52:14 INFO - Installing collected packages: jsonschema, functools32 01:52:14 INFO - Running setup.py install for functools32 01:52:14 INFO - warning: no files found matching '*.txt' 01:52:14 INFO - no previously-included directories found matching 'build' 01:52:14 INFO - no previously-included directories found matching 'dist' 01:52:14 INFO - no previously-included directories found matching '.git*' 01:52:14 INFO - Successfully installed jsonschema functools32 01:52:14 INFO - Cleaning up... 01:52:14 INFO - Return code: 0 01:52:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:52:14 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')]} 01:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:14 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')]} 01:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:14 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 0x7f8654821f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, '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': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', '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 01:52:14 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 01:52:14 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 01:52:14 INFO - Using env: {'DISPLAY': ':0', 01:52:14 INFO - 'HOME': '/home/cltbld', 01:52:14 INFO - 'LANG': 'en_US.UTF-8', 01:52:14 INFO - 'LANGUAGE': 'en_US:en', 01:52:14 INFO - 'LOGNAME': 'cltbld', 01:52:14 INFO - 'MAIL': '/var/mail/cltbld', 01:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:14 INFO - 'MOZ_NO_REMOTE': '1', 01:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:14 INFO - 'NO_EM_RESTART': '1', 01:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:14 INFO - 'PWD': '/builds/slave/test', 01:52:14 INFO - 'SHELL': '/bin/bash', 01:52:14 INFO - 'SHLVL': '1', 01:52:14 INFO - 'TERM': 'linux', 01:52:14 INFO - 'TMOUT': '86400', 01:52:14 INFO - 'USER': 'cltbld', 01:52:14 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:14 INFO - '_': '/tools/buildbot/bin/python'} 01:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:14 INFO - Downloading/unpacking flake8 01:52:14 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 01:52:14 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 01:52:14 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 01:52:14 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 01:52:14 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 01:52:14 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 01:52:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:52:16 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 01:52:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:52:16 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 01:52:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:16 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 01:52:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:17 INFO - no previously-included directories found matching 'docs/_build' 01:52:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:52:17 INFO - Running setup.py install for pep8 01:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:17 INFO - no previously-included directories found matching 'docs/_build' 01:52:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:52:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:52:17 INFO - Cleaning up... 01:52:17 INFO - Return code: 0 01:52:17 INFO - Running post-action listener: _resource_record_post_action 01:52:17 INFO - Running post-action listener: _start_resource_monitoring 01:52:17 INFO - Starting resource monitoring. 01:52:17 INFO - ##### 01:52:17 INFO - ##### Running install step. 01:52:17 INFO - ##### 01:52:17 INFO - Running pre-action listener: _resource_record_pre_action 01:52:17 INFO - Running main action method: install 01:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:17 INFO - Reading from file tmpfile_stdout 01:52:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:52:17 INFO - Reading from file tmpfile_stdout 01:52:17 INFO - Output received: 01:52:17 INFO - Usage: mozinstall [options] installer 01:52:17 INFO - Options: 01:52:17 INFO - -h, --help show this help message and exit 01:52:17 INFO - -d DEST, --destination=DEST 01:52:17 INFO - Directory to install application into. [default: 01:52:17 INFO - "/builds/slave/test"] 01:52:17 INFO - --app=APP Application being installed. [default: firefox] 01:52:17 INFO - mkdir: /builds/slave/test/build/application 01:52:17 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'] 01:52:17 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 01:52:32 INFO - Reading from file tmpfile_stdout 01:52:32 INFO - Output received: 01:52:32 INFO - /builds/slave/test/build/application/firefox/firefox 01:52:32 INFO - Running post-action listener: _resource_record_post_action 01:52:32 INFO - ##### 01:52:32 INFO - ##### Running run-tests step. 01:52:32 INFO - ##### 01:52:32 INFO - Running pre-action listener: _resource_record_pre_action 01:52:32 INFO - Running main action method: run_tests 01:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:52:32 INFO - Python 2.7.3 01:52:32 INFO - Return code: 0 01:52:32 INFO - grabbing minidump binary from tooltool 01:52:32 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')]} 01:52:32 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 0x2b940b0>, '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 0x2b94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b95440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:52:32 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 01:52:32 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 01:52:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:52:32 INFO - Return code: 0 01:52:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:52:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:52:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:52:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:52:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:52:33 INFO - Return code: 0 01:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Elm', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 01:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Elm --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 01:52:33 INFO - Using env: {'DISPLAY': ':0', 01:52:33 INFO - 'HOME': '/home/cltbld', 01:52:33 INFO - 'LANG': 'en_US.UTF-8', 01:52:33 INFO - 'LANGUAGE': 'en_US:en', 01:52:33 INFO - 'LOGNAME': 'cltbld', 01:52:33 INFO - 'MAIL': '/var/mail/cltbld', 01:52:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:52:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:33 INFO - 'MOZ_NO_REMOTE': '1', 01:52:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:33 INFO - 'NO_EM_RESTART': '1', 01:52:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:33 INFO - 'PWD': '/builds/slave/test', 01:52:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:52:33 INFO - 'SHELL': '/bin/bash', 01:52:33 INFO - 'SHLVL': '1', 01:52:33 INFO - 'TERM': 'linux', 01:52:33 INFO - 'TMOUT': '86400', 01:52:33 INFO - 'USER': 'cltbld', 01:52:33 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448961238.737819-79228111', 01:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:33 INFO - '_': '/tools/buildbot/bin/python'} 01:52:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Elm', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 01:52:33 INFO - mozversion INFO | application_buildid: 20151201003341 01:52:33 INFO - mozversion INFO | application_changeset: c2cd8d858ea2a9705694a2bc0d8049fa109e121a 01:52:33 INFO - mozversion INFO | application_display_name: Nightly 01:52:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:52:33 INFO - mozversion INFO | application_name: Firefox 01:52:33 INFO - mozversion INFO | application_remotingname: firefox 01:52:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/elm 01:52:33 INFO - mozversion INFO | application_vendor: Mozilla 01:52:33 INFO - mozversion INFO | application_version: 45.0a1 01:52:33 INFO - mozversion INFO | platform_buildid: 20151201003341 01:52:33 INFO - mozversion INFO | platform_changeset: c2cd8d858ea2a9705694a2bc0d8049fa109e121a 01:52:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/elm 01:52:33 INFO - mozversion INFO | platform_version: 45.0a1 01:52:33 INFO - 2015-12-01 01:52:33,207 DEBUG : using testdate: 1448963553 01:52:33 INFO - 2015-12-01 01:52:33,207 DEBUG : actual date: 1448963553 01:52:33 INFO - 2015-12-01 01:52:33,219 INFO : starting webserver on 'localhost:50775' 01:52:33 INFO - 2015-12-01 01:52:33,219 INFO : Starting test suite talos-linux64-ix-014 01:52:33 INFO - 2015-12-01 01:52:33,220 INFO : Starting test dromaeo_css 01:52:33 INFO - 2015-12-01 01:52:33,220 DEBUG : operating with platform_type : linux_ 01:52:33 INFO - 2015-12-01 01:52:33,221 INFO : Initialising browser for dromaeo_css test... 01:52:33 INFO - 2015-12-01 01:52:33,233 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj_bo61/profile http://localhost:50775/getInfo.html 01:52:37 INFO - 2015-12-01 01:52:37,532 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:52:37 INFO - 2015-12-01 01:52:37,532 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:52:37 INFO - 2015-12-01 01:52:37,532 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:52:37 INFO - 2015-12-01 01:52:37,532 DEBUG : BROWSER_OUTPUT: __metrics 01:52:37 INFO - 2015-12-01 01:52:37,674 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] 01:52:39 INFO - 2015-12-01 01:52:39,142 INFO : Browser initialized. 01:52:39 INFO - 2015-12-01 01:52:39,143 INFO : Running cycle 1/1 for dromaeo_css test... 01:52:39 INFO - 2015-12-01 01:52:39,143 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj_bo61/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:52:50 INFO - 2015-12-01 01:52:50,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 137818112 01:52:50 INFO - 2015-12-01 01:52:50,970 DEBUG : BROWSER_OUTPUT: 01:53:42 INFO - 2015-12-01 01:53:42,121 DEBUG : BROWSER_OUTPUT: 1448963622116 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] 01:55:53 INFO - 2015-12-01 01:55:53,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50775/tests/dromaeo/cssquery-ext.html) 01:55:55 INFO - 2015-12-01 01:55:55,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 218746880 01:55:55 INFO - 2015-12-01 01:55:55,267 DEBUG : BROWSER_OUTPUT: 01:58:57 INFO - 2015-12-01 01:58:57,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/dromaeo/cssquery-ext.html (next: http://localhost:50775/tests/dromaeo/cssquery-jquery.html) 01:58:58 INFO - 2015-12-01 01:58:58,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 214999040 01:58:58 INFO - 2015-12-01 01:58:58,272 DEBUG : BROWSER_OUTPUT: 02:02:00 INFO - 2015-12-01 02:02:00,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50775/tests/dromaeo/cssquery-mootools.html) 02:02:00 INFO - 2015-12-01 02:02:00,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 209715200 02:02:00 INFO - 2015-12-01 02:02:00,914 DEBUG : BROWSER_OUTPUT: 02:05:02 INFO - 2015-12-01 02:05:02,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50775/tests/dromaeo/cssquery-prototype.html) 02:05:03 INFO - 2015-12-01 02:05:03,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 198053888 02:05:03 INFO - 2015-12-01 02:05:03,392 DEBUG : BROWSER_OUTPUT: 02:08:06 INFO - 2015-12-01 02:08:06,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50775/tests/dromaeo/cssquery-yui.html) 02:08:06 INFO - 2015-12-01 02:08:06,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 201424896 02:08:06 INFO - 2015-12-01 02:08:06,925 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/dromaeo/cssquery-yui.html (next: http://localhost:50775/tests/dromaeo/cssquery-dojo.html) 02:11:09 INFO - 2015-12-01 02:11:09,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 259461120 02:11:09 INFO - 2015-12-01 02:11:09,800 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,802 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:11:09 INFO - 2015-12-01 02:11:09,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:11:09 INFO - 2015-12-01 02:11:09,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:11:09 INFO - 2015-12-01 02:11:09,802 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:11:09 INFO - 2015-12-01 02:11:09,806 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2623.5146497897886;2691.4213444109514;2692.919212423627;2705.621213030176;2731.890724371026;4485.842995495158;4589.105124500724;4611.33135695324;4643.048175124104;4663.813447462102;4598.954010459895;4600.930986035212;4634.467036290827;4694.647901407399;4701.717896926187;4301.655867530606;4353.521112677603;4362.323839804835;4375.1031038637;4387.758673272985;4156.189543039109;4385.780710964439;4388.824447022132;4454.086912182995;4471.418715566988;4169.541350451448;4188.183304255656;4212.557681443435;4293.0769884474985;4300.569943005675;4324.070324880135;4354.7604881731495;4355.73865568067;4364.083542456088;4400.955990440087;4327.242732521796;4333.155034768221;4333.328334108218;4367.978160109179;4393.494748103977;4369.868903932887;4486.506484286726;4490.146872094324;4501.41481607389;4630.907381852344;5048.747562621891;5049.267856160873;5055;5056.873578160538;5058.988202359543;5081.441041485434;5087.9745601272125;5114.130597798383;5117.181250999859;5121.436641969381;4578.313253012042;4650.651201159926;4700.55344742249;4710.858674239778;4727.716337019755;5167.431582525919;5170.508801663836;5177.844664660066;5217.7912883485;5228.08508511009;4962.6774259673;4964.925526117111;4978.751062446863;4989.925151122736;5008.1486147355035;4726.834560790356;4814.061258054646;4820.3492528508905;4835.347228124228;5031.748412579356;4829.782659780319;4934.5805606523845;4956.058348913695;4966.354373931365;4987.426445958761;4941.085899108676;4974.950250497521;4975.925361119586;4978.253262010728;5017.9247311290355;3748.381517049711;3857.8456861725217;3887.96112038876;3894.90262743428;3927.56796752357;3425.6403077676982;3427.605825330069;3466.2547552276383;3490.406630872758;3515.595706493786;4342.609165175149;4356.956430435718;4358.564143585616;4362.781860906942;4398.56014398564;4787.904241915142;5055.443901170868;5072.442031376546;5075.416327122428;5077.136886729265;4236.597523235288;4266.466691663542;4282.464691913511;4289.528151903288;4308.698391112592;4505.504394516601;4517.661175411858;4523.819047238139;4545.6136228420955;4557.977210113928;4820.493848145964;4820.638452116105;4822.903541929212;4829.323894654822;4869.147899117711;4814.518548145157;4944.604431645388;4944.802207911644;4958.950410495849;5072.163093089599;4852.636052296021;4853.514648535118;4856.587190088882;4860.198067318995;4896.069746748249;5023.773930173078;5024.42219144803;5029.044481548494;5033.119204139334;5034.496550345083;4805.543473370164;4866.48901865299;4914.533119353656;4919.114559379346;5137.717425541481;4712.128256272601;4762.214234651382;4764.475907650087;4867.245576935581;4990.176620857663;4877.6829506081995;4884.90230195387;4886.584640305614;4889.217725163957;4929.038837426668;4794.5924596409695;4797.712137271775;4798.088363210979;4799.616030717604;4826.517348265286;4675.345451636706;4759.833405830779;4779.211430113992;4779.354787103696;4846.418429788448;4783.832565860178;4801.399825021872;4806.303086052433;4821.63837712166;4868.61051115917 02:11:09 INFO - 2015-12-01 02:11:09,806 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.8474169603359;557.409146304917;566.2412367427647;567.7991048931511;574.5949105880355;28027.299317517045;28389.29026774329;28510.572341414896;35581.64418355816;36306.63693363065;40498;41028.79485602568;41039.58960410395;41097.7945110274;41157;7900.683972641087;8079.838403231932;8082.353411727077;8084.3936704747375;8085.3531717462465;7110.360067593915;7309.926900731004;9698.272629552777;9901.257405694565;9905.75235619108;9719;9823.70528884131;9824.36141650794;9831.754206144831;9834.31159818813;7127.750528731522;7335.88996165058;9280.582373793162;9305.813883722356;9354.84838487145;9617.134457898752;9853.802923941552;9857.753556161082;9859.852102218472;9870.062344077302;33094.83452582746;33398;33437.498437523456;33504.832475837466;33514;2756.4487102579365;2768.820026698258;2781.193453898367;3383.8477268522975;3540.567976429231;27742;27818.165455036382;28131.71868281332;29191.56212656812;30669.38661226763;3298.8515516801804;3307.355065762177;3340.599128104643;3346.3474622448634;3371.3257348530146;213280;214134;214230;214234;215224;52431;53684.73157634187;57044;57555.13667294994;57560.424395756345;67528.6623566879;68904.31095688979;69195.65402173057;69239;69254.65372673105;13944.51194208198;14352.273068117025;14362.353694083582;14372.568822935329;14378.784318235235;10523.421211833269;10557.049865512141;10562.577496900038;10646.361218326925;10684.732881678021;19691.03089691048;20010.69983950242;20019.899900500695;20100;20109.19563217455;7494.812629684301;7679.500832445873;7801.815491662343;7837.568933708701;7872.921270787218;867.7136544940155;868.769776009358;910.7085732565515;934.8737920380662;958.942463452195;25494.872525637253;25662;25770.133380863277;25925.22224333273;25988;951.1012093571646;951.9095685909828;1008.0725732326277;1040.3705758016442;1124.100719424457;13737.931310343385;13832.446702132003;13837.377318020714;14028.438862445388;14030.929845350913;307702;314115;314298;315909;316015;47101.29348059782;47387;47395;47421;47461.525384746405;1199.6760874563993;1215.070471089617;1215.8966487848454;1216.6593353860933;1220.9877901220875;25015;25734.871325643253;26023.73976260289;26052.73947260503;26066.86966565155;35655.465168023016;38610.613893861824;39300.21399571935;39308.213835722556;39429.605703942594;162828;232793;238332;239102;239494;27499.31251718723;28148.21480348387;28176.43647127087;28187.859060704566;28204.71795282021;35333.823330883184;36472.452913205794;36839.81580092083;36840.63159368372;36856.07859803527;33282.83358583192;33409.331813364086;34078.318433631684;34238.657613423544;34394.48408273828;33960.15099622529;38497.2300553993;40348.394774079;40679.7966010168;42146.57853421549;34639;35752;37738.811305943294;37758.62241377551;37769.81115094517;36323;37449;37467;37887;37949.241015180094;28720.42559148847;29627.259318517208;29710.702892970792;32772.672273277916;32890.50664240086 02:11:09 INFO - 2015-12-01 02:11:09,810 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.1346053462324;324.2251020062051;324.38367102505254;327.1510430433026;331.2662452667343;11995.880041199585;12353.938230308835;14971;15293.082415055105;15352;11870.643880683572;14520.128792272471;14524.419023239057;14817;14821.555353339418;4770.332153498513;4773.427188737356;4917.606591472673;4922.4585295617635;4922.70463772173;3288.753343499235;3385.5091011803274;4973.875653108665;5009.02324046811;5035.672681275723;5159.587233021368;5192.428832828386;5203.661761985478;5216.8174113906025;5217.5565076968505;5088.847334579968;5175.689458632494;5188.06614809336;5236.476352364733;5243.79024839006;4976.477469865648;5039.395272567279;5041.672291301091;5049.2426136079885;5051.595872330205;10388.532516036796;13511.932440337736;18186;18595;18596.349127780464;1684.6714890596338;1689.0878925380403;1756.1307152959366;1794.676958147533;1812.619349936515;8729.083446238117;8965.148310910454;8980.46117232968;9306.813863722755;13024.153430027018;1535.6775077233683;1624.3827345608593;1730.7317365808194;1755.10489650278;1767.9911600442044;53153;57706.711466442815;57824;58071.709641451525;58813;9176.632934682671;9317.999999999864;9373;9464.905350946403;9471.289653276031;11679.299242045334;11701.473433695504;11720.765584688259;11761.764764704829;11799.115066370057;6839.62382068991;6887.5178737488895;6894.655267236618;6953.617551034742;7018.157821061403;6644.634370382123;6948.5483443576;7049.647517624098;7089.645517724093;7101.005859179719;4081.1225586499045;4164.7917604119675;4169.437125988014;4183.790810459464;4239.936400953989;1620.5462470508276;1637.148682684997;1645.407653244831;1666.9583260418588;1708.2910592104138;849.5072857742495;854.811941372897;878.4246318661287;918.912703293186;938.5030875753163;15685.529434116996;15809.841901580838;16059.87580869328;16200.270987805578;16286.837131628768;751.4927423988786;845.3026253341018;885.349268287808;917.3624331089828;934.4346670264528;8628;8765.342599305077;8896.191187453323;8940.50827204497;9071.818563628822;493572;495904;514786;520891;533193;69314.65342673255;71060.64469677722;72298.55402892017;72817.6359118201;73237.63381183166;1021.2697920986382;1032.0453580438066;1032.055669062799;1032.26193271811;1063.2132222155549;14328.355224015153;14383.568492945229;14396.68099570104;14493.347799349265;14724.926375368483;31282.68717312798;32205.35589288248;32276;32426.027219183463;32894.50658240176;40536.18927621372;43007;43044;43270;45649.97850236405;8323.209295116954;8584.527850968258;8632.05047444768;8717.52053637056;8733.039365669643;10214.693559193236;11456;16389.672206555562;16517.504474865775;16666.333346665997;13258.602241932758;13751.106178098391;14008.229547374993;14077.225752583297;14188;12773.10588258813;12916.741665166832;13545.1195672281;13834.446622135001;13871.722565548835;10911.78176436451;13716.65708357299;14017.158970461805;14041.5085472008;14238.430462781373;8055.677772889018;8267.503949763033;8340.916590834015;8360.958195209229;8381.706640267561;8917.242034427147;8956;12754.42605082755;13183.274919879499;13545.59363219105 02:11:09 INFO - 2015-12-01 02:11:09,811 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1305.1060023883638;1353.6209861238854;1379.6068120585635;1439.9496017639378;1697.5077227603988;5435.456454354563;6566.212054553454;6745;6750.054992301082;6766.188057433109;6728.293529179439;6889;6889.552179108355;6898.275681053492;6905.171379434462;2030.2792508659472;2060.701198326242;2064.905600031978;2064.9793502065013;2065.607534568435;2038.0828627117783;2055.917763289474;2062.3400511836144;2079.5321052763156;2082.822960048398;1963.4011626453926;2006.7692215395198;2020.171729590868;2026.9797302026939;2036.0735865181382;1967.4982879365814;2002.2791794953805;2002.8798272103575;2004.6291436084298;2005.5988802239538;1974.1708482437411;2012.4264584593468;2012.6377252094617;2014.7280117184287;2016.3547664747286;5711.543076553866;5849.093390524476;6791.456683465311;6864.141982252218;6883.208431030445;3830.2339532093415;3925.3326934421216;3943.7239393242485;3945.309570825094;3957.881263562098;2639.8944042238286;2640.4323070539735;2681.9865900670566;2688.865556722176;2718.7281271872853;880.6785523284019;887.5917078144062;904.281096528255;923.3628796130715;934.5047125023748;9080.318976076755;9147.679831205876;9148;9159.496227707474;9172.128647778518;3707.981460092736;3733.9626603733614;3785.37541305687;3787.7727336359358;3795.35478968576;8037.316828069563;8055.5972201389695;8064.274215320649;8067.314278286294;8067.596620168968;3929.135590170158;3943.38877473992;3979.7413168143976;3982.024404021033;3987.521497420328;3578.928421431609;3581.982090089585;3596.9100772480897;3609.368360536948;3626.0390996385977;3157.6526582075953;3160.115167753033;3171.6828317168097;3186.314942287373;3196.168996061041;982.111189373618;983.8475036369374;985.9499632890949;986.8717066781272;987.1855719031828;1166.3934753928079;1179.2334982261427;1180.8228765685044;1189.8631657359342;1193.8746431624727;6262.718177682015;6386.201724784402;6449.677516124175;6474.223093228748;6487.54587178893;1011.9443430611387;1023.4268809466722;1028.5268776362807;1033.5762337441613;1054.7040498442368;4479.820807167742;5230.843074707765;5271.393789714232;5271.71005594696;5274.683518988873;7034.155901291775;8086.676532938734;8105.392095592854;8110.83778324442;8138.064122625974;7939.087004994384;7950.443468957117;8029.397795165386;8043.11525732169;8044.074931382849;6299.307076221612;6475.190601174853;6480.546361754632;6492.156019717407;6549.803505894926;6285.937140628535;6302.401271879165;6309.842253943688;6337.366263373626;6378.45783108441;7116.430685545248;7344.926550734638;7349.412047036331;7350.338469537767;7352.0442342495135;7347.08161479815;7495.587742674205;7497.700091996259;7551.848963020819;7588.772336829904;5655.632383895034;5678.545716342765;5727.599068065362;5740.3685594585395;5768.307803063659;6018.157457955802;6069;6072.332043475126;6102.359252278625;6108.847278818065;5929;5972.58191926561;5993.430624090704;6056.545759068;6101.511879049576;5787.276590426197;5820.796272130455;5858.326292476419;5907.438793314628;5994.910076348945;5693.629914055573;6052.061930400795;6072.787452439144;6093.878122437615;6107.694615269308;5705.885882282248;5731.054376027909;5733.39799321082;5738.483536481736;5745.91381129275;5696.8006119785605;5716.714164291686;5723.513501352431;5726.255586773859;5734.168545560954 02:11:09 INFO - 2015-12-01 02:11:09,813 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.97080291970804;292.0493792704746;298.6401386329473;306.2359413263907;307.9430305393501;5245.44922783108;5305.522502974727;5326.6005049621335;5326.866828329289;5433.049216387131;5190.091733946554;5314.9468505314935;5345.7594408251625;5351.678899266037;5352.116900711388;4132.504099508048;4132.5122955735915;4132.834686612532;4134.152498737752;4139.710220284582;3879.7478163919395;3974.940375894364;3995.220931918277;4083.4079058536495;4098.077932465201;4044.9797751011206;4054.736442131252;4064.4309796628495;4065.6340929316357;4068.65416439603;4051.9797401012806;4059.451973983504;4059.776712280838;4060.045889216032;4073.083556199861;3568.660977207161;3570.428731402963;3571.39286321326;3571.4464258040043;3579.6599323064265;5006.724630145341;5154.4072431670465;5159.922601160985;5170.870728231786;5206.869828254286;4683.461401938753;4687.7656117194;4702.788374523155;4713.717176969359;4717.103750287434;5649.350324712628;5652.9152062719095;5653.802116925929;5658.8302350929125;5670.858228544319;3619.5113659656135;3712.1276500022473;3771.73597848148;3895.668868146211;3902.5316961964463;5854.443827836349;5900;5914.556408269354;5920.200772895647;5920.585559010871;4003.6396724294373;4010;4012.4382586437923;4020.336644453691;4021.1756589899;4063.349864021742;4069.8168582413864;4072.3077076897;4078.1435898461655;4086.203190377907;4517.751523666164;4672.859814205579;4688.929666055012;4699.224627936353;4702.764861756967;5662.150677398423;5665.291838520185;5670.5463562914865;5676.120201368794;5677.205191273142;1429.349645911108;1440.9639759006109;1443.3577058208996;1443.538067818288;1448.0008793932152;960.6781728121018;967.4582233949011;973.5181085362649;987.3286165407449;989.6338354808767;4973.925391119136;4996.7501624918605;4996.850094497171;5011.323471331397;5012.749362531858;5854.677992710356;5858.912116318259;5859.912101318484;5864.354920958691;5872.354041055481;4979.950200498021;4984.102861484895;4984.177610694195;4992.575631071327;5004.274380214922;3069.079276217126;3127.5465057566526;3155.4635711929027;3157.2106973256687;3160.8419579020956;5583.3858275589655;5588.050031494656;5601.187827764951;5640.153976903497;5642.04085305499;6095.878082438327;6099.4815440688035;6101.603395779349;6106.6336019838955;6110.908336374958;5618.4662457066515;5624.156376543551;5627.43725627434;5630.887382252332;5632.52123569493;5713.200151978644;5916.290045194432;5918;5922.6446413213625;5926.67403292823;5556.611037227355;5632.127020311858;5702.37273899879;5751.712414379181;5791.391903850204;5572.192032155233;5585.776568937197;5607.327120745536;5610.354809196831;5620.381758006698;3957.821898014539;3960.2475529649273;3968.9007774804704;3996.420519024783;4005.058811179312;5714.657120572779;5841.620294680833;5852.619579727304;5853.03424934881;5855.3559108497175;5710.428957104256;5714.314282286152;5721;5722.113072473773;5722.513586345207;5709.286339207599;5711.086226203787;5713.800016999385;5716.571257155647;5721.370649228665;5527.778888844401;5584.329880414376;5591.161325801162;5592.916106258491;5596.580256480862;5511.696856672921;5645.830625081254;5718.771249149988;5720.74256658443;5723.627964182315;5562.916556251578;5574.498295153456;5576.219329293983;5577.832665020056;5579.358373786904 02:11:09 INFO - 2015-12-01 02:11:09,816 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.63106213927;675.8242856857215;687.8246047257954;705.9804787957622;779.3258831111089;11247.381394023325;11485.966263036325;11487.42562871855;11494.252873563213;11509.827352589718;11990.460429280682;12103.75792484152;13507.12203706761;13900.096493727926;13932.930335348334;618.6628287583278;626.8871603111438;798.1459837973371;813.1380736419385;815.7960509872532;618.638096713421;794.4081659163902;805.2511164616903;809.2676128104075;810.1776696652902;782.1083964280724;830.4062595244399;844.3414136973171;845.2561745663808;845.446232717571;630.0989584893623;637.4581605635173;837.2966707965278;841.1168273313027;841.2638940926689;612.1124369663961;615.7690865925279;616.134331264574;616.2081724983375;616.4390404731672;11891.821622675667;12094;12100.092493062968;12111.757764844653;12118.151729378947;11594;12055.397230138458;12145.332006739625;12337.62987110379;12343;8926.955365223197;9013.729588112366;9070.138336857988;9186.173244408035;9381.859272110856;3288.2930170013324;3311.1887587540964;3324.069260607034;3347.7656564040526;3351.865925363007;41957.370639440735;42895.1420971582;43025.35461968073;43077.784611077055;43101;9609.375390599589;9645.08371704687;9792.167665748491;9819.705408837746;9918.900810991941;16553.917230413772;16751.581210469834;16768.161591920354;17435;17452.389166379115;6435.967820160869;6496.350364963466;6496.610203387811;6549.8362540935905;6598.802035938929;3592.150042727997;3597.784132952031;3602.189507360823;3722.5346831646043;3801.2777572261184;2823.6752773431317;2839.687634360219;2873.281679580105;2879.755220806213;2889.6821349651523;474.0660898030874;482.2284345047895;487.8560824556764;489.88487705389207;493.42515968895833;554.5840619535348;606.4753987800609;618.6875627807929;624.3818619566597;636.2174525333866;7616.771496855104;7717.807054823675;8006.839863202703;8048.476849004796;8074;568.8094488346368;585.5637550025174;593.9910901336483;597.5010865927;612.552836429409;3426.5202871597994;3645.0887278180453;3691.5570131583845;3728.55257369112;3737.588865224823;53049.73475132677;53792.19311710328;53903;53992.460075399526;54030.729846350514;44748.3287750684;45458;47022.29466558004;47545;47662.04675906462;41260.79369603133;42050.57949420466;42093.15813683648;42518.93702657458;42952.78523607425;7869.960650196713;7964.561949092624;8104.635291411782;8462.111478294937;8489.872651910102;31194.22014449657;31772.68227317697;32209.51685724669;32236.516452252767;32642.673573264914;38531.2293754129;39552;39862.60137398705;39990.40014399844;40915.59084409237;9700.320977531788;9859.507024648596;10084.532694553784;10151.137153342048;10275.434851083262;11135.220534562503;11318.377489237842;11408.486618102039;11630.825537616773;12007.459664315302;10514.894851051391;10638.202134840072;10877;10879.347239165676;11252.437378130897;10488.895111048792;10603.575856965635;10865.185111116856;10972.725681858017;11211.103111750877;10435.895641043493;10698.251122421356;10761.677149685522;10842.512086956263;10875.782484350428;8631.956840215758;9070.591823368097;9149.359544831797;9330.066993300616;9464.668736594185;8953.776155595902;9187;9694.418334899929;9708.22334213247;9729.756756081155 02:11:09 INFO - 2015-12-01 02:11:09,816 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:11:09 INFO - 2015-12-01 02:11:09,816 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:11:09 INFO - 2015-12-01 02:11:09,816 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1083 02:11:09 INFO - 2015-12-01 02:11:09,816 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: __startTimestamp1448964669801__endTimestamp 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4608.43 Median:4779.35 stddev:504.91 (10.6%) stddev-sans-first:481.85 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: Values: 2623.5 2691.4 2692.9 2705.6 2731.9 4485.8 4589.1 4611.3 4643.0 4663.8 4599.0 4600.9 4634.5 4694.6 4701.7 4301.7 4353.5 4362.3 4375.1 4387.8 4156.2 4385.8 4388.8 4454.1 4471.4 4169.5 4188.2 4212.6 4293.1 4300.6 4324.1 4354.8 4355.7 4364.1 4401.0 4327.2 4333.2 4333.3 4368.0 4393.5 4369.9 4486.5 4490.1 4501.4 4630.9 5048.7 5049.3 5055.0 5056.9 5059.0 5081.4 5088.0 5114.1 5117.2 5121.4 4578.3 4650.7 4700.6 4710.9 4727.7 5167.4 5170.5 5177.8 5217.8 5228.1 4962.7 4964.9 4978.8 4989.9 5008.1 4726.8 4814.1 4820.3 4835.3 5031.7 4829.8 4934.6 4956.1 4966.4 4987.4 4941.1 4975.0 4975.9 4978.3 5017.9 3748.4 3857.8 3888.0 3894.9 3927.6 3425.6 3427.6 3466.3 3490.4 3515.6 4342.6 4357.0 4358.6 4362.8 4398.6 4787.9 5055.4 5072.4 5075.4 5077.1 4236.6 4266.5 4282.5 4289.5 4308.7 4505.5 4517.7 4523.8 4545.6 4558.0 4820.5 4820.6 4822.9 4829.3 4869.1 4814.5 4944.6 4944.8 4959.0 5072.2 4852.6 4853.5 4856.6 4860.2 4896.1 5023.8 5024.4 5029.0 5033.1 5034.5 4805.5 4866.5 4914.5 4919.1 5137.7 4712.1 4762.2 4764.5 4867.2 4990.2 4877.7 4884.9 4886.6 4889.2 4929.0 4794.6 4797.7 4798.1 4799.6 4826.5 4675.3 4759.8 4779.2 4779.4 4846.4 4783.8 4801.4 4806.3 4821.6 4868.6 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41958.92 Median:34516.74 stddev:66578.42 (192.9%) stddev-sans-first:66692.60 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: Values: 554.8 557.4 566.2 567.8 574.6 28027.3 28389.3 28510.6 35581.6 36306.6 40498.0 41028.8 41039.6 41097.8 41157.0 7900.7 8079.8 8082.4 8084.4 8085.4 7110.4 7309.9 9698.3 9901.3 9905.8 9719.0 9823.7 9824.4 9831.8 9834.3 7127.8 7335.9 9280.6 9305.8 9354.8 9617.1 9853.8 9857.8 9859.9 9870.1 33094.8 33398.0 33437.5 33504.8 33514.0 2756.4 2768.8 2781.2 3383.8 3540.6 27742.0 27818.2 28131.7 29191.6 30669.4 3298.9 3307.4 3340.6 3346.3 3371.3 213280.0 214134.0 214230.0 214234.0 215224.0 52431.0 53684.7 57044.0 57555.1 57560.4 67528.7 68904.3 69195.7 69239.0 69254.7 13944.5 14352.3 14362.4 14372.6 14378.8 10523.4 10557.0 10562.6 10646.4 10684.7 19691.0 20010.7 20019.9 20100.0 20109.2 7494.8 7679.5 7801.8 7837.6 7872.9 867.7 868.8 910.7 934.9 958.9 25494.9 25662.0 25770.1 25925.2 25988.0 951.1 951.9 1008.1 1040.4 1124.1 13737.9 13832.4 13837.4 14028.4 14030.9 307702.0 314115.0 314298.0 315909.0 316015.0 47101.3 47387.0 47395.0 47421.0 47461.5 1199.7 1215.1 1215.9 1216.7 1221.0 25015.0 25734.9 26023.7 26052.7 26066.9 35655.5 38610.6 39300.2 39308.2 39429.6 162828.0 232793.0 238332.0 239102.0 239494.0 27499.3 28148.2 28176.4 28187.9 28204.7 35333.8 36472.5 36839.8 36840.6 36856.1 33282.8 33409.3 34078.3 34238.7 34394.5 33960.2 38497.2 40348.4 40679.8 42146.6 34639.0 35752.0 37738.8 37758.6 37769.8 36323.0 37449.0 37467.0 37887.0 37949.2 28720.4 29627.3 29710.7 32772.7 32890.5 02:11:09 INFO - 2015-12-01 02:11:09,817 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26781.59 Median:4211.86 stddev:83623.18 (1985.4%) stddev-sans-first:83834.16 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: Values: 324.1 324.2 324.4 327.2 331.3 11995.9 12353.9 14971.0 15293.1 15352.0 11870.6 14520.1 14524.4 14817.0 14821.6 4770.3 4773.4 4917.6 4922.5 4922.7 3288.8 3385.5 4973.9 5009.0 5035.7 5159.6 5192.4 5203.7 5216.8 5217.6 5088.8 5175.7 5188.1 5236.5 5243.8 4976.5 5039.4 5041.7 5049.2 5051.6 10388.5 13511.9 18186.0 18595.0 18596.3 1684.7 1689.1 1756.1 1794.7 1812.6 8729.1 8965.1 8980.5 9306.8 13024.2 1535.7 1624.4 1730.7 1755.1 1768.0 53153.0 57706.7 57824.0 58071.7 58813.0 9176.6 9318.0 9373.0 9464.9 9471.3 11679.3 11701.5 11720.8 11761.8 11799.1 6839.6 6887.5 6894.7 6953.6 7018.2 6644.6 6948.5 7049.6 7089.6 7101.0 4081.1 4164.8 4169.4 4183.8 4239.9 1620.5 1637.1 1645.4 1667.0 1708.3 849.5 854.8 878.4 918.9 938.5 15685.5 15809.8 16059.9 16200.3 16286.8 751.5 845.3 885.3 917.4 934.4 8628.0 8765.3 8896.2 8940.5 9071.8 493572.0 495904.0 514786.0 520891.0 533193.0 69314.7 71060.6 72298.6 72817.6 73237.6 1021.3 1032.0 1032.1 1032.3 1063.2 14328.4 14383.6 14396.7 14493.3 14724.9 31282.7 32205.4 32276.0 32426.0 32894.5 40536.2 43007.0 43044.0 43270.0 45650.0 8323.2 8584.5 8632.1 8717.5 8733.0 10214.7 11456.0 16389.7 16517.5 16666.3 13258.6 13751.1 14008.2 14077.2 14188.0 12773.1 12916.7 13545.1 13834.4 13871.7 10911.8 13716.7 14017.2 14041.5 14238.4 8055.7 8267.5 8340.9 8361.0 8381.7 8917.2 8956.0 12754.4 13183.3 13545.6 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4717.33 Median:5743.14 stddev:2404.97 (41.9%) stddev-sans-first:2398.04 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: Values: 1305.1 1353.6 1379.6 1439.9 1697.5 5435.5 6566.2 6745.0 6750.1 6766.2 6728.3 6889.0 6889.6 6898.3 6905.2 2030.3 2060.7 2064.9 2065.0 2065.6 2038.1 2055.9 2062.3 2079.5 2082.8 1963.4 2006.8 2020.2 2027.0 2036.1 1967.5 2002.3 2002.9 2004.6 2005.6 1974.2 2012.4 2012.6 2014.7 2016.4 5711.5 5849.1 6791.5 6864.1 6883.2 3830.2 3925.3 3943.7 3945.3 3957.9 2639.9 2640.4 2682.0 2688.9 2718.7 880.7 887.6 904.3 923.4 934.5 9080.3 9147.7 9148.0 9159.5 9172.1 3708.0 3734.0 3785.4 3787.8 3795.4 8037.3 8055.6 8064.3 8067.3 8067.6 3929.1 3943.4 3979.7 3982.0 3987.5 3578.9 3582.0 3596.9 3609.4 3626.0 3157.7 3160.1 3171.7 3186.3 3196.2 982.1 983.8 985.9 986.9 987.2 1166.4 1179.2 1180.8 1189.9 1193.9 6262.7 6386.2 6449.7 6474.2 6487.5 1011.9 1023.4 1028.5 1033.6 1054.7 4479.8 5230.8 5271.4 5271.7 5274.7 7034.2 8086.7 8105.4 8110.8 8138.1 7939.1 7950.4 8029.4 8043.1 8044.1 6299.3 6475.2 6480.5 6492.2 6549.8 6285.9 6302.4 6309.8 6337.4 6378.5 7116.4 7344.9 7349.4 7350.3 7352.0 7347.1 7495.6 7497.7 7551.8 7588.8 5655.6 5678.5 5727.6 5740.4 5768.3 6018.2 6069.0 6072.3 6102.4 6108.8 5929.0 5972.6 5993.4 6056.5 6101.5 5787.3 5820.8 5858.3 5907.4 5994.9 5693.6 6052.1 6072.8 6093.9 6107.7 5705.9 5731.1 5733.4 5738.5 5745.9 5696.8 5716.7 5723.5 5726.3 5734.2 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4675.61 Median:5336.31 stddev:1397.17 (26.2%) stddev-sans-first:1361.79 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: Values: 292.0 292.0 298.6 306.2 307.9 5245.4 5305.5 5326.6 5326.9 5433.0 5190.1 5314.9 5345.8 5351.7 5352.1 4132.5 4132.5 4132.8 4134.2 4139.7 3879.7 3974.9 3995.2 4083.4 4098.1 4045.0 4054.7 4064.4 4065.6 4068.7 4052.0 4059.5 4059.8 4060.0 4073.1 3568.7 3570.4 3571.4 3571.4 3579.7 5006.7 5154.4 5159.9 5170.9 5206.9 4683.5 4687.8 4702.8 4713.7 4717.1 5649.4 5652.9 5653.8 5658.8 5670.9 3619.5 3712.1 3771.7 3895.7 3902.5 5854.4 5900.0 5914.6 5920.2 5920.6 4003.6 4010.0 4012.4 4020.3 4021.2 4063.3 4069.8 4072.3 4078.1 4086.2 4517.8 4672.9 4688.9 4699.2 4702.8 5662.2 5665.3 5670.5 5676.1 5677.2 1429.3 1441.0 1443.4 1443.5 1448.0 960.7 967.5 973.5 987.3 989.6 4973.9 4996.8 4996.9 5011.3 5012.7 5854.7 5858.9 5859.9 5864.4 5872.4 4980.0 4984.1 4984.2 4992.6 5004.3 3069.1 3127.5 3155.5 3157.2 3160.8 5583.4 5588.1 5601.2 5640.2 5642.0 6095.9 6099.5 6101.6 6106.6 6110.9 5618.5 5624.2 5627.4 5630.9 5632.5 5713.2 5916.3 5918.0 5922.6 5926.7 5556.6 5632.1 5702.4 5751.7 5791.4 5572.2 5585.8 5607.3 5610.4 5620.4 3957.8 3960.2 3968.9 3996.4 4005.1 5714.7 5841.6 5852.6 5853.0 5855.4 5710.4 5714.3 5721.0 5722.1 5722.5 5709.3 5711.1 5713.8 5716.6 5721.4 5527.8 5584.3 5591.2 5592.9 5596.6 5511.7 5645.8 5718.8 5720.7 5723.6 5562.9 5574.5 5576.2 5577.8 5579.4 02:11:09 INFO - 2015-12-01 02:11:09,818 DEBUG : BROWSER_OUTPUT: 02:11:09 INFO - 2015-12-01 02:11:09,819 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12672.63 Median:23748.18 stddev:14502.20 (61.1%) stddev-sans-first:14514.74 02:11:09 INFO - 2015-12-01 02:11:09,819 DEBUG : BROWSER_OUTPUT: Values: 641.6 675.8 687.8 706.0 779.3 11247.4 11486.0 11487.4 11494.3 11509.8 11990.5 12103.8 13507.1 13900.1 13932.9 618.7 626.9 798.1 813.1 815.8 618.6 794.4 805.3 809.3 810.2 782.1 830.4 844.3 845.3 845.4 630.1 637.5 837.3 841.1 841.3 612.1 615.8 616.1 616.2 616.4 11891.8 12094.0 12100.1 12111.8 12118.2 11594.0 12055.4 12145.3 12337.6 12343.0 8927.0 9013.7 9070.1 9186.2 9381.9 3288.3 3311.2 3324.1 3347.8 3351.9 41957.4 42895.1 43025.4 43077.8 43101.0 9609.4 9645.1 9792.2 9819.7 9918.9 16553.9 16751.6 16768.2 17435.0 17452.4 6436.0 6496.4 6496.6 6549.8 6598.8 3592.2 3597.8 3602.2 3722.5 3801.3 2823.7 2839.7 2873.3 2879.8 2889.7 474.1 482.2 487.9 489.9 493.4 554.6 606.5 618.7 624.4 636.2 7616.8 7717.8 8006.8 8048.5 8074.0 568.8 585.6 594.0 597.5 612.6 3426.5 3645.1 3691.6 3728.6 3737.6 53049.7 53792.2 53903.0 53992.5 54030.7 44748.3 45458.0 47022.3 47545.0 47662.0 41260.8 42050.6 42093.2 42518.9 42952.8 7870.0 7964.6 8104.6 8462.1 8489.9 31194.2 31772.7 32209.5 32236.5 32642.7 38531.2 39552.0 39862.6 39990.4 40915.6 9700.3 9859.5 10084.5 10151.1 10275.4 11135.2 11318.4 11408.5 11630.8 12007.5 10514.9 10638.2 10877.0 10879.3 11252.4 10488.9 10603.6 10865.2 10972.7 11211.1 10435.9 10698.3 10761.7 10842.5 10875.8 8632.0 9070.6 9149.4 9330.1 9464.7 8953.8 9187.0 9694.4 9708.2 9729.8 02:11:09 INFO - 2015-12-01 02:11:09,819 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:11:09 INFO - 2015-12-01 02:11:09,819 DEBUG : BROWSER_OUTPUT: 02:11:10 INFO - 2015-12-01 02:11:10,586 INFO : Browser exited with error code: 0 02:11:10 INFO - 2015-12-01 02:11:10,602 INFO : Completed test dromaeo_css (00:18:37) 02:11:10 INFO - 2015-12-01 02:11:10,602 INFO : Starting test kraken 02:11:10 INFO - 2015-12-01 02:11:10,603 DEBUG : operating with platform_type : linux_ 02:11:10 INFO - 2015-12-01 02:11:10,603 INFO : Initialising browser for kraken test... 02:11:10 INFO - 2015-12-01 02:11:10,609 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA3fgWk/profile http://localhost:50775/getInfo.html 02:11:14 INFO - 2015-12-01 02:11:14,505 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:11:14 INFO - 2015-12-01 02:11:14,505 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:11:14 INFO - 2015-12-01 02:11:14,505 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:11:14 INFO - 2015-12-01 02:11:14,505 DEBUG : BROWSER_OUTPUT: __metrics 02:11:14 INFO - 2015-12-01 02:11:14,642 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] 02:11:16 INFO - 2015-12-01 02:11:16,014 INFO : Browser initialized. 02:11:16 INFO - 2015-12-01 02:11:16,015 INFO : Running cycle 1/1 for kraken test... 02:11:16 INFO - 2015-12-01 02:11:16,015 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA3fgWk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:11:27 INFO - 2015-12-01 02:11:27,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 02:11:27 INFO - 2015-12-01 02:11:27,807 DEBUG : BROWSER_OUTPUT: 02:11:30 INFO - 2015-12-01 02:11:30,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50775/tests/kraken/driver.html?testName=audio-beat-detection) 02:11:31 INFO - 2015-12-01 02:11:31,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 174886912 02:11:31 INFO - 2015-12-01 02:11:31,021 DEBUG : BROWSER_OUTPUT: 02:11:33 INFO - 2015-12-01 02:11:33,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50775/tests/kraken/driver.html?testName=audio-dft) 02:11:34 INFO - 2015-12-01 02:11:34,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 164225024 02:11:34 INFO - 2015-12-01 02:11:34,326 DEBUG : BROWSER_OUTPUT: 02:11:37 INFO - 2015-12-01 02:11:37,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50775/tests/kraken/driver.html?testName=audio-fft) 02:11:37 INFO - 2015-12-01 02:11:37,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 149585920 02:11:37 INFO - 2015-12-01 02:11:37,911 DEBUG : BROWSER_OUTPUT: 02:11:39 INFO - 2015-12-01 02:11:39,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50775/tests/kraken/driver.html?testName=audio-oscillator) 02:11:40 INFO - 2015-12-01 02:11:40,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 152817664 02:11:40 INFO - 2015-12-01 02:11:40,522 DEBUG : BROWSER_OUTPUT: 02:11:42 INFO - 2015-12-01 02:11:42,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:11:43 INFO - 2015-12-01 02:11:43,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 154664960 02:11:43 INFO - 2015-12-01 02:11:43,353 DEBUG : BROWSER_OUTPUT: 02:11:46 INFO - 2015-12-01 02:11:46,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50775/tests/kraken/driver.html?testName=imaging-darkroom) 02:11:46 INFO - 2015-12-01 02:11:46,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 153329664 02:11:46 INFO - 2015-12-01 02:11:46,915 DEBUG : BROWSER_OUTPUT: 02:11:50 INFO - 2015-12-01 02:11:50,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50775/tests/kraken/driver.html?testName=imaging-desaturate) 02:11:50 INFO - 2015-12-01 02:11:50,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 156323840 02:11:50 INFO - 2015-12-01 02:11:50,916 DEBUG : BROWSER_OUTPUT: 02:11:53 INFO - 2015-12-01 02:11:53,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50775/tests/kraken/driver.html?testName=json-parse-financial) 02:11:54 INFO - 2015-12-01 02:11:54,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 154370048 02:11:54 INFO - 2015-12-01 02:11:54,397 DEBUG : BROWSER_OUTPUT: 02:11:56 INFO - 2015-12-01 02:11:56,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:11:56 INFO - 2015-12-01 02:11:56,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 162058240 02:11:56 INFO - 2015-12-01 02:11:56,759 DEBUG : BROWSER_OUTPUT: 02:11:58 INFO - 2015-12-01 02:11:58,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:11:59 INFO - 2015-12-01 02:11:59,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 163471360 02:11:59 INFO - 2015-12-01 02:11:59,272 DEBUG : BROWSER_OUTPUT: 02:12:01 INFO - 2015-12-01 02:12:01,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:12:01 INFO - 2015-12-01 02:12:01,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 169943040 02:12:01 INFO - 2015-12-01 02:12:01,986 DEBUG : BROWSER_OUTPUT: 02:12:04 INFO - 2015-12-01 02:12:04,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:12:05 INFO - 2015-12-01 02:12:05,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 176615424 02:12:05 INFO - 2015-12-01 02:12:05,079 DEBUG : BROWSER_OUTPUT: 02:12:07 INFO - 2015-12-01 02:12:07,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:12:08 INFO - 2015-12-01 02:12:08,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 175947776 02:12:08 INFO - 2015-12-01 02:12:08,243 DEBUG : BROWSER_OUTPUT: 02:12:09 INFO - 2015-12-01 02:12:09,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50775/tests/kraken/driver.html?testName=ai-astar) 02:12:10 INFO - 2015-12-01 02:12:10,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 234917888 02:12:10 INFO - 2015-12-01 02:12:10,244 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,246 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:12:10 INFO - 2015-12-01 02:12:10,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:12:10 INFO - 2015-12-01 02:12:10,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:12:10 INFO - 2015-12-01 02:12:10,247 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:12:10 INFO - 2015-12-01 02:12:10,247 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;107;112;113;113;102;113;112;106 02:12:10 INFO - 2015-12-01 02:12:10,247 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;140;156;178;131;158;160;132;165;131 02:12:10 INFO - 2015-12-01 02:12:10,247 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;162;160;159;159;161;162;161 02:12:10 INFO - 2015-12-01 02:12:10,247 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;82;90;71;71;72;94;88;71 02:12:10 INFO - 2015-12-01 02:12:10,248 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;133;94;95;94;134;95;95;130 02:12:10 INFO - 2015-12-01 02:12:10,248 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;110;110;109;110;110 02:12:10 INFO - 2015-12-01 02:12:10,248 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;147;146;147;146;146;147;147 02:12:10 INFO - 2015-12-01 02:12:10,248 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;97;96;96;96;96;97;96 02:12:10 INFO - 2015-12-01 02:12:10,248 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;72;71;70;71;70;79;69;69 02:12:10 INFO - 2015-12-01 02:12:10,248 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;69;69;70;69;69;70;70 02:12:10 INFO - 2015-12-01 02:12:10,249 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;91;83;85;82;81;80;82;89;82 02:12:10 INFO - 2015-12-01 02:12:10,249 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;119;129;118;121;118;125;129;133;118 02:12:10 INFO - 2015-12-01 02:12:10,249 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;136;153;147;147;147;149;144;145;134 02:12:10 INFO - 2015-12-01 02:12:10,249 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;67;68;70;70;68;67;68;68 02:12:10 INFO - 2015-12-01 02:12:10,249 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:12:10 INFO - 2015-12-01 02:12:10,250 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:12:10 INFO - 2015-12-01 02:12:10,250 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,994 02:12:10 INFO - 2015-12-01 02:12:10,250 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:12:10 INFO - 2015-12-01 02:12:10,250 DEBUG : BROWSER_OUTPUT: __startTimestamp1448964730245__endTimestamp 02:12:10 INFO - 2015-12-01 02:12:10,250 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,254 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:12:10 INFO - 2015-12-01 02:12:10,254 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:12:10 INFO - 2015-12-01 02:12:10,254 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,255 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:112.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 02:12:10 INFO - 2015-12-01 02:12:10,255 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 107.0 112.0 113.0 113.0 102.0 113.0 112.0 106.0 02:12:10 INFO - 2015-12-01 02:12:10,255 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,255 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.00 stddev:16.18 (10.3%) stddev-sans-first:17.16 02:12:10 INFO - 2015-12-01 02:12:10,256 DEBUG : BROWSER_OUTPUT: Values: 150.0 140.0 156.0 178.0 131.0 158.0 160.0 132.0 165.0 131.0 02:12:10 INFO - 2015-12-01 02:12:10,256 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,256 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 02:12:10 INFO - 2015-12-01 02:12:10,256 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 162.0 160.0 159.0 159.0 161.0 162.0 161.0 02:12:10 INFO - 2015-12-01 02:12:10,256 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,257 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.10 Median:77.00 stddev:9.41 (12.2%) stddev-sans-first:9.62 02:12:10 INFO - 2015-12-01 02:12:10,257 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 82.0 90.0 71.0 71.0 72.0 94.0 88.0 71.0 02:12:10 INFO - 2015-12-01 02:12:10,257 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:95.00 stddev:18.20 (19.2%) stddev-sans-first:18.87 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 133.0 94.0 95.0 94.0 134.0 95.0 95.0 130.0 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:12:10 INFO - 2015-12-01 02:12:10,258 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:2.88 (4.0%) stddev-sans-first:3.04 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 71.0 70.0 71.0 70.0 79.0 69.0 69.0 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 02:12:10 INFO - 2015-12-01 02:12:10,259 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 69.0 69.0 70.0 69.0 69.0 70.0 70.0 02:12:10 INFO - 2015-12-01 02:12:10,260 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,260 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:82.50 stddev:3.59 (4.4%) stddev-sans-first:3.76 02:12:10 INFO - 2015-12-01 02:12:10,260 DEBUG : BROWSER_OUTPUT: Values: 82.0 91.0 83.0 85.0 82.0 81.0 80.0 82.0 89.0 82.0 02:12:10 INFO - 2015-12-01 02:12:10,260 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,261 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:127.00 stddev:5.76 (4.5%) stddev-sans-first:5.81 02:12:10 INFO - 2015-12-01 02:12:10,261 DEBUG : BROWSER_OUTPUT: Values: 129.0 119.0 129.0 118.0 121.0 118.0 125.0 129.0 133.0 118.0 02:12:10 INFO - 2015-12-01 02:12:10,261 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,261 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:147.00 stddev:5.76 (3.9%) stddev-sans-first:6.06 02:12:10 INFO - 2015-12-01 02:12:10,261 DEBUG : BROWSER_OUTPUT: Values: 147.0 136.0 153.0 147.0 147.0 147.0 149.0 144.0 145.0 134.0 02:12:10 INFO - 2015-12-01 02:12:10,262 DEBUG : BROWSER_OUTPUT: 02:12:10 INFO - 2015-12-01 02:12:10,262 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 02:12:10 INFO - 2015-12-01 02:12:10,262 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 70.0 70.0 68.0 67.0 68.0 68.0 02:12:10 INFO - 2015-12-01 02:12:10,262 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:12:10 INFO - 2015-12-01 02:12:10,262 DEBUG : BROWSER_OUTPUT: 02:12:11 INFO - 2015-12-01 02:12:11,134 INFO : Browser exited with error code: 0 02:12:11 INFO - 2015-12-01 02:12:11,185 INFO : Completed test kraken (00:01:00) 02:12:11 INFO - 2015-12-01 02:12:11,185 INFO : Starting test v8_7 02:12:11 INFO - 2015-12-01 02:12:11,185 DEBUG : operating with platform_type : linux_ 02:12:11 INFO - 2015-12-01 02:12:11,185 INFO : Initialising browser for v8_7 test... 02:12:11 INFO - 2015-12-01 02:12:11,191 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXgZA0j/profile http://localhost:50775/getInfo.html 02:12:15 INFO - 2015-12-01 02:12:15,079 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:12:15 INFO - 2015-12-01 02:12:15,079 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:12:15 INFO - 2015-12-01 02:12:15,079 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:12:15 INFO - 2015-12-01 02:12:15,079 DEBUG : BROWSER_OUTPUT: __metrics 02:12:15 INFO - 2015-12-01 02:12:15,196 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] 02:12:16 INFO - 2015-12-01 02:12:16,526 INFO : Browser initialized. 02:12:16 INFO - 2015-12-01 02:12:16,527 INFO : Running cycle 1/1 for v8_7 test... 02:12:16 INFO - 2015-12-01 02:12:16,527 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXgZA0j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:12:28 INFO - 2015-12-01 02:12:28,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 138301440 02:12:28 INFO - 2015-12-01 02:12:28,429 DEBUG : BROWSER_OUTPUT: 02:12:49 INFO - 2015-12-01 02:12:49,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50775/tests/v8_7/run.html (next: http://localhost:50775/tests/v8_7/run.html) 02:12:50 INFO - 2015-12-01 02:12:50,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 447700992 02:12:50 INFO - 2015-12-01 02:12:50,130 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,131 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:12:50 INFO - 2015-12-01 02:12:50,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:12:50 INFO - 2015-12-01 02:12:50,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:12:50 INFO - 2015-12-01 02:12:50,132 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:12:50 INFO - 2015-12-01 02:12:50,132 DEBUG : BROWSER_OUTPUT: |0;Richards;165.39861065167054 02:12:50 INFO - 2015-12-01 02:12:50,132 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.38755980861245 02:12:50 INFO - 2015-12-01 02:12:50,132 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 02:12:50 INFO - 2015-12-01 02:12:50,132 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 02:12:50 INFO - 2015-12-01 02:12:50,132 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2047.034764826176 02:12:50 INFO - 2015-12-01 02:12:50,132 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 02:12:50 INFO - 2015-12-01 02:12:50,133 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 02:12:50 INFO - 2015-12-01 02:12:50,133 DEBUG : BROWSER_OUTPUT: |7;RegExp;26230.76923076923 02:12:50 INFO - 2015-12-01 02:12:50,133 DEBUG : BROWSER_OUTPUT: |8;Splay;619.1950464396285 02:12:50 INFO - 2015-12-01 02:12:50,133 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: __startTimestamp1448964770130__endTimestamp 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.40 Median:165.40 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: Values: 165.4 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,134 DEBUG : BROWSER_OUTPUT: Values: 191.4 02:12:50 INFO - 2015-12-01 02:12:50,135 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,135 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,135 DEBUG : BROWSER_OUTPUT: Values: 277.8 02:12:50 INFO - 2015-12-01 02:12:50,135 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,135 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,135 DEBUG : BROWSER_OUTPUT: Values: 5133.3 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2047.03 Median:2047.03 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: Values: 2047.0 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: Values: 790.5 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: Values: 12419.8 02:12:50 INFO - 2015-12-01 02:12:50,136 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: Values: 26230.8 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.20 Median:619.20 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: Values: 619.2 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: Values: 4840.6 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:12:50 INFO - 2015-12-01 02:12:50,137 DEBUG : BROWSER_OUTPUT: 02:12:50 INFO - 2015-12-01 02:12:50,986 INFO : Browser exited with error code: 0 02:12:51 INFO - 2015-12-01 02:12:51,001 INFO : Completed test v8_7 (00:00:39) 02:12:51 INFO - 2015-12-01 02:12:51,117 INFO : Completed test suite (00:20:17) 02:12:51 INFO - 2015-12-01 02:12:51,118 DEBUG : Working with test: dromaeo_css 02:12:51 INFO - 2015-12-01 02:12:51,118 DEBUG : Generating results file: dromaeo_css 02:12:51 INFO - 2015-12-01 02:12:51,119 DEBUG : Working with test: kraken 02:12:51 INFO - 2015-12-01 02:12:51,119 DEBUG : Generating results file: kraken 02:12:51 INFO - 2015-12-01 02:12:51,119 INFO : javascript benchmark 02:12:51 INFO - 2015-12-01 02:12:51,119 DEBUG : Working with test: v8_7 02:12:51 INFO - 2015-12-01 02:12:51,120 DEBUG : Generating results file: v8_7 02:12:51 INFO - 2015-12-01 02:12:51,120 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:12:51 INFO - 2015-12-01 02:12:51,167 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,141,35]] 02:12:51 INFO - 2015-12-01 02:12:51,167 DEBUG : process_Request line: dromaeo_css 6295.35 graph.html#tests=[[72,141,35]] 02:12:51 INFO - 2015-12-01 02:12:51,167 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:12:51 INFO - 2015-12-01 02:12:51,201 DEBUG : process_Request line: kraken 1519.40 graph.html#tests=[[232,141,35]] 02:12:51 INFO - 2015-12-01 02:12:51,201 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:12:51 INFO - 2015-12-01 02:12:51,231 DEBUG : process_Request line: v8_7 19682.80 graph.html#tests=[[230,141,35]] 02:12:51 INFO - 2015-12-01 02:12:51,232 INFO : javascript benchmark 02:12:51 INFO - 2015-12-01 02:12:51,236 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2623.5146497897886, 2691.4213444109514, 2692.919212423627, 2705.621213030176, 2731.890724371026, 4485.842995495158, 4589.105124500724, 4611.33135695324, 4643.048175124104, 4663.813447462102, 4598.954010459895, 4600.930986035212, 4634.467036290827, 4694.647901407399, 4701.717896926187, 4301.655867530606, 4353.521112677603, 4362.323839804835, 4375.1031038637, 4387.758673272985, 4156.189543039109, 4385.780710964439, 4388.824447022132, 4454.086912182995, 4471.418715566988, 4169.541350451448, 4188.183304255656, 4212.557681443435, 4293.0769884474985, 4300.569943005675, 4324.070324880135, 4354.7604881731495, 4355.73865568067, 4364.083542456088, 4400.955990440087, 4327.242732521796, 4333.155034768221, 4333.328334108218, 4367.978160109179, 4393.494748103977, 4369.868903932887, 4486.506484286726, 4490.146872094324, 4501.41481607389, 4630.907381852344, 5048.747562621891, 5049.267856160873, 5055.0, 5056.873578160538, 5058.988202359543, 5081.441041485434, 5087.9745601272125, 5114.130597798383, 5117.181250999859, 5121.436641969381, 4578.313253012042, 4650.651201159926, 4700.55344742249, 4710.858674239778, 4727.716337019755, 5167.431582525919, 5170.508801663836, 5177.844664660066, 5217.7912883485, 5228.08508511009, 4962.6774259673, 4964.925526117111, 4978.751062446863, 4989.925151122736, 5008.1486147355035, 4726.834560790356, 4814.061258054646, 4820.3492528508905, 4835.347228124228, 5031.748412579356, 4829.782659780319, 4934.5805606523845, 4956.058348913695, 4966.354373931365, 4987.426445958761, 4941.085899108676, 4974.950250497521, 4975.925361119586, 4978.253262010728, 5017.9247311290355, 3748.381517049711, 3857.8456861725217, 3887.96112038876, 3894.90262743428, 3927.56796752357, 3425.6403077676982, 3427.605825330069, 3466.2547552276383, 3490.406630872758, 3515.595706493786, 4342.609165175149, 4356.956430435718, 4358.564143585616, 4362.781860906942, 4398.56014398564, 4787.904241915142, 5055.443901170868, 5072.442031376546, 5075.416327122428, 5077.136886729265, 4236.597523235288, 4266.466691663542, 4282.464691913511, 4289.528151903288, 4308.698391112592, 4505.504394516601, 4517.661175411858, 4523.819047238139, 4545.6136228420955, 4557.977210113928, 4820.493848145964, 4820.638452116105, 4822.903541929212, 4829.323894654822, 4869.147899117711, 4814.518548145157, 4944.604431645388, 4944.802207911644, 4958.950410495849, 5072.163093089599, 4852.636052296021, 4853.514648535118, 4856.587190088882, 4860.198067318995, 4896.069746748249, 5023.773930173078, 5024.42219144803, 5029.044481548494, 5033.119204139334, 5034.496550345083, 4805.543473370164, 4866.48901865299, 4914.533119353656, 4919.114559379346, 5137.717425541481, 4712.128256272601, 4762.214234651382, 4764.475907650087, 4867.245576935581, 4990.176620857663, 4877.6829506081995, 4884.90230195387, 4886.584640305614, 4889.217725163957, 4929.038837426668, 4794.5924596409695, 4797.712137271775, 4798.088363210979, 4799.616030717604, 4826.517348265286, 4675.345451636706, 4759.833405830779, 4779.211430113992, 4779.354787103696, 4846.418429788448, 4783.832565860178, 4801.399825021872, 4806.303086052433, 4821.63837712166, 4868.61051115917], "unit": "ms", "name": "dojo.html", "value": 4575.641876205073}, {"lowerIsBetter": false, "replicates": [554.8474169603359, 557.409146304917, 566.2412367427647, 567.7991048931511, 574.5949105880355, 28027.299317517045, 28389.29026774329, 28510.572341414896, 35581.64418355816, 36306.63693363065, 40498.0, 41028.79485602568, 41039.58960410395, 41097.7945110274, 41157.0, 7900.683972641087, 8079.838403231932, 8082.353411727077, 8084.3936704747375, 8085.3531717462465, 7110.360067593915, 7309.926900731004, 9698.272629552777, 9901.257405694565, 9905.75235619108, 9719.0, 9823.70528884131, 9824.36141650794, 9831.754206144831, 9834.31159818813, 7127.750528731522, 7335.88996165058, 9280.582373793162, 9305.813883722356, 9354.84838487145, 9617.134457898752, 9853.802923941552, 9857.753556161082, 9859.852102218472, 9870.062344077302, 33094.83452582746, 33398.0, 33437.498437523456, 33504.832475837466, 33514.0, 2756.4487102579365, 2768.820026698258, 2781.193453898367, 3383.8477268522975, 3540.567976429231, 27742.0, 27818.165455036382, 28131.71868281332, 29191.56212656812, 30669.38661226763, 3298.8515516801804, 3307.355065762177, 3340.599128104643, 3346.3474622448634, 3371.3257348530146, 213280.0, 214134.0, 214230.0, 214234.0, 215224.0, 52431.0, 53684.73157634187, 57044.0, 57555.13667294994, 57560.424395756345, 67528.6623566879, 68904.31095688979, 69195.65402173057, 69239.0, 69254.65372673105, 13944.51194208198, 14352.273068117025, 14362.353694083582, 14372.568822935329, 14378.784318235235, 10523.421211833269, 10557.049865512141, 10562.577496900038, 10646.361218326925, 10684.732881678021, 19691.03089691048, 20010.69983950242, 20019.899900500695, 20100.0, 20109.19563217455, 7494.812629684301, 7679.500832445873, 7801.815491662343, 7837.568933708701, 7872.921270787218, 867.7136544940155, 868.769776009358, 910.7085732565515, 934.8737920380662, 958.942463452195, 25494.872525637253, 25662.0, 25770.133380863277, 25925.22224333273, 25988.0, 951.1012093571646, 951.9095685909828, 1008.0725732326277, 1040.3705758016442, 1124.100719424457, 13737.931310343385, 13832.446702132003, 13837.377318020714, 14028.438862445388, 14030.929845350913, 307702.0, 314115.0, 314298.0, 315909.0, 316015.0, 47101.29348059782, 47387.0, 47395.0, 47421.0, 47461.525384746405, 1199.6760874563993, 1215.070471089617, 1215.8966487848454, 1216.6593353860933, 1220.9877901220875, 25015.0, 25734.871325643253, 26023.73976260289, 26052.73947260503, 26066.86966565155, 35655.465168023016, 38610.613893861824, 39300.21399571935, 39308.213835722556, 39429.605703942594, 162828.0, 232793.0, 238332.0, 239102.0, 239494.0, 27499.31251718723, 28148.21480348387, 28176.43647127087, 28187.859060704566, 28204.71795282021, 35333.823330883184, 36472.452913205794, 36839.81580092083, 36840.63159368372, 36856.07859803527, 33282.83358583192, 33409.331813364086, 34078.318433631684, 34238.657613423544, 34394.48408273828, 33960.15099622529, 38497.2300553993, 40348.394774079, 40679.7966010168, 42146.57853421549, 34639.0, 35752.0, 37738.811305943294, 37758.62241377551, 37769.81115094517, 36323.0, 37449.0, 37467.0, 37887.0, 37949.241015180094, 28720.42559148847, 29627.259318517208, 29710.702892970792, 32772.672273277916, 32890.50664240086], "unit": "ms", "name": "ext.html", "value": 17524.199021182303}, {"lowerIsBetter": false, "replicates": [324.1346053462324, 324.2251020062051, 324.38367102505254, 327.1510430433026, 331.2662452667343, 11995.880041199585, 12353.938230308835, 14971.0, 15293.082415055105, 15352.0, 11870.643880683572, 14520.128792272471, 14524.419023239057, 14817.0, 14821.555353339418, 4770.332153498513, 4773.427188737356, 4917.606591472673, 4922.4585295617635, 4922.70463772173, 3288.753343499235, 3385.5091011803274, 4973.875653108665, 5009.02324046811, 5035.672681275723, 5159.587233021368, 5192.428832828386, 5203.661761985478, 5216.8174113906025, 5217.5565076968505, 5088.847334579968, 5175.689458632494, 5188.06614809336, 5236.476352364733, 5243.79024839006, 4976.477469865648, 5039.395272567279, 5041.672291301091, 5049.2426136079885, 5051.595872330205, 10388.532516036796, 13511.932440337736, 18186.0, 18595.0, 18596.349127780464, 1684.6714890596338, 1689.0878925380403, 1756.1307152959366, 1794.676958147533, 1812.619349936515, 8729.083446238117, 8965.148310910454, 8980.46117232968, 9306.813863722755, 13024.153430027018, 1535.6775077233683, 1624.3827345608593, 1730.7317365808194, 1755.10489650278, 1767.9911600442044, 53153.0, 57706.711466442815, 57824.0, 58071.709641451525, 58813.0, 9176.632934682671, 9317.999999999864, 9373.0, 9464.905350946403, 9471.289653276031, 11679.299242045334, 11701.473433695504, 11720.765584688259, 11761.764764704829, 11799.115066370057, 6839.62382068991, 6887.5178737488895, 6894.655267236618, 6953.617551034742, 7018.157821061403, 6644.634370382123, 6948.5483443576, 7049.647517624098, 7089.645517724093, 7101.005859179719, 4081.1225586499045, 4164.7917604119675, 4169.437125988014, 4183.790810459464, 4239.936400953989, 1620.5462470508276, 1637.148682684997, 1645.407653244831, 1666.9583260418588, 1708.2910592104138, 849.5072857742495, 854.811941372897, 878.4246318661287, 918.912703293186, 938.5030875753163, 15685.529434116996, 15809.841901580838, 16059.87580869328, 16200.270987805578, 16286.837131628768, 751.4927423988786, 845.3026253341018, 885.349268287808, 917.3624331089828, 934.4346670264528, 8628.0, 8765.342599305077, 8896.191187453323, 8940.50827204497, 9071.818563628822, 493572.0, 495904.0, 514786.0, 520891.0, 533193.0, 69314.65342673255, 71060.64469677722, 72298.55402892017, 72817.6359118201, 73237.63381183166, 1021.2697920986382, 1032.0453580438066, 1032.055669062799, 1032.26193271811, 1063.2132222155549, 14328.355224015153, 14383.568492945229, 14396.68099570104, 14493.347799349265, 14724.926375368483, 31282.68717312798, 32205.35589288248, 32276.0, 32426.027219183463, 32894.50658240176, 40536.18927621372, 43007.0, 43044.0, 43270.0, 45649.97850236405, 8323.209295116954, 8584.527850968258, 8632.05047444768, 8717.52053637056, 8733.039365669643, 10214.693559193236, 11456.0, 16389.672206555562, 16517.504474865775, 16666.333346665997, 13258.602241932758, 13751.106178098391, 14008.229547374993, 14077.225752583297, 14188.0, 12773.10588258813, 12916.741665166832, 13545.1195672281, 13834.446622135001, 13871.722565548835, 10911.78176436451, 13716.65708357299, 14017.158970461805, 14041.5085472008, 14238.430462781373, 8055.677772889018, 8267.503949763033, 8340.916590834015, 8360.958195209229, 8381.706640267561, 8917.242034427147, 8956.0, 12754.42605082755, 13183.274919879499, 13545.59363219105], "unit": "ms", "name": "jquery.html", "value": 8060.904494021649}, {"lowerIsBetter": false, "replicates": [1305.1060023883638, 1353.6209861238854, 1379.6068120585635, 1439.9496017639378, 1697.5077227603988, 5435.456454354563, 6566.212054553454, 6745.0, 6750.054992301082, 6766.188057433109, 6728.293529179439, 6889.0, 6889.552179108355, 6898.275681053492, 6905.171379434462, 2030.2792508659472, 2060.701198326242, 2064.905600031978, 2064.9793502065013, 2065.607534568435, 2038.0828627117783, 2055.917763289474, 2062.3400511836144, 2079.5321052763156, 2082.822960048398, 1963.4011626453926, 2006.7692215395198, 2020.171729590868, 2026.9797302026939, 2036.0735865181382, 1967.4982879365814, 2002.2791794953805, 2002.8798272103575, 2004.6291436084298, 2005.5988802239538, 1974.1708482437411, 2012.4264584593468, 2012.6377252094617, 2014.7280117184287, 2016.3547664747286, 5711.543076553866, 5849.093390524476, 6791.456683465311, 6864.141982252218, 6883.208431030445, 3830.2339532093415, 3925.3326934421216, 3943.7239393242485, 3945.309570825094, 3957.881263562098, 2639.8944042238286, 2640.4323070539735, 2681.9865900670566, 2688.865556722176, 2718.7281271872853, 880.6785523284019, 887.5917078144062, 904.281096528255, 923.3628796130715, 934.5047125023748, 9080.318976076755, 9147.679831205876, 9148.0, 9159.496227707474, 9172.128647778518, 3707.981460092736, 3733.9626603733614, 3785.37541305687, 3787.7727336359358, 3795.35478968576, 8037.316828069563, 8055.5972201389695, 8064.274215320649, 8067.314278286294, 8067.596620168968, 3929.135590170158, 3943.38877473992, 3979.7413168143976, 3982.024404021033, 3987.521497420328, 3578.928421431609, 3581.982090089585, 3596.9100772480897, 3609.368360536948, 3626.0390996385977, 3157.6526582075953, 3160.115167753033, 3171.6828317168097, 3186.314942287373, 3196.168996061041, 982.111189373618, 983.8475036369374, 985.9499632890949, 986.8717066781272, 987.1855719031828, 1166.3934753928079, 1179.2334982261427, 1180.8228765685044, 1189.8631657359342, 1193.8746431624727, 6262.718177682015, 6386.201724784402, 6449.677516124175, 6474.223093228748, 6487.54587178893, 1011.9443430611387, 1023.4268809466722, 1028.5268776362807, 1033.5762337441613, 1054.7040498442368, 4479.820807167742, 5230.843074707765, 5271.393789714232, 5271.71005594696, 5274.683518988873, 7034.155901291775, 8086.676532938734, 8105.392095592854, 8110.83778324442, 8138.064122625974, 7939.087004994384, 7950.443468957117, 8029.397795165386, 8043.11525732169, 8044.074931382849, 6299.307076221612, 6475.190601174853, 6480.546361754632, 6492.156019717407, 6549.803505894926, 6285.937140628535, 6302.401271879165, 6309.842253943688, 6337.366263373626, 6378.45783108441, 7116.430685545248, 7344.926550734638, 7349.412047036331, 7350.338469537767, 7352.0442342495135, 7347.08161479815, 7495.587742674205, 7497.700091996259, 7551.848963020819, 7588.772336829904, 5655.632383895034, 5678.545716342765, 5727.599068065362, 5740.3685594585395, 5768.307803063659, 6018.157457955802, 6069.0, 6072.332043475126, 6102.359252278625, 6108.847278818065, 5929.0, 5972.58191926561, 5993.430624090704, 6056.545759068, 6101.511879049576, 5787.276590426197, 5820.796272130455, 5858.326292476419, 5907.438793314628, 5994.910076348945, 5693.629914055573, 6052.061930400795, 6072.787452439144, 6093.878122437615, 6107.694615269308, 5705.885882282248, 5731.054376027909, 5733.39799321082, 5738.483536481736, 5745.91381129275, 5696.8006119785605, 5716.714164291686, 5723.513501352431, 5726.255586773859, 5734.168545560954], "unit": "ms", "name": "mootools.html", "value": 3917.5459177968446}, {"lowerIsBetter": false, "replicates": [291.97080291970804, 292.0493792704746, 298.6401386329473, 306.2359413263907, 307.9430305393501, 5245.44922783108, 5305.522502974727, 5326.6005049621335, 5326.866828329289, 5433.049216387131, 5190.091733946554, 5314.9468505314935, 5345.7594408251625, 5351.678899266037, 5352.116900711388, 4132.504099508048, 4132.5122955735915, 4132.834686612532, 4134.152498737752, 4139.710220284582, 3879.7478163919395, 3974.940375894364, 3995.220931918277, 4083.4079058536495, 4098.077932465201, 4044.9797751011206, 4054.736442131252, 4064.4309796628495, 4065.6340929316357, 4068.65416439603, 4051.9797401012806, 4059.451973983504, 4059.776712280838, 4060.045889216032, 4073.083556199861, 3568.660977207161, 3570.428731402963, 3571.39286321326, 3571.4464258040043, 3579.6599323064265, 5006.724630145341, 5154.4072431670465, 5159.922601160985, 5170.870728231786, 5206.869828254286, 4683.461401938753, 4687.7656117194, 4702.788374523155, 4713.717176969359, 4717.103750287434, 5649.350324712628, 5652.9152062719095, 5653.802116925929, 5658.8302350929125, 5670.858228544319, 3619.5113659656135, 3712.1276500022473, 3771.73597848148, 3895.668868146211, 3902.5316961964463, 5854.443827836349, 5900.0, 5914.556408269354, 5920.200772895647, 5920.585559010871, 4003.6396724294373, 4010.0, 4012.4382586437923, 4020.336644453691, 4021.1756589899, 4063.349864021742, 4069.8168582413864, 4072.3077076897, 4078.1435898461655, 4086.203190377907, 4517.751523666164, 4672.859814205579, 4688.929666055012, 4699.224627936353, 4702.764861756967, 5662.150677398423, 5665.291838520185, 5670.5463562914865, 5676.120201368794, 5677.205191273142, 1429.349645911108, 1440.9639759006109, 1443.3577058208996, 1443.538067818288, 1448.0008793932152, 960.6781728121018, 967.4582233949011, 973.5181085362649, 987.3286165407449, 989.6338354808767, 4973.925391119136, 4996.7501624918605, 4996.850094497171, 5011.323471331397, 5012.749362531858, 5854.677992710356, 5858.912116318259, 5859.912101318484, 5864.354920958691, 5872.354041055481, 4979.950200498021, 4984.102861484895, 4984.177610694195, 4992.575631071327, 5004.274380214922, 3069.079276217126, 3127.5465057566526, 3155.4635711929027, 3157.2106973256687, 3160.8419579020956, 5583.3858275589655, 5588.050031494656, 5601.187827764951, 5640.153976903497, 5642.04085305499, 6095.878082438327, 6099.4815440688035, 6101.603395779349, 6106.6336019838955, 6110.908336374958, 5618.4662457066515, 5624.156376543551, 5627.43725627434, 5630.887382252332, 5632.52123569493, 5713.200151978644, 5916.290045194432, 5918.0, 5922.6446413213625, 5926.67403292823, 5556.611037227355, 5632.127020311858, 5702.37273899879, 5751.712414379181, 5791.391903850204, 5572.192032155233, 5585.776568937197, 5607.327120745536, 5610.354809196831, 5620.381758006698, 3957.821898014539, 3960.2475529649273, 3968.9007774804704, 3996.420519024783, 4005.058811179312, 5714.657120572779, 5841.620294680833, 5852.619579727304, 5853.03424934881, 5855.3559108497175, 5710.428957104256, 5714.314282286152, 5721.0, 5722.113072473773, 5722.513586345207, 5709.286339207599, 5711.086226203787, 5713.800016999385, 5716.571257155647, 5721.370649228665, 5527.778888844401, 5584.329880414376, 5591.161325801162, 5592.916106258491, 5596.580256480862, 5511.696856672921, 5645.830625081254, 5718.771249149988, 5720.74256658443, 5723.627964182315, 5562.916556251578, 5574.498295153456, 5576.219329293983, 5577.832665020056, 5579.358373786904], "unit": "ms", "name": "prototype.html", "value": 4224.795649896746}, {"lowerIsBetter": false, "replicates": [641.63106213927, 675.8242856857215, 687.8246047257954, 705.9804787957622, 779.3258831111089, 11247.381394023325, 11485.966263036325, 11487.42562871855, 11494.252873563213, 11509.827352589718, 11990.460429280682, 12103.75792484152, 13507.12203706761, 13900.096493727926, 13932.930335348334, 618.6628287583278, 626.8871603111438, 798.1459837973371, 813.1380736419385, 815.7960509872532, 618.638096713421, 794.4081659163902, 805.2511164616903, 809.2676128104075, 810.1776696652902, 782.1083964280724, 830.4062595244399, 844.3414136973171, 845.2561745663808, 845.446232717571, 630.0989584893623, 637.4581605635173, 837.2966707965278, 841.1168273313027, 841.2638940926689, 612.1124369663961, 615.7690865925279, 616.134331264574, 616.2081724983375, 616.4390404731672, 11891.821622675667, 12094.0, 12100.092493062968, 12111.757764844653, 12118.151729378947, 11594.0, 12055.397230138458, 12145.332006739625, 12337.62987110379, 12343.0, 8926.955365223197, 9013.729588112366, 9070.138336857988, 9186.173244408035, 9381.859272110856, 3288.2930170013324, 3311.1887587540964, 3324.069260607034, 3347.7656564040526, 3351.865925363007, 41957.370639440735, 42895.1420971582, 43025.35461968073, 43077.784611077055, 43101.0, 9609.375390599589, 9645.08371704687, 9792.167665748491, 9819.705408837746, 9918.900810991941, 16553.917230413772, 16751.581210469834, 16768.161591920354, 17435.0, 17452.389166379115, 6435.967820160869, 6496.350364963466, 6496.610203387811, 6549.8362540935905, 6598.802035938929, 3592.150042727997, 3597.784132952031, 3602.189507360823, 3722.5346831646043, 3801.2777572261184, 2823.6752773431317, 2839.687634360219, 2873.281679580105, 2879.755220806213, 2889.6821349651523, 474.0660898030874, 482.2284345047895, 487.8560824556764, 489.88487705389207, 493.42515968895833, 554.5840619535348, 606.4753987800609, 618.6875627807929, 624.3818619566597, 636.2174525333866, 7616.771496855104, 7717.807054823675, 8006.839863202703, 8048.476849004796, 8074.0, 568.8094488346368, 585.5637550025174, 593.9910901336483, 597.5010865927, 612.552836429409, 3426.5202871597994, 3645.0887278180453, 3691.5570131583845, 3728.55257369112, 3737.588865224823, 53049.73475132677, 53792.19311710328, 53903.0, 53992.460075399526, 54030.729846350514, 44748.3287750684, 45458.0, 47022.29466558004, 47545.0, 47662.04675906462, 41260.79369603133, 42050.57949420466, 42093.15813683648, 42518.93702657458, 42952.78523607425, 7869.960650196713, 7964.561949092624, 8104.635291411782, 8462.111478294937, 8489.872651910102, 31194.22014449657, 31772.68227317697, 32209.51685724669, 32236.516452252767, 32642.673573264914, 38531.2293754129, 39552.0, 39862.60137398705, 39990.40014399844, 40915.59084409237, 9700.320977531788, 9859.507024648596, 10084.532694553784, 10151.137153342048, 10275.434851083262, 11135.220534562503, 11318.377489237842, 11408.486618102039, 11630.825537616773, 12007.459664315302, 10514.894851051391, 10638.202134840072, 10877.0, 10879.347239165676, 11252.437378130897, 10488.895111048792, 10603.575856965635, 10865.185111116856, 10972.725681858017, 11211.103111750877, 10435.895641043493, 10698.251122421356, 10761.677149685522, 10842.512086956263, 10875.782484350428, 8631.956840215758, 9070.591823368097, 9149.359544831797, 9330.066993300616, 9464.668736594185, 8953.776155595902, 9187.0, 9694.418334899929, 9708.22334213247, 9729.756756081155], "unit": "ms", "name": "yui.html", "value": 5818.047465398235}], "name": "dromaeo_css", "value": 6295.3492760900035}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 112.0, 113.0, 113.0, 102.0, 113.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [150.0, 140.0, 156.0, 178.0, 131.0, 158.0, 160.0, 132.0, 165.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 162.0, 160.0, 159.0, 159.0, 161.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 82.0, 90.0, 71.0, 71.0, 72.0, 94.0, 88.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 78.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 94.0, 95.0, 94.0, 134.0, 95.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 71.0, 70.0, 71.0, 70.0, 79.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [82.0, 91.0, 83.0, 85.0, 82.0, 81.0, 80.0, 82.0, 89.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [129.0, 119.0, 129.0, 118.0, 121.0, 118.0, 125.0, 129.0, 133.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 153.0, 147.0, 147.0, 147.0, 149.0, 144.0, 145.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 70.0, 70.0, 68.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1519.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.39861065167054], "unit": "score", "name": "Richards", "value": 213.43589200000002}, {"lowerIsBetter": false, "replicates": [191.38755980861245], "unit": "score", "name": "DeltaBlue", "value": 345.4665499999999}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2047.034764826176], "unit": "score", "name": "RayTrace", "value": 361.49312787212784}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [619.1950464396285], "unit": "score", "name": "Splay", "value": 131.60796499999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19682.79530410802}]} 02:12:51 INFO - RETURN: dromaeo_css: 6295.35 02:12:51 INFO - RETURN: kraken: 1519.40 02:12:51 INFO - RETURN: v8_7: 19682.80 02:12:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,141,35]]", "result": "19682.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,141,35]]", "result": "1519.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,141,35]]", "result": "6295.35"}}} 02:12:51 INFO - Return code: 0 02:12:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:12:51 INFO - # TBPL SUCCESS # 02:12:51 INFO - Running post-action listener: _resource_record_post_action 02:12:51 INFO - Running post-run listener: _resource_record_post_run 02:12:52 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 348160; Write bytes: 516907008; Read time: 368; Write time: 599304 02:12:52 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 161656832; Read time: 96; Write time: 329316 02:12:52 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 344064; Write bytes: 273346560; Read time: 272; Write time: 194436 02:12:52 INFO - Running post-run listener: _upload_blobber_files 02:12:52 INFO - Blob upload gear active. 02:12:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:12:52 INFO - Copying logs to upload dir... 02:12:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.848921 ========= master_lag: 205.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 39 secs) (at 2015-12-01 02:16:17.780214) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 02:16:17.783530) ========= 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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010163 build_url: 'https://queue.taskcluster.net/v1/task/3oPMh9yUTqqEkBhXqdeSPw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.18 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 02:16:17.975432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 02:16:17.975786) ========= 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=01deea79d00cc2c334834894000001d2-1448961238.737819-79228111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 02:16:18.106206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 02:16:18.106533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 02:16:18.106857) ========= ========= Total master_lag: 205.78 =========