builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1448888041.87 results: success (0) buildid: 20151130032833 builduid: f72ba8183a4c4c3b99bb9197d7252094 revision: a68027fa23fc05f97e0bb68350817037a5c89cd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.869390) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.869842) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.870233) ========= 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=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006532 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.893937) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.894276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.929592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.930066) ========= 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=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.997671) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.998094) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.998590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:01.998908) ========= 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=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-30 04:54:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-30 04:54:02 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.186517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.186845) ========= 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=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015430 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.236789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.237199) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a68027fa23fc05f97e0bb68350817037a5c89cd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a68027fa23fc05f97e0bb68350817037a5c89cd1 --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=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-30 04:54:02,385 truncating revision to first 12 chars 2015-11-30 04:54:02,385 Setting DEBUG logging. 2015-11-30 04:54:02,385 attempt 1/10 2015-11-30 04:54:02,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a68027fa23fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-30 04:54:02,642 unpacking tar archive at: mozilla-central-a68027fa23fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570841 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.820847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.821155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.831566) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.831869) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 04:54:02.832374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-30 04:54:02.832668) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:54:03 INFO - MultiFileLogger online at 20151130 04:54:03 in /builds/slave/test 04:54:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:54:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:03 INFO - {'append_to_log': False, 04:54:03 INFO - 'base_work_dir': '/builds/slave/test', 04:54:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:54:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:03 INFO - 'branch': 'Firefox-Non-PGO', 04:54:03 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:03 INFO - 'config_files': ('talos/linux_config.py',), 04:54:03 INFO - 'default_actions': ('clobber', 04:54:03 INFO - 'read-buildbot-config', 04:54:03 INFO - 'download-and-extract', 04:54:03 INFO - 'populate-webroot', 04:54:03 INFO - 'create-virtualenv', 04:54:03 INFO - 'install', 04:54:03 INFO - 'run-tests'), 04:54:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:03 INFO - 'download_minidump_stackwalk': True, 04:54:03 INFO - 'download_symbols': 'ondemand', 04:54:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:03 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:03 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:03 INFO - 'installer_path': 'installer.exe', 04:54:03 INFO - 'log_level': 'info', 04:54:03 INFO - 'log_name': 'talos', 04:54:03 INFO - 'log_to_console': True, 04:54:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:54:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:54:03 INFO - 'opt_config_files': (), 04:54:03 INFO - 'pip_index': False, 04:54:03 INFO - 'sps_profile': False, 04:54:03 INFO - 'sps_profile_interval': 0, 04:54:03 INFO - 'suite': 'dromaeojs-e10s', 04:54:03 INFO - 'system_bits': '64', 04:54:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:03 INFO - 'title': 'talos-linux64-ix-033', 04:54:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:03 INFO - 'use_talos_json': True, 04:54:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:03 INFO - 'work_dir': 'build'} 04:54:03 INFO - ##### 04:54:03 INFO - ##### Running clobber step. 04:54:03 INFO - ##### 04:54:03 INFO - Running pre-action listener: _resource_record_pre_action 04:54:03 INFO - Running main action method: clobber 04:54:03 INFO - rmtree: /builds/slave/test/build 04:54:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:03 INFO - Running post-action listener: _resource_record_post_action 04:54:03 INFO - ##### 04:54:03 INFO - ##### Running read-buildbot-config step. 04:54:03 INFO - ##### 04:54:03 INFO - Running pre-action listener: _resource_record_pre_action 04:54:03 INFO - Running main action method: read_buildbot_config 04:54:03 INFO - Using buildbot properties: 04:54:03 INFO - { 04:54:03 INFO - "properties": { 04:54:03 INFO - "buildnumber": 149, 04:54:03 INFO - "product": "firefox", 04:54:03 INFO - "script_repo_revision": "production", 04:54:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:54:03 INFO - "repository": "", 04:54:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:54:03 INFO - "buildid": "20151130032833", 04:54:03 INFO - "slavename": "talos-linux64-ix-033", 04:54:03 INFO - "pgo_build": "False", 04:54:03 INFO - "basedir": "/builds/slave/test", 04:54:03 INFO - "project": "", 04:54:03 INFO - "platform": "ubuntu64_hw", 04:54:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:54:03 INFO - "slavebuilddir": "test", 04:54:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:54:03 INFO - "branch": "mozilla-central", 04:54:03 INFO - "repo_path": "mozilla-central", 04:54:03 INFO - "stage_platform": "linux64", 04:54:03 INFO - "builduid": "f72ba8183a4c4c3b99bb9197d7252094", 04:54:03 INFO - "revision": "a68027fa23fc05f97e0bb68350817037a5c89cd1" 04:54:03 INFO - }, 04:54:03 INFO - "sourcestamp": { 04:54:03 INFO - "repository": "", 04:54:03 INFO - "hasPatch": false, 04:54:03 INFO - "project": "", 04:54:03 INFO - "branch": "mozilla-central-linux64-talos", 04:54:03 INFO - "changes": [ 04:54:03 INFO - { 04:54:03 INFO - "category": null, 04:54:03 INFO - "files": [ 04:54:03 INFO - { 04:54:03 INFO - "url": null, 04:54:03 INFO - "name": "https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:54:03 INFO - } 04:54:03 INFO - ], 04:54:03 INFO - "repository": "", 04:54:03 INFO - "rev": "a68027fa23fc05f97e0bb68350817037a5c89cd1", 04:54:03 INFO - "who": "cbook@mozilla.com", 04:54:03 INFO - "when": 1448887961, 04:54:03 INFO - "number": 6720859, 04:54:03 INFO - "comments": "merge b2g-inbound to mozilla-central a=merge", 04:54:03 INFO - "project": "", 04:54:03 INFO - "at": "Mon 30 Nov 2015 04:52:41", 04:54:03 INFO - "branch": "mozilla-central-linux64-talos", 04:54:03 INFO - "revlink": "", 04:54:03 INFO - "properties": [ 04:54:03 INFO - [ 04:54:03 INFO - "buildid", 04:54:03 INFO - "20151130032833", 04:54:03 INFO - "Change" 04:54:03 INFO - ], 04:54:03 INFO - [ 04:54:03 INFO - "builduid", 04:54:03 INFO - "f72ba8183a4c4c3b99bb9197d7252094", 04:54:03 INFO - "Change" 04:54:03 INFO - ], 04:54:03 INFO - [ 04:54:03 INFO - "pgo_build", 04:54:03 INFO - "False", 04:54:03 INFO - "Change" 04:54:03 INFO - ] 04:54:03 INFO - ], 04:54:03 INFO - "revision": "a68027fa23fc05f97e0bb68350817037a5c89cd1" 04:54:03 INFO - } 04:54:03 INFO - ], 04:54:03 INFO - "revision": "a68027fa23fc05f97e0bb68350817037a5c89cd1" 04:54:03 INFO - } 04:54:03 INFO - } 04:54:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:54:03 INFO - Running post-action listener: _resource_record_post_action 04:54:03 INFO - ##### 04:54:03 INFO - ##### Running download-and-extract step. 04:54:03 INFO - ##### 04:54:03 INFO - Running pre-action listener: _resource_record_pre_action 04:54:03 INFO - Running main action method: download_and_extract 04:54:03 INFO - mkdir: /builds/slave/test/build/tests 04:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:03 INFO - https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:54:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/test_packages.json 04:54:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/test_packages.json 04:54:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:54:05 INFO - Downloaded 1302 bytes. 04:54:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:54:05 INFO - Using the following test package requirements: 04:54:05 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:05 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:54:05 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:05 INFO - u'jsshell-linux-x86_64.zip'], 04:54:05 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:54:05 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:05 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:54:05 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:54:05 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:54:05 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:05 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:05 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:54:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:54: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')]} 04:54:05 INFO - https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:06 INFO - Downloaded 21516951 bytes. 04:54:06 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 04:54:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:06 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 04:54:07 INFO - Return code: 0 04:54:07 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 04:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:07 INFO - https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:11 INFO - Downloaded 21516951 bytes. 04:54:11 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 04:54:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:11 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 04:54:13 INFO - Return code: 0 04:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:13 INFO - https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:14 INFO - Downloaded 11131728 bytes. 04:54:14 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 04:54:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:14 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 04:54:14 INFO - Return code: 0 04:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:14 INFO - https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:54:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2hKpQaZTt2qctkdOOR_4g/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 04:54:16 INFO - Downloaded 56875183 bytes. 04:54:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:16 INFO - mkdir: /builds/slave/test/properties 04:54:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:16 INFO - Contents: 04:54:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:16 INFO - Running post-action listener: _resource_record_post_action 04:54:16 INFO - Running post-action listener: set_extra_try_arguments 04:54:16 INFO - ##### 04:54:16 INFO - ##### Running populate-webroot step. 04:54:16 INFO - ##### 04:54:16 INFO - Running pre-action listener: _resource_record_pre_action 04:54:16 INFO - Running main action method: populate_webroot 04:54:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:16 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:54:16 INFO - '../fennec_ids.txt'], 04:54:16 INFO - 'tests': ['tcheck2']}, 04:54:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:16 INFO - '--tppagecycles', 04:54:16 INFO - '7'], 04:54:16 INFO - 'tests': ['tsvgm']}}, 04:54:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:54:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'tests': ['damp', 'tps']}, 04:54:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['damp', 'tps']}, 04:54:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:54:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:16 INFO - 'other': {'tests': ['a11yr', 04:54:16 INFO - 'ts_paint', 04:54:16 INFO - 'tpaint', 04:54:16 INFO - 'sessionrestore', 04:54:16 INFO - 'sessionrestore_no_auto_restore']}, 04:54:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['a11yr', 04:54:16 INFO - 'ts_paint', 04:54:16 INFO - 'tpaint', 04:54:16 INFO - 'sessionrestore', 04:54:16 INFO - 'sessionrestore_no_auto_restore']}, 04:54:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['a11yr', 04:54:16 INFO - 'ts_paint', 04:54:16 INFO - 'tpaint', 04:54:16 INFO - 'sessionrestore', 04:54:16 INFO - 'sessionrestore_no_auto_restore']}, 04:54:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['a11yr', 04:54:16 INFO - 'ts_paint', 04:54:16 INFO - 'tpaint', 04:54:16 INFO - 'sessionrestore', 04:54:16 INFO - 'sessionrestore_no_auto_restore']}, 04:54:16 INFO - 'other_l64': {'tests': ['a11yr', 04:54:16 INFO - 'ts_paint', 04:54:16 INFO - 'tpaint', 04:54:16 INFO - 'sessionrestore', 04:54:16 INFO - 'sessionrestore_no_auto_restore']}, 04:54:16 INFO - 'other_nol64': {'tests': ['a11yr', 04:54:16 INFO - 'ts_paint', 04:54:16 INFO - 'tpaint', 04:54:16 INFO - 'sessionrestore', 04:54:16 INFO - 'sessionrestore_no_auto_restore']}, 04:54:16 INFO - 'svgr': {'tests': ['tsvgx', 04:54:16 INFO - 'tsvgr_opacity', 04:54:16 INFO - 'tart', 04:54:16 INFO - 'tscrollx', 04:54:16 INFO - 'cart']}, 04:54:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['tsvgx', 04:54:16 INFO - 'tsvgr_opacity', 04:54:16 INFO - 'tart', 04:54:16 INFO - 'tscrollx', 04:54:16 INFO - 'cart']}, 04:54:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'tests': ['tp5o']}, 04:54:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'talos_options': ['--e10s'], 04:54:16 INFO - 'tests': ['tp5o']}, 04:54:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'talos_options': ['--xperf_path', 04:54:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:16 INFO - 'tests': ['tp5n']}, 04:54:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:16 INFO - 'talos_options': ['--e10s', 04:54:16 INFO - '--xperf_path', 04:54:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:16 INFO - 'tests': ['tp5n']}}, 04:54:16 INFO - 'talos.zip': {'path': '', 04:54:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:16 INFO - Running post-action listener: _resource_record_post_action 04:54:16 INFO - ##### 04:54:16 INFO - ##### Running create-virtualenv step. 04:54:16 INFO - ##### 04:54:16 INFO - Running pre-action listener: _resource_record_pre_action 04:54:16 INFO - Running main action method: create_virtualenv 04:54:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:16 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 04:54:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:16 INFO - Using real prefix '/usr' 04:54:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:19 INFO - Installing pip.................done. 04:54:19 INFO - Return code: 0 04:54:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54:19 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')]} 04:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:19 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')]} 04:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:19 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:19 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 04:54:19 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 04:54:19 INFO - Using env: {'DISPLAY': ':0', 04:54:19 INFO - 'HOME': '/home/cltbld', 04:54:19 INFO - 'LANG': 'en_US.UTF-8', 04:54:19 INFO - 'LANGUAGE': 'en_US:en', 04:54:19 INFO - 'LOGNAME': 'cltbld', 04:54:19 INFO - 'MAIL': '/var/mail/cltbld', 04:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:19 INFO - 'MOZ_NO_REMOTE': '1', 04:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:19 INFO - 'NO_EM_RESTART': '1', 04:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:19 INFO - 'PWD': '/builds/slave/test', 04:54:19 INFO - 'SHELL': '/bin/bash', 04:54:19 INFO - 'SHLVL': '1', 04:54:19 INFO - 'TERM': 'linux', 04:54:19 INFO - 'TMOUT': '86400', 04:54:19 INFO - 'USER': 'cltbld', 04:54:19 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:19 INFO - '_': '/tools/buildbot/bin/python'} 04:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:19 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 04:54:19 INFO - Cleaning up... 04:54:19 INFO - Return code: 0 04:54:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:54:19 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')]} 04:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:19 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')]} 04:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:19 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:19 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 04:54:19 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 04:54:19 INFO - Using env: {'DISPLAY': ':0', 04:54:19 INFO - 'HOME': '/home/cltbld', 04:54:19 INFO - 'LANG': 'en_US.UTF-8', 04:54:19 INFO - 'LANGUAGE': 'en_US:en', 04:54:19 INFO - 'LOGNAME': 'cltbld', 04:54:19 INFO - 'MAIL': '/var/mail/cltbld', 04:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:19 INFO - 'MOZ_NO_REMOTE': '1', 04:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:19 INFO - 'NO_EM_RESTART': '1', 04:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:19 INFO - 'PWD': '/builds/slave/test', 04:54:19 INFO - 'SHELL': '/bin/bash', 04:54:19 INFO - 'SHLVL': '1', 04:54:19 INFO - 'TERM': 'linux', 04:54:19 INFO - 'TMOUT': '86400', 04:54:19 INFO - 'USER': 'cltbld', 04:54:19 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:19 INFO - '_': '/tools/buildbot/bin/python'} 04:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:19 INFO - Downloading/unpacking psutil>=0.7.1 04:54:19 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 04:54:19 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 04:54:19 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 04:54:19 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 04:54:19 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 04:54:19 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 04:54:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:54:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:21 INFO - Installing collected packages: psutil 04:54:21 INFO - Running setup.py install for psutil 04:54:21 INFO - building 'psutil._psutil_linux' extension 04:54:21 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 04:54:21 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 04:54:21 INFO - building 'psutil._psutil_posix' extension 04:54:21 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 04:54:21 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 04:54:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:21 INFO - Successfully installed psutil 04:54:21 INFO - Cleaning up... 04:54:21 INFO - Return code: 0 04:54:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:54:21 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')]} 04:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:21 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')]} 04:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:21 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:21 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 04:54:21 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 04:54:21 INFO - Using env: {'DISPLAY': ':0', 04:54:21 INFO - 'HOME': '/home/cltbld', 04:54:21 INFO - 'LANG': 'en_US.UTF-8', 04:54:21 INFO - 'LANGUAGE': 'en_US:en', 04:54:21 INFO - 'LOGNAME': 'cltbld', 04:54:21 INFO - 'MAIL': '/var/mail/cltbld', 04:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:21 INFO - 'MOZ_NO_REMOTE': '1', 04:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:21 INFO - 'NO_EM_RESTART': '1', 04:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:21 INFO - 'PWD': '/builds/slave/test', 04:54:21 INFO - 'SHELL': '/bin/bash', 04:54:21 INFO - 'SHLVL': '1', 04:54:21 INFO - 'TERM': 'linux', 04:54:21 INFO - 'TMOUT': '86400', 04:54:21 INFO - 'USER': 'cltbld', 04:54:21 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:21 INFO - '_': '/tools/buildbot/bin/python'} 04:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:54:22 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 04:54:22 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 04:54:22 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 04:54:22 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 04:54:22 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 04:54:22 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 04:54:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:54:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:54:23 INFO - Installing collected packages: mozsystemmonitor 04:54:23 INFO - Running setup.py install for mozsystemmonitor 04:54:23 INFO - Successfully installed mozsystemmonitor 04:54:23 INFO - Cleaning up... 04:54:24 INFO - Return code: 0 04:54:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54:24 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')]} 04:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:24 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')]} 04:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:24 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:24 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 04:54:24 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 04:54:24 INFO - Using env: {'DISPLAY': ':0', 04:54:24 INFO - 'HOME': '/home/cltbld', 04:54:24 INFO - 'LANG': 'en_US.UTF-8', 04:54:24 INFO - 'LANGUAGE': 'en_US:en', 04:54:24 INFO - 'LOGNAME': 'cltbld', 04:54:24 INFO - 'MAIL': '/var/mail/cltbld', 04:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:24 INFO - 'MOZ_NO_REMOTE': '1', 04:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:24 INFO - 'NO_EM_RESTART': '1', 04:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:24 INFO - 'PWD': '/builds/slave/test', 04:54:24 INFO - 'SHELL': '/bin/bash', 04:54:24 INFO - 'SHLVL': '1', 04:54:24 INFO - 'TERM': 'linux', 04:54:24 INFO - 'TMOUT': '86400', 04:54:24 INFO - 'USER': 'cltbld', 04:54:24 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:24 INFO - '_': '/tools/buildbot/bin/python'} 04:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:24 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 04:54:24 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 04:54:24 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 04:54:24 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 04:54:24 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 04:54:24 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 04:54:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 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 04:54:26 INFO - Downloading docopt-0.6.1.tar.gz 04:54:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:26 INFO - Running setup.py install for blobuploader 04:54:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:26 INFO - Running setup.py install for requests 04:54:27 INFO - Running setup.py install for docopt 04:54:27 INFO - Successfully installed blobuploader requests docopt 04:54:27 INFO - Cleaning up... 04:54:27 INFO - Return code: 0 04:54:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:27 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')]} 04:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:27 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')]} 04:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:27 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:27 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 04:54:27 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 04:54:27 INFO - Using env: {'DISPLAY': ':0', 04:54:27 INFO - 'HOME': '/home/cltbld', 04:54:27 INFO - 'LANG': 'en_US.UTF-8', 04:54:27 INFO - 'LANGUAGE': 'en_US:en', 04:54:27 INFO - 'LOGNAME': 'cltbld', 04:54:27 INFO - 'MAIL': '/var/mail/cltbld', 04:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:27 INFO - 'MOZ_NO_REMOTE': '1', 04:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:27 INFO - 'NO_EM_RESTART': '1', 04:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:27 INFO - 'PWD': '/builds/slave/test', 04:54:27 INFO - 'SHELL': '/bin/bash', 04:54:27 INFO - 'SHLVL': '1', 04:54:27 INFO - 'TERM': 'linux', 04:54:27 INFO - 'TMOUT': '86400', 04:54:27 INFO - 'USER': 'cltbld', 04:54:27 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:27 INFO - '_': '/tools/buildbot/bin/python'} 04:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:27 INFO - Running setup.py (path:/tmp/pip-XLfS9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:27 INFO - Running setup.py (path:/tmp/pip-p87A5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:27 INFO - Running setup.py (path:/tmp/pip-oAI4a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:27 INFO - Running setup.py (path:/tmp/pip-ZP8Q1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:27 INFO - Running setup.py (path:/tmp/pip-p4Kn8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:27 INFO - Running setup.py (path:/tmp/pip-gzbwXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:27 INFO - Running setup.py (path:/tmp/pip-rlUOM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:28 INFO - Running setup.py (path:/tmp/pip-Zjb9Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:28 INFO - Running setup.py (path:/tmp/pip-7W4hib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:28 INFO - Running setup.py (path:/tmp/pip-Y8dGWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:28 INFO - Running setup.py (path:/tmp/pip-9Vi1u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:28 INFO - Running setup.py (path:/tmp/pip-qCibcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:28 INFO - Running setup.py (path:/tmp/pip-hDR3gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:28 INFO - Running setup.py (path:/tmp/pip-kf084B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:28 INFO - Running setup.py (path:/tmp/pip-yZjSJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:28 INFO - Running setup.py (path:/tmp/pip-umK1Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:28 INFO - Running setup.py (path:/tmp/pip-aLutbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:28 INFO - Running setup.py install for manifestparser 04:54:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozcrash 04:54:28 INFO - Running setup.py install for mozdebug 04:54:29 INFO - Running setup.py install for mozdevice 04:54:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozfile 04:54:29 INFO - Running setup.py install for mozhttpd 04:54:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozinfo 04:54:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozInstall 04:54:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozleak 04:54:29 INFO - Running setup.py install for mozlog 04:54:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for moznetwork 04:54:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozprocess 04:54:29 INFO - Running setup.py install for mozprofile 04:54:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:30 INFO - Running setup.py install for mozrunner 04:54:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:30 INFO - Running setup.py install for mozscreenshot 04:54:30 INFO - Running setup.py install for moztest 04:54:30 INFO - Running setup.py install for mozversion 04:54:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:30 INFO - Cleaning up... 04:54:30 INFO - Return code: 0 04:54:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '-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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:30 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 04:54:30 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 04:54:30 INFO - Using env: {'DISPLAY': ':0', 04:54:30 INFO - 'HOME': '/home/cltbld', 04:54:30 INFO - 'LANG': 'en_US.UTF-8', 04:54:30 INFO - 'LANGUAGE': 'en_US:en', 04:54:30 INFO - 'LOGNAME': 'cltbld', 04:54:30 INFO - 'MAIL': '/var/mail/cltbld', 04:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:30 INFO - 'MOZ_NO_REMOTE': '1', 04:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:30 INFO - 'NO_EM_RESTART': '1', 04:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:30 INFO - 'PWD': '/builds/slave/test', 04:54:30 INFO - 'SHELL': '/bin/bash', 04:54:30 INFO - 'SHLVL': '1', 04:54:30 INFO - 'TERM': 'linux', 04:54:30 INFO - 'TMOUT': '86400', 04:54:30 INFO - 'USER': 'cltbld', 04:54:30 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:30 INFO - '_': '/tools/buildbot/bin/python'} 04:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:30 INFO - Running setup.py (path:/tmp/pip-ISWXOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:30 INFO - Running setup.py (path:/tmp/pip-_hXvs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:30 INFO - Running setup.py (path:/tmp/pip-Tx8yTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:30 INFO - Running setup.py (path:/tmp/pip-kQqYaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:31 INFO - Running setup.py (path:/tmp/pip-c3IgPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:31 INFO - Running setup.py (path:/tmp/pip-WSuoyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:31 INFO - Running setup.py (path:/tmp/pip-JW37ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:31 INFO - Running setup.py (path:/tmp/pip-gR5HDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:31 INFO - Running setup.py (path:/tmp/pip-px7Wkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:31 INFO - Running setup.py (path:/tmp/pip-HGTmLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:31 INFO - Running setup.py (path:/tmp/pip-MyokgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:31 INFO - Running setup.py (path:/tmp/pip-wu0JuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:31 INFO - Running setup.py (path:/tmp/pip-tCdeWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:31 INFO - Running setup.py (path:/tmp/pip-AG0pnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:31 INFO - Running setup.py (path:/tmp/pip-FvDUJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:31 INFO - Running setup.py (path:/tmp/pip-0QSd0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:31 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)) 04:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:31 INFO - Running setup.py (path:/tmp/pip-OPmOVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:31 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)) 04:54:31 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)) 04:54:31 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)) 04:54:31 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)) 04:54:31 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)) 04:54:31 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)) 04:54:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:31 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 04:54:31 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 04:54:31 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 04:54:31 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 04:54:31 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 04:54:31 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 04:54:33 INFO - Downloading blessings-1.5.1.tar.gz 04:54:33 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 04:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:33 INFO - Installing collected packages: blessings 04:54:33 INFO - Running setup.py install for blessings 04:54:33 INFO - Successfully installed blessings 04:54:33 INFO - Cleaning up... 04:54:33 INFO - Return code: 0 04:54:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:34 INFO - Reading from file tmpfile_stdout 04:54:34 INFO - Current package versions: 04:54:34 INFO - argparse == 1.2.1 04:54:34 INFO - blessings == 1.5.1 04:54:34 INFO - blobuploader == 1.2.4 04:54:34 INFO - docopt == 0.6.1 04:54:34 INFO - manifestparser == 1.1 04:54:34 INFO - mozInstall == 1.12 04:54:34 INFO - mozcrash == 0.16 04:54:34 INFO - mozdebug == 0.1 04:54:34 INFO - mozdevice == 0.47 04:54:34 INFO - mozfile == 1.2 04:54:34 INFO - mozhttpd == 0.7 04:54:34 INFO - mozinfo == 0.9 04:54:34 INFO - mozleak == 0.1 04:54:34 INFO - mozlog == 3.1 04:54:34 INFO - moznetwork == 0.27 04:54:34 INFO - mozprocess == 0.22 04:54:34 INFO - mozprofile == 0.27 04:54:34 INFO - mozrunner == 6.11 04:54:34 INFO - mozscreenshot == 0.1 04:54:34 INFO - mozsystemmonitor == 0.0 04:54:34 INFO - moztest == 0.7 04:54:34 INFO - mozversion == 1.4 04:54:34 INFO - psutil == 3.1.1 04:54:34 INFO - requests == 1.2.3 04:54:34 INFO - wsgiref == 0.1.2 04:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:34 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')]} 04:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:34 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')]} 04:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:34 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:34 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 04:54:34 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 04:54:34 INFO - Using env: {'DISPLAY': ':0', 04:54:34 INFO - 'HOME': '/home/cltbld', 04:54:34 INFO - 'LANG': 'en_US.UTF-8', 04:54:34 INFO - 'LANGUAGE': 'en_US:en', 04:54:34 INFO - 'LOGNAME': 'cltbld', 04:54:34 INFO - 'MAIL': '/var/mail/cltbld', 04:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:34 INFO - 'MOZ_NO_REMOTE': '1', 04:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:34 INFO - 'NO_EM_RESTART': '1', 04:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:34 INFO - 'PWD': '/builds/slave/test', 04:54:34 INFO - 'SHELL': '/bin/bash', 04:54:34 INFO - 'SHLVL': '1', 04:54:34 INFO - 'TERM': 'linux', 04:54:34 INFO - 'TMOUT': '86400', 04:54:34 INFO - 'USER': 'cltbld', 04:54:34 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:34 INFO - '_': '/tools/buildbot/bin/python'} 04:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 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)) 04:54:34 INFO - Cleaning up... 04:54:34 INFO - Return code: 0 04:54:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:34 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')]} 04:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:34 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')]} 04:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:34 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:34 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 04:54:34 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 04:54:34 INFO - Using env: {'DISPLAY': ':0', 04:54:34 INFO - 'HOME': '/home/cltbld', 04:54:34 INFO - 'LANG': 'en_US.UTF-8', 04:54:34 INFO - 'LANGUAGE': 'en_US:en', 04:54:34 INFO - 'LOGNAME': 'cltbld', 04:54:34 INFO - 'MAIL': '/var/mail/cltbld', 04:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:34 INFO - 'MOZ_NO_REMOTE': '1', 04:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:34 INFO - 'NO_EM_RESTART': '1', 04:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:34 INFO - 'PWD': '/builds/slave/test', 04:54:34 INFO - 'SHELL': '/bin/bash', 04:54:34 INFO - 'SHLVL': '1', 04:54:34 INFO - 'TERM': 'linux', 04:54:34 INFO - 'TMOUT': '86400', 04:54:34 INFO - 'USER': 'cltbld', 04:54:34 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:34 INFO - '_': '/tools/buildbot/bin/python'} 04:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:34 INFO - Downloading/unpacking jsonschema 04:54:34 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 04:54:34 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 04:54:34 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 04:54:34 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 04:54:34 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 04:54:34 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 04:54:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:36 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 04:54:36 INFO - Downloading/unpacking functools32 (from jsonschema) 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:36 INFO - warning: no files found matching '*.txt' 04:54:36 INFO - no previously-included directories found matching 'build' 04:54:36 INFO - no previously-included directories found matching 'dist' 04:54:36 INFO - no previously-included directories found matching '.git*' 04:54:36 INFO - Installing collected packages: jsonschema, functools32 04:54:36 INFO - Running setup.py install for functools32 04:54:36 INFO - warning: no files found matching '*.txt' 04:54:36 INFO - no previously-included directories found matching 'build' 04:54:36 INFO - no previously-included directories found matching 'dist' 04:54:36 INFO - no previously-included directories found matching '.git*' 04:54:36 INFO - Successfully installed jsonschema functools32 04:54:36 INFO - Cleaning up... 04:54:36 INFO - Return code: 0 04:54:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:36 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 0x7fa03da2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', '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 04:54:36 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 04:54:36 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 04:54:36 INFO - Using env: {'DISPLAY': ':0', 04:54:36 INFO - 'HOME': '/home/cltbld', 04:54:36 INFO - 'LANG': 'en_US.UTF-8', 04:54:36 INFO - 'LANGUAGE': 'en_US:en', 04:54:36 INFO - 'LOGNAME': 'cltbld', 04:54:36 INFO - 'MAIL': '/var/mail/cltbld', 04:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:36 INFO - 'MOZ_NO_REMOTE': '1', 04:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:36 INFO - 'NO_EM_RESTART': '1', 04:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:36 INFO - 'PWD': '/builds/slave/test', 04:54:36 INFO - 'SHELL': '/bin/bash', 04:54:36 INFO - 'SHLVL': '1', 04:54:36 INFO - 'TERM': 'linux', 04:54:36 INFO - 'TMOUT': '86400', 04:54:36 INFO - 'USER': 'cltbld', 04:54:36 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:36 INFO - '_': '/tools/buildbot/bin/python'} 04:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:36 INFO - Downloading/unpacking flake8 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 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 04:54:36 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 04:54:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:54:38 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 04:54:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:54:38 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 04:54:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 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 04:54:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:39 INFO - no previously-included directories found matching 'docs/_build' 04:54:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:54:39 INFO - Running setup.py install for pep8 04:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:39 INFO - no previously-included directories found matching 'docs/_build' 04:54:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:54:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:54:39 INFO - Cleaning up... 04:54:39 INFO - Return code: 0 04:54:39 INFO - Running post-action listener: _resource_record_post_action 04:54:39 INFO - Running post-action listener: _start_resource_monitoring 04:54:39 INFO - Starting resource monitoring. 04:54:39 INFO - ##### 04:54:39 INFO - ##### Running install step. 04:54:39 INFO - ##### 04:54:39 INFO - Running pre-action listener: _resource_record_pre_action 04:54:39 INFO - Running main action method: install 04:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:39 INFO - Reading from file tmpfile_stdout 04:54:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:39 INFO - Reading from file tmpfile_stdout 04:54:39 INFO - Output received: 04:54:39 INFO - Usage: mozinstall [options] installer 04:54:39 INFO - Options: 04:54:39 INFO - -h, --help show this help message and exit 04:54:39 INFO - -d DEST, --destination=DEST 04:54:39 INFO - Directory to install application into. [default: 04:54:39 INFO - "/builds/slave/test"] 04:54:39 INFO - --app=APP Application being installed. [default: firefox] 04:54:39 INFO - mkdir: /builds/slave/test/build/application 04:54:39 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'] 04:54:39 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 04:54:54 INFO - Reading from file tmpfile_stdout 04:54:54 INFO - Output received: 04:54:54 INFO - /builds/slave/test/build/application/firefox/firefox 04:54:54 INFO - Running post-action listener: _resource_record_post_action 04:54:54 INFO - ##### 04:54:54 INFO - ##### Running run-tests step. 04:54:54 INFO - ##### 04:54:54 INFO - Running pre-action listener: _resource_record_pre_action 04:54:54 INFO - Running main action method: run_tests 04:54:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:54 INFO - Python 2.7.3 04:54:54 INFO - Return code: 0 04:54:54 INFO - grabbing minidump binary from tooltool 04:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:54 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 0x12400b0>, '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 0x1240fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1241440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:54 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 04:54:54 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 04:54:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:54 INFO - Return code: 0 04:54:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:54:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:54:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:55 INFO - Return code: 0 04:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test/build 04:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 04:54:55 INFO - Using env: {'DISPLAY': ':0', 04:54:55 INFO - 'HOME': '/home/cltbld', 04:54:55 INFO - 'LANG': 'en_US.UTF-8', 04:54:55 INFO - 'LANGUAGE': 'en_US:en', 04:54:55 INFO - 'LOGNAME': 'cltbld', 04:54:55 INFO - 'MAIL': '/var/mail/cltbld', 04:54:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:55 INFO - 'MOZ_NO_REMOTE': '1', 04:54:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:55 INFO - 'NO_EM_RESTART': '1', 04:54:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:55 INFO - 'PWD': '/builds/slave/test', 04:54:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:55 INFO - 'SHELL': '/bin/bash', 04:54:55 INFO - 'SHLVL': '1', 04:54:55 INFO - 'TERM': 'linux', 04:54:55 INFO - 'TMOUT': '86400', 04:54:55 INFO - 'USER': 'cltbld', 04:54:55 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507', 04:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:55 INFO - '_': '/tools/buildbot/bin/python'} 04:54:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 04:54:55 INFO - mozversion INFO | application_buildid: 20151130032833 04:54:55 INFO - mozversion INFO | application_changeset: a68027fa23fc05f97e0bb68350817037a5c89cd1 04:54:55 INFO - mozversion INFO | application_display_name: Nightly 04:54:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:55 INFO - mozversion INFO | application_name: Firefox 04:54:55 INFO - mozversion INFO | application_remotingname: firefox 04:54:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:54:55 INFO - mozversion INFO | application_vendor: Mozilla 04:54:55 INFO - mozversion INFO | application_version: 45.0a1 04:54:55 INFO - mozversion INFO | platform_buildid: 20151130032833 04:54:55 INFO - mozversion INFO | platform_changeset: a68027fa23fc05f97e0bb68350817037a5c89cd1 04:54:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:54:55 INFO - mozversion INFO | platform_version: 45.0a1 04:54:55 INFO - 2015-11-30 04:54:55,336 DEBUG : using testdate: 1448888095 04:54:55 INFO - 2015-11-30 04:54:55,336 DEBUG : actual date: 1448888095 04:54:55 INFO - 2015-11-30 04:54:55,345 INFO : starting webserver on 'localhost:34898' 04:54:55 INFO - 2015-11-30 04:54:55,346 INFO : Starting test suite talos-linux64-ix-033.e 04:54:55 INFO - 2015-11-30 04:54:55,346 INFO : Starting test dromaeo_css 04:54:55 INFO - 2015-11-30 04:54:55,346 DEBUG : operating with platform_type : linux_ 04:54:55 INFO - 2015-11-30 04:54:55,347 INFO : Initialising browser for dromaeo_css test... 04:54:55 INFO - 2015-11-30 04:54:55,360 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzZrpbz/profile http://localhost:34898/getInfo.html 04:55:01 INFO - 2015-11-30 04:55:01,781 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:55:01 INFO - 2015-11-30 04:55:01,781 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:55:01 INFO - 2015-11-30 04:55:01,781 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:55:01 INFO - 2015-11-30 04:55:01,781 DEBUG : BROWSER_OUTPUT: __metrics 04:55:03 INFO - 2015-11-30 04:55:03,353 INFO : Browser initialized. 04:55:03 INFO - 2015-11-30 04:55:03,354 INFO : Running cycle 1/1 for dromaeo_css test... 04:55:03 INFO - 2015-11-30 04:55:03,354 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzZrpbz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:55:15 INFO - 2015-11-30 04:55:15,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 138903552 04:55:15 INFO - 2015-11-30 04:55:15,296 DEBUG : BROWSER_OUTPUT: 04:56:04 INFO - 2015-11-30 04:56:04,936 DEBUG : BROWSER_OUTPUT: 1448888164932 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] 04:58:16 INFO - 2015-11-30 04:58:16,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34898/tests/dromaeo/cssquery-ext.html) 04:58:17 INFO - 2015-11-30 04:58:17,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 146309120 04:58:17 INFO - 2015-11-30 04:58:17,624 DEBUG : BROWSER_OUTPUT: 05:01:19 INFO - 2015-11-30 05:01:19,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/dromaeo/cssquery-ext.html (next: http://localhost:34898/tests/dromaeo/cssquery-jquery.html) 05:01:20 INFO - 2015-11-30 05:01:20,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 144842752 05:01:20 INFO - 2015-11-30 05:01:20,234 DEBUG : BROWSER_OUTPUT: 05:04:22 INFO - 2015-11-30 05:04:22,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34898/tests/dromaeo/cssquery-mootools.html) 05:04:22 INFO - 2015-11-30 05:04:22,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 144904192 05:04:22 INFO - 2015-11-30 05:04:22,635 DEBUG : BROWSER_OUTPUT: 05:07:24 INFO - 2015-11-30 05:07:24,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34898/tests/dromaeo/cssquery-prototype.html) 05:07:24 INFO - 2015-11-30 05:07:24,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 140427264 05:07:24 INFO - 2015-11-30 05:07:24,993 DEBUG : BROWSER_OUTPUT: 05:10:27 INFO - 2015-11-30 05:10:27,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34898/tests/dromaeo/cssquery-yui.html) 05:10:28 INFO - 2015-11-30 05:10:28,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 141942784 05:10:28 INFO - 2015-11-30 05:10:28,173 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/dromaeo/cssquery-yui.html (next: http://localhost:34898/tests/dromaeo/cssquery-dojo.html) 05:13:30 INFO - 2015-11-30 05:13:30,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 145510400 05:13:30 INFO - 2015-11-30 05:13:30,728 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,728 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:13:30 INFO - 2015-11-30 05:13:30,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:13:30 INFO - 2015-11-30 05:13:30,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:13:30 INFO - 2015-11-30 05:13:30,728 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:13:30 INFO - 2015-11-30 05:13:30,728 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2651.973480265197;2677.9330516737077;2679.6066045656253;2691.8654067296643;2699.8245114067586;4547.977260113703;4709.08172906283;4784.473707892138;4795.640326975477;4807.062622788558;4648.325992731052;4705.2942058691215;4750.121227572901;4755.476897541276;4785.258284965827;4357;4403.889902752425;4460.219461594224;4465.977670111645;4496.190685676577;4359.346098085297;4396.538363471821;4449.221386257408;4478;4496.078303947683;4197.517285512175;4271.380649805792;4297.162053399588;4426.845060422902;4436.6672499562665;4416.24923762961;4423.7566933818625;4426.911461770779;4433.822647094113;4445.755483448409;4384.101259241847;4399.38408622793;4405.537418571036;4419.845305414295;4435.290353543418;4454.086912182995;4538.432695913011;4548.385967894358;4697.553732395417;4751.31105989633;5069.746512674388;5073.543381095682;5085.542301192873;5092.3125378073855;5145.073886700392;5120.590352771769;5129.589632829365;5135.64050516464;5138.511841375063;5141.357330333708;4646.186917289495;4734.597559207437;4773.570378665937;4816.614670826326;4852.563269305709;5246.501582349747;5275.498827611371;5290.65610735301;5294.470552944675;5381.9461805382225;4841.975790121027;5095.082885080721;5099.209622508517;5103.2855400244;5103.7192954387865;5047.671901326402;5092.516210959953;5182.792688292501;5198.506141916512;5252.107141785906;5110.131277682803;5114.232865070269;5115.7442127893455;5122.846314610493;5168.7415629218385;4860.684055536379;4959.231319145538;5086.491350864958;5090.160123579642;5092.083424983539;4241.448611680524;4276.679249056333;4288.2066817638215;4322.200392927319;4346.847860324873;3771.6039815819495;3802.961970380316;3806.5051543299196;3830.4254361845387;3834.0606551395085;4254.234237837219;4343.630791382768;4399.802008909607;4438.5561443856;4453.087117140978;5157.484251574888;5178.249153872667;5179.404368497596;5193.2989046479;5196.376434827845;4451.399061126771;4455.353973673799;4456.420665313553;4499.572540608637;4500.662450316239;4447.577480139382;4500.549945005473;4565.338025986213;4595.058013107305;4611.7232966021475;4808.783604737725;4821.059893320768;4832.613390928647;4860.6111511079025;4914.778834952507;5121.667091639031;5139.331886854685;5143.537081662668;5172.405173405106;5191.974040129775;4653.325267836077;4716.8113275468595;4750.453697824656;4836.854894353175;4843.733594652328;5064.290999260033;5092.949070509248;5099.949000509948;5108.923366149436;5122.385313762373;4949.653524253412;5160.458151894147;5162;5190.584753219658;5196.480351964925;4841.273808928689;4895.877603059952;4901.436334821398;4928.827491037797;4954.628402869727;4992.101421744121;4999.675021123615;5004.974975125101;5009.248612707977;5039.899202016012;4654.464736555339;4750.857474275777;4911.803527858846;4929.112759703288;4959.057779021974;4886.780094895667;4910.337104490848;4943.406791184937;4952.2819191217795;5002.149634562061;4885.316055752127;4891.315215869852;4954.20732682769;4961;4963 05:13:30 INFO - 2015-11-30 05:13:30,729 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.6192610607583;561.2030916099138;580.5210701171533;584.5469760935276;613.4662843326307;27994;36021.819890900544;36504.81747591265;36591.81704091476;36704;39120.21759564807;39307.21385572294;39411;39509.20981580374;39691.40462893052;7929.365650747941;8055.959720201391;8057.879131813028;8069.354451643854;8094.069182044052;7864.724734634289;7981.0422749270165;7985.961824962776;7992.680292788311;8005.599720013976;8011.839763204733;8084.474509156916;8110.229528194812;8116.756497305061;8127.3091787198155;7952.960235198845;7996.560189189592;8020.11778704342;8051.718189863356;8059.476134051297;7904.367650587997;7990.720324788605;8024.67901283948;8047.476914000571;8048.31589314909;35687.64312356869;35931.82034089839;36118;36123.45814812754;36298;2807.452546753384;2911.228524441025;2948.660903996025;2949.144748023071;3001.639803223605;26187.345316367053;26491.73508264912;26561.468770624673;26617.334566635796;26649.200523984313;3380.8140552269615;3423.17843717506;3437.8796742114155;3455.4989526518766;3526.9647897786313;217282;217410;219054;219095;219872;49932;51120.48879511232;53652.19521707178;54870.451295486535;55461.44538554644;55512.44487555153;55538.72230638821;55621.38461000022;55938.16092758612;55980.440195598334;11734.589289374831;11870.584529541424;12024;12050.819237711441;12051.397430128458;8909.5099769512;9058.36591438593;9064.138906803842;9080.046595107418;9090.86363704545;19132;19135.80864191368;19181.32865349706;19204.423867284004;19253.593300837394;7558.546487210785;7884.842303153905;7897.565633890191;7972.083210430875;8102.635381407851;862.4221771413169;863.5595846118525;944.5466176235308;957.9521023948914;1016.8678071850612;25142.24573262805;25154.37114072163;25196.346529753082;25329.746702533106;25454;920.1258804136097;941.331654525281;973.109604711695;976.3946353261024;980.8724865767405;13977.65055873591;14147;14280.714385712436;14680.92659536717;14902.627434314229;330800;334850;335501;335782;336025;47770;47979;48044.759776201594;48065.5193448068;48146.759266203444;1200.543793358518;1213.5024639897777;1217.7320989382322;1220.4690959432498;1224.2287358963974;26523;26736.19791406261;26975.46049079047;27230;27387.589186161826;42964.78517607392;43064;43305;43394.78302608467;43517.34723979206;253663;257712;259065;259383;259781;38719;41699.58300417078;41983.370249446896;42679.3598096035;42681.1463770729;38520.422193666556;38741.418878717406;38772.41841372325;39614.207715846096;39984.600153998086;31997.8400107998;32378.35243295168;33150.336993259516;33287.66712332846;33683.15792105217;35728;36249.63750362568;37288.6271137296;38107.42838857364;38475.615243847205;33123.66876331206;33233.66766332306;37555.624443755216;38379.808100959315;38515.807420962716;28908.71091289144;30257.24356891007;31001.534976975814;31016.844915775277;31076;23576.17483388073;23639.81800909982;23767.643485347387;24143.51712965766;24227 05:13:30 INFO - 2015-11-30 05:13:30,733 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.61056900012983;319.6260375360829;319.803320957611;321.19700748129674;322.3408130373386;14728.116313021214;15095.094294342347;15119.092854428742;15637.452689155853;16333.673326533491;9234.307426942973;9298.86051709225;9526.571304291307;9540.952295238532;9551.904480955189;4349.238883195444;4458.66560007999;4482.148391805563;4490.281554951209;4511.932321015187;4435.534268901767;4512.571305725951;5043;5047.545720885119;5058.519440653132;4687.742174180418;4797.90404191916;4845.176320025586;5022.547970682638;5029.346184995946;4683.6253099752275;4784.5933095686905;4818.421789385278;4822.517748225149;4826.589739872097;4671.205894997858;4680.274557443568;4690.718556886563;4707.6233901287815;4715.41057367829;10168;10172.694819155437;10234;10348.94825525875;10559.73600659982;1722.84494395505;1725.3271224222563;1776.4848194023718;1841.5027942455597;2069.0172168220124;8305.543195124266;8362.58187090643;8556.358273129541;8565.957170214171;8583.699570515002;1686.1147897353865;1732.7054400751902;1748.0735210338541;1761.5067781021335;1778.9822101778946;32829.67170328314;33362.49956250658;47255;47391.5260847394;48673.26990095151;9459.716208513755;9500.19248363883;9502;9503.714888553355;9518.762030949143;11918.761624767629;11952.462139203757;11977.64067077989;11991.880081199077;12023.158378913393;6501.837454063591;6538.476921846336;6564.934350656527;6584.703688334036;6615.040819081302;6206.658633775186;6237.688115594293;6249.843753906098;6258.843528911813;6266.122742816009;3818.6754125899056;3843.9231215375535;3925.9803700981884;3943.861964831217;3960.940585891214;1575.4958413307631;1616.8544830965034;1640.7702921590749;1675.9413420530223;1682.7139386304357;779.5829231361195;939.6147579492375;943.1370296179057;960.8558716192488;965.0687086960976;15270.923645381925;15382.692346153015;15417.229138543027;15687.1372074537;16029.839701603069;790.5138339921023;818.5416166946529;846.7798372423214;850.4982060584285;852.5481494807761;7633.770986870402;8882.777930551789;8927.10728927115;8929;9003.36976411658;332889;343917;344291;495799;498634;65741;65815.34184658092;66086.66956665282;66260.33739662638;70613.64693176604;1019.4291196929743;1041.8020576090519;1044.12815299226;1046.6493724602192;1052.5947510208625;13649.454021839016;14543.490977815725;14549.199794011007;14616.488422905148;15113.47102851395;31812.204694881886;32335.514967275038;33214.16964575905;33729.662703372655;34370.48444273288;39843.60156398399;42226.577734222265;42401.36397953972;42754.57245427506;44605;8381.455205411628;8486.787830304045;8520.105388934073;8597.52713600758;9009.324300677607;16292.674146516767;16331.346746130022;16671.083090430144;16690.16549172561;16690.666186675957;10819.783604328028;11246.268992515461;12684.429200686176;13445.932770336085;13686.178829270275;12642.494300227889;12724.745505090032;13030.804537931748;13160.407781649657;13369.933150334185;13199.472021119433;13354.131981421177;13552.93223533876;13758.862411375758;14215.147091174562;7864.2922137007945;8380.287675547646;8664.090270521756;8693.217610415093;8746.868796968178;8790.560471976503;8880.689175878813;9199.816003680024;13753.38109785082;13766.24285664298 05:13:30 INFO - 2015-11-30 05:13:30,734 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1469.8824094072475;1603.486884197057;1654.5780825889397;1681.4283143731136;1695.2032544703984;5755.68343741094;5897.941020589793;6177.258728952526;6579.243387010495;6599.472042236622;6306.369363063692;6401.871962560746;6448.709808058637;6460.935390646092;6489.415952564268;1948.2109745553073;1984.0377416952767;1986.1757370691219;1987.8608497405187;1991.800819918011;1934.8742331748463;1971.546544294813;1983.186893373717;1984.682450807871;1993.5913137806788;1868.3460788723905;1890.2533499267781;1900.0499750124939;1906.4185423445842;1911.1877452082879;1906.9713954290696;1962.8331591814713;1963.980360196394;1964.5285131568392;1967.1836187982112;1951.4731022623812;1973.7828838827718;1978.980210197894;1983.4347211044783;1998.4704053425853;6395.16862807832;6429.646369449679;6446.548741588091;6455.5158363122955;6456.192975878015;3761.8307176176863;3825.923481530354;3828.712846536493;3831.7892515911612;3833.674137698299;2473.641322008317;2561.859097749623;2564.3460917466114;2570.588705807062;2571.537123317802;852.8933883264592;877.6533269358631;880.6433394475248;882.6248844241236;919.4621146629163;8598.484090954562;8627.611757470866;8665.220130188314;8716.300321437258;8747.125287471266;3348.68187522185;3405.1487128217946;3439.174598096439;3453.568303962005;3455.3953058215216;7181.928180718231;7197.748078817216;7203.099612548432;7218.45861560385;7242.420606351479;3794.962050379516;3822.8853134406013;3831.8084095795098;3837.309284328792;3850.4801851750217;3500.6674365935196;3516.1561225306255;3523.2777280657406;3533.3286675531567;3533.982330088333;2988.4321978823955;3027.167528929518;3030.575719399286;3030.8029978051354;3032.302570408818;885.4731434796286;900;900.2797761790541;907.2968449451728;908.6910450446748;911.9042500537481;926.4672813132476;928.2017464980112;962.2013728605241;1164.3596022187762;6144.262688477412;6144.846378840475;6144.969275153596;6171.84570385744;6193.81418557444;381.8548951398451;383.11500433997554;383.44209175649365;1050.3172937590475;1068.4474123539262;4909.484504127086;4950.18321976877;4996.875078123004;4997.550220480174;5006.724630145377;7149.96425017882;7500.549967001888;7609.809754756065;7619.69521219145;7642.235776422313;7741.07107147146;7765.961170194113;7808.453408261481;7851.332636725942;7862.410319226081;6052.334243233241;6085.452309292274;6234.812955611339;6247.937520624736;6314.210723659543;6305.432511074026;6320.146780184617;6346.746130154742;6365.61806291624;6370.076338930921;6771.255161932085;6840.589564626139;6867.175938887166;7035.22612512613;7047.154341479055;6925.82685432848;6984.965075174591;6993.895091573529;7072.151341839012;7079.752208672672;5782.710864456844;5789;5813.912791308218;5817.621854579439;5825.825225243249;6192.164057852132;6278.434940855345;6338.58799178052;6351.904721429275;6388.361163883575;5997.070454079625;6040.1241819934985;6043.8186854394435;6049.637021778707;6125.418085281891;5835.153902684172;5885.440883116097;5915.40845915405;5934.3175534814045;5937.435943585352;5870.383609720918;5888.646681199141;5915.615484993462;5932.0508718604815;5946.256717910262;5539.393575862955;5546.473085056913;5579.497845193952;5641.689707066151;5712.028955077563;5663.122216056518;5688.658680479184;5696.857578560569;5697.401772813961;5710.057840456278 05:13:30 INFO - 2015-11-30 05:13:30,735 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.48439020738186;297.19460262688114;299.7437191201524;301.28144375664044;301.4287924383295;5611.719414029302;5646.74589643466;5657.038303488406;5689.971550142254;5758.856028599287;5492.5605951523785;5569.0254205513975;5651.2370829937945;5660.264165658469;5686.346070201928;4299.355096735483;4326.84856030039;4329.7618630975285;4330.155619654153;4349.956500434987;4331.913361732763;4334.956650433503;4347.282698354784;4349.826006959718;4358.782060896942;4202.684798640114;4269.423627810237;4292.6780491463105;4303.419038429804;4308.849190278341;4288.249556327662;4288.97855510722;4291.699581029329;4294.957050429487;4296.205202037618;3670.6512881276235;3683.6684698377007;3685.281370132825;3690.9630903690886;3691.5201023866725;5382.811601593926;5456.127019676872;5489.204065410533;5494.148406996922;5498.230247765316;4929.260610908356;4937.061958227925;4940.90118197634;4964.255361695738;4979.701217926936;5972.581919265654;6009.218801555813;6010.429009244115;6015.218021657201;6034.155218269446;3971.3347267841264;4007.338789099795;4045.9190816183805;4067.410225517313;4072.1855628874046;6225.315215326311;6323.051542268697;6325.304216536178;6336.081268216083;6338.524610654219;4153.68847336451;4156.418101465797;4167.74993500391;4170.22850772608;4170.895727606773;4229.429027081366;4230.090530535888;4231.344141658048;4231.746095234295;4232.851850185229;4695.694779839368;4905.828296009622;4908.337374454474;4917.950820491821;4919.901601968012;5885.764569417175;5922.763089476372;6005.129256257818;6008.939910600838;6021.217241758543;1466.054394915295;1500.7448733715294;1500.9774853377207;1501.1668523969083;1503.8947273690737;958.6261358070358;964.262339310428;979.3193730357333;997.9600815967425;997.9900200997897;5181.81863634771;5203.453637368098;5206;5221.947780522222;5226.869328266747;6276.309605943343;6277.278113016971;6277.686115694197;6285.402886725754;6292.433680968735;5176.456472070454;5184.5593124584075;5208.427073021964;5212.296339994128;5218.399884013311;3331.351555859066;3363;3378.2567835076243;3415.8121303328057;3419.4870769384793;5798.797042103506;5873.706314684248;5877.9118313225335;5886.529077673861;5890.970545147246;6470.838229044311;6524.804255872332;6535.411812936763;6535.934640653532;6544.443722283564;5883.764649414061;5899.292084949748;5921.052631579013;5924.437178468125;5939.851503712442;6179.783707570214;6292.402221788922;6304;6314.810555683337;6322.494200464043;6125;6158.445739883432;6164.198654174928;6170.10533472653;6173.9073913892225;5899.17411562373;5920.259967504062;5937.970310148422;5943.91084133747;5950.7917222896995;4114.650254728382;4138.089620283533;4160.729552579072;4161.604647558477;4172.874813755592;6201.81394558164;6257.4681152102585;6326.240851097898;6326.778562750282;6340.048992651139;6048.818535443944;6074.605150665369;6077.27072751255;6078.300995385587;6079.604825686316;6029.397060294111;6065.545084118797;6081.969590152021;6095.238095238095;6097.390260973867;5752.194692743103;5885.058390657474;5896.8820623586425;5951.256092988377;5973.462388385066;6036.185115009594;6046.969765151146;6053.727582258897;6147.678249176449;6150.723217455315;5944.64332140073;5965.433283838202;5977.551683623833;5991.2510936132985;5994.400559943971 05:13:30 INFO - 2015-11-30 05:13:30,735 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.9247682754896;697.003285302018;753.9623018849056;775.360327729623;794.4200733464571;10753.946230268848;11041.619797525309;11122.499487523051;11125.666230013092;11152.609658661948;10549.84175237372;10938.726531836708;10945.069669078139;10988;10994.505247263893;752.9811754706135;755.403231447156;771.2018061306549;779.2168870285356;781.5896654256533;774.6746366526045;776.4332037612546;778.5173192620583;784.5096814490943;787.7361084036854;804.2440106300088;809.2352726673296;810.6514198894473;810.7405630198339;811.253646645085;793.3573805217734;797.956112413817;799.3325573146429;799.8680217764062;800.4596897094467;596.7314708381202;596.8865915476046;599.9520038396918;601.6931365003836;603.6891001134419;11265.831012534736;11318.830217546743;11369.488373023234;11407.714807129805;11431.942840285745;10431.739206519898;10695.679129626124;10828.242023058388;10963.890361096366;11173.83239251412;8733.214010739;8753.124687531259;8922.553872306358;9279.118483744101;9610.327277090606;3221;3227.1770698471973;3230.628477725068;3240.3843269778667;3281.917952051194;41260;41281.587184128075;41567.168656627;41599.376009359585;41623;8360.372972027122;8480.957595212109;8527.104654011364;8540.359473039547;8903.599338029804;15400.845991539942;15722.29249683767;15730.213489325488;15814.76277855833;15869.841301587066;6021.397860213943;6085.69571521431;6123.724432400552;6231.875362492725;6259.029850373199;3399.6260411354733;3500.9474857877153;3506.4915587239707;3546.3261980223674;3589.6948759355746;2606;2633.210036988896;2647.695515015759;2649.629051932731;2653.721359257289;476.07403599997673;503.33559701194804;507.4544864270924;519.9532042116227;521.6035812782313;565.3244372974339;612.2194202391897;619.7923695562038;625.2122325869346;627.632834791652;7428.73999410018;7436.330730234305;7506.24937506245;7513.511621744678;7525.510841795266;416.9061961058798;425.525539023986;547.7726743401523;584.7047241143281;586.2700937333047;3772.6227377262603;3923.391874259494;4001.1797581495725;4035.475388199574;4125.422440858282;47923.52076479191;50140.749296253285;50295.24557131646;50784.74607626938;50917.236241456405;44469.77765111154;44618.33072503915;44990;45374.31938520925;46573.76713116481;40220.39669404961;40979;41168.9999999994;41445;42044;7591;7613.08642962848;7907.209279072047;8060.83878322442;8115.4319197655595;31557.684423155475;31695;32170.839145804122;32187.35625287528;32199.195020124684;37013.444798328586;37603.623963760016;40821.591784082964;40946.59053409428;41389.37915931203;9875.506224688881;10004.699859004242;10252.43611601369;10326.48367581633;10337.37975721459;11245.212835101463;11579.363135027654;11649.59226427071;11684.649460516199;11991.340476273888;10337.30591524731;10422.895771042193;10589.52347144365;10663;10668.786624267626;9801.656942006995;9857.35927164732;10139.239557033105;10427.94786026065;10430.530626121994;9907;10184.388936663527;10805;10822.729431764268;10950.178736594946;9032.683856065007;9137.954310228406;9267.67563135287;9279.953600231956;9677.419354838732;8552.102029286836;8754.29965602763;8798.34012449056;9002.64078794322;9037 05:13:30 INFO - 2015-11-30 05:13:30,735 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:13:30 INFO - 2015-11-30 05:13:30,735 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:13:30 INFO - 2015-11-30 05:13:30,736 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 05:13:30 INFO - 2015-11-30 05:13:30,736 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:13:30 INFO - 2015-11-30 05:13:30,736 DEBUG : BROWSER_OUTPUT: __startTimestamp1448889210727__endTimestamp 05:13:30 INFO - 2015-11-30 05:13:30,736 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,736 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:13:30 INFO - 2015-11-30 05:13:30,736 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:13:30 INFO - 2015-11-30 05:13:30,737 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,737 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4718.31 Median:4836.85 stddev:498.85 (10.3%) stddev-sans-first:473.31 05:13:30 INFO - 2015-11-30 05:13:30,738 DEBUG : BROWSER_OUTPUT: Values: 2652.0 2677.9 2679.6 2691.9 2699.8 4548.0 4709.1 4784.5 4795.6 4807.1 4648.3 4705.3 4750.1 4755.5 4785.3 4357.0 4403.9 4460.2 4466.0 4496.2 4359.3 4396.5 4449.2 4478.0 4496.1 4197.5 4271.4 4297.2 4426.8 4436.7 4416.2 4423.8 4426.9 4433.8 4445.8 4384.1 4399.4 4405.5 4419.8 4435.3 4454.1 4538.4 4548.4 4697.6 4751.3 5069.7 5073.5 5085.5 5092.3 5145.1 5120.6 5129.6 5135.6 5138.5 5141.4 4646.2 4734.6 4773.6 4816.6 4852.6 5246.5 5275.5 5290.7 5294.5 5381.9 4842.0 5095.1 5099.2 5103.3 5103.7 5047.7 5092.5 5182.8 5198.5 5252.1 5110.1 5114.2 5115.7 5122.8 5168.7 4860.7 4959.2 5086.5 5090.2 5092.1 4241.4 4276.7 4288.2 4322.2 4346.8 3771.6 3803.0 3806.5 3830.4 3834.1 4254.2 4343.6 4399.8 4438.6 4453.1 5157.5 5178.2 5179.4 5193.3 5196.4 4451.4 4455.4 4456.4 4499.6 4500.7 4447.6 4500.5 4565.3 4595.1 4611.7 4808.8 4821.1 4832.6 4860.6 4914.8 5121.7 5139.3 5143.5 5172.4 5192.0 4653.3 4716.8 4750.5 4836.9 4843.7 5064.3 5092.9 5099.9 5108.9 5122.4 4949.7 5160.5 5162.0 5190.6 5196.5 4841.3 4895.9 4901.4 4928.8 4954.6 4992.1 4999.7 5005.0 5009.2 5039.9 4654.5 4750.9 4911.8 4929.1 4959.1 4886.8 4910.3 4943.4 4952.3 5002.1 4885.3 4891.3 4954.2 4961.0 4963.0 05:13:30 INFO - 2015-11-30 05:13:30,738 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,738 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43161.36 Median:37422.13 stddev:71916.78 (192.2%) stddev-sans-first:72047.35 05:13:30 INFO - 2015-11-30 05:13:30,738 DEBUG : BROWSER_OUTPUT: Values: 548.6 561.2 580.5 584.5 613.5 27994.0 36021.8 36504.8 36591.8 36704.0 39120.2 39307.2 39411.0 39509.2 39691.4 7929.4 8056.0 8057.9 8069.4 8094.1 7864.7 7981.0 7986.0 7992.7 8005.6 8011.8 8084.5 8110.2 8116.8 8127.3 7953.0 7996.6 8020.1 8051.7 8059.5 7904.4 7990.7 8024.7 8047.5 8048.3 35687.6 35931.8 36118.0 36123.5 36298.0 2807.5 2911.2 2948.7 2949.1 3001.6 26187.3 26491.7 26561.5 26617.3 26649.2 3380.8 3423.2 3437.9 3455.5 3527.0 217282.0 217410.0 219054.0 219095.0 219872.0 49932.0 51120.5 53652.2 54870.5 55461.4 55512.4 55538.7 55621.4 55938.2 55980.4 11734.6 11870.6 12024.0 12050.8 12051.4 8909.5 9058.4 9064.1 9080.0 9090.9 19132.0 19135.8 19181.3 19204.4 19253.6 7558.5 7884.8 7897.6 7972.1 8102.6 862.4 863.6 944.5 958.0 1016.9 25142.2 25154.4 25196.3 25329.7 25454.0 920.1 941.3 973.1 976.4 980.9 13977.7 14147.0 14280.7 14680.9 14902.6 330800.0 334850.0 335501.0 335782.0 336025.0 47770.0 47979.0 48044.8 48065.5 48146.8 1200.5 1213.5 1217.7 1220.5 1224.2 26523.0 26736.2 26975.5 27230.0 27387.6 42964.8 43064.0 43305.0 43394.8 43517.3 253663.0 257712.0 259065.0 259383.0 259781.0 38719.0 41699.6 41983.4 42679.4 42681.1 38520.4 38741.4 38772.4 39614.2 39984.6 31997.8 32378.4 33150.3 33287.7 33683.2 35728.0 36249.6 37288.6 38107.4 38475.6 33123.7 33233.7 37555.6 38379.8 38515.8 28908.7 30257.2 31001.5 31016.8 31076.0 23576.2 23639.8 23767.6 24143.5 24227.0 05:13:30 INFO - 2015-11-30 05:13:30,738 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,738 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22868.55 Median:23551.91 stddev:67125.38 (285.0%) stddev-sans-first:67292.33 05:13:30 INFO - 2015-11-30 05:13:30,739 DEBUG : BROWSER_OUTPUT: Values: 316.6 319.6 319.8 321.2 322.3 14728.1 15095.1 15119.1 15637.5 16333.7 9234.3 9298.9 9526.6 9541.0 9551.9 4349.2 4458.7 4482.1 4490.3 4511.9 4435.5 4512.6 5043.0 5047.5 5058.5 4687.7 4797.9 4845.2 5022.5 5029.3 4683.6 4784.6 4818.4 4822.5 4826.6 4671.2 4680.3 4690.7 4707.6 4715.4 10168.0 10172.7 10234.0 10348.9 10559.7 1722.8 1725.3 1776.5 1841.5 2069.0 8305.5 8362.6 8556.4 8566.0 8583.7 1686.1 1732.7 1748.1 1761.5 1779.0 32829.7 33362.5 47255.0 47391.5 48673.3 9459.7 9500.2 9502.0 9503.7 9518.8 11918.8 11952.5 11977.6 11991.9 12023.2 6501.8 6538.5 6564.9 6584.7 6615.0 6206.7 6237.7 6249.8 6258.8 6266.1 3818.7 3843.9 3926.0 3943.9 3960.9 1575.5 1616.9 1640.8 1675.9 1682.7 779.6 939.6 943.1 960.9 965.1 15270.9 15382.7 15417.2 15687.1 16029.8 790.5 818.5 846.8 850.5 852.5 7633.8 8882.8 8927.1 8929.0 9003.4 332889.0 343917.0 344291.0 495799.0 498634.0 65741.0 65815.3 66086.7 66260.3 70613.6 1019.4 1041.8 1044.1 1046.6 1052.6 13649.5 14543.5 14549.2 14616.5 15113.5 31812.2 32335.5 33214.2 33729.7 34370.5 39843.6 42226.6 42401.4 42754.6 44605.0 8381.5 8486.8 8520.1 8597.5 9009.3 16292.7 16331.3 16671.1 16690.2 16690.7 10819.8 11246.3 12684.4 13445.9 13686.2 12642.5 12724.7 13030.8 13160.4 13369.9 13199.5 13354.1 13552.9 13758.9 14215.1 7864.3 8380.3 8664.1 8693.2 8746.9 8790.6 8880.7 9199.8 13753.4 13766.2 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4557.75 Median:5893.29 stddev:2324.87 (39.4%) stddev-sans-first:2319.81 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: Values: 1469.9 1603.5 1654.6 1681.4 1695.2 5755.7 5897.9 6177.3 6579.2 6599.5 6306.4 6401.9 6448.7 6460.9 6489.4 1948.2 1984.0 1986.2 1987.9 1991.8 1934.9 1971.5 1983.2 1984.7 1993.6 1868.3 1890.3 1900.0 1906.4 1911.2 1907.0 1962.8 1964.0 1964.5 1967.2 1951.5 1973.8 1979.0 1983.4 1998.5 6395.2 6429.6 6446.5 6455.5 6456.2 3761.8 3825.9 3828.7 3831.8 3833.7 2473.6 2561.9 2564.3 2570.6 2571.5 852.9 877.7 880.6 882.6 919.5 8598.5 8627.6 8665.2 8716.3 8747.1 3348.7 3405.1 3439.2 3453.6 3455.4 7181.9 7197.7 7203.1 7218.5 7242.4 3795.0 3822.9 3831.8 3837.3 3850.5 3500.7 3516.2 3523.3 3533.3 3534.0 2988.4 3027.2 3030.6 3030.8 3032.3 885.5 900.0 900.3 907.3 908.7 911.9 926.5 928.2 962.2 1164.4 6144.3 6144.8 6145.0 6171.8 6193.8 381.9 383.1 383.4 1050.3 1068.4 4909.5 4950.2 4996.9 4997.6 5006.7 7150.0 7500.5 7609.8 7619.7 7642.2 7741.1 7766.0 7808.5 7851.3 7862.4 6052.3 6085.5 6234.8 6247.9 6314.2 6305.4 6320.1 6346.7 6365.6 6370.1 6771.3 6840.6 6867.2 7035.2 7047.2 6925.8 6985.0 6993.9 7072.2 7079.8 5782.7 5789.0 5813.9 5817.6 5825.8 6192.2 6278.4 6338.6 6351.9 6388.4 5997.1 6040.1 6043.8 6049.6 6125.4 5835.2 5885.4 5915.4 5934.3 5937.4 5870.4 5888.6 5915.6 5932.1 5946.3 5539.4 5546.5 5579.5 5641.7 5712.0 5663.1 5688.7 5696.9 5697.4 5710.1 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4951.74 Median:5658.65 stddev:1502.67 (26.6%) stddev-sans-first:1465.59 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: Values: 290.5 297.2 299.7 301.3 301.4 5611.7 5646.7 5657.0 5690.0 5758.9 5492.6 5569.0 5651.2 5660.3 5686.3 4299.4 4326.8 4329.8 4330.2 4350.0 4331.9 4335.0 4347.3 4349.8 4358.8 4202.7 4269.4 4292.7 4303.4 4308.8 4288.2 4289.0 4291.7 4295.0 4296.2 3670.7 3683.7 3685.3 3691.0 3691.5 5382.8 5456.1 5489.2 5494.1 5498.2 4929.3 4937.1 4940.9 4964.3 4979.7 5972.6 6009.2 6010.4 6015.2 6034.2 3971.3 4007.3 4045.9 4067.4 4072.2 6225.3 6323.1 6325.3 6336.1 6338.5 4153.7 4156.4 4167.7 4170.2 4170.9 4229.4 4230.1 4231.3 4231.7 4232.9 4695.7 4905.8 4908.3 4918.0 4919.9 5885.8 5922.8 6005.1 6008.9 6021.2 1466.1 1500.7 1501.0 1501.2 1503.9 958.6 964.3 979.3 998.0 998.0 5181.8 5203.5 5206.0 5221.9 5226.9 6276.3 6277.3 6277.7 6285.4 6292.4 5176.5 5184.6 5208.4 5212.3 5218.4 3331.4 3363.0 3378.3 3415.8 3419.5 5798.8 5873.7 5877.9 5886.5 5891.0 6470.8 6524.8 6535.4 6535.9 6544.4 5883.8 5899.3 5921.1 5924.4 5939.9 6179.8 6292.4 6304.0 6314.8 6322.5 6125.0 6158.4 6164.2 6170.1 6173.9 5899.2 5920.3 5938.0 5943.9 5950.8 4114.7 4138.1 4160.7 4161.6 4172.9 6201.8 6257.5 6326.2 6326.8 6340.0 6048.8 6074.6 6077.3 6078.3 6079.6 6029.4 6065.5 6082.0 6095.2 6097.4 5752.2 5885.1 5896.9 5951.3 5973.5 6036.2 6047.0 6053.7 6147.7 6150.7 5944.6 5965.4 5977.6 5991.3 5994.4 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-11-30 05:13:30,740 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12190.77 Median:45182.16 stddev:14005.88 (31.0%) stddev-sans-first:14018.51 05:13:30 INFO - 2015-11-30 05:13:30,742 DEBUG : BROWSER_OUTPUT: Values: 683.9 697.0 754.0 775.4 794.4 10753.9 11041.6 11122.5 11125.7 11152.6 10549.8 10938.7 10945.1 10988.0 10994.5 753.0 755.4 771.2 779.2 781.6 774.7 776.4 778.5 784.5 787.7 804.2 809.2 810.7 810.7 811.3 793.4 798.0 799.3 799.9 800.5 596.7 596.9 600.0 601.7 603.7 11265.8 11318.8 11369.5 11407.7 11431.9 10431.7 10695.7 10828.2 10963.9 11173.8 8733.2 8753.1 8922.6 9279.1 9610.3 3221.0 3227.2 3230.6 3240.4 3281.9 41260.0 41281.6 41567.2 41599.4 41623.0 8360.4 8481.0 8527.1 8540.4 8903.6 15400.8 15722.3 15730.2 15814.8 15869.8 6021.4 6085.7 6123.7 6231.9 6259.0 3399.6 3500.9 3506.5 3546.3 3589.7 2606.0 2633.2 2647.7 2649.6 2653.7 476.1 503.3 507.5 520.0 521.6 565.3 612.2 619.8 625.2 627.6 7428.7 7436.3 7506.2 7513.5 7525.5 416.9 425.5 547.8 584.7 586.3 3772.6 3923.4 4001.2 4035.5 4125.4 47923.5 50140.7 50295.2 50784.7 50917.2 44469.8 44618.3 44990.0 45374.3 46573.8 40220.4 40979.0 41169.0 41445.0 42044.0 7591.0 7613.1 7907.2 8060.8 8115.4 31557.7 31695.0 32170.8 32187.4 32199.2 37013.4 37603.6 40821.6 40946.6 41389.4 9875.5 10004.7 10252.4 10326.5 10337.4 11245.2 11579.4 11649.6 11684.6 11991.3 10337.3 10422.9 10589.5 10663.0 10668.8 9801.7 9857.4 10139.2 10427.9 10430.5 9907.0 10184.4 10805.0 10822.7 10950.2 9032.7 9138.0 9267.7 9280.0 9677.4 8552.1 8754.3 8798.3 9002.6 9037.0 05:13:30 INFO - 2015-11-30 05:13:30,742 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:13:30 INFO - 2015-11-30 05:13:30,742 DEBUG : BROWSER_OUTPUT: 05:13:31 INFO - 2015-11-30 05:13:31,509 INFO : Browser exited with error code: 0 05:13:31 INFO - 2015-11-30 05:13:31,533 INFO : Completed test dromaeo_css (00:18:36) 05:13:31 INFO - 2015-11-30 05:13:31,533 INFO : Starting test kraken 05:13:31 INFO - 2015-11-30 05:13:31,533 DEBUG : operating with platform_type : linux_ 05:13:31 INFO - 2015-11-30 05:13:31,533 INFO : Initialising browser for kraken test... 05:13:31 INFO - 2015-11-30 05:13:31,539 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8z6Fmf/profile http://localhost:34898/getInfo.html 05:13:36 INFO - 2015-11-30 05:13:36,722 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:13:36 INFO - 2015-11-30 05:13:36,722 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:13:36 INFO - 2015-11-30 05:13:36,722 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:13:36 INFO - 2015-11-30 05:13:36,723 DEBUG : BROWSER_OUTPUT: __metrics 05:13:37 INFO - 2015-11-30 05:13:37,881 INFO : Browser initialized. 05:13:37 INFO - 2015-11-30 05:13:37,882 INFO : Running cycle 1/1 for kraken test... 05:13:37 INFO - 2015-11-30 05:13:37,882 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8z6Fmf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:13:49 INFO - 2015-11-30 05:13:49,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 138760192 05:13:49 INFO - 2015-11-30 05:13:49,797 DEBUG : BROWSER_OUTPUT: 05:13:52 INFO - 2015-11-30 05:13:52,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34898/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:52 INFO - 2015-11-30 05:13:52,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 140824576 05:13:52 INFO - 2015-11-30 05:13:52,967 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-11-30 05:13:55,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34898/tests/kraken/driver.html?testName=audio-dft) 05:13:56 INFO - 2015-11-30 05:13:56,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 139882496 05:13:56 INFO - 2015-11-30 05:13:56,307 DEBUG : BROWSER_OUTPUT: 05:13:59 INFO - 2015-11-30 05:13:59,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34898/tests/kraken/driver.html?testName=audio-fft) 05:13:59 INFO - 2015-11-30 05:13:59,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 135954432 05:13:59 INFO - 2015-11-30 05:13:59,787 DEBUG : BROWSER_OUTPUT: 05:14:01 INFO - 2015-11-30 05:14:01,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34898/tests/kraken/driver.html?testName=audio-oscillator) 05:14:02 INFO - 2015-11-30 05:14:02,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 136650752 05:14:02 INFO - 2015-11-30 05:14:02,451 DEBUG : BROWSER_OUTPUT: 05:14:04 INFO - 2015-11-30 05:14:04,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:05 INFO - 2015-11-30 05:14:05,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 137900032 05:14:05 INFO - 2015-11-30 05:14:05,320 DEBUG : BROWSER_OUTPUT: 05:14:08 INFO - 2015-11-30 05:14:08,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34898/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:08 INFO - 2015-11-30 05:14:08,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 137752576 05:14:08 INFO - 2015-11-30 05:14:08,961 DEBUG : BROWSER_OUTPUT: 05:14:12 INFO - 2015-11-30 05:14:12,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34898/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:13 INFO - 2015-11-30 05:14:13,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 135143424 05:14:13 INFO - 2015-11-30 05:14:13,042 DEBUG : BROWSER_OUTPUT: 05:14:15 INFO - 2015-11-30 05:14:15,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34898/tests/kraken/driver.html?testName=json-parse-financial) 05:14:16 INFO - 2015-11-30 05:14:16,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 135774208 05:14:16 INFO - 2015-11-30 05:14:16,563 DEBUG : BROWSER_OUTPUT: 05:14:18 INFO - 2015-11-30 05:14:18,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:18 INFO - 2015-11-30 05:14:18,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 138211328 05:14:18 INFO - 2015-11-30 05:14:18,960 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-11-30 05:14:20,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:21 INFO - 2015-11-30 05:14:21,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 138457088 05:14:21 INFO - 2015-11-30 05:14:21,443 DEBUG : BROWSER_OUTPUT: 05:14:23 INFO - 2015-11-30 05:14:23,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:24 INFO - 2015-11-30 05:14:24,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 137658368 05:14:24 INFO - 2015-11-30 05:14:24,234 DEBUG : BROWSER_OUTPUT: 05:14:26 INFO - 2015-11-30 05:14:26,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:27 INFO - 2015-11-30 05:14:27,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 138092544 05:14:27 INFO - 2015-11-30 05:14:27,433 DEBUG : BROWSER_OUTPUT: 05:14:30 INFO - 2015-11-30 05:14:30,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:30 INFO - 2015-11-30 05:14:30,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 137162752 05:14:30 INFO - 2015-11-30 05:14:30,652 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34898/tests/kraken/driver.html?testName=ai-astar) 05:14:32 INFO - 2015-11-30 05:14:32,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 137302016 05:14:32 INFO - 2015-11-30 05:14:32,665 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,668 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:14:32 INFO - 2015-11-30 05:14:32,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:14:32 INFO - 2015-11-30 05:14:32,669 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:14:32 INFO - 2015-11-30 05:14:32,669 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:14:32 INFO - 2015-11-30 05:14:32,669 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;113;113;115;126;113;112;112;114 05:14:32 INFO - 2015-11-30 05:14:32,669 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;131;154;166;132;161;158;137;164;132 05:14:32 INFO - 2015-11-30 05:14:32,669 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;161;162;164;163;170;165;163;162 05:14:32 INFO - 2015-11-30 05:14:32,670 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;73;74;73;150;72;82;71;74 05:14:32 INFO - 2015-11-30 05:14:32,670 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;94;130;96;96;95;128;95;95;129 05:14:32 INFO - 2015-11-30 05:14:32,670 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;113;110;110;110;109;110;111;110;110;110 05:14:32 INFO - 2015-11-30 05:14:32,670 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;147;147;148;150;148;147;148;147 05:14:32 INFO - 2015-11-30 05:14:32,670 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;97;96;96;96;96;96;96;95 05:14:32 INFO - 2015-11-30 05:14:32,670 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;79;77;75;75;78;77;75;77;81;73 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;68;69;68;69 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;88;83;85;84;89;86;85;85 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;127;127;121;127;131;124;122;120;131 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;149;153;148;149;151;140;146;149;148 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;72;69;70;70;70;69;76 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:14:32 INFO - 2015-11-30 05:14:32,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,785 05:14:32 INFO - 2015-11-30 05:14:32,672 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:14:32 INFO - 2015-11-30 05:14:32,672 DEBUG : BROWSER_OUTPUT: __startTimestamp1448889272667__endTimestamp 05:14:32 INFO - 2015-11-30 05:14:32,672 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,675 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:14:32 INFO - 2015-11-30 05:14:32,675 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:14:32 INFO - 2015-11-30 05:14:32,676 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,677 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.00 Median:113.50 stddev:4.62 (4.1%) stddev-sans-first:4.90 05:14:32 INFO - 2015-11-30 05:14:32,677 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 113.0 113.0 115.0 126.0 113.0 112.0 112.0 114.0 05:14:32 INFO - 2015-11-30 05:14:32,677 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,677 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.10 Median:157.00 stddev:14.37 (9.2%) stddev-sans-first:15.02 05:14:32 INFO - 2015-11-30 05:14:32,677 DEBUG : BROWSER_OUTPUT: Values: 156.0 131.0 154.0 166.0 132.0 161.0 158.0 137.0 164.0 132.0 05:14:32 INFO - 2015-11-30 05:14:32,677 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.50 (1.5%) stddev-sans-first:2.65 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 161.0 162.0 164.0 163.0 170.0 165.0 163.0 162.0 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.00 stddev:24.30 (33.3%) stddev-sans-first:25.53 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 74.0 73.0 150.0 72.0 82.0 71.0 74.0 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:95.00 stddev:16.24 (17.1%) stddev-sans-first:16.93 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: Values: 97.0 94.0 130.0 96.0 96.0 95.0 128.0 95.0 95.0 129.0 05:14:32 INFO - 2015-11-30 05:14:32,678 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.06 (1.0%) stddev-sans-first:0.50 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 110.0 110.0 109.0 110.0 111.0 110.0 110.0 110.0 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 147.0 147.0 148.0 150.0 148.0 147.0 148.0 147.0 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 05:14:32 INFO - 2015-11-30 05:14:32,679 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.70 Median:77.00 stddev:2.31 (3.0%) stddev-sans-first:2.30 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: Values: 79.0 77.0 75.0 75.0 78.0 77.0 75.0 77.0 81.0 73.0 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 68.0 69.0 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:1.84 (2.2%) stddev-sans-first:1.88 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 88.0 83.0 85.0 84.0 89.0 86.0 85.0 85.0 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,680 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:4.22 (3.3%) stddev-sans-first:4.07 05:14:32 INFO - 2015-11-30 05:14:32,681 DEBUG : BROWSER_OUTPUT: Values: 120.0 127.0 127.0 121.0 127.0 131.0 124.0 122.0 120.0 131.0 05:14:32 INFO - 2015-11-30 05:14:32,681 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,681 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:149.00 stddev:5.37 (3.6%) stddev-sans-first:3.62 05:14:32 INFO - 2015-11-30 05:14:32,681 DEBUG : BROWSER_OUTPUT: Values: 135.0 149.0 153.0 148.0 149.0 151.0 140.0 146.0 149.0 148.0 05:14:32 INFO - 2015-11-30 05:14:32,681 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-30 05:14:32,681 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.17 (3.1%) stddev-sans-first:2.30 05:14:32 INFO - 2015-11-30 05:14:32,681 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 72.0 69.0 70.0 70.0 70.0 69.0 76.0 05:14:32 INFO - 2015-11-30 05:14:32,683 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:14:32 INFO - 2015-11-30 05:14:32,683 DEBUG : BROWSER_OUTPUT: 05:14:33 INFO - 2015-11-30 05:14:33,645 INFO : Browser exited with error code: 0 05:14:33 INFO - 2015-11-30 05:14:33,699 INFO : Completed test kraken (00:01:02) 05:14:33 INFO - 2015-11-30 05:14:33,699 INFO : Starting test v8_7 05:14:33 INFO - 2015-11-30 05:14:33,699 DEBUG : operating with platform_type : linux_ 05:14:33 INFO - 2015-11-30 05:14:33,699 INFO : Initialising browser for v8_7 test... 05:14:33 INFO - 2015-11-30 05:14:33,705 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmXtvVV/profile http://localhost:34898/getInfo.html 05:14:39 INFO - 2015-11-30 05:14:39,799 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:14:39 INFO - 2015-11-30 05:14:39,799 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:14:39 INFO - 2015-11-30 05:14:39,799 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:14:39 INFO - 2015-11-30 05:14:39,800 DEBUG : BROWSER_OUTPUT: __metrics 05:14:40 INFO - 2015-11-30 05:14:40,945 INFO : Browser initialized. 05:14:40 INFO - 2015-11-30 05:14:40,946 INFO : Running cycle 1/1 for v8_7 test... 05:14:40 INFO - 2015-11-30 05:14:40,946 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmXtvVV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:14:52 INFO - 2015-11-30 05:14:52,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 05:14:52 INFO - 2015-11-30 05:14:52,920 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34898/tests/v8_7/run.html (next: http://localhost:34898/tests/v8_7/run.html) 05:15:14 INFO - 2015-11-30 05:15:14,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 138407936 05:15:14 INFO - 2015-11-30 05:15:14,604 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,604 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:15:14 INFO - 2015-11-30 05:15:14,604 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:15:14 INFO - 2015-11-30 05:15:14,604 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:15:14 INFO - 2015-11-30 05:15:14,604 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:15:14 INFO - 2015-11-30 05:15:14,605 DEBUG : BROWSER_OUTPUT: |0;Richards;167.25204883759827 05:15:14 INFO - 2015-11-30 05:15:14,605 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.08236165093467 05:15:14 INFO - 2015-11-30 05:15:14,605 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 05:15:14 INFO - 2015-11-30 05:15:14,605 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 05:15:14 INFO - 2015-11-30 05:15:14,605 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.322033898305 05:15:14 INFO - 2015-11-30 05:15:14,605 DEBUG : BROWSER_OUTPUT: |5;Earley;708.2152974504249 05:15:14 INFO - 2015-11-30 05:15:14,605 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: |7;RegExp;25500 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: |8;Splay;630.2573760200879 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: __startTimestamp1448889314602__endTimestamp 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.25 Median:167.25 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,606 DEBUG : BROWSER_OUTPUT: Values: 167.3 05:15:14 INFO - 2015-11-30 05:15:14,607 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,607 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.08 Median:185.08 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,607 DEBUG : BROWSER_OUTPUT: Values: 185.1 05:15:14 INFO - 2015-11-30 05:15:14,607 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,607 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,608 DEBUG : BROWSER_OUTPUT: Values: 280.0 05:15:14 INFO - 2015-11-30 05:15:14,608 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,608 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,608 DEBUG : BROWSER_OUTPUT: Values: 5159.8 05:15:14 INFO - 2015-11-30 05:15:14,608 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: Values: 1059.3 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:708.22 Median:708.22 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: Values: 708.2 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,609 DEBUG : BROWSER_OUTPUT: Values: 12256.1 05:15:14 INFO - 2015-11-30 05:15:14,610 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,610 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,610 DEBUG : BROWSER_OUTPUT: Values: 25500.0 05:15:14 INFO - 2015-11-30 05:15:14,610 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,610 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:630.26 Median:630.26 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,610 DEBUG : BROWSER_OUTPUT: Values: 630.3 05:15:14 INFO - 2015-11-30 05:15:14,611 DEBUG : BROWSER_OUTPUT: 05:15:14 INFO - 2015-11-30 05:15:14,611 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 05:15:14 INFO - 2015-11-30 05:15:14,611 DEBUG : BROWSER_OUTPUT: Values: 4845.4 05:15:14 INFO - 2015-11-30 05:15:14,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:15:14 INFO - 2015-11-30 05:15:14,611 DEBUG : BROWSER_OUTPUT: 05:15:15 INFO - 2015-11-30 05:15:15,589 INFO : Browser exited with error code: 0 05:15:15 INFO - 2015-11-30 05:15:15,604 INFO : Completed test v8_7 (00:00:41) 05:15:15 INFO - 2015-11-30 05:15:15,614 INFO : Completed test suite (00:20:20) 05:15:15 INFO - 2015-11-30 05:15:15,615 DEBUG : Working with test: dromaeo_css 05:15:15 INFO - 2015-11-30 05:15:15,615 DEBUG : Generating results file: dromaeo_css 05:15:15 INFO - 2015-11-30 05:15:15,616 DEBUG : Working with test: kraken 05:15:15 INFO - 2015-11-30 05:15:15,616 DEBUG : Generating results file: kraken 05:15:15 INFO - 2015-11-30 05:15:15,617 INFO : javascript benchmark 05:15:15 INFO - 2015-11-30 05:15:15,617 DEBUG : Working with test: v8_7 05:15:15 INFO - 2015-11-30 05:15:15,617 DEBUG : Generating results file: v8_7 05:15:15 INFO - 2015-11-30 05:15:15,617 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:15 INFO - 2015-11-30 05:15:15,796 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 05:15:15 INFO - 2015-11-30 05:15:15,796 DEBUG : process_Request line: dromaeo_css 6218.56 graph.html#tests=[[72,94,43]] 05:15:15 INFO - 2015-11-30 05:15:15,796 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:15 INFO - 2015-11-30 05:15:15,829 DEBUG : process_Request line: kraken 1541.20 graph.html#tests=[[232,94,43]] 05:15:15 INFO - 2015-11-30 05:15:15,829 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:15 INFO - 2015-11-30 05:15:15,861 DEBUG : process_Request line: v8_7 21326.94 graph.html#tests=[[230,94,43]] 05:15:15 INFO - 2015-11-30 05:15:15,863 INFO : javascript benchmark 05:15:15 INFO - 2015-11-30 05:15:15,865 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2651.973480265197, 2677.9330516737077, 2679.6066045656253, 2691.8654067296643, 2699.8245114067586, 4547.977260113703, 4709.08172906283, 4784.473707892138, 4795.640326975477, 4807.062622788558, 4648.325992731052, 4705.2942058691215, 4750.121227572901, 4755.476897541276, 4785.258284965827, 4357.0, 4403.889902752425, 4460.219461594224, 4465.977670111645, 4496.190685676577, 4359.346098085297, 4396.538363471821, 4449.221386257408, 4478.0, 4496.078303947683, 4197.517285512175, 4271.380649805792, 4297.162053399588, 4426.845060422902, 4436.6672499562665, 4416.24923762961, 4423.7566933818625, 4426.911461770779, 4433.822647094113, 4445.755483448409, 4384.101259241847, 4399.38408622793, 4405.537418571036, 4419.845305414295, 4435.290353543418, 4454.086912182995, 4538.432695913011, 4548.385967894358, 4697.553732395417, 4751.31105989633, 5069.746512674388, 5073.543381095682, 5085.542301192873, 5092.3125378073855, 5145.073886700392, 5120.590352771769, 5129.589632829365, 5135.64050516464, 5138.511841375063, 5141.357330333708, 4646.186917289495, 4734.597559207437, 4773.570378665937, 4816.614670826326, 4852.563269305709, 5246.501582349747, 5275.498827611371, 5290.65610735301, 5294.470552944675, 5381.9461805382225, 4841.975790121027, 5095.082885080721, 5099.209622508517, 5103.2855400244, 5103.7192954387865, 5047.671901326402, 5092.516210959953, 5182.792688292501, 5198.506141916512, 5252.107141785906, 5110.131277682803, 5114.232865070269, 5115.7442127893455, 5122.846314610493, 5168.7415629218385, 4860.684055536379, 4959.231319145538, 5086.491350864958, 5090.160123579642, 5092.083424983539, 4241.448611680524, 4276.679249056333, 4288.2066817638215, 4322.200392927319, 4346.847860324873, 3771.6039815819495, 3802.961970380316, 3806.5051543299196, 3830.4254361845387, 3834.0606551395085, 4254.234237837219, 4343.630791382768, 4399.802008909607, 4438.5561443856, 4453.087117140978, 5157.484251574888, 5178.249153872667, 5179.404368497596, 5193.2989046479, 5196.376434827845, 4451.399061126771, 4455.353973673799, 4456.420665313553, 4499.572540608637, 4500.662450316239, 4447.577480139382, 4500.549945005473, 4565.338025986213, 4595.058013107305, 4611.7232966021475, 4808.783604737725, 4821.059893320768, 4832.613390928647, 4860.6111511079025, 4914.778834952507, 5121.667091639031, 5139.331886854685, 5143.537081662668, 5172.405173405106, 5191.974040129775, 4653.325267836077, 4716.8113275468595, 4750.453697824656, 4836.854894353175, 4843.733594652328, 5064.290999260033, 5092.949070509248, 5099.949000509948, 5108.923366149436, 5122.385313762373, 4949.653524253412, 5160.458151894147, 5162.0, 5190.584753219658, 5196.480351964925, 4841.273808928689, 4895.877603059952, 4901.436334821398, 4928.827491037797, 4954.628402869727, 4992.101421744121, 4999.675021123615, 5004.974975125101, 5009.248612707977, 5039.899202016012, 4654.464736555339, 4750.857474275777, 4911.803527858846, 4929.112759703288, 4959.057779021974, 4886.780094895667, 4910.337104490848, 4943.406791184937, 4952.2819191217795, 5002.149634562061, 4885.316055752127, 4891.315215869852, 4954.20732682769, 4961.0, 4963.0], "unit": "ms", "name": "dojo.html", "value": 4686.668801147988}, {"lowerIsBetter": false, "replicates": [548.6192610607583, 561.2030916099138, 580.5210701171533, 584.5469760935276, 613.4662843326307, 27994.0, 36021.819890900544, 36504.81747591265, 36591.81704091476, 36704.0, 39120.21759564807, 39307.21385572294, 39411.0, 39509.20981580374, 39691.40462893052, 7929.365650747941, 8055.959720201391, 8057.879131813028, 8069.354451643854, 8094.069182044052, 7864.724734634289, 7981.0422749270165, 7985.961824962776, 7992.680292788311, 8005.599720013976, 8011.839763204733, 8084.474509156916, 8110.229528194812, 8116.756497305061, 8127.3091787198155, 7952.960235198845, 7996.560189189592, 8020.11778704342, 8051.718189863356, 8059.476134051297, 7904.367650587997, 7990.720324788605, 8024.67901283948, 8047.476914000571, 8048.31589314909, 35687.64312356869, 35931.82034089839, 36118.0, 36123.45814812754, 36298.0, 2807.452546753384, 2911.228524441025, 2948.660903996025, 2949.144748023071, 3001.639803223605, 26187.345316367053, 26491.73508264912, 26561.468770624673, 26617.334566635796, 26649.200523984313, 3380.8140552269615, 3423.17843717506, 3437.8796742114155, 3455.4989526518766, 3526.9647897786313, 217282.0, 217410.0, 219054.0, 219095.0, 219872.0, 49932.0, 51120.48879511232, 53652.19521707178, 54870.451295486535, 55461.44538554644, 55512.44487555153, 55538.72230638821, 55621.38461000022, 55938.16092758612, 55980.440195598334, 11734.589289374831, 11870.584529541424, 12024.0, 12050.819237711441, 12051.397430128458, 8909.5099769512, 9058.36591438593, 9064.138906803842, 9080.046595107418, 9090.86363704545, 19132.0, 19135.80864191368, 19181.32865349706, 19204.423867284004, 19253.593300837394, 7558.546487210785, 7884.842303153905, 7897.565633890191, 7972.083210430875, 8102.635381407851, 862.4221771413169, 863.5595846118525, 944.5466176235308, 957.9521023948914, 1016.8678071850612, 25142.24573262805, 25154.37114072163, 25196.346529753082, 25329.746702533106, 25454.0, 920.1258804136097, 941.331654525281, 973.109604711695, 976.3946353261024, 980.8724865767405, 13977.65055873591, 14147.0, 14280.714385712436, 14680.92659536717, 14902.627434314229, 330800.0, 334850.0, 335501.0, 335782.0, 336025.0, 47770.0, 47979.0, 48044.759776201594, 48065.5193448068, 48146.759266203444, 1200.543793358518, 1213.5024639897777, 1217.7320989382322, 1220.4690959432498, 1224.2287358963974, 26523.0, 26736.19791406261, 26975.46049079047, 27230.0, 27387.589186161826, 42964.78517607392, 43064.0, 43305.0, 43394.78302608467, 43517.34723979206, 253663.0, 257712.0, 259065.0, 259383.0, 259781.0, 38719.0, 41699.58300417078, 41983.370249446896, 42679.3598096035, 42681.1463770729, 38520.422193666556, 38741.418878717406, 38772.41841372325, 39614.207715846096, 39984.600153998086, 31997.8400107998, 32378.35243295168, 33150.336993259516, 33287.66712332846, 33683.15792105217, 35728.0, 36249.63750362568, 37288.6271137296, 38107.42838857364, 38475.615243847205, 33123.66876331206, 33233.66766332306, 37555.624443755216, 38379.808100959315, 38515.807420962716, 28908.71091289144, 30257.24356891007, 31001.534976975814, 31016.844915775277, 31076.0, 23576.17483388073, 23639.81800909982, 23767.643485347387, 24143.51712965766, 24227.0], "unit": "ms", "name": "ext.html", "value": 17141.0455691271}, {"lowerIsBetter": false, "replicates": [316.61056900012983, 319.6260375360829, 319.803320957611, 321.19700748129674, 322.3408130373386, 14728.116313021214, 15095.094294342347, 15119.092854428742, 15637.452689155853, 16333.673326533491, 9234.307426942973, 9298.86051709225, 9526.571304291307, 9540.952295238532, 9551.904480955189, 4349.238883195444, 4458.66560007999, 4482.148391805563, 4490.281554951209, 4511.932321015187, 4435.534268901767, 4512.571305725951, 5043.0, 5047.545720885119, 5058.519440653132, 4687.742174180418, 4797.90404191916, 4845.176320025586, 5022.547970682638, 5029.346184995946, 4683.6253099752275, 4784.5933095686905, 4818.421789385278, 4822.517748225149, 4826.589739872097, 4671.205894997858, 4680.274557443568, 4690.718556886563, 4707.6233901287815, 4715.41057367829, 10168.0, 10172.694819155437, 10234.0, 10348.94825525875, 10559.73600659982, 1722.84494395505, 1725.3271224222563, 1776.4848194023718, 1841.5027942455597, 2069.0172168220124, 8305.543195124266, 8362.58187090643, 8556.358273129541, 8565.957170214171, 8583.699570515002, 1686.1147897353865, 1732.7054400751902, 1748.0735210338541, 1761.5067781021335, 1778.9822101778946, 32829.67170328314, 33362.49956250658, 47255.0, 47391.5260847394, 48673.26990095151, 9459.716208513755, 9500.19248363883, 9502.0, 9503.714888553355, 9518.762030949143, 11918.761624767629, 11952.462139203757, 11977.64067077989, 11991.880081199077, 12023.158378913393, 6501.837454063591, 6538.476921846336, 6564.934350656527, 6584.703688334036, 6615.040819081302, 6206.658633775186, 6237.688115594293, 6249.843753906098, 6258.843528911813, 6266.122742816009, 3818.6754125899056, 3843.9231215375535, 3925.9803700981884, 3943.861964831217, 3960.940585891214, 1575.4958413307631, 1616.8544830965034, 1640.7702921590749, 1675.9413420530223, 1682.7139386304357, 779.5829231361195, 939.6147579492375, 943.1370296179057, 960.8558716192488, 965.0687086960976, 15270.923645381925, 15382.692346153015, 15417.229138543027, 15687.1372074537, 16029.839701603069, 790.5138339921023, 818.5416166946529, 846.7798372423214, 850.4982060584285, 852.5481494807761, 7633.770986870402, 8882.777930551789, 8927.10728927115, 8929.0, 9003.36976411658, 332889.0, 343917.0, 344291.0, 495799.0, 498634.0, 65741.0, 65815.34184658092, 66086.66956665282, 66260.33739662638, 70613.64693176604, 1019.4291196929743, 1041.8020576090519, 1044.12815299226, 1046.6493724602192, 1052.5947510208625, 13649.454021839016, 14543.490977815725, 14549.199794011007, 14616.488422905148, 15113.47102851395, 31812.204694881886, 32335.514967275038, 33214.16964575905, 33729.662703372655, 34370.48444273288, 39843.60156398399, 42226.577734222265, 42401.36397953972, 42754.57245427506, 44605.0, 8381.455205411628, 8486.787830304045, 8520.105388934073, 8597.52713600758, 9009.324300677607, 16292.674146516767, 16331.346746130022, 16671.083090430144, 16690.16549172561, 16690.666186675957, 10819.783604328028, 11246.268992515461, 12684.429200686176, 13445.932770336085, 13686.178829270275, 12642.494300227889, 12724.745505090032, 13030.804537931748, 13160.407781649657, 13369.933150334185, 13199.472021119433, 13354.131981421177, 13552.93223533876, 13758.862411375758, 14215.147091174562, 7864.2922137007945, 8380.287675547646, 8664.090270521756, 8693.217610415093, 8746.868796968178, 8790.560471976503, 8880.689175878813, 9199.816003680024, 13753.38109785082, 13766.24285664298], "unit": "ms", "name": "jquery.html", "value": 7647.6804913162605}, {"lowerIsBetter": false, "replicates": [1469.8824094072475, 1603.486884197057, 1654.5780825889397, 1681.4283143731136, 1695.2032544703984, 5755.68343741094, 5897.941020589793, 6177.258728952526, 6579.243387010495, 6599.472042236622, 6306.369363063692, 6401.871962560746, 6448.709808058637, 6460.935390646092, 6489.415952564268, 1948.2109745553073, 1984.0377416952767, 1986.1757370691219, 1987.8608497405187, 1991.800819918011, 1934.8742331748463, 1971.546544294813, 1983.186893373717, 1984.682450807871, 1993.5913137806788, 1868.3460788723905, 1890.2533499267781, 1900.0499750124939, 1906.4185423445842, 1911.1877452082879, 1906.9713954290696, 1962.8331591814713, 1963.980360196394, 1964.5285131568392, 1967.1836187982112, 1951.4731022623812, 1973.7828838827718, 1978.980210197894, 1983.4347211044783, 1998.4704053425853, 6395.16862807832, 6429.646369449679, 6446.548741588091, 6455.5158363122955, 6456.192975878015, 3761.8307176176863, 3825.923481530354, 3828.712846536493, 3831.7892515911612, 3833.674137698299, 2473.641322008317, 2561.859097749623, 2564.3460917466114, 2570.588705807062, 2571.537123317802, 852.8933883264592, 877.6533269358631, 880.6433394475248, 882.6248844241236, 919.4621146629163, 8598.484090954562, 8627.611757470866, 8665.220130188314, 8716.300321437258, 8747.125287471266, 3348.68187522185, 3405.1487128217946, 3439.174598096439, 3453.568303962005, 3455.3953058215216, 7181.928180718231, 7197.748078817216, 7203.099612548432, 7218.45861560385, 7242.420606351479, 3794.962050379516, 3822.8853134406013, 3831.8084095795098, 3837.309284328792, 3850.4801851750217, 3500.6674365935196, 3516.1561225306255, 3523.2777280657406, 3533.3286675531567, 3533.982330088333, 2988.4321978823955, 3027.167528929518, 3030.575719399286, 3030.8029978051354, 3032.302570408818, 885.4731434796286, 900.0, 900.2797761790541, 907.2968449451728, 908.6910450446748, 911.9042500537481, 926.4672813132476, 928.2017464980112, 962.2013728605241, 1164.3596022187762, 6144.262688477412, 6144.846378840475, 6144.969275153596, 6171.84570385744, 6193.81418557444, 381.8548951398451, 383.11500433997554, 383.44209175649365, 1050.3172937590475, 1068.4474123539262, 4909.484504127086, 4950.18321976877, 4996.875078123004, 4997.550220480174, 5006.724630145377, 7149.96425017882, 7500.549967001888, 7609.809754756065, 7619.69521219145, 7642.235776422313, 7741.07107147146, 7765.961170194113, 7808.453408261481, 7851.332636725942, 7862.410319226081, 6052.334243233241, 6085.452309292274, 6234.812955611339, 6247.937520624736, 6314.210723659543, 6305.432511074026, 6320.146780184617, 6346.746130154742, 6365.61806291624, 6370.076338930921, 6771.255161932085, 6840.589564626139, 6867.175938887166, 7035.22612512613, 7047.154341479055, 6925.82685432848, 6984.965075174591, 6993.895091573529, 7072.151341839012, 7079.752208672672, 5782.710864456844, 5789.0, 5813.912791308218, 5817.621854579439, 5825.825225243249, 6192.164057852132, 6278.434940855345, 6338.58799178052, 6351.904721429275, 6388.361163883575, 5997.070454079625, 6040.1241819934985, 6043.8186854394435, 6049.637021778707, 6125.418085281891, 5835.153902684172, 5885.440883116097, 5915.40845915405, 5934.3175534814045, 5937.435943585352, 5870.383609720918, 5888.646681199141, 5915.615484993462, 5932.0508718604815, 5946.256717910262, 5539.393575862955, 5546.473085056913, 5579.497845193952, 5641.689707066151, 5712.028955077563, 5663.122216056518, 5688.658680479184, 5696.857578560569, 5697.401772813961, 5710.057840456278], "unit": "ms", "name": "mootools.html", "value": 3742.8121193204474}, {"lowerIsBetter": false, "replicates": [290.48439020738186, 297.19460262688114, 299.7437191201524, 301.28144375664044, 301.4287924383295, 5611.719414029302, 5646.74589643466, 5657.038303488406, 5689.971550142254, 5758.856028599287, 5492.5605951523785, 5569.0254205513975, 5651.2370829937945, 5660.264165658469, 5686.346070201928, 4299.355096735483, 4326.84856030039, 4329.7618630975285, 4330.155619654153, 4349.956500434987, 4331.913361732763, 4334.956650433503, 4347.282698354784, 4349.826006959718, 4358.782060896942, 4202.684798640114, 4269.423627810237, 4292.6780491463105, 4303.419038429804, 4308.849190278341, 4288.249556327662, 4288.97855510722, 4291.699581029329, 4294.957050429487, 4296.205202037618, 3670.6512881276235, 3683.6684698377007, 3685.281370132825, 3690.9630903690886, 3691.5201023866725, 5382.811601593926, 5456.127019676872, 5489.204065410533, 5494.148406996922, 5498.230247765316, 4929.260610908356, 4937.061958227925, 4940.90118197634, 4964.255361695738, 4979.701217926936, 5972.581919265654, 6009.218801555813, 6010.429009244115, 6015.218021657201, 6034.155218269446, 3971.3347267841264, 4007.338789099795, 4045.9190816183805, 4067.410225517313, 4072.1855628874046, 6225.315215326311, 6323.051542268697, 6325.304216536178, 6336.081268216083, 6338.524610654219, 4153.68847336451, 4156.418101465797, 4167.74993500391, 4170.22850772608, 4170.895727606773, 4229.429027081366, 4230.090530535888, 4231.344141658048, 4231.746095234295, 4232.851850185229, 4695.694779839368, 4905.828296009622, 4908.337374454474, 4917.950820491821, 4919.901601968012, 5885.764569417175, 5922.763089476372, 6005.129256257818, 6008.939910600838, 6021.217241758543, 1466.054394915295, 1500.7448733715294, 1500.9774853377207, 1501.1668523969083, 1503.8947273690737, 958.6261358070358, 964.262339310428, 979.3193730357333, 997.9600815967425, 997.9900200997897, 5181.81863634771, 5203.453637368098, 5206.0, 5221.947780522222, 5226.869328266747, 6276.309605943343, 6277.278113016971, 6277.686115694197, 6285.402886725754, 6292.433680968735, 5176.456472070454, 5184.5593124584075, 5208.427073021964, 5212.296339994128, 5218.399884013311, 3331.351555859066, 3363.0, 3378.2567835076243, 3415.8121303328057, 3419.4870769384793, 5798.797042103506, 5873.706314684248, 5877.9118313225335, 5886.529077673861, 5890.970545147246, 6470.838229044311, 6524.804255872332, 6535.411812936763, 6535.934640653532, 6544.443722283564, 5883.764649414061, 5899.292084949748, 5921.052631579013, 5924.437178468125, 5939.851503712442, 6179.783707570214, 6292.402221788922, 6304.0, 6314.810555683337, 6322.494200464043, 6125.0, 6158.445739883432, 6164.198654174928, 6170.10533472653, 6173.9073913892225, 5899.17411562373, 5920.259967504062, 5937.970310148422, 5943.91084133747, 5950.7917222896995, 4114.650254728382, 4138.089620283533, 4160.729552579072, 4161.604647558477, 4172.874813755592, 6201.81394558164, 6257.4681152102585, 6326.240851097898, 6326.778562750282, 6340.048992651139, 6048.818535443944, 6074.605150665369, 6077.27072751255, 6078.300995385587, 6079.604825686316, 6029.397060294111, 6065.545084118797, 6081.969590152021, 6095.238095238095, 6097.390260973867, 5752.194692743103, 5885.058390657474, 5896.8820623586425, 5951.256092988377, 5973.462388385066, 6036.185115009594, 6046.969765151146, 6053.727582258897, 6147.678249176449, 6150.723217455315, 5944.64332140073, 5965.433283838202, 5977.551683623833, 5991.2510936132985, 5994.400559943971], "unit": "ms", "name": "prototype.html", "value": 4456.500588587033}, {"lowerIsBetter": false, "replicates": [683.9247682754896, 697.003285302018, 753.9623018849056, 775.360327729623, 794.4200733464571, 10753.946230268848, 11041.619797525309, 11122.499487523051, 11125.666230013092, 11152.609658661948, 10549.84175237372, 10938.726531836708, 10945.069669078139, 10988.0, 10994.505247263893, 752.9811754706135, 755.403231447156, 771.2018061306549, 779.2168870285356, 781.5896654256533, 774.6746366526045, 776.4332037612546, 778.5173192620583, 784.5096814490943, 787.7361084036854, 804.2440106300088, 809.2352726673296, 810.6514198894473, 810.7405630198339, 811.253646645085, 793.3573805217734, 797.956112413817, 799.3325573146429, 799.8680217764062, 800.4596897094467, 596.7314708381202, 596.8865915476046, 599.9520038396918, 601.6931365003836, 603.6891001134419, 11265.831012534736, 11318.830217546743, 11369.488373023234, 11407.714807129805, 11431.942840285745, 10431.739206519898, 10695.679129626124, 10828.242023058388, 10963.890361096366, 11173.83239251412, 8733.214010739, 8753.124687531259, 8922.553872306358, 9279.118483744101, 9610.327277090606, 3221.0, 3227.1770698471973, 3230.628477725068, 3240.3843269778667, 3281.917952051194, 41260.0, 41281.587184128075, 41567.168656627, 41599.376009359585, 41623.0, 8360.372972027122, 8480.957595212109, 8527.104654011364, 8540.359473039547, 8903.599338029804, 15400.845991539942, 15722.29249683767, 15730.213489325488, 15814.76277855833, 15869.841301587066, 6021.397860213943, 6085.69571521431, 6123.724432400552, 6231.875362492725, 6259.029850373199, 3399.6260411354733, 3500.9474857877153, 3506.4915587239707, 3546.3261980223674, 3589.6948759355746, 2606.0, 2633.210036988896, 2647.695515015759, 2649.629051932731, 2653.721359257289, 476.07403599997673, 503.33559701194804, 507.4544864270924, 519.9532042116227, 521.6035812782313, 565.3244372974339, 612.2194202391897, 619.7923695562038, 625.2122325869346, 627.632834791652, 7428.73999410018, 7436.330730234305, 7506.24937506245, 7513.511621744678, 7525.510841795266, 416.9061961058798, 425.525539023986, 547.7726743401523, 584.7047241143281, 586.2700937333047, 3772.6227377262603, 3923.391874259494, 4001.1797581495725, 4035.475388199574, 4125.422440858282, 47923.52076479191, 50140.749296253285, 50295.24557131646, 50784.74607626938, 50917.236241456405, 44469.77765111154, 44618.33072503915, 44990.0, 45374.31938520925, 46573.76713116481, 40220.39669404961, 40979.0, 41168.9999999994, 41445.0, 42044.0, 7591.0, 7613.08642962848, 7907.209279072047, 8060.83878322442, 8115.4319197655595, 31557.684423155475, 31695.0, 32170.839145804122, 32187.35625287528, 32199.195020124684, 37013.444798328586, 37603.623963760016, 40821.591784082964, 40946.59053409428, 41389.37915931203, 9875.506224688881, 10004.699859004242, 10252.43611601369, 10326.48367581633, 10337.37975721459, 11245.212835101463, 11579.363135027654, 11649.59226427071, 11684.649460516199, 11991.340476273888, 10337.30591524731, 10422.895771042193, 10589.52347144365, 10663.0, 10668.786624267626, 9801.656942006995, 9857.35927164732, 10139.239557033105, 10427.94786026065, 10430.530626121994, 9907.0, 10184.388936663527, 10805.0, 10822.729431764268, 10950.178736594946, 9032.683856065007, 9137.954310228406, 9267.67563135287, 9279.953600231956, 9677.419354838732, 8552.102029286836, 8754.29965602763, 8798.34012449056, 9002.64078794322, 9037.0], "unit": "ms", "name": "yui.html", "value": 5642.455194280348}], "name": "dromaeo_css", "value": 6218.55677797728}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 113.0, 113.0, 115.0, 126.0, 113.0, 112.0, 112.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 154.0, 166.0, 132.0, 161.0, 158.0, 137.0, 164.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 161.0, 162.0, 164.0, 163.0, 170.0, 165.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 74.0, 73.0, 150.0, 72.0, 82.0, 71.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 130.0, 96.0, 96.0, 95.0, 128.0, 95.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 147.0, 147.0, 148.0, 150.0, 148.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 75.0, 75.0, 78.0, 77.0, 75.0, 77.0, 81.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 76.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 88.0, 83.0, 85.0, 84.0, 89.0, 86.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 127.0, 121.0, 127.0, 131.0, 124.0, 122.0, 120.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 153.0, 148.0, 149.0, 151.0, 140.0, 146.0, 149.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 72.0, 69.0, 70.0, 70.0, 70.0, 69.0, 76.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1541.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.25204883759827], "unit": "score", "name": "Richards", "value": 211.07065799999992}, {"lowerIsBetter": false, "replicates": [185.08236165093467], "unit": "score", "name": "DeltaBlue", "value": 357.23555399999987}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [708.2152974504249], "unit": "score", "name": "Earley", "value": 941.0457559999996}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25500.0], "unit": "score", "name": "RegExp", "value": 35.72490196078431}, {"lowerIsBetter": false, "replicates": [630.2573760200879], "unit": "score", "name": "Splay", "value": 129.2979711155378}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21326.938690577535}]} 05:15:15 INFO - RETURN: dromaeo_css: 6218.56 05:15:15 INFO - RETURN: kraken: 1541.20 05:15:15 INFO - RETURN: v8_7: 21326.94 05:15:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21326.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1541.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6218.56"}}} 05:15:15 INFO - Return code: 0 05:15:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:15 INFO - # TBPL SUCCESS # 05:15:15 INFO - Running post-action listener: _resource_record_post_action 05:15:15 INFO - Running post-run listener: _resource_record_post_run 05:15:17 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511721472; Read time: 8; Write time: 967724 05:15:17 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 240742400; Read time: 0; Write time: 621744 05:15:17 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 270979072; Read time: 8; Write time: 345980 05:15:17 INFO - Running post-run listener: _upload_blobber_files 05:15:17 INFO - Blob upload gear active. 05:15:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:15:17 INFO - Copying logs to upload dir... 05:15:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.177072 ========= master_lag: 0.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-30 05:15:17.492032) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 05:15:17.495444) ========= 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=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010016 build_url: 'https://queue.taskcluster.net/v1/task/Z2hKpQaZTt2qctkdOOR_4g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 05:15:17.518756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 05:15:17.519071) ========= 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=a194aa7faa1be204aaca7d660000020b-1448887826.847884-1959271507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 05:15:17.572027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 05:15:17.572406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 05:15:17.572699) ========= ========= Total master_lag: 0.69 =========