builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1449856635.02 results: success (0) buildid: 20151211091433 builduid: f34c110e3d134b089f053d0484b3e4db revision: d8ce27c85590380ef025bb4ed66e564a4dff9bff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.016411) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.016811) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.017091) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006325 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.042890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.043206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.057620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.057905) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.34 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.405928) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.406192) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.409576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.409877) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 09:57:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-11 09:57:17 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.362020 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.783990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.784298) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019422 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:15.837203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 09:57:15.840579) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8ce27c85590380ef025bb4ed66e564a4dff9bff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d8ce27c85590380ef025bb4ed66e564a4dff9bff --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=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 09:57:18,034 truncating revision to first 12 chars 2015-12-11 09:57:18,034 Setting DEBUG logging. 2015-12-11 09:57:18,034 attempt 1/10 2015-12-11 09:57:18,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8ce27c85590?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 09:57:18,818 unpacking tar archive at: fx-team-d8ce27c85590/testing/mozharness/ program finished with exit code 0 elapsedTime=1.083197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 09:57:16.937053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:16.937358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:16.944806) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:16.945130) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:57:16.945579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-11 09:57:16.945864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:19 INFO - MultiFileLogger online at 20151211 09:57:19 in /builds/slave/test 09:57:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:57:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:19 INFO - {'append_to_log': False, 09:57:19 INFO - 'base_work_dir': '/builds/slave/test', 09:57:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:57:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:19 INFO - 'branch': 'Fx-Team-Non-PGO', 09:57:19 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:19 INFO - 'config_files': ('talos/linux_config.py',), 09:57:19 INFO - 'default_actions': ('clobber', 09:57:19 INFO - 'read-buildbot-config', 09:57:19 INFO - 'download-and-extract', 09:57:19 INFO - 'populate-webroot', 09:57:19 INFO - 'create-virtualenv', 09:57:19 INFO - 'install', 09:57:19 INFO - 'run-tests'), 09:57:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:19 INFO - 'download_minidump_stackwalk': True, 09:57:19 INFO - 'download_symbols': 'ondemand', 09:57:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:19 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:19 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:19 INFO - 'installer_path': 'installer.exe', 09:57:19 INFO - 'log_level': 'info', 09:57:19 INFO - 'log_name': 'talos', 09:57:19 INFO - 'log_to_console': True, 09:57:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:19 INFO - 'opt_config_files': (), 09:57:19 INFO - 'pip_index': False, 09:57:19 INFO - 'sps_profile': False, 09:57:19 INFO - 'sps_profile_interval': 0, 09:57:19 INFO - 'suite': 'dromaeojs-e10s', 09:57:19 INFO - 'system_bits': '64', 09:57:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:19 INFO - 'title': 'talos-linux64-ix-048', 09:57:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:19 INFO - 'use_talos_json': True, 09:57:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:19 INFO - 'work_dir': 'build'} 09:57:19 INFO - ##### 09:57:19 INFO - ##### Running clobber step. 09:57:19 INFO - ##### 09:57:19 INFO - Running pre-action listener: _resource_record_pre_action 09:57:19 INFO - Running main action method: clobber 09:57:19 INFO - rmtree: /builds/slave/test/build 09:57:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:20 INFO - Running post-action listener: _resource_record_post_action 09:57:20 INFO - ##### 09:57:20 INFO - ##### Running read-buildbot-config step. 09:57:20 INFO - ##### 09:57:20 INFO - Running pre-action listener: _resource_record_pre_action 09:57:20 INFO - Running main action method: read_buildbot_config 09:57:20 INFO - Using buildbot properties: 09:57:20 INFO - { 09:57:20 INFO - "properties": { 09:57:20 INFO - "buildnumber": 568, 09:57:20 INFO - "product": "firefox", 09:57:20 INFO - "script_repo_revision": "production", 09:57:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:57:20 INFO - "repository": "", 09:57:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:57:20 INFO - "buildid": "20151211091433", 09:57:20 INFO - "slavename": "talos-linux64-ix-048", 09:57:20 INFO - "pgo_build": "False", 09:57:20 INFO - "basedir": "/builds/slave/test", 09:57:20 INFO - "project": "", 09:57:20 INFO - "platform": "ubuntu64_hw", 09:57:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:57:20 INFO - "slavebuilddir": "test", 09:57:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:57:20 INFO - "branch": "fx-team", 09:57:20 INFO - "repo_path": "integration/fx-team", 09:57:20 INFO - "stage_platform": "linux64", 09:57:20 INFO - "builduid": "f34c110e3d134b089f053d0484b3e4db", 09:57:20 INFO - "revision": "d8ce27c85590380ef025bb4ed66e564a4dff9bff" 09:57:20 INFO - }, 09:57:20 INFO - "sourcestamp": { 09:57:20 INFO - "repository": "", 09:57:20 INFO - "hasPatch": false, 09:57:20 INFO - "project": "", 09:57:20 INFO - "branch": "fx-team-linux64-talos", 09:57:20 INFO - "changes": [ 09:57:20 INFO - { 09:57:20 INFO - "category": null, 09:57:20 INFO - "files": [ 09:57:20 INFO - { 09:57:20 INFO - "url": null, 09:57:20 INFO - "name": "https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:57:20 INFO - } 09:57:20 INFO - ], 09:57:20 INFO - "repository": "", 09:57:20 INFO - "rev": "d8ce27c85590380ef025bb4ed66e564a4dff9bff", 09:57:20 INFO - "who": "maglione.k@gmail.com", 09:57:20 INFO - "when": 1449856595, 09:57:20 INFO - "number": 7350997, 09:57:20 INFO - "comments": "Bug 1229874: Support defineLazyServiceGetter in components-import eslint helper. r=miker", 09:57:20 INFO - "project": "", 09:57:20 INFO - "at": "Fri 11 Dec 2015 09:56:35", 09:57:20 INFO - "branch": "fx-team-linux64-talos", 09:57:20 INFO - "revlink": "", 09:57:20 INFO - "properties": [ 09:57:20 INFO - [ 09:57:20 INFO - "buildid", 09:57:20 INFO - "20151211091433", 09:57:20 INFO - "Change" 09:57:20 INFO - ], 09:57:20 INFO - [ 09:57:20 INFO - "builduid", 09:57:20 INFO - "f34c110e3d134b089f053d0484b3e4db", 09:57:20 INFO - "Change" 09:57:20 INFO - ], 09:57:20 INFO - [ 09:57:20 INFO - "pgo_build", 09:57:20 INFO - "False", 09:57:20 INFO - "Change" 09:57:20 INFO - ] 09:57:20 INFO - ], 09:57:20 INFO - "revision": "d8ce27c85590380ef025bb4ed66e564a4dff9bff" 09:57:20 INFO - } 09:57:20 INFO - ], 09:57:20 INFO - "revision": "d8ce27c85590380ef025bb4ed66e564a4dff9bff" 09:57:20 INFO - } 09:57:20 INFO - } 09:57:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:57:20 INFO - Running post-action listener: _resource_record_post_action 09:57:20 INFO - ##### 09:57:20 INFO - ##### Running download-and-extract step. 09:57:20 INFO - ##### 09:57:20 INFO - Running pre-action listener: _resource_record_pre_action 09:57:20 INFO - Running main action method: download_and_extract 09:57:20 INFO - mkdir: /builds/slave/test/build/tests 09:57:20 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')]} 09:57:20 INFO - https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:57:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/test_packages.json 09:57:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/test_packages.json 09:57:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:57:20 INFO - Downloaded 1302 bytes. 09:57:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:57:20 INFO - Using the following test package requirements: 09:57:20 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:20 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:20 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:20 INFO - u'jsshell-linux-x86_64.zip'], 09:57:20 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:20 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:20 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:57:20 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:57:20 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:20 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:20 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:20 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:20 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')]} 09:57:20 INFO - https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:21 INFO - Downloaded 21874385 bytes. 09:57:21 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 09:57:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:21 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 09:57:22 INFO - Return code: 0 09:57:22 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 09:57:22 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')]} 09:57:22 INFO - https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:24 INFO - Downloaded 21874385 bytes. 09:57:24 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 09:57:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:24 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 09:57:25 INFO - Return code: 0 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:25 INFO - https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:26 INFO - Downloaded 11132038 bytes. 09:57:26 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 09:57:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:26 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 09:57:26 INFO - Return code: 0 09:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:26 INFO - https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfTivFILQa6uNtITIHHG8g/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 09:57:27 INFO - Downloaded 57727822 bytes. 09:57:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:27 INFO - mkdir: /builds/slave/test/properties 09:57:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:27 INFO - Contents: 09:57:27 INFO - build_url:https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:27 INFO - Running post-action listener: _resource_record_post_action 09:57:27 INFO - Running post-action listener: set_extra_try_arguments 09:57:27 INFO - ##### 09:57:27 INFO - ##### Running populate-webroot step. 09:57:27 INFO - ##### 09:57:27 INFO - Running pre-action listener: _resource_record_pre_action 09:57:27 INFO - Running main action method: populate_webroot 09:57:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:27 INFO - '--tppagecycles', 09:57:27 INFO - '7'], 09:57:27 INFO - 'tests': ['tsvgm']}}, 09:57:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:57:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'tests': ['damp', 'tps']}, 09:57:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['damp', 'tps']}, 09:57:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:57:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:27 INFO - 'other': {'tests': ['a11yr', 09:57:27 INFO - 'ts_paint', 09:57:27 INFO - 'tpaint', 09:57:27 INFO - 'sessionrestore', 09:57:27 INFO - 'sessionrestore_no_auto_restore']}, 09:57:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['a11yr', 09:57:27 INFO - 'ts_paint', 09:57:27 INFO - 'tpaint', 09:57:27 INFO - 'sessionrestore', 09:57:27 INFO - 'sessionrestore_no_auto_restore']}, 09:57:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['a11yr', 09:57:27 INFO - 'ts_paint', 09:57:27 INFO - 'tpaint', 09:57:27 INFO - 'sessionrestore', 09:57:27 INFO - 'sessionrestore_no_auto_restore']}, 09:57:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['a11yr', 09:57:27 INFO - 'ts_paint', 09:57:27 INFO - 'tpaint', 09:57:27 INFO - 'sessionrestore', 09:57:27 INFO - 'sessionrestore_no_auto_restore']}, 09:57:27 INFO - 'other_l64': {'tests': ['a11yr', 09:57:27 INFO - 'ts_paint', 09:57:27 INFO - 'tpaint', 09:57:27 INFO - 'sessionrestore', 09:57:27 INFO - 'sessionrestore_no_auto_restore']}, 09:57:27 INFO - 'other_nol64': {'tests': ['a11yr', 09:57:27 INFO - 'ts_paint', 09:57:27 INFO - 'tpaint', 09:57:27 INFO - 'sessionrestore', 09:57:27 INFO - 'sessionrestore_no_auto_restore']}, 09:57:27 INFO - 'svgr': {'tests': ['tsvgx', 09:57:27 INFO - 'tsvgr_opacity', 09:57:27 INFO - 'tart', 09:57:27 INFO - 'tscrollx', 09:57:27 INFO - 'cart']}, 09:57:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['tsvgx', 09:57:27 INFO - 'tsvgr_opacity', 09:57:27 INFO - 'tart', 09:57:27 INFO - 'tscrollx', 09:57:27 INFO - 'cart']}, 09:57:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'tests': ['tp5o']}, 09:57:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'talos_options': ['--e10s'], 09:57:27 INFO - 'tests': ['tp5o']}, 09:57:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'talos_options': ['--xperf_path', 09:57:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:27 INFO - 'tests': ['tp5n']}, 09:57:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:27 INFO - 'talos_options': ['--e10s', 09:57:27 INFO - '--xperf_path', 09:57:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:27 INFO - 'tests': ['tp5n']}}, 09:57:27 INFO - 'talos.zip': {'path': '', 09:57:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:27 INFO - Running post-action listener: _resource_record_post_action 09:57:27 INFO - ##### 09:57:27 INFO - ##### Running create-virtualenv step. 09:57:27 INFO - ##### 09:57:27 INFO - Running pre-action listener: _resource_record_pre_action 09:57:27 INFO - Running main action method: create_virtualenv 09:57:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:27 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 09:57:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:27 INFO - Using real prefix '/usr' 09:57:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:30 INFO - Installing pip.................done. 09:57:30 INFO - Return code: 0 09:57:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:30 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')]} 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:30 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')]} 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:30 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:30 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 09:57:30 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 09:57:30 INFO - Using env: {'DISPLAY': ':0', 09:57:30 INFO - 'HOME': '/home/cltbld', 09:57:30 INFO - 'LANG': 'en_US.UTF-8', 09:57:30 INFO - 'LANGUAGE': 'en_US:en', 09:57:30 INFO - 'LOGNAME': 'cltbld', 09:57:30 INFO - 'MAIL': '/var/mail/cltbld', 09:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:30 INFO - 'MOZ_NO_REMOTE': '1', 09:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:30 INFO - 'NO_EM_RESTART': '1', 09:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:30 INFO - 'PWD': '/builds/slave/test', 09:57:30 INFO - 'SHELL': '/bin/bash', 09:57:30 INFO - 'SHLVL': '1', 09:57:30 INFO - 'TERM': 'linux', 09:57:30 INFO - 'TMOUT': '86400', 09:57:30 INFO - 'USER': 'cltbld', 09:57:30 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:30 INFO - '_': '/tools/buildbot/bin/python'} 09:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:30 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 09:57:30 INFO - Cleaning up... 09:57:30 INFO - Return code: 0 09:57:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:57:30 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')]} 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:30 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')]} 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:30 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:30 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 09:57:30 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 09:57:30 INFO - Using env: {'DISPLAY': ':0', 09:57:30 INFO - 'HOME': '/home/cltbld', 09:57:30 INFO - 'LANG': 'en_US.UTF-8', 09:57:30 INFO - 'LANGUAGE': 'en_US:en', 09:57:30 INFO - 'LOGNAME': 'cltbld', 09:57:30 INFO - 'MAIL': '/var/mail/cltbld', 09:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:30 INFO - 'MOZ_NO_REMOTE': '1', 09:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:30 INFO - 'NO_EM_RESTART': '1', 09:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:30 INFO - 'PWD': '/builds/slave/test', 09:57:30 INFO - 'SHELL': '/bin/bash', 09:57:30 INFO - 'SHLVL': '1', 09:57:30 INFO - 'TERM': 'linux', 09:57:30 INFO - 'TMOUT': '86400', 09:57:30 INFO - 'USER': 'cltbld', 09:57:30 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:30 INFO - '_': '/tools/buildbot/bin/python'} 09:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:30 INFO - Downloading/unpacking psutil>=0.7.1 09:57:30 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 09:57:30 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 09:57:30 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 09:57:30 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 09:57:30 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 09:57:30 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 09:57:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:57:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:32 INFO - Installing collected packages: psutil 09:57:32 INFO - Running setup.py install for psutil 09:57:32 INFO - building 'psutil._psutil_linux' extension 09:57:32 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 09:57:32 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 09:57:32 INFO - building 'psutil._psutil_posix' extension 09:57:32 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 09:57:33 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 09:57:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:33 INFO - Successfully installed psutil 09:57:33 INFO - Cleaning up... 09:57:33 INFO - Return code: 0 09:57:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:33 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:33 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 09:57:33 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 09:57:33 INFO - Using env: {'DISPLAY': ':0', 09:57:33 INFO - 'HOME': '/home/cltbld', 09:57:33 INFO - 'LANG': 'en_US.UTF-8', 09:57:33 INFO - 'LANGUAGE': 'en_US:en', 09:57:33 INFO - 'LOGNAME': 'cltbld', 09:57:33 INFO - 'MAIL': '/var/mail/cltbld', 09:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:33 INFO - 'MOZ_NO_REMOTE': '1', 09:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:33 INFO - 'NO_EM_RESTART': '1', 09:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:33 INFO - 'PWD': '/builds/slave/test', 09:57:33 INFO - 'SHELL': '/bin/bash', 09:57:33 INFO - 'SHLVL': '1', 09:57:33 INFO - 'TERM': 'linux', 09:57:33 INFO - 'TMOUT': '86400', 09:57:33 INFO - 'USER': 'cltbld', 09:57:33 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:33 INFO - '_': '/tools/buildbot/bin/python'} 09:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:33 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 09:57:33 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 09:57:33 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 09:57:33 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 09:57:33 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 09:57:33 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 09:57:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:35 INFO - Installing collected packages: mozsystemmonitor 09:57:35 INFO - Running setup.py install for mozsystemmonitor 09:57:35 INFO - Successfully installed mozsystemmonitor 09:57:35 INFO - Cleaning up... 09:57:35 INFO - Return code: 0 09:57:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:35 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')]} 09:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:35 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')]} 09:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:35 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:35 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 09:57:35 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 09:57:35 INFO - Using env: {'DISPLAY': ':0', 09:57:35 INFO - 'HOME': '/home/cltbld', 09:57:35 INFO - 'LANG': 'en_US.UTF-8', 09:57:35 INFO - 'LANGUAGE': 'en_US:en', 09:57:35 INFO - 'LOGNAME': 'cltbld', 09:57:35 INFO - 'MAIL': '/var/mail/cltbld', 09:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:35 INFO - 'MOZ_NO_REMOTE': '1', 09:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:35 INFO - 'NO_EM_RESTART': '1', 09:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:35 INFO - 'PWD': '/builds/slave/test', 09:57:35 INFO - 'SHELL': '/bin/bash', 09:57:35 INFO - 'SHLVL': '1', 09:57:35 INFO - 'TERM': 'linux', 09:57:35 INFO - 'TMOUT': '86400', 09:57:35 INFO - 'USER': 'cltbld', 09:57:35 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:35 INFO - '_': '/tools/buildbot/bin/python'} 09:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:35 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 09:57:35 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 09:57:35 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 09:57:35 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 09:57:35 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 09:57:35 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 09:57:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 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 09:57:37 INFO - Downloading docopt-0.6.1.tar.gz 09:57:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:38 INFO - Running setup.py install for blobuploader 09:57:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:38 INFO - Running setup.py install for requests 09:57:38 INFO - Running setup.py install for docopt 09:57:38 INFO - Successfully installed blobuploader requests docopt 09:57:38 INFO - Cleaning up... 09:57:38 INFO - Return code: 0 09:57:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:38 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:38 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 09:57:38 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 09:57:38 INFO - Using env: {'DISPLAY': ':0', 09:57:38 INFO - 'HOME': '/home/cltbld', 09:57:38 INFO - 'LANG': 'en_US.UTF-8', 09:57:38 INFO - 'LANGUAGE': 'en_US:en', 09:57:38 INFO - 'LOGNAME': 'cltbld', 09:57:38 INFO - 'MAIL': '/var/mail/cltbld', 09:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:38 INFO - 'MOZ_NO_REMOTE': '1', 09:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:38 INFO - 'NO_EM_RESTART': '1', 09:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:38 INFO - 'PWD': '/builds/slave/test', 09:57:38 INFO - 'SHELL': '/bin/bash', 09:57:38 INFO - 'SHLVL': '1', 09:57:38 INFO - 'TERM': 'linux', 09:57:38 INFO - 'TMOUT': '86400', 09:57:38 INFO - 'USER': 'cltbld', 09:57:38 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:38 INFO - '_': '/tools/buildbot/bin/python'} 09:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:38 INFO - Running setup.py (path:/tmp/pip-Fe242v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:38 INFO - Running setup.py (path:/tmp/pip-x2MNMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:39 INFO - Running setup.py (path:/tmp/pip-xy63Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:39 INFO - Running setup.py (path:/tmp/pip-J7KqvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:39 INFO - Running setup.py (path:/tmp/pip-BNSgz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:39 INFO - Running setup.py (path:/tmp/pip-8WpAse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:39 INFO - Running setup.py (path:/tmp/pip-_hXMom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:39 INFO - Running setup.py (path:/tmp/pip-ZXOrAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:39 INFO - Running setup.py (path:/tmp/pip-wPEzfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:39 INFO - Running setup.py (path:/tmp/pip-fNsipF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:39 INFO - Running setup.py (path:/tmp/pip-9M8DPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:39 INFO - Running setup.py (path:/tmp/pip-P9eUWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:39 INFO - Running setup.py (path:/tmp/pip-kHJPoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:39 INFO - Running setup.py (path:/tmp/pip-Su_zIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:39 INFO - Running setup.py (path:/tmp/pip-SBnFG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:39 INFO - Running setup.py (path:/tmp/pip-WGjUrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:40 INFO - Running setup.py (path:/tmp/pip-gEKbJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:40 INFO - Running setup.py install for manifestparser 09:57:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozcrash 09:57:40 INFO - Running setup.py install for mozdebug 09:57:40 INFO - Running setup.py install for mozdevice 09:57:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozfile 09:57:40 INFO - Running setup.py install for mozhttpd 09:57:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozinfo 09:57:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozInstall 09:57:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozleak 09:57:41 INFO - Running setup.py install for mozlog 09:57:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for moznetwork 09:57:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for mozprocess 09:57:41 INFO - Running setup.py install for mozprofile 09:57:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for mozrunner 09:57:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for mozscreenshot 09:57:41 INFO - Running setup.py install for moztest 09:57:41 INFO - Running setup.py install for mozversion 09:57:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:41 INFO - Cleaning up... 09:57:41 INFO - Return code: 0 09:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:41 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')]} 09:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:41 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')]} 09:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:41 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:41 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 09:57:41 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 09:57:41 INFO - Using env: {'DISPLAY': ':0', 09:57:41 INFO - 'HOME': '/home/cltbld', 09:57:41 INFO - 'LANG': 'en_US.UTF-8', 09:57:41 INFO - 'LANGUAGE': 'en_US:en', 09:57:41 INFO - 'LOGNAME': 'cltbld', 09:57:41 INFO - 'MAIL': '/var/mail/cltbld', 09:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:41 INFO - 'MOZ_NO_REMOTE': '1', 09:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:41 INFO - 'NO_EM_RESTART': '1', 09:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:41 INFO - 'PWD': '/builds/slave/test', 09:57:41 INFO - 'SHELL': '/bin/bash', 09:57:41 INFO - 'SHLVL': '1', 09:57:41 INFO - 'TERM': 'linux', 09:57:41 INFO - 'TMOUT': '86400', 09:57:41 INFO - 'USER': 'cltbld', 09:57:41 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:41 INFO - '_': '/tools/buildbot/bin/python'} 09:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:42 INFO - Running setup.py (path:/tmp/pip-sVMI2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:42 INFO - Running setup.py (path:/tmp/pip-5LRG2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:42 INFO - Running setup.py (path:/tmp/pip-Z08FeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:42 INFO - Running setup.py (path:/tmp/pip-joxuFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:42 INFO - Running setup.py (path:/tmp/pip-OVKr2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:42 INFO - Running setup.py (path:/tmp/pip-UDeyjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:42 INFO - Running setup.py (path:/tmp/pip-Ahe0Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:42 INFO - Running setup.py (path:/tmp/pip-03PFET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:42 INFO - Running setup.py (path:/tmp/pip-19lnYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:42 INFO - Running setup.py (path:/tmp/pip-DJQk6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:42 INFO - Running setup.py (path:/tmp/pip-6aqwB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:42 INFO - Running setup.py (path:/tmp/pip-_8wZmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:42 INFO - Running setup.py (path:/tmp/pip-nNh_9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:43 INFO - Running setup.py (path:/tmp/pip-0f40XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:43 INFO - Running setup.py (path:/tmp/pip-spQgrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:43 INFO - Running setup.py (path:/tmp/pip-ZtNcpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:43 INFO - Running setup.py (path:/tmp/pip-San321-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:43 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)) 09:57:43 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)) 09:57:43 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)) 09:57:43 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)) 09:57:43 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)) 09:57:43 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)) 09:57:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:43 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 09:57:43 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 09:57:43 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 09:57:43 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 09:57:43 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 09:57:43 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 09:57:45 INFO - Downloading blessings-1.5.1.tar.gz 09:57:45 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 09:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:45 INFO - Installing collected packages: blessings 09:57:45 INFO - Running setup.py install for blessings 09:57:45 INFO - Successfully installed blessings 09:57:45 INFO - Cleaning up... 09:57:45 INFO - Return code: 0 09:57:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:45 INFO - Reading from file tmpfile_stdout 09:57:45 INFO - Current package versions: 09:57:45 INFO - argparse == 1.2.1 09:57:45 INFO - blessings == 1.5.1 09:57:45 INFO - blobuploader == 1.2.4 09:57:45 INFO - docopt == 0.6.1 09:57:45 INFO - manifestparser == 1.1 09:57:45 INFO - mozInstall == 1.12 09:57:45 INFO - mozcrash == 0.16 09:57:45 INFO - mozdebug == 0.1 09:57:45 INFO - mozdevice == 0.47 09:57:45 INFO - mozfile == 1.2 09:57:45 INFO - mozhttpd == 0.7 09:57:45 INFO - mozinfo == 0.9 09:57:45 INFO - mozleak == 0.1 09:57:45 INFO - mozlog == 3.1 09:57:45 INFO - moznetwork == 0.27 09:57:45 INFO - mozprocess == 0.22 09:57:45 INFO - mozprofile == 0.27 09:57:45 INFO - mozrunner == 6.11 09:57:45 INFO - mozscreenshot == 0.1 09:57:45 INFO - mozsystemmonitor == 0.0 09:57:45 INFO - moztest == 0.7 09:57:45 INFO - mozversion == 1.4 09:57:45 INFO - psutil == 3.1.1 09:57:45 INFO - requests == 1.2.3 09:57:45 INFO - wsgiref == 0.1.2 09:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:45 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 09:57:45 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 09:57:45 INFO - Using env: {'DISPLAY': ':0', 09:57:45 INFO - 'HOME': '/home/cltbld', 09:57:45 INFO - 'LANG': 'en_US.UTF-8', 09:57:45 INFO - 'LANGUAGE': 'en_US:en', 09:57:45 INFO - 'LOGNAME': 'cltbld', 09:57:45 INFO - 'MAIL': '/var/mail/cltbld', 09:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:45 INFO - 'MOZ_NO_REMOTE': '1', 09:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:45 INFO - 'NO_EM_RESTART': '1', 09:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:45 INFO - 'PWD': '/builds/slave/test', 09:57:45 INFO - 'SHELL': '/bin/bash', 09:57:45 INFO - 'SHLVL': '1', 09:57:45 INFO - 'TERM': 'linux', 09:57:45 INFO - 'TMOUT': '86400', 09:57:45 INFO - 'USER': 'cltbld', 09:57:45 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:45 INFO - '_': '/tools/buildbot/bin/python'} 09:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 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)) 09:57:45 INFO - Cleaning up... 09:57:45 INFO - Return code: 0 09:57:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:45 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:45 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 09:57:45 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 09:57:45 INFO - Using env: {'DISPLAY': ':0', 09:57:45 INFO - 'HOME': '/home/cltbld', 09:57:45 INFO - 'LANG': 'en_US.UTF-8', 09:57:45 INFO - 'LANGUAGE': 'en_US:en', 09:57:45 INFO - 'LOGNAME': 'cltbld', 09:57:45 INFO - 'MAIL': '/var/mail/cltbld', 09:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:45 INFO - 'MOZ_NO_REMOTE': '1', 09:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:45 INFO - 'NO_EM_RESTART': '1', 09:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:45 INFO - 'PWD': '/builds/slave/test', 09:57:45 INFO - 'SHELL': '/bin/bash', 09:57:45 INFO - 'SHLVL': '1', 09:57:45 INFO - 'TERM': 'linux', 09:57:45 INFO - 'TMOUT': '86400', 09:57:45 INFO - 'USER': 'cltbld', 09:57:45 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:45 INFO - '_': '/tools/buildbot/bin/python'} 09:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:45 INFO - Downloading/unpacking jsonschema 09:57:45 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 09:57:45 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 09:57:45 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 09:57:45 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 09:57:45 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 09:57:45 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 09:57:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:47 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 09:57:47 INFO - Downloading/unpacking functools32 (from jsonschema) 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:47 INFO - warning: no files found matching '*.txt' 09:57:47 INFO - no previously-included directories found matching 'build' 09:57:47 INFO - no previously-included directories found matching 'dist' 09:57:47 INFO - no previously-included directories found matching '.git*' 09:57:47 INFO - Installing collected packages: jsonschema, functools32 09:57:47 INFO - Running setup.py install for functools32 09:57:48 INFO - warning: no files found matching '*.txt' 09:57:48 INFO - no previously-included directories found matching 'build' 09:57:48 INFO - no previously-included directories found matching 'dist' 09:57:48 INFO - no previously-included directories found matching '.git*' 09:57:48 INFO - Successfully installed jsonschema functools32 09:57:48 INFO - Cleaning up... 09:57:48 INFO - Return code: 0 09:57:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:57:48 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')]} 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:48 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')]} 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:48 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 0x7f935b7a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', '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 09:57:48 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 09:57:48 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 09:57:48 INFO - Using env: {'DISPLAY': ':0', 09:57:48 INFO - 'HOME': '/home/cltbld', 09:57:48 INFO - 'LANG': 'en_US.UTF-8', 09:57:48 INFO - 'LANGUAGE': 'en_US:en', 09:57:48 INFO - 'LOGNAME': 'cltbld', 09:57:48 INFO - 'MAIL': '/var/mail/cltbld', 09:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:48 INFO - 'MOZ_NO_REMOTE': '1', 09:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:48 INFO - 'NO_EM_RESTART': '1', 09:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:48 INFO - 'PWD': '/builds/slave/test', 09:57:48 INFO - 'SHELL': '/bin/bash', 09:57:48 INFO - 'SHLVL': '1', 09:57:48 INFO - 'TERM': 'linux', 09:57:48 INFO - 'TMOUT': '86400', 09:57:48 INFO - 'USER': 'cltbld', 09:57:48 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:48 INFO - '_': '/tools/buildbot/bin/python'} 09:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:48 INFO - Downloading/unpacking flake8 09:57:48 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 09:57:48 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 09:57:48 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 09:57:48 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 09:57:48 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 09:57:48 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 09:57:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:57:49 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 09:57:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:57:49 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 09:57:49 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 09:57:49 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 09:57:49 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 09:57:49 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 09:57:49 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 09:57:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:57:50 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 09:57:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:50 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 09:57:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:50 INFO - no previously-included directories found matching 'docs/_build' 09:57:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:57:50 INFO - Running setup.py install for pep8 09:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:50 INFO - no previously-included directories found matching 'docs/_build' 09:57:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:57:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:57:50 INFO - Cleaning up... 09:57:50 INFO - Return code: 0 09:57:50 INFO - Running post-action listener: _resource_record_post_action 09:57:50 INFO - Running post-action listener: _start_resource_monitoring 09:57:50 INFO - Starting resource monitoring. 09:57:50 INFO - ##### 09:57:50 INFO - ##### Running install step. 09:57:50 INFO - ##### 09:57:50 INFO - Running pre-action listener: _resource_record_pre_action 09:57:50 INFO - Running main action method: install 09:57:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:51 INFO - Reading from file tmpfile_stdout 09:57:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:51 INFO - Reading from file tmpfile_stdout 09:57:51 INFO - Output received: 09:57:51 INFO - Usage: mozinstall [options] installer 09:57:51 INFO - Options: 09:57:51 INFO - -h, --help show this help message and exit 09:57:51 INFO - -d DEST, --destination=DEST 09:57:51 INFO - Directory to install application into. [default: 09:57:51 INFO - "/builds/slave/test"] 09:57:51 INFO - --app=APP Application being installed. [default: firefox] 09:57:51 INFO - mkdir: /builds/slave/test/build/application 09:57:51 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'] 09:57:51 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 09:58:05 INFO - Reading from file tmpfile_stdout 09:58:05 INFO - Output received: 09:58:05 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:05 INFO - Running post-action listener: _resource_record_post_action 09:58:05 INFO - ##### 09:58:05 INFO - ##### Running run-tests step. 09:58:05 INFO - ##### 09:58:05 INFO - Running pre-action listener: _resource_record_pre_action 09:58:05 INFO - Running main action method: run_tests 09:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:05 INFO - Python 2.7.3 09:58:05 INFO - Return code: 0 09:58:05 INFO - grabbing minidump binary from tooltool 09:58: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')]} 09:58:05 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 0x203d0b0>, '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 0x203dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:05 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 09:58:05 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 09:58:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:05 INFO - Return code: 0 09:58:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:06 INFO - Return code: 0 09:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test/build 09:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 09:58:06 INFO - Using env: {'DISPLAY': ':0', 09:58:06 INFO - 'HOME': '/home/cltbld', 09:58:06 INFO - 'LANG': 'en_US.UTF-8', 09:58:06 INFO - 'LANGUAGE': 'en_US:en', 09:58:06 INFO - 'LOGNAME': 'cltbld', 09:58:06 INFO - 'MAIL': '/var/mail/cltbld', 09:58:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:06 INFO - 'MOZ_NO_REMOTE': '1', 09:58:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:06 INFO - 'NO_EM_RESTART': '1', 09:58:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:06 INFO - 'PWD': '/builds/slave/test', 09:58:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:06 INFO - 'SHELL': '/bin/bash', 09:58:06 INFO - 'SHLVL': '1', 09:58:06 INFO - 'TERM': 'linux', 09:58:06 INFO - 'TMOUT': '86400', 09:58:06 INFO - 'USER': 'cltbld', 09:58:06 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202', 09:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:06 INFO - '_': '/tools/buildbot/bin/python'} 09:58:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 09:58:06 INFO - mozversion INFO | application_buildid: 20151211091433 09:58:06 INFO - mozversion INFO | application_changeset: d8ce27c85590380ef025bb4ed66e564a4dff9bff 09:58:06 INFO - mozversion INFO | application_display_name: Nightly 09:58:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:06 INFO - mozversion INFO | application_name: Firefox 09:58:06 INFO - mozversion INFO | application_remotingname: firefox 09:58:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:58:06 INFO - mozversion INFO | application_vendor: Mozilla 09:58:06 INFO - mozversion INFO | application_version: 45.0a1 09:58:06 INFO - mozversion INFO | platform_buildid: 20151211091433 09:58:06 INFO - mozversion INFO | platform_changeset: d8ce27c85590380ef025bb4ed66e564a4dff9bff 09:58:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:58:06 INFO - mozversion INFO | platform_version: 45.0a1 09:58:06 INFO - 2015-12-11 09:58:06,936 DEBUG : using testdate: 1449856686 09:58:06 INFO - 2015-12-11 09:58:06,936 DEBUG : actual date: 1449856686 09:58:06 INFO - 2015-12-11 09:58:06,947 INFO : starting webserver on 'localhost:60672' 09:58:06 INFO - 2015-12-11 09:58:06,948 INFO : Starting test suite talos-linux64-ix-048.e 09:58:06 INFO - 2015-12-11 09:58:06,948 INFO : Starting test dromaeo_css 09:58:06 INFO - 2015-12-11 09:58:06,949 DEBUG : operating with platform_type : linux_ 09:58:06 INFO - 2015-12-11 09:58:06,949 INFO : Initialising browser for dromaeo_css test... 09:58:06 INFO - 2015-12-11 09:58:06,966 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3bbZp/profile http://localhost:60672/getInfo.html 09:58:11 INFO - 2015-12-11 09:58:11,673 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:58:11 INFO - 2015-12-11 09:58:11,673 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:58:11 INFO - 2015-12-11 09:58:11,673 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:58:11 INFO - 2015-12-11 09:58:11,673 DEBUG : BROWSER_OUTPUT: __metrics 09:58:11 INFO - 2015-12-11 09:58:11,815 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:58:12 INFO - 2015-12-11 09:58:12,776 INFO : Browser initialized. 09:58:12 INFO - 2015-12-11 09:58:12,776 INFO : Running cycle 1/1 for dromaeo_css test... 09:58:12 INFO - 2015-12-11 09:58:12,777 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3bbZp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:58:24 INFO - 2015-12-11 09:58:24,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 142712832 09:58:24 INFO - 2015-12-11 09:58:24,777 DEBUG : BROWSER_OUTPUT: 09:59:14 INFO - 2015-12-11 09:59:14,409 DEBUG : BROWSER_OUTPUT: 1449856754405 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] 10:01:25 INFO - 2015-12-11 10:01:25,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60672/tests/dromaeo/cssquery-ext.html) 10:01:27 INFO - 2015-12-11 10:01:27,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 147554304 10:01:27 INFO - 2015-12-11 10:01:27,216 DEBUG : BROWSER_OUTPUT: 10:04:29 INFO - 2015-12-11 10:04:29,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/dromaeo/cssquery-ext.html (next: http://localhost:60672/tests/dromaeo/cssquery-jquery.html) 10:04:30 INFO - 2015-12-11 10:04:30,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 144953344 10:04:30 INFO - 2015-12-11 10:04:30,009 DEBUG : BROWSER_OUTPUT: 10:07:31 INFO - 2015-12-11 10:07:31,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60672/tests/dromaeo/cssquery-mootools.html) 10:07:32 INFO - 2015-12-11 10:07:32,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 146051072 10:07:32 INFO - 2015-12-11 10:07:32,381 DEBUG : BROWSER_OUTPUT: 10:10:34 INFO - 2015-12-11 10:10:34,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60672/tests/dromaeo/cssquery-prototype.html) 10:10:34 INFO - 2015-12-11 10:10:34,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 143323136 10:10:34 INFO - 2015-12-11 10:10:34,829 DEBUG : BROWSER_OUTPUT: 10:13:37 INFO - 2015-12-11 10:13:37,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60672/tests/dromaeo/cssquery-yui.html) 10:13:38 INFO - 2015-12-11 10:13:38,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 144740352 10:13:38 INFO - 2015-12-11 10:13:38,098 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/dromaeo/cssquery-yui.html (next: http://localhost:60672/tests/dromaeo/cssquery-dojo.html) 10:16:40 INFO - 2015-12-11 10:16:40,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 147468288 10:16:40 INFO - 2015-12-11 10:16:40,816 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,818 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:16:40 INFO - 2015-12-11 10:16:40,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:16:40 INFO - 2015-12-11 10:16:40,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:16:40 INFO - 2015-12-11 10:16:40,818 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:16:40 INFO - 2015-12-11 10:16:40,819 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.5722284434487;2724.0738149029326;2752.600872873433;2764.599133125697;2768.266409401508;4570.451545814507;4790.377250957375;4810.5189481051875;4827.034593081385;4829.179039563274;4570.428696412949;4701.7414042227665;4725.480197178307;4787.569118779309;4793.592544633701;4238.470191226097;4347.695661303702;4522.389477420539;4531.818727250906;4555.3850230218995;4218.303979843322;4439.977800111011;4510.751908645023;4518.186726389248;4527.20773864574;4307.655387568987;4335.08963117744;4371.4098596689355;4401.141777353418;4406.581374769392;4393.03353262285;4400.559944005606;4405.0969551241915;4416.712913660602;4416.933745993812;4192.496900371975;4313.0726893718;4377.409049778303;4378.584034516748;4441.289393696993;4578.221702310615;4665.066986602693;4674.883127921795;4722;4730.952690473086;5113.897722045538;5152.201408781645;5157.226416037624;5161.071007218699;5213.061648903196;4970.055689419035;5071.822486212965;5089.8727531812;5179.741012949337;5223.973880130613;4656.16189085961;4706.1293660672545;4710.034442939189;4719.126961512131;4744.335792988984;5287.104248636791;5289;5323.653962492425;5323.893522129613;5358.812441564526;4811.4707382187935;5099.260607211933;5106.183010718267;5114.258432527337;5123.052235336475;4930.605551555867;5070.29015937769;5132.820351287687;5141.177411614124;5191.169412893919;5106.719130447861;5117.74411279442;5118.539331460112;5126.1798112302595;5158.613104017214;4841.370621819141;4947.802087916515;5083.161278389024;5092.312537807423;5104.387473503203;4195.622393984495;4236.237477254123;4236.3857240700545;4240.406343111967;4273.316269396882;3775.3581891078584;3778.7732736035928;3780.2494369313677;3787.4318852172396;3811.618838116166;4199.958000420018;4313.396124542566;4328.3723860040745;4421.027373977719;4439.489458712224;5161.200013997836;5185.818496352609;5206.505381988705;5212.817551385683;5246.396664383645;4448.822047118144;4451.577100175543;4458.4426946631675;4464.598186163261;4491.910161796745;4325.805338759764;4466.9553304466535;4556.225441674923;4622.791974361162;4652.348671186037;4768.450253667572;4815.2054910939305;4818.975905120452;4835.588974937099;4849.95150048495;5120.743962801919;5124.948750512447;5124.9743751281;5128.79484820603;5173.370388327665;4697.859064227942;4720.716756994591;4791.113643975876;4815.422149342101;4835.443923948791;5073.11220536412;5083.059633967728;5086.669366491166;5090.211017292326;5114.64197506171;4917.655764096622;5177.689338639693;5178.844634660966;5183.740812959261;5199.948000519947;4897.461279259207;4950.257461380822;4950.504949505021;4980.601551875914;5021.372328458942;5013.122703526796;5013.949860501494;5016.899662006813;5023.673461225008;5045.94035252601;4628.884277892945;4796.944672172117;4895.6083513318135;4907.950920490749;4934.358533390637;4923.138450771173;4936.9259461107395;4941.802327906988;4959.752012399438;4967.205247160437;4836.95163048365;4883.60931125502;4890.657653964188;4906.362172917497;4951.10880041596 10:16:40 INFO - 2015-12-11 10:16:40,821 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.2553406106123;578.8668606220568;583.0379873209205;588.602693182102;597.3190562758454;35144.824275878615;35933.1016724582;35945.82027089864;36100.2779944401;36254.45618315727;39324.213515729665;39469.80265098678;39508.604913950854;40045.39931901024;40092.79953600235;7871.80320491988;8067.515949043047;8069.193080691914;8071.031476222862;8102.270795628392;7903.0911445183965;8010.39922005849;8013.759587212393;8040.1959804019425;8058.879116813252;7898.170692077335;7966.5618390988475;7970.920290797105;7981.6009199540085;8013.078495972979;7752.496087754278;7766.068071831388;7790.220977902221;7807.570583617899;7836.451448398614;7845.882311765328;7893.605319733991;7955.840883182362;7964.16376280488;7993.640286187077;36664.45003324952;37123.81438092792;37132.814335928415;37285.62714372849;37305.440418393744;2958.4970555005702;3035.696430356969;3058.9388212235854;3072.0630207786617;3073.231692076981;27600.585991210148;27985;28013.719862801314;28091.71908280932;28230.294242644097;3461.2039230976766;3485.2680937003006;3510.2979404119023;3523.0311664292267;3564.3049605326974;198475;199546;199874.00062999738;199896;199914;50080.499195007586;51180.48819511757;52256.21615675768;52492;52495;63256;64441;64805;64873.351266487676;64883;11718;11739.589114380955;11780.52877884875;11838.585649502225;11872.168948173545;9813.607455701693;9827.606895724233;9893.752656183653;9898.30711850178;9909.157721593745;18656.253749849853;18799.624007519775;18902.90548547276;19011.80988190128;19040.80959190418;7334.449916256195;7722.189170137055;7731.304182623591;7754.961225193838;7757.495762775401;803.1767438375712;841.5035129273758;851.4252879306443;935.1677007463363;1021.1218352217087;26033.479330413287;26906.32734181622;27002.459950801265;27760.305992350353;28263.57604635932;919.5540163020929;960.4189465373348;967.5065716484644;1010.4796030044533;1047.7642530430592;12105.394730263451;12393.752124957451;12462.31457269859;12464.5014199431;12511.3744312784;252507;256560;257116;258590;259162;44698.55301446944;44912;45044.09911801811;45067.323990140176;45223.321650175276;1216.1122380662166;1221.1879100398135;1237.3256575166556;1237.566851601932;1237.789575772121;23806.960889845548;23910.875120959154;24015.469415013158;24087.459884226377;24132.155374561808;37644.81177594094;37873.62126378701;38197;38272.42591361076;38446.61553384542;241306;242119;242626;243054;244048;28360.71639283663;29058.27354316159;29199.7080029197;29215.123546293646;29426.705732942395;33887;34827.82586087054;37161.25677486381;37698.2460350786;38170.618293816704;31776.36447271088;32133.1966700825;32313;32747.34505309833;32761.836190818893;31857.33640631357;32138.678613213568;32493.35013299768;32603.836980814944;32607.18482037968;32507.674923250466;32519.18702032468;32552;32601.836990815842;33139.337213255116;25960.870195649655;25971;29741.702582973892;30027;30279.848600756854;21866.890665547206;23561.64657530104;23957.16149934744;23992.40018999539;24023.51952960896 10:16:40 INFO - 2015-12-11 10:16:40,824 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.11090341440143;329.2624521072797;329.99670003299974;331.80091944833106;334.1279261128453;14949.252537373128;15460.768088478682;15891.364345426198;16466.75299870503;16732.749008764877;10343.431111288875;10357.792844143112;10424.21818363622;12741.171823831468;15227.23863806808;4596.90806183877;4608.3778689876945;4710.387649605564;4711.929321060187;4718.57532822046;4506.571875671806;4521.728696278217;4540.523245059271;4550.385697930787;4557.361969324297;4515.571020753039;4538.523455037223;4918.065567542173;5081.364829396325;5101.132807422729;5009.9479109387075;5013.448520662742;5021.548060674539;5037.5214354636255;5057.241413787924;5115.7442127893455;5146.768395422215;5178.378594568676;5179.2749015137915;5191;11464.426778661034;11828.763424731544;14746.778798318033;18691.252349905986;18695.06524673761;1749.9912500437545;1763.4797734668175;1772.831580999803;1865.309835360925;1888.5089876632037;9169.358144929858;9242.491662958535;9302.20931220847;10627.937206279388;13056.34718264083;1681.218233521406;1737.5482374582573;1776.7956684981264;1797.5125830829982;1804.7022241330164;54757.45242547603;57762.71118644422;58338.7083064582;59525;59972.400275997556;9539.14147726708;9781.315307928377;9826.459544724965;9881.752956176153;10017.599296028076;12500.374981250901;12505.93747031259;12543.56097536582;12546.309952952493;12572.497100115894;6591.472682185414;6655.301193374626;6734.865302693918;6743.696533655997;6925.722971081201;6314.116023756677;6349.619022858643;6350.269718982284;6372.7132279047555;6377.489800815923;4202.117555313418;4212.957870421256;4270.850520231777;4288.699791014599;4294.033842385438;1694.466243133409;1750.9824901751074;1754.6929287374658;1758.1560850791436;1769.4691592522192;759.3355813663045;812.3298278919915;836;854.7008547008621;888.6756333938066;15423.383064677511;15581.143037133066;15898.841011589737;16024.75962860558;16307.673846523003;823.6622984576295;858.8539948208819;867.3061550759368;902.3548163063441;907.5462268865567;8976.596053177622;9212.216961558343;9222.170004699608;9280.350375473787;9331.953340233254;446366;453196;457281;459575;462935;69551.65224173847;71187.64406177936;71386;72021;75189.6240518794;1023.0230130225617;1036.7045392063226;1074.0601973273385;1075.725689949058;1083.182197440927;13728.862711372758;14297.785533216802;14350;14457.710845783236;14532.418703251751;29332.12003639894;29381.559276611297;29893;30711.539326909668;31134.53298200574;36440.27119457649;36550.26899462049;39834.40248396334;41003.38494922638;41706.58293417027;8833.293336532934;8973.820523589622;9127.132922372364;9163.175314221751;9164.770880727769;16234.837651623333;16630.417935372203;16649.833501664827;16776.58058548546;16833.158342082603;10924.945375273392;12373.62879113628;13292.401841916944;13733.45066197341;14344;12779.23324600527;13071.934640326737;13159.868401315864;13362.465501380224;13395.732085358433;13194.274314912773;13692.452301907811;13788.862111378758;13951.511697090553;14070.296485175904;8596.484210947363;8804.383693141419;8864.290856731575;9031.187193152648;9031.819363612822;12883.742325153256;13445.394957226752;13481.123726957716;13501;13923.860761392662 10:16:40 INFO - 2015-12-11 10:16:40,826 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1381.9704320281392;1663.7670726098345;1671.5486818558988;1706.5136436115702;1737.2008875917081;5834.679092649913;6191.257049154096;6478.74085036598;6846.760363387282;6855.657217139142;6776.593404395728;6909.48178886583;6958.304169583039;7051;7053.435725141976;2084.8019438153387;2115.629764791163;2123.7132987046707;2123.81947534459;2129.58473097746;2061;2070.534129820793;2107.4625970377533;2110.968335474969;2121.4802373418534;2066.442060643633;2089.8641588296787;2090.602785470763;2118.692789545515;2120.385088324384;2079.8128168464837;2111.123883588317;2114.5770845830893;2115.270231770037;2116.4179850541223;2041.9081141348674;2064.112431654388;2088.749350077985;2090.320645790124;2094.3821572636107;7054.118235220598;7077.433805295564;7105.644717764143;7136.714531418737;7179.3179647933885;4230.8153716959305;4287.871363859089;4296.591823776736;4314.590113939171;4315.697901146921;2669.8859611489665;2699.91900242993;2779.3885345224016;2790.497710412125;2798.3144129688153;873.6549063120095;1686.342326492669;1730.2214003698386;1753.8333858283443;1761.9561308881764;9288.11762882525;9467.952660236724;9469.384490008197;9488.335816492849;9501.287403444769;3804.7336686431686;3816.6183381661613;3821.082940094413;3863.690904727615;3873.360895452275;7609.505382150142;7668.65491052904;7677.155512893689;7691.961540192375;7724.6523906424345;4142.71001029925;4160.583941605876;4190.078182799779;4194.203101410722;4195.223883581547;3230.4346739320995;3303.570535830375;3781.3193625147187;3817.4655548222718;3831.7892515911335;3063.065764941714;3079.2455848317304;3092.149658843836;3097.845107744604;3132.263917979273;867.2974890338845;868.3140319147802;870.4994628088748;871.1680345270252;872.6291326186346;981.4209616326401;991.1426615977127;995.0845222395413;995.6117114325419;1039.740064983754;6769.120014398097;6770.1537307836525;6774.593524388552;6807.897881531781;6815.045893574805;430.2234466787416;436.4152036271412;1093.6664317383274;1133.121830581306;1133.9433028348715;5282.735863206901;5300.522952934254;5312.04383211018;5331.360236771612;5404.567634589223;8269.29710974574;8361.916380836235;8457.534835584102;8472.576371181416;8505.914940850513;8096.433249672584;8285.917140828635;8330;8342.916570834213;8383.664653413916;6739.932600674028;6776.796696099125;6780.660966951633;6793.728250870009;6822.863542729117;6604.603723776589;6697.966510167418;6708.463322934251;6726.764563240459;6753.15585551806;7518.135414427192;7592.544447333178;7637.121731000784;7672.654730537028;7767.611619419119;7664.540127592362;7707.267809558307;7794.92205077942;7812.492188007988;7854.921450785419;5097.8215762448135;5281.815136470205;6187.783427580013;6266.937330626635;6273.905891411541;6131.693415329305;6490.188726409199;6517.674116294261;6531.477481801349;6574.211094668671;6166.383361663798;6229.595076320024;6288.151099601495;6399.712012959521;6482.35176482348;6188.690565471798;6266.655333956676;6282.905756413749;6353.809385718436;6443.387878151568;6283.905741413791;6296.150019747459;6300.432961033529;6307.810765677037;6320.399562041599;5860.120981852756;5920.289565252025;5939;5942.702864856654;5952.940470595412;5903.940960590511;5919.940800592111;6081.087836824512;6095.603785753912;6115.6330620162935 10:16:40 INFO - 2015-12-11 10:16:40,827 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.4314880153308;303.64625211628453;307.554046632383;308.7499125708178;312.72792670376776;5539.335279766428;5565.053940830058;5598.6640801551885;5744.913826292609;5765.308163020443;5570.777168913239;5603.159526071091;5641.746121424536;5646.463585959327;5655.971720141404;4222.324428091506;4309.396684464177;4340.696151269412;4346.760928148959;4347.08711170653;4280.850170244042;4295.248331541983;4310.698251122407;4314.80583373749;4328.264195086827;4258.382534532491;4259.552746961571;4260.957390426087;4266.679999000072;4269.252880745873;4262.467191601035;4263;4268;4277.823598510404;4282.229198744225;3611.205534782344;3699.6300369963055;3719.0516418313427;3721.106934335767;3732.0669832541867;5181.870453238662;5339.733013349317;5347.491988261109;5352.464753524655;5359.115745901921;4911.680740751875;4916.262560615901;4917.164082106051;4917.262410638397;4922.409310882681;5893.6463812171405;5908.14331921869;5922.022866227067;5926.585139040269;5944.64332140073;3882.0877093882914;3995.98002009991;4009.799510024487;4026.154507553388;4049.250888585592;6174.722137503823;6232.470240029603;6236.469900058455;6238.87522249557;6243.8126856194385;4134;4136.048708796993;4136.193442278727;4136.689748268892;4146.688998325138;4201;4203.054312779661;4205.201011807808;4208.36874468826;4208.684348673801;4758.405199350082;4826.276058591239;4847.466778654345;4853.369062021915;4863.610911127102;5879.323877754027;5886.735096920649;5895.056790913433;5898;5900.380460051719;1482.8443013483645;1483.3250870853735;1491.1798510819006;1493.4175671488129;1493.7311283968772;994.7065615643403;996.1333639733333;998.1366118307611;1012.099231683802;1014.6651604970342;5085.313482679865;5105.33630628016;5106.642535022513;5108.361454818148;5114.74426278692;5983.461488466059;6090.878182436327;6092.482139018233;6093.9390606093375;6107;5060.240963855451;5079.263506791568;5095;5107.565856902131;5111.105556527667;3229.0958531611186;3302.2239773653173;3309.8179600121744;3330.4171769940162;3331.700146986783;5626.549876009909;5787.102999035156;5804.245448091721;5808.186853840466;5825.854353641108;6370.012648039468;6398.200224971879;6401.583897046677;6413.134226879311;6420.807375778734;5793.420657934173;5800;5801.129830525455;5810.070388737866;5816.88366232673;5990.700464976647;6163.9383606163365;6171.84570385744;6195.876082478415;6197.690115494117;5991.580589358878;6032.426919442646;6040.305364882919;6047.818565443044;6065.090236464389;5801.680907550125;5807.186993820784;5809.041508151107;5818.0981947798155;5823.155642431739;4122.3404255319;4184.790760462026;4186.099988502487;4195.895102622337;4203.096334288142;6049;6165.753369865155;6177.320494745664;6190.659513726789;6194.287656919512;5922.496587790086;5945;5950.9404905952115;5956.702164891652;5965.761369545343;5931.792387266425;5949.851253718692;5951.226340575698;5958.433948774859;5976.193213916065;5673.432656734293;5756.3380211276235;5825.94174058254;5831.679257640701;5845.09401042839;5948.851278718067;5988.580799344004;6008.609440386361;6015.157877897011;6028.4272994065495;5819.301683797971;5820.505257053198;5831.300243970751;5839.5036421904615;5860.472557469848 10:16:40 INFO - 2015-12-11 10:16:40,827 DEBUG : BROWSER_OUTPUT: |5;yui.html;732.2494443195724;743.8884167374894;758.6661868777737;780.7072347869547;799.5122974985262;11250;13523.864761352395;13757.105788123765;13806.240656763874;13830.654233644163;13500.054996150273;13655.590332290023;13660.180389176656;13667.589972300822;13668;792.9008873890778;801.0787594266582;805.7502174325978;805.8428606421721;807.8020884883182;802.1296892871242;814.4136221920238;818.0633175014605;818.8075802186481;825.6697321071559;840.7477756673004;845.7927807687125;846.8814365988736;852.0669866496177;853.5817449449787;839.9790005249856;842.30509829391;842.5408152556871;843.9198276163785;845.5814371885895;622.7695752571532;624.572168064877;626.1797045869924;626.6553395632429;627.2473032361185;11498.25261358009;11577.594784182513;11581.073514118934;11601.129915256304;11642.417879106011;10668.253222274443;10727.141828653766;10978.231523793338;11314.264572802824;11373.772524549462;9356.719298421058;9418.717438476857;9598.6640467584;9633.22934165272;9740.805183896282;3100.2404410919244;3110.5645209670665;3128.139761565565;3148.5434611981364;3162.76279279055;42166.367504487454;42288.788556057334;42368;42668.57331426677;42792.14415711699;9140.908590914005;9205.40119449485;9363;9447.858282125773;9463.76340591477;15851.603709907344;15880.52358429249;15918.124503152438;15925;16062.75905861413;6239.594426362272;6417.197850268716;6427.807165785034;6449.5485316027425;6580.078788969548;3458.221900072514;3575.588807287143;3611.7291203159866;3612;3659.2864391443413;2490.3151633300986;2520.4959008198434;2527.6082207257905;2531.4304281536874;2532.025170309444;477.6012029954957;482;482.0696056610775;483.135188013459;485.7231378114511;447.11471286851565;519.3689667054547;556.7661582135432;570.6433479075578;578.3609111931339;6637.502187335969;7262.527935684164;7619.657115429819;7782.299593036654;7873.291403773574;448.5536890793681;457.7482384688475;493.64704236471096;512.9615278854101;573.489594261108;3480.3039392121173;3537.1510837399355;3836.271108489378;3970.5433875104154;4020.4773379460485;49725;50117.74941125271;50222.24666630004;50432;50667.74666126646;43427.34858977118;43845.78077109594;44237.8940526483;44248.55751442444;44393.55606443894;39904.800475997436;40438.59561404349;40574.79712601477;40885.795571021954;41043.58956410457;7841.1766764491185;7951.165127661512;8094.231048050426;8226;8231.588420579066;28737;29020.419591608472;29273.70726292795;30266.697333026386;32756.344873101927;38753.03117422087;38858.6114138855;39407;40423.59576404198;40823.79588102041;9494.667686630935;9788.412695238309;9963.103320701171;10062.094411503;10122.291439599157;10906.672799816019;11046.834297485384;11212.103031757602;11241.775164496828;11360.431978401211;10390.3246288994;10410.27128101056;10729.248952573245;10936;10967.287126336763;10177.185825133824;10337.328073675188;10404.11565016982;10453.529591168264;10953.233273670767;9477.336586439158;9737.318387713076;9788.363756355815;10025;10718.571257149939;8815.911840881508;8919.821603568022;9076.41003334781;9134.665430734096;9271.443713377219;9313.580888859882;9407.623695052394;9445.24438044941;9463.526823658927;9546.331756776959 10:16:40 INFO - 2015-12-11 10:16:40,827 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:16:40 INFO - 2015-12-11 10:16:40,827 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:16:40 INFO - 2015-12-11 10:16:40,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 10:16:40 INFO - 2015-12-11 10:16:40,827 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:16:40 INFO - 2015-12-11 10:16:40,827 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857800816__endTimestamp 10:16:40 INFO - 2015-12-11 10:16:40,828 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,828 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:16:40 INFO - 2015-12-11 10:16:40,828 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:16:40 INFO - 2015-12-11 10:16:40,828 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,828 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4715.56 Median:4818.98 stddev:498.05 (10.3%) stddev-sans-first:473.12 10:16:40 INFO - 2015-12-11 10:16:40,829 DEBUG : BROWSER_OUTPUT: Values: 2673.6 2724.1 2752.6 2764.6 2768.3 4570.5 4790.4 4810.5 4827.0 4829.2 4570.4 4701.7 4725.5 4787.6 4793.6 4238.5 4347.7 4522.4 4531.8 4555.4 4218.3 4440.0 4510.8 4518.2 4527.2 4307.7 4335.1 4371.4 4401.1 4406.6 4393.0 4400.6 4405.1 4416.7 4416.9 4192.5 4313.1 4377.4 4378.6 4441.3 4578.2 4665.1 4674.9 4722.0 4731.0 5113.9 5152.2 5157.2 5161.1 5213.1 4970.1 5071.8 5089.9 5179.7 5224.0 4656.2 4706.1 4710.0 4719.1 4744.3 5287.1 5289.0 5323.7 5323.9 5358.8 4811.5 5099.3 5106.2 5114.3 5123.1 4930.6 5070.3 5132.8 5141.2 5191.2 5106.7 5117.7 5118.5 5126.2 5158.6 4841.4 4947.8 5083.2 5092.3 5104.4 4195.6 4236.2 4236.4 4240.4 4273.3 3775.4 3778.8 3780.2 3787.4 3811.6 4200.0 4313.4 4328.4 4421.0 4439.5 5161.2 5185.8 5206.5 5212.8 5246.4 4448.8 4451.6 4458.4 4464.6 4491.9 4325.8 4467.0 4556.2 4622.8 4652.3 4768.5 4815.2 4819.0 4835.6 4850.0 5120.7 5124.9 5125.0 5128.8 5173.4 4697.9 4720.7 4791.1 4815.4 4835.4 5073.1 5083.1 5086.7 5090.2 5114.6 4917.7 5177.7 5178.8 5183.7 5199.9 4897.5 4950.3 4950.5 4980.6 5021.4 5013.1 5013.9 5016.9 5023.7 5045.9 4628.9 4796.9 4895.6 4908.0 4934.4 4923.1 4936.9 4941.8 4959.8 4967.2 4837.0 4883.6 4890.7 4906.4 4951.1 10:16:40 INFO - 2015-12-11 10:16:40,830 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,830 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39311.15 Median:19156.55 stddev:61060.48 (318.7%) stddev-sans-first:61162.50 10:16:40 INFO - 2015-12-11 10:16:40,830 DEBUG : BROWSER_OUTPUT: Values: 577.3 578.9 583.0 588.6 597.3 35144.8 35933.1 35945.8 36100.3 36254.5 39324.2 39469.8 39508.6 40045.4 40092.8 7871.8 8067.5 8069.2 8071.0 8102.3 7903.1 8010.4 8013.8 8040.2 8058.9 7898.2 7966.6 7970.9 7981.6 8013.1 7752.5 7766.1 7790.2 7807.6 7836.5 7845.9 7893.6 7955.8 7964.2 7993.6 36664.5 37123.8 37132.8 37285.6 37305.4 2958.5 3035.7 3058.9 3072.1 3073.2 27600.6 27985.0 28013.7 28091.7 28230.3 3461.2 3485.3 3510.3 3523.0 3564.3 198475.0 199546.0 199874.0 199896.0 199914.0 50080.5 51180.5 52256.2 52492.0 52495.0 63256.0 64441.0 64805.0 64873.4 64883.0 11718.0 11739.6 11780.5 11838.6 11872.2 9813.6 9827.6 9893.8 9898.3 9909.2 18656.3 18799.6 18902.9 19011.8 19040.8 7334.4 7722.2 7731.3 7755.0 7757.5 803.2 841.5 851.4 935.2 1021.1 26033.5 26906.3 27002.5 27760.3 28263.6 919.6 960.4 967.5 1010.5 1047.8 12105.4 12393.8 12462.3 12464.5 12511.4 252507.0 256560.0 257116.0 258590.0 259162.0 44698.6 44912.0 45044.1 45067.3 45223.3 1216.1 1221.2 1237.3 1237.6 1237.8 23807.0 23910.9 24015.5 24087.5 24132.2 37644.8 37873.6 38197.0 38272.4 38446.6 241306.0 242119.0 242626.0 243054.0 244048.0 28360.7 29058.3 29199.7 29215.1 29426.7 33887.0 34827.8 37161.3 37698.2 38170.6 31776.4 32133.2 32313.0 32747.3 32761.8 31857.3 32138.7 32493.4 32603.8 32607.2 32507.7 32519.2 32552.0 32601.8 33139.3 25960.9 25971.0 29741.7 30027.0 30279.8 21866.9 23561.6 23957.2 23992.4 24023.5 10:16:40 INFO - 2015-12-11 10:16:40,830 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,830 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25209.52 Median:40418.89 stddev:74532.71 (184.4%) stddev-sans-first:74718.38 10:16:40 INFO - 2015-12-11 10:16:40,831 DEBUG : BROWSER_OUTPUT: Values: 329.1 329.3 330.0 331.8 334.1 14949.3 15460.8 15891.4 16466.8 16732.7 10343.4 10357.8 10424.2 12741.2 15227.2 4596.9 4608.4 4710.4 4711.9 4718.6 4506.6 4521.7 4540.5 4550.4 4557.4 4515.6 4538.5 4918.1 5081.4 5101.1 5009.9 5013.4 5021.5 5037.5 5057.2 5115.7 5146.8 5178.4 5179.3 5191.0 11464.4 11828.8 14746.8 18691.3 18695.1 1750.0 1763.5 1772.8 1865.3 1888.5 9169.4 9242.5 9302.2 10627.9 13056.3 1681.2 1737.5 1776.8 1797.5 1804.7 54757.5 57762.7 58338.7 59525.0 59972.4 9539.1 9781.3 9826.5 9881.8 10017.6 12500.4 12505.9 12543.6 12546.3 12572.5 6591.5 6655.3 6734.9 6743.7 6925.7 6314.1 6349.6 6350.3 6372.7 6377.5 4202.1 4213.0 4270.9 4288.7 4294.0 1694.5 1751.0 1754.7 1758.2 1769.5 759.3 812.3 836.0 854.7 888.7 15423.4 15581.1 15898.8 16024.8 16307.7 823.7 858.9 867.3 902.4 907.5 8976.6 9212.2 9222.2 9280.4 9332.0 446366.0 453196.0 457281.0 459575.0 462935.0 69551.7 71187.6 71386.0 72021.0 75189.6 1023.0 1036.7 1074.1 1075.7 1083.2 13728.9 14297.8 14350.0 14457.7 14532.4 29332.1 29381.6 29893.0 30711.5 31134.5 36440.3 36550.3 39834.4 41003.4 41706.6 8833.3 8973.8 9127.1 9163.2 9164.8 16234.8 16630.4 16649.8 16776.6 16833.2 10924.9 12373.6 13292.4 13733.5 14344.0 12779.2 13071.9 13159.9 13362.5 13395.7 13194.3 13692.5 13788.9 13951.5 14070.3 8596.5 8804.4 8864.3 9031.2 9031.8 12883.7 13445.4 13481.1 13501.0 13923.9 10:16:40 INFO - 2015-12-11 10:16:40,831 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,831 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4905.37 Median:6188.24 stddev:2494.81 (40.3%) stddev-sans-first:2487.75 10:16:40 INFO - 2015-12-11 10:16:40,832 DEBUG : BROWSER_OUTPUT: Values: 1382.0 1663.8 1671.5 1706.5 1737.2 5834.7 6191.3 6478.7 6846.8 6855.7 6776.6 6909.5 6958.3 7051.0 7053.4 2084.8 2115.6 2123.7 2123.8 2129.6 2061.0 2070.5 2107.5 2111.0 2121.5 2066.4 2089.9 2090.6 2118.7 2120.4 2079.8 2111.1 2114.6 2115.3 2116.4 2041.9 2064.1 2088.7 2090.3 2094.4 7054.1 7077.4 7105.6 7136.7 7179.3 4230.8 4287.9 4296.6 4314.6 4315.7 2669.9 2699.9 2779.4 2790.5 2798.3 873.7 1686.3 1730.2 1753.8 1762.0 9288.1 9468.0 9469.4 9488.3 9501.3 3804.7 3816.6 3821.1 3863.7 3873.4 7609.5 7668.7 7677.2 7692.0 7724.7 4142.7 4160.6 4190.1 4194.2 4195.2 3230.4 3303.6 3781.3 3817.5 3831.8 3063.1 3079.2 3092.1 3097.8 3132.3 867.3 868.3 870.5 871.2 872.6 981.4 991.1 995.1 995.6 1039.7 6769.1 6770.2 6774.6 6807.9 6815.0 430.2 436.4 1093.7 1133.1 1133.9 5282.7 5300.5 5312.0 5331.4 5404.6 8269.3 8361.9 8457.5 8472.6 8505.9 8096.4 8285.9 8330.0 8342.9 8383.7 6739.9 6776.8 6780.7 6793.7 6822.9 6604.6 6698.0 6708.5 6726.8 6753.2 7518.1 7592.5 7637.1 7672.7 7767.6 7664.5 7707.3 7794.9 7812.5 7854.9 5097.8 5281.8 6187.8 6266.9 6273.9 6131.7 6490.2 6517.7 6531.5 6574.2 6166.4 6229.6 6288.2 6399.7 6482.4 6188.7 6266.7 6282.9 6353.8 6443.4 6283.9 6296.2 6300.4 6307.8 6320.4 5860.1 5920.3 5939.0 5942.7 5952.9 5903.9 5919.9 6081.1 6095.6 6115.6 10:16:40 INFO - 2015-12-11 10:16:40,832 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,832 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4881.63 Median:5600.91 stddev:1461.87 (26.1%) stddev-sans-first:1424.92 10:16:40 INFO - 2015-12-11 10:16:40,832 DEBUG : BROWSER_OUTPUT: Values: 298.4 303.6 307.6 308.7 312.7 5539.3 5565.1 5598.7 5744.9 5765.3 5570.8 5603.2 5641.7 5646.5 5656.0 4222.3 4309.4 4340.7 4346.8 4347.1 4280.9 4295.2 4310.7 4314.8 4328.3 4258.4 4259.6 4261.0 4266.7 4269.3 4262.5 4263.0 4268.0 4277.8 4282.2 3611.2 3699.6 3719.1 3721.1 3732.1 5181.9 5339.7 5347.5 5352.5 5359.1 4911.7 4916.3 4917.2 4917.3 4922.4 5893.6 5908.1 5922.0 5926.6 5944.6 3882.1 3996.0 4009.8 4026.2 4049.3 6174.7 6232.5 6236.5 6238.9 6243.8 4134.0 4136.0 4136.2 4136.7 4146.7 4201.0 4203.1 4205.2 4208.4 4208.7 4758.4 4826.3 4847.5 4853.4 4863.6 5879.3 5886.7 5895.1 5898.0 5900.4 1482.8 1483.3 1491.2 1493.4 1493.7 994.7 996.1 998.1 1012.1 1014.7 5085.3 5105.3 5106.6 5108.4 5114.7 5983.5 6090.9 6092.5 6093.9 6107.0 5060.2 5079.3 5095.0 5107.6 5111.1 3229.1 3302.2 3309.8 3330.4 3331.7 5626.5 5787.1 5804.2 5808.2 5825.9 6370.0 6398.2 6401.6 6413.1 6420.8 5793.4 5800.0 5801.1 5810.1 5816.9 5990.7 6163.9 6171.8 6195.9 6197.7 5991.6 6032.4 6040.3 6047.8 6065.1 5801.7 5807.2 5809.0 5818.1 5823.2 4122.3 4184.8 4186.1 4195.9 4203.1 6049.0 6165.8 6177.3 6190.7 6194.3 5922.5 5945.0 5950.9 5956.7 5965.8 5931.8 5949.9 5951.2 5958.4 5976.2 5673.4 5756.3 5825.9 5831.7 5845.1 5948.9 5988.6 6008.6 6015.2 6028.4 5819.3 5820.5 5831.3 5839.5 5860.5 10:16:40 INFO - 2015-12-11 10:16:40,833 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-12-11 10:16:40,833 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12304.78 Median:453.15 stddev:13894.11 (3066.1%) stddev-sans-first:13905.91 10:16:40 INFO - 2015-12-11 10:16:40,833 DEBUG : BROWSER_OUTPUT: Values: 732.2 743.9 758.7 780.7 799.5 11250.0 13523.9 13757.1 13806.2 13830.7 13500.1 13655.6 13660.2 13667.6 13668.0 792.9 801.1 805.8 805.8 807.8 802.1 814.4 818.1 818.8 825.7 840.7 845.8 846.9 852.1 853.6 840.0 842.3 842.5 843.9 845.6 622.8 624.6 626.2 626.7 627.2 11498.3 11577.6 11581.1 11601.1 11642.4 10668.3 10727.1 10978.2 11314.3 11373.8 9356.7 9418.7 9598.7 9633.2 9740.8 3100.2 3110.6 3128.1 3148.5 3162.8 42166.4 42288.8 42368.0 42668.6 42792.1 9140.9 9205.4 9363.0 9447.9 9463.8 15851.6 15880.5 15918.1 15925.0 16062.8 6239.6 6417.2 6427.8 6449.5 6580.1 3458.2 3575.6 3611.7 3612.0 3659.3 2490.3 2520.5 2527.6 2531.4 2532.0 477.6 482.0 482.1 483.1 485.7 447.1 519.4 556.8 570.6 578.4 6637.5 7262.5 7619.7 7782.3 7873.3 448.6 457.7 493.6 513.0 573.5 3480.3 3537.2 3836.3 3970.5 4020.5 49725.0 50117.7 50222.2 50432.0 50667.7 43427.3 43845.8 44237.9 44248.6 44393.6 39904.8 40438.6 40574.8 40885.8 41043.6 7841.2 7951.2 8094.2 8226.0 8231.6 28737.0 29020.4 29273.7 30266.7 32756.3 38753.0 38858.6 39407.0 40423.6 40823.8 9494.7 9788.4 9963.1 10062.1 10122.3 10906.7 11046.8 11212.1 11241.8 11360.4 10390.3 10410.3 10729.2 10936.0 10967.3 10177.2 10337.3 10404.1 10453.5 10953.2 9477.3 9737.3 9788.4 10025.0 10718.6 8815.9 8919.8 9076.4 9134.7 9271.4 9313.6 9407.6 9445.2 9463.5 9546.3 10:16:40 INFO - 2015-12-11 10:16:40,833 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:16:40 INFO - 2015-12-11 10:16:40,834 DEBUG : BROWSER_OUTPUT: 10:16:41 INFO - 2015-12-11 10:16:41,578 INFO : Browser exited with error code: 0 10:16:41 INFO - 2015-12-11 10:16:41,602 INFO : Completed test dromaeo_css (00:18:34) 10:16:41 INFO - 2015-12-11 10:16:41,602 INFO : Starting test kraken 10:16:41 INFO - 2015-12-11 10:16:41,602 DEBUG : operating with platform_type : linux_ 10:16:41 INFO - 2015-12-11 10:16:41,602 INFO : Initialising browser for kraken test... 10:16:41 INFO - 2015-12-11 10:16:41,608 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ACxGM/profile http://localhost:60672/getInfo.html 10:16:46 INFO - 2015-12-11 10:16:46,155 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:16:46 INFO - 2015-12-11 10:16:46,155 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:16:46 INFO - 2015-12-11 10:16:46,155 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:16:46 INFO - 2015-12-11 10:16:46,155 DEBUG : BROWSER_OUTPUT: __metrics 10:16:46 INFO - 2015-12-11 10:16:46,297 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:16:47 INFO - 2015-12-11 10:16:47,202 INFO : Browser initialized. 10:16:47 INFO - 2015-12-11 10:16:47,202 INFO : Running cycle 1/1 for kraken test... 10:16:47 INFO - 2015-12-11 10:16:47,202 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ACxGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:16:59 INFO - 2015-12-11 10:16:59,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 143052800 10:16:59 INFO - 2015-12-11 10:16:59,279 DEBUG : BROWSER_OUTPUT: 10:17:01 INFO - 2015-12-11 10:17:01,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60672/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:02 INFO - 2015-12-11 10:17:02,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 142573568 10:17:02 INFO - 2015-12-11 10:17:02,491 DEBUG : BROWSER_OUTPUT: 10:17:05 INFO - 2015-12-11 10:17:05,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60672/tests/kraken/driver.html?testName=audio-dft) 10:17:05 INFO - 2015-12-11 10:17:05,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 142893056 10:17:05 INFO - 2015-12-11 10:17:05,828 DEBUG : BROWSER_OUTPUT: 10:17:08 INFO - 2015-12-11 10:17:08,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60672/tests/kraken/driver.html?testName=audio-fft) 10:17:09 INFO - 2015-12-11 10:17:09,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 10:17:09 INFO - 2015-12-11 10:17:09,351 DEBUG : BROWSER_OUTPUT: 10:17:11 INFO - 2015-12-11 10:17:11,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60672/tests/kraken/driver.html?testName=audio-oscillator) 10:17:12 INFO - 2015-12-11 10:17:12,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 139661312 10:17:12 INFO - 2015-12-11 10:17:12,038 DEBUG : BROWSER_OUTPUT: 10:17:14 INFO - 2015-12-11 10:17:14,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:14 INFO - 2015-12-11 10:17:14,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 140980224 10:17:14 INFO - 2015-12-11 10:17:14,870 DEBUG : BROWSER_OUTPUT: 10:17:17 INFO - 2015-12-11 10:17:17,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60672/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:18 INFO - 2015-12-11 10:17:18,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 139264000 10:17:18 INFO - 2015-12-11 10:17:18,538 DEBUG : BROWSER_OUTPUT: 10:17:21 INFO - 2015-12-11 10:17:21,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60672/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:22 INFO - 2015-12-11 10:17:22,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 137723904 10:17:22 INFO - 2015-12-11 10:17:22,588 DEBUG : BROWSER_OUTPUT: 10:17:25 INFO - 2015-12-11 10:17:25,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60672/tests/kraken/driver.html?testName=json-parse-financial) 10:17:26 INFO - 2015-12-11 10:17:26,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 137969664 10:17:26 INFO - 2015-12-11 10:17:26,092 DEBUG : BROWSER_OUTPUT: 10:17:27 INFO - 2015-12-11 10:17:27,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:28 INFO - 2015-12-11 10:17:28,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 140718080 10:17:28 INFO - 2015-12-11 10:17:28,448 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-11 10:17:30,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:30 INFO - 2015-12-11 10:17:30,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 140910592 10:17:30 INFO - 2015-12-11 10:17:30,987 DEBUG : BROWSER_OUTPUT: 10:17:33 INFO - 2015-12-11 10:17:33,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:33 INFO - 2015-12-11 10:17:33,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 140935168 10:17:33 INFO - 2015-12-11 10:17:33,761 DEBUG : BROWSER_OUTPUT: 10:17:36 INFO - 2015-12-11 10:17:36,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:36 INFO - 2015-12-11 10:17:36,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 141541376 10:17:36 INFO - 2015-12-11 10:17:36,946 DEBUG : BROWSER_OUTPUT: 10:17:39 INFO - 2015-12-11 10:17:39,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:40 INFO - 2015-12-11 10:17:40,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 140423168 10:17:40 INFO - 2015-12-11 10:17:40,168 DEBUG : BROWSER_OUTPUT: 10:17:41 INFO - 2015-12-11 10:17:41,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60672/tests/kraken/driver.html?testName=ai-astar) 10:17:42 INFO - 2015-12-11 10:17:42,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 140705792 10:17:42 INFO - 2015-12-11 10:17:42,182 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,185 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:17:42 INFO - 2015-12-11 10:17:42,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:17:42 INFO - 2015-12-11 10:17:42,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:17:42 INFO - 2015-12-11 10:17:42,186 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:17:42 INFO - 2015-12-11 10:17:42,186 DEBUG : BROWSER_OUTPUT: |0;ai-astar;122;106;116;112;114;123;112;113;116;112 10:17:42 INFO - 2015-12-11 10:17:42,186 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;130;150;163;131;156;158;130;168;131 10:17:42 INFO - 2015-12-11 10:17:42,186 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;164;164;162;165;171;166;173;166;165 10:17:42 INFO - 2015-12-11 10:17:42,186 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;74;74;141;73;74;74;73;94 10:17:42 INFO - 2015-12-11 10:17:42,186 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;138;96;95;94;132;94;95;129 10:17:42 INFO - 2015-12-11 10:17:42,186 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;109;110;110;109;110;110;110;111 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;148;148;148;148;147;149;147;149 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;97;97;97;96;95 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;77;72;75;72;73;74;74;75 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;69;70;67;68;68 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;93;85;86;85;84;84;85;97 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;126;131;128;121;138;129;124;127;138 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;149;149;151;148;137;151;160;148;138 10:17:42 INFO - 2015-12-11 10:17:42,187 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;70;73;72;69;71;71;69;71 10:17:42 INFO - 2015-12-11 10:17:42,188 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:17:42 INFO - 2015-12-11 10:17:42,188 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:17:42 INFO - 2015-12-11 10:17:42,188 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,792 10:17:42 INFO - 2015-12-11 10:17:42,188 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:17:42 INFO - 2015-12-11 10:17:42,188 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857862183__endTimestamp 10:17:42 INFO - 2015-12-11 10:17:42,188 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:5.02 (4.4%) stddev-sans-first:4.55 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: Values: 122.0 106.0 116.0 112.0 114.0 123.0 112.0 113.0 116.0 112.0 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:157.00 stddev:15.69 (10.0%) stddev-sans-first:15.79 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: Values: 162.0 130.0 150.0 163.0 131.0 156.0 158.0 130.0 168.0 131.0 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:3.35 (2.0%) stddev-sans-first:3.53 10:17:42 INFO - 2015-12-11 10:17:42,196 DEBUG : BROWSER_OUTPUT: Values: 165.0 164.0 164.0 162.0 165.0 171.0 166.0 173.0 166.0 165.0 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:74.00 stddev:21.71 (29.3%) stddev-sans-first:22.72 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 74.0 74.0 141.0 73.0 74.0 74.0 73.0 94.0 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:94.50 stddev:18.63 (19.7%) stddev-sans-first:19.23 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 138.0 96.0 95.0 94.0 132.0 94.0 95.0 129.0 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 111.0 10:17:42 INFO - 2015-12-11 10:17:42,197 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,198 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 10:17:42 INFO - 2015-12-11 10:17:42,198 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 148.0 148.0 148.0 148.0 147.0 149.0 147.0 149.0 10:17:42 INFO - 2015-12-11 10:17:42,198 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,198 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 10:17:42 INFO - 2015-12-11 10:17:42,198 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 97.0 97.0 97.0 96.0 95.0 10:17:42 INFO - 2015-12-11 10:17:42,198 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,198 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.90 Median:74.00 stddev:1.52 (2.1%) stddev-sans-first:1.62 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 77.0 72.0 75.0 72.0 73.0 74.0 74.0 75.0 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 69.0 70.0 67.0 68.0 68.0 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.00 stddev:4.67 (5.5%) stddev-sans-first:4.78 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 93.0 85.0 86.0 85.0 84.0 84.0 85.0 97.0 10:17:42 INFO - 2015-12-11 10:17:42,199 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,200 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:128.50 stddev:5.80 (4.5%) stddev-sans-first:5.80 10:17:42 INFO - 2015-12-11 10:17:42,200 DEBUG : BROWSER_OUTPUT: Values: 123.0 126.0 131.0 128.0 121.0 138.0 129.0 124.0 127.0 138.0 10:17:42 INFO - 2015-12-11 10:17:42,200 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,200 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:149.00 stddev:7.12 (4.8%) stddev-sans-first:6.94 10:17:42 INFO - 2015-12-11 10:17:42,200 DEBUG : BROWSER_OUTPUT: Values: 139.0 149.0 149.0 151.0 148.0 137.0 151.0 160.0 148.0 138.0 10:17:42 INFO - 2015-12-11 10:17:42,200 DEBUG : BROWSER_OUTPUT: 10:17:42 INFO - 2015-12-11 10:17:42,200 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 10:17:42 INFO - 2015-12-11 10:17:42,201 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 70.0 73.0 72.0 69.0 71.0 71.0 69.0 71.0 10:17:42 INFO - 2015-12-11 10:17:42,201 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:17:42 INFO - 2015-12-11 10:17:42,201 DEBUG : BROWSER_OUTPUT: 10:17:43 INFO - 2015-12-11 10:17:43,098 INFO : Browser exited with error code: 0 10:17:43 INFO - 2015-12-11 10:17:43,147 INFO : Completed test kraken (00:01:01) 10:17:43 INFO - 2015-12-11 10:17:43,148 INFO : Starting test v8_7 10:17:43 INFO - 2015-12-11 10:17:43,148 DEBUG : operating with platform_type : linux_ 10:17:43 INFO - 2015-12-11 10:17:43,148 INFO : Initialising browser for v8_7 test... 10:17:43 INFO - 2015-12-11 10:17:43,154 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph6CLGa/profile http://localhost:60672/getInfo.html 10:17:47 INFO - 2015-12-11 10:17:47,759 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:17:47 INFO - 2015-12-11 10:17:47,759 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:17:47 INFO - 2015-12-11 10:17:47,759 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:17:47 INFO - 2015-12-11 10:17:47,759 DEBUG : BROWSER_OUTPUT: __metrics 10:17:47 INFO - 2015-12-11 10:17:47,876 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:17:48 INFO - 2015-12-11 10:17:48,790 INFO : Browser initialized. 10:17:48 INFO - 2015-12-11 10:17:48,790 INFO : Running cycle 1/1 for v8_7 test... 10:17:48 INFO - 2015-12-11 10:17:48,791 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph6CLGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:18:00 INFO - 2015-12-11 10:18:00,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 143712256 10:18:00 INFO - 2015-12-11 10:18:00,892 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60672/tests/v8_7/run.html (next: http://localhost:60672/tests/v8_7/run.html) 10:18:22 INFO - 2015-12-11 10:18:22,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 137809920 10:18:22 INFO - 2015-12-11 10:18:22,672 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,673 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: |0;Richards;167.81339150864238 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.70102135561746 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 10:18:22 INFO - 2015-12-11 10:18:22,674 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1090.5125408942204 10:18:22 INFO - 2015-12-11 10:18:22,675 DEBUG : BROWSER_OUTPUT: |5;Earley;733.3333333333334 10:18:22 INFO - 2015-12-11 10:18:22,675 DEBUG : BROWSER_OUTPUT: |6;Boyer;12550 10:18:22 INFO - 2015-12-11 10:18:22,675 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 10:18:22 INFO - 2015-12-11 10:18:22,675 DEBUG : BROWSER_OUTPUT: |8;Splay;604.9606775559589 10:18:22 INFO - 2015-12-11 10:18:22,675 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 10:18:22 INFO - 2015-12-11 10:18:22,675 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:18:22 INFO - 2015-12-11 10:18:22,675 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857902672__endTimestamp 10:18:22 INFO - 2015-12-11 10:18:22,676 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,676 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:18:22 INFO - 2015-12-11 10:18:22,677 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:18:22 INFO - 2015-12-11 10:18:22,677 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,677 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,677 DEBUG : BROWSER_OUTPUT: Values: 167.8 10:18:22 INFO - 2015-12-11 10:18:22,677 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.70 Median:185.70 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: Values: 185.7 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: Values: 278.3 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,678 DEBUG : BROWSER_OUTPUT: Values: 5181.3 10:18:22 INFO - 2015-12-11 10:18:22,679 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,679 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1090.51 Median:1090.51 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,679 DEBUG : BROWSER_OUTPUT: Values: 1090.5 10:18:22 INFO - 2015-12-11 10:18:22,679 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,679 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:733.33 Median:733.33 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,679 DEBUG : BROWSER_OUTPUT: Values: 733.3 10:18:22 INFO - 2015-12-11 10:18:22,679 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: Values: 12550.0 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: Values: 25923.1 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.96 Median:604.96 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,680 DEBUG : BROWSER_OUTPUT: Values: 605.0 10:18:22 INFO - 2015-12-11 10:18:22,681 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-12-11 10:18:22,681 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:18:22 INFO - 2015-12-11 10:18:22,681 DEBUG : BROWSER_OUTPUT: Values: 4840.6 10:18:22 INFO - 2015-12-11 10:18:22,681 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:18:22 INFO - 2015-12-11 10:18:22,681 DEBUG : BROWSER_OUTPUT: 10:18:23 INFO - 2015-12-11 10:18:23,566 INFO : Browser exited with error code: 0 10:18:23 INFO - 2015-12-11 10:18:23,584 INFO : Completed test v8_7 (00:00:40) 10:18:23 INFO - 2015-12-11 10:18:23,664 INFO : Completed test suite (00:20:16) 10:18:23 INFO - 2015-12-11 10:18:23,664 DEBUG : Working with test: dromaeo_css 10:18:23 INFO - 2015-12-11 10:18:23,664 DEBUG : Generating results file: dromaeo_css 10:18:23 INFO - 2015-12-11 10:18:23,665 DEBUG : Working with test: kraken 10:18:23 INFO - 2015-12-11 10:18:23,665 DEBUG : Generating results file: kraken 10:18:23 INFO - 2015-12-11 10:18:23,666 INFO : javascript benchmark 10:18:23 INFO - 2015-12-11 10:18:23,666 DEBUG : Working with test: v8_7 10:18:23 INFO - 2015-12-11 10:18:23,666 DEBUG : Generating results file: v8_7 10:18:23 INFO - 2015-12-11 10:18:23,666 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:23 INFO - 2015-12-11 10:18:23,715 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:18:23 INFO - 2015-12-11 10:18:23,715 DEBUG : process_Request line: dromaeo_css 6327.72 graph.html#tests=[[72,132,43]] 10:18:23 INFO - 2015-12-11 10:18:23,715 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:23 INFO - 2015-12-11 10:18:23,745 DEBUG : process_Request line: kraken 1545.30 graph.html#tests=[[232,132,43]] 10:18:23 INFO - 2015-12-11 10:18:23,745 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:23 INFO - 2015-12-11 10:18:23,773 DEBUG : process_Request line: v8_7 21185.94 graph.html#tests=[[230,132,43]] 10:18:23 INFO - 2015-12-11 10:18:23,774 INFO : javascript benchmark 10:18:23 INFO - 2015-12-11 10:18:23,778 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2673.5722284434487, 2724.0738149029326, 2752.600872873433, 2764.599133125697, 2768.266409401508, 4570.451545814507, 4790.377250957375, 4810.5189481051875, 4827.034593081385, 4829.179039563274, 4570.428696412949, 4701.7414042227665, 4725.480197178307, 4787.569118779309, 4793.592544633701, 4238.470191226097, 4347.695661303702, 4522.389477420539, 4531.818727250906, 4555.3850230218995, 4218.303979843322, 4439.977800111011, 4510.751908645023, 4518.186726389248, 4527.20773864574, 4307.655387568987, 4335.08963117744, 4371.4098596689355, 4401.141777353418, 4406.581374769392, 4393.03353262285, 4400.559944005606, 4405.0969551241915, 4416.712913660602, 4416.933745993812, 4192.496900371975, 4313.0726893718, 4377.409049778303, 4378.584034516748, 4441.289393696993, 4578.221702310615, 4665.066986602693, 4674.883127921795, 4722.0, 4730.952690473086, 5113.897722045538, 5152.201408781645, 5157.226416037624, 5161.071007218699, 5213.061648903196, 4970.055689419035, 5071.822486212965, 5089.8727531812, 5179.741012949337, 5223.973880130613, 4656.16189085961, 4706.1293660672545, 4710.034442939189, 4719.126961512131, 4744.335792988984, 5287.104248636791, 5289.0, 5323.653962492425, 5323.893522129613, 5358.812441564526, 4811.4707382187935, 5099.260607211933, 5106.183010718267, 5114.258432527337, 5123.052235336475, 4930.605551555867, 5070.29015937769, 5132.820351287687, 5141.177411614124, 5191.169412893919, 5106.719130447861, 5117.74411279442, 5118.539331460112, 5126.1798112302595, 5158.613104017214, 4841.370621819141, 4947.802087916515, 5083.161278389024, 5092.312537807423, 5104.387473503203, 4195.622393984495, 4236.237477254123, 4236.3857240700545, 4240.406343111967, 4273.316269396882, 3775.3581891078584, 3778.7732736035928, 3780.2494369313677, 3787.4318852172396, 3811.618838116166, 4199.958000420018, 4313.396124542566, 4328.3723860040745, 4421.027373977719, 4439.489458712224, 5161.200013997836, 5185.818496352609, 5206.505381988705, 5212.817551385683, 5246.396664383645, 4448.822047118144, 4451.577100175543, 4458.4426946631675, 4464.598186163261, 4491.910161796745, 4325.805338759764, 4466.9553304466535, 4556.225441674923, 4622.791974361162, 4652.348671186037, 4768.450253667572, 4815.2054910939305, 4818.975905120452, 4835.588974937099, 4849.95150048495, 5120.743962801919, 5124.948750512447, 5124.9743751281, 5128.79484820603, 5173.370388327665, 4697.859064227942, 4720.716756994591, 4791.113643975876, 4815.422149342101, 4835.443923948791, 5073.11220536412, 5083.059633967728, 5086.669366491166, 5090.211017292326, 5114.64197506171, 4917.655764096622, 5177.689338639693, 5178.844634660966, 5183.740812959261, 5199.948000519947, 4897.461279259207, 4950.257461380822, 4950.504949505021, 4980.601551875914, 5021.372328458942, 5013.122703526796, 5013.949860501494, 5016.899662006813, 5023.673461225008, 5045.94035252601, 4628.884277892945, 4796.944672172117, 4895.6083513318135, 4907.950920490749, 4934.358533390637, 4923.138450771173, 4936.9259461107395, 4941.802327906988, 4959.752012399438, 4967.205247160437, 4836.95163048365, 4883.60931125502, 4890.657653964188, 4906.362172917497, 4951.10880041596], "unit": "ms", "name": "dojo.html", "value": 4684.627350422895}, {"lowerIsBetter": false, "replicates": [577.2553406106123, 578.8668606220568, 583.0379873209205, 588.602693182102, 597.3190562758454, 35144.824275878615, 35933.1016724582, 35945.82027089864, 36100.2779944401, 36254.45618315727, 39324.213515729665, 39469.80265098678, 39508.604913950854, 40045.39931901024, 40092.79953600235, 7871.80320491988, 8067.515949043047, 8069.193080691914, 8071.031476222862, 8102.270795628392, 7903.0911445183965, 8010.39922005849, 8013.759587212393, 8040.1959804019425, 8058.879116813252, 7898.170692077335, 7966.5618390988475, 7970.920290797105, 7981.6009199540085, 8013.078495972979, 7752.496087754278, 7766.068071831388, 7790.220977902221, 7807.570583617899, 7836.451448398614, 7845.882311765328, 7893.605319733991, 7955.840883182362, 7964.16376280488, 7993.640286187077, 36664.45003324952, 37123.81438092792, 37132.814335928415, 37285.62714372849, 37305.440418393744, 2958.4970555005702, 3035.696430356969, 3058.9388212235854, 3072.0630207786617, 3073.231692076981, 27600.585991210148, 27985.0, 28013.719862801314, 28091.71908280932, 28230.294242644097, 3461.2039230976766, 3485.2680937003006, 3510.2979404119023, 3523.0311664292267, 3564.3049605326974, 198475.0, 199546.0, 199874.00062999738, 199896.0, 199914.0, 50080.499195007586, 51180.48819511757, 52256.21615675768, 52492.0, 52495.0, 63256.0, 64441.0, 64805.0, 64873.351266487676, 64883.0, 11718.0, 11739.589114380955, 11780.52877884875, 11838.585649502225, 11872.168948173545, 9813.607455701693, 9827.606895724233, 9893.752656183653, 9898.30711850178, 9909.157721593745, 18656.253749849853, 18799.624007519775, 18902.90548547276, 19011.80988190128, 19040.80959190418, 7334.449916256195, 7722.189170137055, 7731.304182623591, 7754.961225193838, 7757.495762775401, 803.1767438375712, 841.5035129273758, 851.4252879306443, 935.1677007463363, 1021.1218352217087, 26033.479330413287, 26906.32734181622, 27002.459950801265, 27760.305992350353, 28263.57604635932, 919.5540163020929, 960.4189465373348, 967.5065716484644, 1010.4796030044533, 1047.7642530430592, 12105.394730263451, 12393.752124957451, 12462.31457269859, 12464.5014199431, 12511.3744312784, 252507.0, 256560.0, 257116.0, 258590.0, 259162.0, 44698.55301446944, 44912.0, 45044.09911801811, 45067.323990140176, 45223.321650175276, 1216.1122380662166, 1221.1879100398135, 1237.3256575166556, 1237.566851601932, 1237.789575772121, 23806.960889845548, 23910.875120959154, 24015.469415013158, 24087.459884226377, 24132.155374561808, 37644.81177594094, 37873.62126378701, 38197.0, 38272.42591361076, 38446.61553384542, 241306.0, 242119.0, 242626.0, 243054.0, 244048.0, 28360.71639283663, 29058.27354316159, 29199.7080029197, 29215.123546293646, 29426.705732942395, 33887.0, 34827.82586087054, 37161.25677486381, 37698.2460350786, 38170.618293816704, 31776.36447271088, 32133.1966700825, 32313.0, 32747.34505309833, 32761.836190818893, 31857.33640631357, 32138.678613213568, 32493.35013299768, 32603.836980814944, 32607.18482037968, 32507.674923250466, 32519.18702032468, 32552.0, 32601.836990815842, 33139.337213255116, 25960.870195649655, 25971.0, 29741.702582973892, 30027.0, 30279.848600756854, 21866.890665547206, 23561.64657530104, 23957.16149934744, 23992.40018999539, 24023.51952960896], "unit": "ms", "name": "ext.html", "value": 16537.330284010426}, {"lowerIsBetter": false, "replicates": [329.11090341440143, 329.2624521072797, 329.99670003299974, 331.80091944833106, 334.1279261128453, 14949.252537373128, 15460.768088478682, 15891.364345426198, 16466.75299870503, 16732.749008764877, 10343.431111288875, 10357.792844143112, 10424.21818363622, 12741.171823831468, 15227.23863806808, 4596.90806183877, 4608.3778689876945, 4710.387649605564, 4711.929321060187, 4718.57532822046, 4506.571875671806, 4521.728696278217, 4540.523245059271, 4550.385697930787, 4557.361969324297, 4515.571020753039, 4538.523455037223, 4918.065567542173, 5081.364829396325, 5101.132807422729, 5009.9479109387075, 5013.448520662742, 5021.548060674539, 5037.5214354636255, 5057.241413787924, 5115.7442127893455, 5146.768395422215, 5178.378594568676, 5179.2749015137915, 5191.0, 11464.426778661034, 11828.763424731544, 14746.778798318033, 18691.252349905986, 18695.06524673761, 1749.9912500437545, 1763.4797734668175, 1772.831580999803, 1865.309835360925, 1888.5089876632037, 9169.358144929858, 9242.491662958535, 9302.20931220847, 10627.937206279388, 13056.34718264083, 1681.218233521406, 1737.5482374582573, 1776.7956684981264, 1797.5125830829982, 1804.7022241330164, 54757.45242547603, 57762.71118644422, 58338.7083064582, 59525.0, 59972.400275997556, 9539.14147726708, 9781.315307928377, 9826.459544724965, 9881.752956176153, 10017.599296028076, 12500.374981250901, 12505.93747031259, 12543.56097536582, 12546.309952952493, 12572.497100115894, 6591.472682185414, 6655.301193374626, 6734.865302693918, 6743.696533655997, 6925.722971081201, 6314.116023756677, 6349.619022858643, 6350.269718982284, 6372.7132279047555, 6377.489800815923, 4202.117555313418, 4212.957870421256, 4270.850520231777, 4288.699791014599, 4294.033842385438, 1694.466243133409, 1750.9824901751074, 1754.6929287374658, 1758.1560850791436, 1769.4691592522192, 759.3355813663045, 812.3298278919915, 836.0, 854.7008547008621, 888.6756333938066, 15423.383064677511, 15581.143037133066, 15898.841011589737, 16024.75962860558, 16307.673846523003, 823.6622984576295, 858.8539948208819, 867.3061550759368, 902.3548163063441, 907.5462268865567, 8976.596053177622, 9212.216961558343, 9222.170004699608, 9280.350375473787, 9331.953340233254, 446366.0, 453196.0, 457281.0, 459575.0, 462935.0, 69551.65224173847, 71187.64406177936, 71386.0, 72021.0, 75189.6240518794, 1023.0230130225617, 1036.7045392063226, 1074.0601973273385, 1075.725689949058, 1083.182197440927, 13728.862711372758, 14297.785533216802, 14350.0, 14457.710845783236, 14532.418703251751, 29332.12003639894, 29381.559276611297, 29893.0, 30711.539326909668, 31134.53298200574, 36440.27119457649, 36550.26899462049, 39834.40248396334, 41003.38494922638, 41706.58293417027, 8833.293336532934, 8973.820523589622, 9127.132922372364, 9163.175314221751, 9164.770880727769, 16234.837651623333, 16630.417935372203, 16649.833501664827, 16776.58058548546, 16833.158342082603, 10924.945375273392, 12373.62879113628, 13292.401841916944, 13733.45066197341, 14344.0, 12779.23324600527, 13071.934640326737, 13159.868401315864, 13362.465501380224, 13395.732085358433, 13194.274314912773, 13692.452301907811, 13788.862111378758, 13951.511697090553, 14070.296485175904, 8596.484210947363, 8804.383693141419, 8864.290856731575, 9031.187193152648, 9031.819363612822, 12883.742325153256, 13445.394957226752, 13481.123726957716, 13501.0, 13923.860761392662], "unit": "ms", "name": "jquery.html", "value": 8087.140619231555}, {"lowerIsBetter": false, "replicates": [1381.9704320281392, 1663.7670726098345, 1671.5486818558988, 1706.5136436115702, 1737.2008875917081, 5834.679092649913, 6191.257049154096, 6478.74085036598, 6846.760363387282, 6855.657217139142, 6776.593404395728, 6909.48178886583, 6958.304169583039, 7051.0, 7053.435725141976, 2084.8019438153387, 2115.629764791163, 2123.7132987046707, 2123.81947534459, 2129.58473097746, 2061.0, 2070.534129820793, 2107.4625970377533, 2110.968335474969, 2121.4802373418534, 2066.442060643633, 2089.8641588296787, 2090.602785470763, 2118.692789545515, 2120.385088324384, 2079.8128168464837, 2111.123883588317, 2114.5770845830893, 2115.270231770037, 2116.4179850541223, 2041.9081141348674, 2064.112431654388, 2088.749350077985, 2090.320645790124, 2094.3821572636107, 7054.118235220598, 7077.433805295564, 7105.644717764143, 7136.714531418737, 7179.3179647933885, 4230.8153716959305, 4287.871363859089, 4296.591823776736, 4314.590113939171, 4315.697901146921, 2669.8859611489665, 2699.91900242993, 2779.3885345224016, 2790.497710412125, 2798.3144129688153, 873.6549063120095, 1686.342326492669, 1730.2214003698386, 1753.8333858283443, 1761.9561308881764, 9288.11762882525, 9467.952660236724, 9469.384490008197, 9488.335816492849, 9501.287403444769, 3804.7336686431686, 3816.6183381661613, 3821.082940094413, 3863.690904727615, 3873.360895452275, 7609.505382150142, 7668.65491052904, 7677.155512893689, 7691.961540192375, 7724.6523906424345, 4142.71001029925, 4160.583941605876, 4190.078182799779, 4194.203101410722, 4195.223883581547, 3230.4346739320995, 3303.570535830375, 3781.3193625147187, 3817.4655548222718, 3831.7892515911335, 3063.065764941714, 3079.2455848317304, 3092.149658843836, 3097.845107744604, 3132.263917979273, 867.2974890338845, 868.3140319147802, 870.4994628088748, 871.1680345270252, 872.6291326186346, 981.4209616326401, 991.1426615977127, 995.0845222395413, 995.6117114325419, 1039.740064983754, 6769.120014398097, 6770.1537307836525, 6774.593524388552, 6807.897881531781, 6815.045893574805, 430.2234466787416, 436.4152036271412, 1093.6664317383274, 1133.121830581306, 1133.9433028348715, 5282.735863206901, 5300.522952934254, 5312.04383211018, 5331.360236771612, 5404.567634589223, 8269.29710974574, 8361.916380836235, 8457.534835584102, 8472.576371181416, 8505.914940850513, 8096.433249672584, 8285.917140828635, 8330.0, 8342.916570834213, 8383.664653413916, 6739.932600674028, 6776.796696099125, 6780.660966951633, 6793.728250870009, 6822.863542729117, 6604.603723776589, 6697.966510167418, 6708.463322934251, 6726.764563240459, 6753.15585551806, 7518.135414427192, 7592.544447333178, 7637.121731000784, 7672.654730537028, 7767.611619419119, 7664.540127592362, 7707.267809558307, 7794.92205077942, 7812.492188007988, 7854.921450785419, 5097.8215762448135, 5281.815136470205, 6187.783427580013, 6266.937330626635, 6273.905891411541, 6131.693415329305, 6490.188726409199, 6517.674116294261, 6531.477481801349, 6574.211094668671, 6166.383361663798, 6229.595076320024, 6288.151099601495, 6399.712012959521, 6482.35176482348, 6188.690565471798, 6266.655333956676, 6282.905756413749, 6353.809385718436, 6443.387878151568, 6283.905741413791, 6296.150019747459, 6300.432961033529, 6307.810765677037, 6320.399562041599, 5860.120981852756, 5920.289565252025, 5939.0, 5942.702864856654, 5952.940470595412, 5903.940960590511, 5919.940800592111, 6081.087836824512, 6095.603785753912, 6115.6330620162935], "unit": "ms", "name": "mootools.html", "value": 4065.1472766443294}, {"lowerIsBetter": false, "replicates": [298.4314880153308, 303.64625211628453, 307.554046632383, 308.7499125708178, 312.72792670376776, 5539.335279766428, 5565.053940830058, 5598.6640801551885, 5744.913826292609, 5765.308163020443, 5570.777168913239, 5603.159526071091, 5641.746121424536, 5646.463585959327, 5655.971720141404, 4222.324428091506, 4309.396684464177, 4340.696151269412, 4346.760928148959, 4347.08711170653, 4280.850170244042, 4295.248331541983, 4310.698251122407, 4314.80583373749, 4328.264195086827, 4258.382534532491, 4259.552746961571, 4260.957390426087, 4266.679999000072, 4269.252880745873, 4262.467191601035, 4263.0, 4268.0, 4277.823598510404, 4282.229198744225, 3611.205534782344, 3699.6300369963055, 3719.0516418313427, 3721.106934335767, 3732.0669832541867, 5181.870453238662, 5339.733013349317, 5347.491988261109, 5352.464753524655, 5359.115745901921, 4911.680740751875, 4916.262560615901, 4917.164082106051, 4917.262410638397, 4922.409310882681, 5893.6463812171405, 5908.14331921869, 5922.022866227067, 5926.585139040269, 5944.64332140073, 3882.0877093882914, 3995.98002009991, 4009.799510024487, 4026.154507553388, 4049.250888585592, 6174.722137503823, 6232.470240029603, 6236.469900058455, 6238.87522249557, 6243.8126856194385, 4134.0, 4136.048708796993, 4136.193442278727, 4136.689748268892, 4146.688998325138, 4201.0, 4203.054312779661, 4205.201011807808, 4208.36874468826, 4208.684348673801, 4758.405199350082, 4826.276058591239, 4847.466778654345, 4853.369062021915, 4863.610911127102, 5879.323877754027, 5886.735096920649, 5895.056790913433, 5898.0, 5900.380460051719, 1482.8443013483645, 1483.3250870853735, 1491.1798510819006, 1493.4175671488129, 1493.7311283968772, 994.7065615643403, 996.1333639733333, 998.1366118307611, 1012.099231683802, 1014.6651604970342, 5085.313482679865, 5105.33630628016, 5106.642535022513, 5108.361454818148, 5114.74426278692, 5983.461488466059, 6090.878182436327, 6092.482139018233, 6093.9390606093375, 6107.0, 5060.240963855451, 5079.263506791568, 5095.0, 5107.565856902131, 5111.105556527667, 3229.0958531611186, 3302.2239773653173, 3309.8179600121744, 3330.4171769940162, 3331.700146986783, 5626.549876009909, 5787.102999035156, 5804.245448091721, 5808.186853840466, 5825.854353641108, 6370.012648039468, 6398.200224971879, 6401.583897046677, 6413.134226879311, 6420.807375778734, 5793.420657934173, 5800.0, 5801.129830525455, 5810.070388737866, 5816.88366232673, 5990.700464976647, 6163.9383606163365, 6171.84570385744, 6195.876082478415, 6197.690115494117, 5991.580589358878, 6032.426919442646, 6040.305364882919, 6047.818565443044, 6065.090236464389, 5801.680907550125, 5807.186993820784, 5809.041508151107, 5818.0981947798155, 5823.155642431739, 4122.3404255319, 4184.790760462026, 4186.099988502487, 4195.895102622337, 4203.096334288142, 6049.0, 6165.753369865155, 6177.320494745664, 6190.659513726789, 6194.287656919512, 5922.496587790086, 5945.0, 5950.9404905952115, 5956.702164891652, 5965.761369545343, 5931.792387266425, 5949.851253718692, 5951.226340575698, 5958.433948774859, 5976.193213916065, 5673.432656734293, 5756.3380211276235, 5825.94174058254, 5831.679257640701, 5845.09401042839, 5948.851278718067, 5988.580799344004, 6008.609440386361, 6015.157877897011, 6028.4272994065495, 5819.301683797971, 5820.505257053198, 5831.300243970751, 5839.5036421904615, 5860.472557469848], "unit": "ms", "name": "prototype.html", "value": 4406.398026680663}, {"lowerIsBetter": false, "replicates": [732.2494443195724, 743.8884167374894, 758.6661868777737, 780.7072347869547, 799.5122974985262, 11250.0, 13523.864761352395, 13757.105788123765, 13806.240656763874, 13830.654233644163, 13500.054996150273, 13655.590332290023, 13660.180389176656, 13667.589972300822, 13668.0, 792.9008873890778, 801.0787594266582, 805.7502174325978, 805.8428606421721, 807.8020884883182, 802.1296892871242, 814.4136221920238, 818.0633175014605, 818.8075802186481, 825.6697321071559, 840.7477756673004, 845.7927807687125, 846.8814365988736, 852.0669866496177, 853.5817449449787, 839.9790005249856, 842.30509829391, 842.5408152556871, 843.9198276163785, 845.5814371885895, 622.7695752571532, 624.572168064877, 626.1797045869924, 626.6553395632429, 627.2473032361185, 11498.25261358009, 11577.594784182513, 11581.073514118934, 11601.129915256304, 11642.417879106011, 10668.253222274443, 10727.141828653766, 10978.231523793338, 11314.264572802824, 11373.772524549462, 9356.719298421058, 9418.717438476857, 9598.6640467584, 9633.22934165272, 9740.805183896282, 3100.2404410919244, 3110.5645209670665, 3128.139761565565, 3148.5434611981364, 3162.76279279055, 42166.367504487454, 42288.788556057334, 42368.0, 42668.57331426677, 42792.14415711699, 9140.908590914005, 9205.40119449485, 9363.0, 9447.858282125773, 9463.76340591477, 15851.603709907344, 15880.52358429249, 15918.124503152438, 15925.0, 16062.75905861413, 6239.594426362272, 6417.197850268716, 6427.807165785034, 6449.5485316027425, 6580.078788969548, 3458.221900072514, 3575.588807287143, 3611.7291203159866, 3612.0, 3659.2864391443413, 2490.3151633300986, 2520.4959008198434, 2527.6082207257905, 2531.4304281536874, 2532.025170309444, 477.6012029954957, 482.0, 482.0696056610775, 483.135188013459, 485.7231378114511, 447.11471286851565, 519.3689667054547, 556.7661582135432, 570.6433479075578, 578.3609111931339, 6637.502187335969, 7262.527935684164, 7619.657115429819, 7782.299593036654, 7873.291403773574, 448.5536890793681, 457.7482384688475, 493.64704236471096, 512.9615278854101, 573.489594261108, 3480.3039392121173, 3537.1510837399355, 3836.271108489378, 3970.5433875104154, 4020.4773379460485, 49725.0, 50117.74941125271, 50222.24666630004, 50432.0, 50667.74666126646, 43427.34858977118, 43845.78077109594, 44237.8940526483, 44248.55751442444, 44393.55606443894, 39904.800475997436, 40438.59561404349, 40574.79712601477, 40885.795571021954, 41043.58956410457, 7841.1766764491185, 7951.165127661512, 8094.231048050426, 8226.0, 8231.588420579066, 28737.0, 29020.419591608472, 29273.70726292795, 30266.697333026386, 32756.344873101927, 38753.03117422087, 38858.6114138855, 39407.0, 40423.59576404198, 40823.79588102041, 9494.667686630935, 9788.412695238309, 9963.103320701171, 10062.094411503, 10122.291439599157, 10906.672799816019, 11046.834297485384, 11212.103031757602, 11241.775164496828, 11360.431978401211, 10390.3246288994, 10410.27128101056, 10729.248952573245, 10936.0, 10967.287126336763, 10177.185825133824, 10337.328073675188, 10404.11565016982, 10453.529591168264, 10953.233273670767, 9477.336586439158, 9737.318387713076, 9788.363756355815, 10025.0, 10718.571257149939, 8815.911840881508, 8919.821603568022, 9076.41003334781, 9134.665430734096, 9271.443713377219, 9313.580888859882, 9407.623695052394, 9445.24438044941, 9463.526823658927, 9546.331756776959], "unit": "ms", "name": "yui.html", "value": 5719.315714672236}], "name": "dromaeo_css", "value": 6327.715595565634}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [122.0, 106.0, 116.0, 112.0, 114.0, 123.0, 112.0, 113.0, 116.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [162.0, 130.0, 150.0, 163.0, 131.0, 156.0, 158.0, 130.0, 168.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 164.0, 162.0, 165.0, 171.0, 166.0, 173.0, 166.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 166.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 74.0, 74.0, 141.0, 73.0, 74.0, 74.0, 73.0, 94.0], "unit": "ms", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 96.0, 95.0, 94.0, 132.0, 94.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 77.0, 72.0, 75.0, 72.0, 73.0, 74.0, 74.0, 75.0], "unit": "ms", "name": "json-parse-financial", "value": 73.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 93.0, 85.0, 86.0, 85.0, 84.0, 84.0, 85.0, 97.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 131.0, 128.0, 121.0, 138.0, 129.0, 124.0, 127.0, 138.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.5}, {"lowerIsBetter": true, "replicates": [139.0, 149.0, 149.0, 151.0, 148.0, 137.0, 151.0, 160.0, 148.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 73.0, 72.0, 69.0, 71.0, 71.0, 69.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1545.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [185.70102135561746], "unit": "score", "name": "DeltaBlue", "value": 356.04543000000007}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1090.5125408942204], "unit": "score", "name": "RayTrace", "value": 678.5699129999998}, {"lowerIsBetter": false, "replicates": [733.3333333333334], "unit": "score", "name": "Earley", "value": 908.8131818181815}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [604.9606775559589], "unit": "score", "name": "Splay", "value": 134.70462300000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21185.935528068654}]} 10:18:23 INFO - RETURN: dromaeo_css: 6327.72 10:18:23 INFO - RETURN: kraken: 1545.30 10:18:23 INFO - RETURN: v8_7: 21185.94 10:18:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21185.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1545.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6327.72"}}} 10:18:23 INFO - Return code: 0 10:18:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:18:23 INFO - # TBPL SUCCESS # 10:18:23 INFO - Running post-action listener: _resource_record_post_action 10:18:23 INFO - Running post-run listener: _resource_record_post_run 10:18:24 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511414272; Read time: 16; Write time: 524600 10:18:24 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235659264; Read time: 0; Write time: 362116 10:18:24 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274923520; Read time: 16; Write time: 162440 10:18:24 INFO - Running post-run listener: _upload_blobber_files 10:18:24 INFO - Blob upload gear active. 10:18:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:18:24 INFO - Copying logs to upload dir... 10:18:24 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.905233 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-11 10:18:22.860838) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:18:22.864948) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010085 build_url: 'https://queue.taskcluster.net/v1/task/TfTivFILQa6uNtITIHHG8g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:18:22.917836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:18:22.918227) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449856587.897578-573663202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:18:22.968726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:18:22.969084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:18:22.969429) ========= ========= Total master_lag: 0.52 =========